builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0039 starttime: 1469104443.54 results: success (0) buildid: 20160721030216 builduid: baf5ae8238104ef689a1a3626b02ab35 revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.541279) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.541645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.541947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.593192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:03.593534) ========= 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.t3tjyKyiGP/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.stynC5RunH/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-07-21 05:34:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 99.0M=0s 2016-07-21 05:34:04 (99.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.577169 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:04.194418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:04.194984) ========= 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.t3tjyKyiGP/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.stynC5RunH/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.026826 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:04.245575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:34:04.245899) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d224fc999cb6accb208af0a105f14433375e2e77 --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 d224fc999cb6accb208af0a105f14433375e2e77 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t3tjyKyiGP/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.stynC5RunH/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-07-21 05:34:04,321 truncating revision to first 12 chars 2016-07-21 05:34:04,322 Setting DEBUG logging. 2016-07-21 05:34:04,322 attempt 1/10 2016-07-21 05:34:04,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d224fc999cb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 05:34:05,450 unpacking tar archive at: mozilla-central-d224fc999cb6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 05:34:05.658964) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.659291) ========= script_repo_revision: d224fc999cb6accb208af0a105f14433375e2e77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.659707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.659997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 05:34:05.678310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-07-21 05:34:05.678657) ========= /tools/buildbot/bin/python 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', '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.t3tjyKyiGP/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.stynC5RunH/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:34:05 INFO - MultiFileLogger online at 20160721 05:34:05 in /builds/slave/test 05:34:05 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 05:34:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:34:05 INFO - {'append_to_log': False, 05:34:05 INFO - 'base_work_dir': '/builds/slave/test', 05:34:05 INFO - 'blob_upload_branch': 'Firefox', 05:34:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:34:05 INFO - 'branch': 'Firefox', 05:34:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:05 INFO - 'config_files': ('talos/mac_config.py',), 05:34:05 INFO - 'default_actions': ('clobber', 05:34:05 INFO - 'read-buildbot-config', 05:34:05 INFO - 'download-and-extract', 05:34:05 INFO - 'populate-webroot', 05:34:05 INFO - 'create-virtualenv', 05:34:05 INFO - 'install', 05:34:05 INFO - 'run-tests'), 05:34:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:05 INFO - 'download_minidump_stackwalk': True, 05:34:05 INFO - 'download_symbols': 'ondemand', 05:34:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:05 INFO - 'installer_path': 'installer.exe', 05:34:05 INFO - 'log_level': 'info', 05:34:05 INFO - 'log_name': 'talos', 05:34:05 INFO - 'log_to_console': True, 05:34:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:34:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:34:05 INFO - 'opt_config_files': (), 05:34:05 INFO - 'pip_index': False, 05:34:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:05 INFO - 'cmd': ('bash', 05:34:05 INFO - '-c', 05:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:05 INFO - 'enabled': True, 05:34:05 INFO - 'halt_on_failure': False, 05:34:05 INFO - 'name': 'check_screen_resolution'},), 05:34:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:05 INFO - 'cmd': ('bash', 05:34:05 INFO - '-c', 05:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:05 INFO - 'enabled': True, 05:34:05 INFO - 'halt_on_failure': False, 05:34:05 INFO - 'name': 'check_screen_resolution'},), 05:34:05 INFO - 'run_cmd_checks_enabled': True, 05:34:05 INFO - 'sps_profile': False, 05:34:05 INFO - 'sps_profile_interval': 0, 05:34:05 INFO - 'suite': 'dromaeojs-e10s', 05:34:05 INFO - 'system_bits': '32', 05:34:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:05 INFO - 'title': 't-yosemite-r7-0039', 05:34:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:05 INFO - 'use_talos_json': True, 05:34:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:34:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:05 INFO - 'work_dir': 'build'} 05:34:05 INFO - [mozharness: 2016-07-21 12:34:05.888134Z] Running clobber step. 05:34:05 INFO - Running pre-action listener: _resource_record_pre_action 05:34:05 INFO - Running main action method: clobber 05:34:05 INFO - rmtree: /builds/slave/test/build 05:34:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:34:08 INFO - Running post-action listener: _resource_record_post_action 05:34:08 INFO - [mozharness: 2016-07-21 12:34:08.060799Z] Finished clobber step (success) 05:34:08 INFO - [mozharness: 2016-07-21 12:34:08.060968Z] Running read-buildbot-config step. 05:34:08 INFO - Running pre-action listener: _resource_record_pre_action 05:34:08 INFO - Running main action method: read_buildbot_config 05:34:08 INFO - Using buildbot properties: 05:34:08 INFO - { 05:34:08 INFO - "project": "", 05:34:08 INFO - "product": "firefox", 05:34:08 INFO - "script_repo_revision": "production", 05:34:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:34:08 INFO - "repository": "", 05:34:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:34:08 INFO - "buildid": "20160721030216", 05:34:08 INFO - "stage_platform": "macosx64", 05:34:08 INFO - "basedir": "/builds/slave/test", 05:34:08 INFO - "nightly_build": "True", 05:34:08 INFO - "buildnumber": 337, 05:34:08 INFO - "slavename": "t-yosemite-r7-0039", 05:34:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:34:08 INFO - "platform": "yosemite_r7", 05:34:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:34:08 INFO - "branch": "mozilla-central", 05:34:08 INFO - "repo_path": "mozilla-central", 05:34:08 INFO - "revision": "d224fc999cb6accb208af0a105f14433375e2e77", 05:34:08 INFO - "pgo_build": "False", 05:34:08 INFO - "builduid": "baf5ae8238104ef689a1a3626b02ab35", 05:34:08 INFO - "slavebuilddir": "test" 05:34:08 INFO - } 05:34:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:34:08 INFO - Running post-action listener: _resource_record_post_action 05:34:08 INFO - [mozharness: 2016-07-21 12:34:08.066995Z] Finished read-buildbot-config step (success) 05:34:08 INFO - [mozharness: 2016-07-21 12:34:08.067179Z] Running download-and-extract step. 05:34:08 INFO - Running pre-action listener: _resource_record_pre_action 05:34:08 INFO - Running main action method: download_and_extract 05:34:08 INFO - mkdir: /builds/slave/test/build/tests 05:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:08 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:34:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:34:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:34:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 05:34:38 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 05:34:38 INFO - retry: attempt #1 caught exception: timed out 05:34:38 INFO - retry: Failed, sleeping 30 seconds before retrying 05:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 05:35:20 INFO - Downloaded 1199 bytes. 05:35:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:35:20 INFO - Using the following test package requirements: 05:35:20 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:35:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:35:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:35:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'jsshell-mac.zip'], 05:35:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:35:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:35:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:35:20 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:35:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:35:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:35:20 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:35:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:35:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:20 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:35:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:35:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:35:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:21 INFO - Downloaded 18843089 bytes. 05:35:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:24 INFO - Return code: 0 05:35:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:24 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:35:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:35:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:35:31 INFO - Downloaded 18843089 bytes. 05:35:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:35 INFO - Return code: 0 05:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:35 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:35:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:35:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:35:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:35:36 INFO - Downloaded 14403317 bytes. 05:35:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:35:36 INFO - Return code: 0 05:35:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:36 INFO - https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:35:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:35:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:35:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:35:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 05:35:39 INFO - Downloaded 113052100 bytes. 05:35:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:35:39 INFO - mkdir: /builds/slave/test/properties 05:35:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:39 INFO - Contents: 05:35:39 INFO - build_url:https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:35:40 INFO - Running post-action listener: _resource_record_post_action 05:35:40 INFO - Running post-action listener: set_extra_try_arguments 05:35:40 INFO - [mozharness: 2016-07-21 12:35:40.435502Z] Finished download-and-extract step (success) 05:35:40 INFO - [mozharness: 2016-07-21 12:35:40.435656Z] Running populate-webroot step. 05:35:40 INFO - Running pre-action listener: _resource_record_pre_action 05:35:40 INFO - Running main action method: populate_webroot 05:35:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:40 INFO - '--tppagecycles', 05:35:40 INFO - '7'], 05:35:40 INFO - 'tests': ['tsvgm']}}, 05:35:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['damp', 'tps']}, 05:35:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'tests': ['damp', 'tps']}, 05:35:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['dromaeo_dom']}, 05:35:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['basic_compositor_video']}, 05:35:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:35:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['a11yr', 05:35:40 INFO - 'ts_paint', 05:35:40 INFO - 'tpaint', 05:35:40 INFO - 'sessionrestore', 05:35:40 INFO - 'sessionrestore_no_auto_restore', 05:35:40 INFO - 'tabpaint']}, 05:35:40 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:40 INFO - 'ts_paint', 05:35:40 INFO - 'tpaint', 05:35:40 INFO - 'sessionrestore', 05:35:40 INFO - 'sessionrestore_no_auto_restore', 05:35:40 INFO - 'tabpaint']}, 05:35:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:40 INFO - 'ts_paint', 05:35:40 INFO - 'tpaint', 05:35:40 INFO - 'sessionrestore', 05:35:40 INFO - 'sessionrestore_no_auto_restore', 05:35:40 INFO - 'tabpaint']}, 05:35:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:40 INFO - 'ts_paint', 05:35:40 INFO - 'tpaint', 05:35:40 INFO - 'sessionrestore', 05:35:40 INFO - 'sessionrestore_no_auto_restore', 05:35:40 INFO - 'tabpaint']}, 05:35:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['a11yr', 05:35:40 INFO - 'ts_paint', 05:35:40 INFO - 'tpaint', 05:35:40 INFO - 'sessionrestore', 05:35:40 INFO - 'sessionrestore_no_auto_restore', 05:35:40 INFO - 'tabpaint']}, 05:35:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['a11yr', 05:35:40 INFO - 'ts_paint', 05:35:40 INFO - 'tpaint', 05:35:40 INFO - 'sessionrestore', 05:35:40 INFO - 'sessionrestore_no_auto_restore', 05:35:40 INFO - 'tabpaint']}, 05:35:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['tsvgx', 05:35:40 INFO - 'tsvgr_opacity', 05:35:40 INFO - 'tart', 05:35:40 INFO - 'tscrollx', 05:35:40 INFO - 'cart']}, 05:35:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:40 INFO - 'tsvgr_opacity', 05:35:40 INFO - 'tart', 05:35:40 INFO - 'tscrollx', 05:35:40 INFO - 'cart']}, 05:35:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'talos_options': ['--disable-e10s'], 05:35:40 INFO - 'tests': ['tp5o']}, 05:35:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'tests': ['tp5o']}, 05:35:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'talos_options': ['--disable-e10s', 05:35:40 INFO - '--xperf_path', 05:35:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:40 INFO - 'tests': ['tp5n']}, 05:35:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:40 INFO - 'talos_options': ['--xperf_path', 05:35:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:40 INFO - 'tests': ['tp5n']}}, 05:35:40 INFO - 'talos.zip': {'path': '', 05:35:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:40 INFO - Running post-action listener: _resource_record_post_action 05:35:40 INFO - [mozharness: 2016-07-21 12:35:40.454742Z] Finished populate-webroot step (success) 05:35:40 INFO - [mozharness: 2016-07-21 12:35:40.454881Z] Running create-virtualenv step. 05:35:40 INFO - Running pre-action listener: _resource_record_pre_action 05:35:40 INFO - Running main action method: create_virtualenv 05:35:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:40 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 05:35:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:40 INFO - Using real prefix '/tools/python27' 05:35:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:44 INFO - Installing pip.................done. 05:35:44 INFO - Return code: 0 05:35:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:35:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:44 INFO - 'HOME': '/Users/cltbld', 05:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:44 INFO - 'LOGNAME': 'cltbld', 05:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:44 INFO - 'MOZ_NO_REMOTE': '1', 05:35:44 INFO - 'NO_EM_RESTART': '1', 05:35:44 INFO - 'PAGER': '/bin/cat', 05:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:44 INFO - 'PWD': '/builds/slave/test', 05:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:44 INFO - 'SHELL': '/bin/bash', 05:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:35:44 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:44 INFO - 'USER': 'cltbld', 05:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:44 INFO - 'XPC_FLAGS': '0x0', 05:35:44 INFO - 'XPC_SERVICE_NAME': '0', 05:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:44 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 05:35:44 INFO - Cleaning up... 05:35:44 INFO - Return code: 0 05:35:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:35:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:44 INFO - 'HOME': '/Users/cltbld', 05:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:44 INFO - 'LOGNAME': 'cltbld', 05:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:44 INFO - 'MOZ_NO_REMOTE': '1', 05:35:44 INFO - 'NO_EM_RESTART': '1', 05:35:44 INFO - 'PAGER': '/bin/cat', 05:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:44 INFO - 'PWD': '/builds/slave/test', 05:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:44 INFO - 'SHELL': '/bin/bash', 05:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:35:44 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:44 INFO - 'USER': 'cltbld', 05:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:44 INFO - 'XPC_FLAGS': '0x0', 05:35:44 INFO - 'XPC_SERVICE_NAME': '0', 05:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:44 INFO - Downloading/unpacking psutil>=3.1.1 05:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:48 INFO - Installing collected packages: psutil 05:35:48 INFO - Running setup.py install for psutil 05:35:48 INFO - building 'psutil._psutil_osx' extension 05:35:48 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 05:35:48 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 05:35:48 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 05:35:48 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 05:35:49 INFO - building 'psutil._psutil_posix' extension 05:35:49 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 05:35:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:35:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:35:49 INFO - ^ 05:35:49 INFO - 1 warning generated. 05:35:49 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 05:35:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:49 INFO - Successfully installed psutil 05:35:49 INFO - Cleaning up... 05:35:49 INFO - Return code: 0 05:35:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:49 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 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:35:49 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 05:35:49 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 05:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:49 INFO - 'HOME': '/Users/cltbld', 05:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:49 INFO - 'LOGNAME': 'cltbld', 05:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:49 INFO - 'MOZ_NO_REMOTE': '1', 05:35:49 INFO - 'NO_EM_RESTART': '1', 05:35:49 INFO - 'PAGER': '/bin/cat', 05:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:49 INFO - 'PWD': '/builds/slave/test', 05:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:49 INFO - 'SHELL': '/bin/bash', 05:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:35:49 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:49 INFO - 'USER': 'cltbld', 05:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:49 INFO - 'XPC_FLAGS': '0x0', 05:35:49 INFO - 'XPC_SERVICE_NAME': '0', 05:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:35:52 INFO - Installing collected packages: mozsystemmonitor 05:35:52 INFO - Running setup.py install for mozsystemmonitor 05:35:52 INFO - Successfully installed mozsystemmonitor 05:35:52 INFO - Cleaning up... 05:35:52 INFO - Return code: 0 05:35:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:35:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:52 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 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:35:52 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 05:35:52 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 05:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:52 INFO - 'HOME': '/Users/cltbld', 05:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:52 INFO - 'LOGNAME': 'cltbld', 05:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:52 INFO - 'MOZ_NO_REMOTE': '1', 05:35:52 INFO - 'NO_EM_RESTART': '1', 05:35:52 INFO - 'PAGER': '/bin/cat', 05:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:52 INFO - 'PWD': '/builds/slave/test', 05:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:52 INFO - 'SHELL': '/bin/bash', 05:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:35:52 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:52 INFO - 'USER': 'cltbld', 05:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:52 INFO - 'XPC_FLAGS': '0x0', 05:35:52 INFO - 'XPC_SERVICE_NAME': '0', 05:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:52 INFO - Downloading/unpacking jsonschema==2.5.1 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:55 INFO - warning: no files found matching '*.txt' 05:35:55 INFO - no previously-included directories found matching 'build' 05:35:55 INFO - no previously-included directories found matching 'dist' 05:35:55 INFO - no previously-included directories found matching '.git*' 05:35:55 INFO - Installing collected packages: jsonschema, functools32 05:35:55 INFO - Running setup.py install for functools32 05:35:55 INFO - warning: no files found matching '*.txt' 05:35:55 INFO - no previously-included directories found matching 'build' 05:35:55 INFO - no previously-included directories found matching 'dist' 05:35:55 INFO - no previously-included directories found matching '.git*' 05:35:55 INFO - Successfully installed jsonschema functools32 05:35:55 INFO - Cleaning up... 05:35:55 INFO - Return code: 0 05:35:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:55 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 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:35:55 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 05:35:55 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 05:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:55 INFO - 'HOME': '/Users/cltbld', 05:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:55 INFO - 'LOGNAME': 'cltbld', 05:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:55 INFO - 'MOZ_NO_REMOTE': '1', 05:35:55 INFO - 'NO_EM_RESTART': '1', 05:35:55 INFO - 'PAGER': '/bin/cat', 05:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:55 INFO - 'PWD': '/builds/slave/test', 05:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:55 INFO - 'SHELL': '/bin/bash', 05:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:35:55 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:55 INFO - 'USER': 'cltbld', 05:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:55 INFO - 'XPC_FLAGS': '0x0', 05:35:55 INFO - 'XPC_SERVICE_NAME': '0', 05:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:56 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 05:35:56 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 05:35:56 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 05:35:56 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 05:35:56 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 05:35:56 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 05:35:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:35:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 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 05:35:59 INFO - Downloading docopt-0.6.1.tar.gz 05:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:59 INFO - Running setup.py install for blobuploader 05:36:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:00 INFO - Running setup.py install for requests 05:36:00 INFO - Running setup.py install for docopt 05:36:00 INFO - Successfully installed blobuploader requests docopt 05:36:00 INFO - Cleaning up... 05:36:00 INFO - Return code: 0 05:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:00 INFO - 'HOME': '/Users/cltbld', 05:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:00 INFO - 'LOGNAME': 'cltbld', 05:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:00 INFO - 'MOZ_NO_REMOTE': '1', 05:36:00 INFO - 'NO_EM_RESTART': '1', 05:36:00 INFO - 'PAGER': '/bin/cat', 05:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:00 INFO - 'PWD': '/builds/slave/test', 05:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:00 INFO - 'SHELL': '/bin/bash', 05:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:36:00 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:00 INFO - 'USER': 'cltbld', 05:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:00 INFO - 'XPC_FLAGS': '0x0', 05:36:00 INFO - 'XPC_SERVICE_NAME': '0', 05:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5Wg2WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-wERqA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-RULT1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ErCx11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-l2IfYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-KLwCak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-EBMzEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-inNjXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:01 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5vZCTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Xb6XYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-UDJLgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-inTQKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-FG9BrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-S64QXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-dAbQpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5GwmaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-hl6quH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:02 INFO - Running setup.py install for manifestparser 05:36:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:03 INFO - Running setup.py install for mozcrash 05:36:03 INFO - Running setup.py install for mozdebug 05:36:03 INFO - Running setup.py install for mozdevice 05:36:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:03 INFO - Running setup.py install for mozfile 05:36:03 INFO - Running setup.py install for mozhttpd 05:36:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:03 INFO - Running setup.py install for mozinfo 05:36:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:03 INFO - Running setup.py install for mozInstall 05:36:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Running setup.py install for mozleak 05:36:04 INFO - Running setup.py install for mozlog 05:36:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Running setup.py install for moznetwork 05:36:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Running setup.py install for mozprocess 05:36:04 INFO - Running setup.py install for mozprofile 05:36:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:04 INFO - Running setup.py install for mozrunner 05:36:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:05 INFO - Running setup.py install for mozscreenshot 05:36:05 INFO - Running setup.py install for moztest 05:36:05 INFO - Running setup.py install for mozversion 05:36:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:05 INFO - Cleaning up... 05:36:05 INFO - Return code: 0 05:36:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:05 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 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:36:05 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 05:36:05 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 05:36:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:36:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:05 INFO - 'HOME': '/Users/cltbld', 05:36:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:05 INFO - 'LOGNAME': 'cltbld', 05:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:05 INFO - 'MOZ_NO_REMOTE': '1', 05:36:05 INFO - 'NO_EM_RESTART': '1', 05:36:05 INFO - 'PAGER': '/bin/cat', 05:36:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:05 INFO - 'PWD': '/builds/slave/test', 05:36:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:05 INFO - 'SHELL': '/bin/bash', 05:36:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:36:05 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:36:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:05 INFO - 'USER': 'cltbld', 05:36:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:05 INFO - 'XPC_FLAGS': '0x0', 05:36:05 INFO - 'XPC_SERVICE_NAME': '0', 05:36:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:05 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-F4lIKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:05 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-r08sud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:05 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)) 05:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:05 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ztLvfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-fWslOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-dJPYdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5TgoCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-B8WL37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-tCdIAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-KnWnCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-MSRWSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-wMKL1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-zYlobY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5DU0ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-NYAPj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ahSVnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-D6UMQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-S7481i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:07 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)) 05:36:07 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)) 05:36:07 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)) 05:36:07 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)) 05:36:07 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)) 05:36:07 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)) 05:36:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:09 INFO - Downloading blessings-1.6.tar.gz 05:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:10 INFO - Installing collected packages: blessings 05:36:10 INFO - Running setup.py install for blessings 05:36:10 INFO - Successfully installed blessings 05:36:10 INFO - Cleaning up... 05:36:10 INFO - Return code: 0 05:36:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:10 INFO - Reading from file tmpfile_stdout 05:36:10 INFO - Current package versions: 05:36:10 INFO - blessings == 1.6 05:36:10 INFO - blobuploader == 1.2.4 05:36:10 INFO - docopt == 0.6.1 05:36:10 INFO - functools32 == 3.2.3-2 05:36:10 INFO - jsonschema == 2.5.1 05:36:10 INFO - manifestparser == 1.1 05:36:10 INFO - mozInstall == 1.12 05:36:10 INFO - mozcrash == 0.17 05:36:10 INFO - mozdebug == 0.1 05:36:10 INFO - mozdevice == 0.48 05:36:10 INFO - mozfile == 1.2 05:36:10 INFO - mozhttpd == 0.7 05:36:10 INFO - mozinfo == 0.9 05:36:10 INFO - mozleak == 0.1 05:36:10 INFO - mozlog == 3.3 05:36:10 INFO - moznetwork == 0.27 05:36:10 INFO - mozprocess == 0.23 05:36:10 INFO - mozprofile == 0.28 05:36:10 INFO - mozrunner == 6.12 05:36:10 INFO - mozscreenshot == 0.1 05:36:10 INFO - mozsystemmonitor == 0.3 05:36:10 INFO - moztest == 0.7 05:36:10 INFO - mozversion == 1.4 05:36:10 INFO - psutil == 3.1.1 05:36:10 INFO - requests == 1.2.3 05:36:10 INFO - wsgiref == 0.1.2 05:36:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:36:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:10 INFO - 'HOME': '/Users/cltbld', 05:36:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:10 INFO - 'LOGNAME': 'cltbld', 05:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:10 INFO - 'MOZ_NO_REMOTE': '1', 05:36:10 INFO - 'NO_EM_RESTART': '1', 05:36:10 INFO - 'PAGER': '/bin/cat', 05:36:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:10 INFO - 'PWD': '/builds/slave/test', 05:36:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:10 INFO - 'SHELL': '/bin/bash', 05:36:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:36:10 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:36:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:10 INFO - 'USER': 'cltbld', 05:36:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:10 INFO - 'XPC_FLAGS': '0x0', 05:36:10 INFO - 'XPC_SERVICE_NAME': '0', 05:36:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:36:10 INFO - Cleaning up... 05:36:10 INFO - Return code: 0 05:36:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea54618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cac9ef00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, '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.t3tjyKyiGP/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.stynC5RunH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 05:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:36:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:36:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:10 INFO - 'HOME': '/Users/cltbld', 05:36:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:10 INFO - 'LOGNAME': 'cltbld', 05:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:10 INFO - 'MOZ_NO_REMOTE': '1', 05:36:10 INFO - 'NO_EM_RESTART': '1', 05:36:10 INFO - 'PAGER': '/bin/cat', 05:36:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:10 INFO - 'PWD': '/builds/slave/test', 05:36:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:10 INFO - 'SHELL': '/bin/bash', 05:36:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:36:10 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:36:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:10 INFO - 'USER': 'cltbld', 05:36:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:10 INFO - 'XPC_FLAGS': '0x0', 05:36:10 INFO - 'XPC_SERVICE_NAME': '0', 05:36:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:36:11 INFO - Cleaning up... 05:36:11 INFO - Return code: 0 05:36:11 INFO - Running post-action listener: _resource_record_post_action 05:36:11 INFO - Running post-action listener: _start_resource_monitoring 05:36:11 INFO - Starting resource monitoring. 05:36:11 INFO - [mozharness: 2016-07-21 12:36:11.258994Z] Finished create-virtualenv step (success) 05:36:11 INFO - [mozharness: 2016-07-21 12:36:11.259919Z] Running install step. 05:36:11 INFO - Running pre-action listener: _resource_record_pre_action 05:36:11 INFO - Running main action method: install 05:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Output received: 05:36:11 INFO - Usage: mozinstall [options] installer 05:36:11 INFO - Options: 05:36:11 INFO - -h, --help show this help message and exit 05:36:11 INFO - -d DEST, --destination=DEST 05:36:11 INFO - Directory to install application into. [default: 05:36:11 INFO - "/builds/slave/test"] 05:36:11 INFO - --app=APP Application being installed. [default: firefox] 05:36:11 INFO - mkdir: /builds/slave/test/build/application 05:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:36:47 INFO - Reading from file tmpfile_stdout 05:36:47 INFO - Output received: 05:36:47 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:36:47 INFO - Running post-action listener: _resource_record_post_action 05:36:47 INFO - [mozharness: 2016-07-21 12:36:47.118037Z] Finished install step (success) 05:36:47 INFO - [mozharness: 2016-07-21 12:36:47.118190Z] Running run-tests step. 05:36:47 INFO - Running pre-action listener: _resource_record_pre_action 05:36:47 INFO - Running main action method: run_tests 05:36:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:47 INFO - 2016-07-21 05:36:47.133 screenresolution[1646:8392] starting screenresolution argv=screenresolution get 05:36:47 INFO - 2016-07-21 05:36:47.135 screenresolution[1646:8392] Display 0: 1600x1200x32@60 05:36:47 INFO - 2016-07-21 05:36:47.142 screenresolution[1647:8394] starting screenresolution argv=screenresolution list 05:36:47 INFO - Available Modes on Display 0 05:36:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:47 INFO - Intel Iris: 05:36:47 INFO - Chipset Model: Intel Iris 05:36:47 INFO - Type: GPU 05:36:47 INFO - Bus: Built-In 05:36:47 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:47 INFO - Vendor: Intel (0x8086) 05:36:47 INFO - Device ID: 0x0a2e 05:36:47 INFO - Revision ID: 0x0009 05:36:47 INFO - Displays: 05:36:47 INFO - Display: 05:36:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:47 INFO - Display Serial Number: 1600x1200 60 05:36:47 INFO - Main Display: Yes 05:36:47 INFO - Mirror: Off 05:36:47 INFO - Online: Yes 05:36:47 INFO - Rotation: Supported 05:36:47 INFO - Return code: 0 05:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:47 INFO - Python 2.7.3 05:36:47 INFO - Return code: 0 05:36:47 INFO - grabbing minidump binary from tooltool 05:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:47 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 0x10e923d30>, '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 0x10e688db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e91bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:47 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 05:36:47 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 05:36:47 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 05:36:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:47 INFO - Return code: 0 05:36:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:36:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:36:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:47 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/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 05:36:47 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/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0039 --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 05:36:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3tjyKyiGP/Render', 05:36:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:47 INFO - 'HOME': '/Users/cltbld', 05:36:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:47 INFO - 'LOGNAME': 'cltbld', 05:36:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:47 INFO - 'MOZ_NO_REMOTE': '1', 05:36:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:47 INFO - 'NO_EM_RESTART': '1', 05:36:47 INFO - 'PAGER': '/bin/cat', 05:36:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:47 INFO - 'PWD': '/builds/slave/test', 05:36:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:47 INFO - 'SHELL': '/bin/bash', 05:36:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.stynC5RunH/Listeners', 05:36:47 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 05:36:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:47 INFO - 'USER': 'cltbld', 05:36:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:47 INFO - 'XPC_FLAGS': '0x0', 05:36:47 INFO - 'XPC_SERVICE_NAME': '0', 05:36:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:47 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/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 05:36:47 INFO - mozversion application_buildid: 20160721030216 05:36:47 INFO - mozversion application_changeset: d224fc999cb6accb208af0a105f14433375e2e77 05:36:47 INFO - mozversion application_display_name: Nightly 05:36:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:47 INFO - mozversion application_name: Firefox 05:36:47 INFO - mozversion application_remotingname: firefox 05:36:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:36:47 INFO - mozversion application_vendor: Mozilla 05:36:47 INFO - mozversion application_version: 50.0a1 05:36:47 INFO - mozversion platform_buildid: 20160721030216 05:36:47 INFO - mozversion platform_changeset: d224fc999cb6accb208af0a105f14433375e2e77 05:36:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:36:47 INFO - mozversion platform_version: 50.0a1 05:36:47 INFO - using testdate: 1469104607 05:36:47 INFO - actual date: 1469104607 05:36:47 INFO - starting webserver on 'localhost:49272' 05:36:47 INFO - SUITE-START | Running 2 tests 05:36:47 INFO - TEST-START | dromaeo_css 05:36:47 INFO - operating with platform_type : mac_ 05:36:47 INFO - Initialising browser for dromaeo_css test... 05:36:47 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmp9mrD5k/profile http://localhost:49272/getInfo.html) 05:36:51 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:36:51 INFO - PROCESS | 1657 | colorDepth:24 05:36:51 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:36:51 INFO - PROCESS | 1657 | __metrics 05:36:51 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:36:51 INFO - TEST-INFO | 1657: exit 0 05:36:51 INFO - Browser initialized. 05:36:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:51 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmp9mrD5k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:03 INFO - PROCESS | 1662 | RSS: Main: 254902272 05:37:03 INFO - PROCESS | 1662 | 05:37:53 INFO - PROCESS | 1662 | 1469104673476 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] 05:40:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:40:07 INFO - PROCESS | 1662 | RSS: Main: 267259904 05:40:07 INFO - PROCESS | 1662 | 05:43:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:43:10 INFO - PROCESS | 1662 | RSS: Main: 275931136 05:43:10 INFO - PROCESS | 1662 | 05:46:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:46:12 INFO - PROCESS | 1662 | RSS: Main: 280440832 05:46:12 INFO - PROCESS | 1662 | 05:49:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:49:15 INFO - PROCESS | 1662 | RSS: Main: 280141824 05:49:15 INFO - PROCESS | 1662 | 05:52:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:52:18 INFO - PROCESS | 1662 | RSS: Main: 283389952 05:52:18 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:55:21 INFO - PROCESS | 1662 | RSS: Main: 283430912 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | __start_tp_report 05:55:21 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:55:21 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:55:21 INFO - PROCESS | 1662 | |i|pagename|runs| 05:55:21 INFO - PROCESS | 1662 | |0;dojo.html;3191.297914458819;3434.536337594424;3459.2389674271653;3473.7742046766957;3484.825758712065;5957.255343082109;6004.249468816398;6023.909641355383;6052.788152414666;6075.088736689493;5726.284214473191;5749.856253593663;5791.623544469617;5886.969780288443;5983.700814959257;5271.841844744664;5334.893302133955;5429.782808687648;5437.537809286196;5480.91778623321;5395.244665746799;5418.593605479585;5475.4524547545125;5521.978433989705;5527.889442211153;5081.822136225214;5333.040052790496;5397.055515284809;5419.403865574804;5453.64551304164;5409.999150157194;5425.430329815352;5427;5442.156465747816;5453.045716999549;5358.571314294847;5369.114096174127;5426.077566813651;5445.1832225166145;5453.727313634303;4436.889077773049;5795.391483894173;5856.297244330665;5919.911201331984;6028.487578555828;6239.251289845248;6267.2479302484;6304.432601065881;6308.179936608258;6314.210723659543;6349.2698339690605;6363.459105975998;6368.426841584233;6395.456386207178;6412.839679008062;5925.259342582177;6026.276846778414;6101.0848372744;6115.602485838406;6145.371476558716;6494.870102598016;6500.414962653384;6512.511561632897;6515.446187074152;6523.18460192476;6207.6275423474735;6226.159468471698;6284.717187726564;6311.684415779193;6316.747330106744;6202.596831206048;6294.527910406738;6294.874102517924;6310.905336419957;6415.903761443582;6189.783357582553;6284.874302514016;6285.654289014056;6290.528210384239;6295.559310848288;4791.784369703371;5918.171455996164;6295.905561416583;6316.210473690789;6325.114483972247;5004.724740139327;5074.949250507521;5083.491650834961;5083.847484575469;5129.743512824344;3822.50307460034;4584.129015487113;4597.816087356468;4619.122366750306;4644.373009643722;6012.969935150296;6092.238470191226;6096.3903609639565;6106.755729770848;6109.175261339751;6166.691665416712;6265.8746825063245;6369.45859601939;6394.680265986682;6402.775902843378;6099.218990344071;6101.47943246205;6112.716259964539;6126.356732543108;6131.529590167202;5623.803166889221;5627.6904770237215;5630.60585758993;5641;5652.8869422611315;6321.241451025906;6436.967815160894;6474.805755827333;6552.213734351908;6572.474202063823;6395.776147834804;6411.807645770635;6429.7749578764515;6450.645214513247;6456.999165129412;6516.2180538333805;6551.082848401133;6580.670966451754;6584.144061272004;6602.240742314695;6190.752369905334;6215.12988181664;6241.78153764616;6351.523635727432;6351.904721429275;6296.968515157395;6319.46284565817;6332.556721029484;6336.58812177207;6374.298827129105;6196.845078873064;6233.345498722569;6266.248050234001;6269.404406581368;6294.433500984934;5528.391876893458;6142.600730952474;6220.440160385587;6226.719797609027;6268.874622507616;6132.724027418688;6132.998044146438;6148.78479253224;6209.627422354673;6225.595336303126;5716.685162412585;5750.30996280449;6295.401936815995;6300.991841305369;6306.46395056407;6054.576179667381;6133.2428548619655;6184;6213.2233470816145;6240.625562466266 05:55:21 INFO - PROCESS | 1662 | |1;ext.html;460.87095613228286;528.3712382265104;546.9371022332431;562.0136660161418;573.6386076771633;37940.81029594852;40121.39817902727;40189;40221;40230.994225144386;41475.17049659005;41797;41878.16243675125;41887.79056104715;41920.790396047974;9588.137067663927;9773.120419162275;9776.071273229032;9785.461799601018;9801.264905132108;9525;9610;9614.471204083773;9629.988851170632;9640.951795241013;9569.473678947656;9619.759506012335;9656.71029869105;9659.855102173473;9686.031396860328;9491.288153388488;9545.90454095457;9570.234381249518;9601.327907046509;9627.133557979816;9289.953550232272;9419.858702119474;9464.621415143454;9477.099675530813;9489.90510094897;39077.60922390768;39380.80309598434;39514.802425987975;39719.8014009931;39740.80129599333;3083.1521331633758;3333.3666603345287;3346.916327091818;3460.4046964776417;3529.8411571479087;25606.74393256062;28580.571291430646;29913.25216869574;30073;30431.847840760875;2782.3044238940265;3095;3100.7364374028234;3109.860056297472;3226.58054452922;407332;419250;422257.88871055754;426634;427865;32818.85134020298;33078;33104;33161;33178.668213318044;33984.830075849466;34011.97964061082;34060.82969585136;35092.473612895825;35120.64879351225;16491.91754041222;16625.7506137408;16652.91673541649;16672.083035432926;16699.9145055571;12727.745445091232;12839.935800320938;12846.100772945803;12855.871441285655;12882.67793305175;19220.231190752493;19272.710909336372;19291.035448227532;19292.517687057654;19320.903395482932;8151.470154439942;8244.134365891616;8246.958765206256;8267.338612910953;8316.667333306721;888.6667499687617;918.1094338491653;956.7034219392011;1041.1202533858877;1044.3420644993605;24185.79551700365;30089;30127.54808677828;30388.24029399283;30869.929902342832;1035.1977217656226;1048.3290693955873;1069.04320633033;1085.7122862441458;1107.7230692326918;15234.238288085551;15372.769408458882;15621.921890390702;15807.13060781645;15975.440859570092;712040;718246;720704.7929520742;720941;722316;58323;58440.707796460745;58724.41275587275;58920.705396472746;59194.704026479594;1394.3655636685285;1409.3728290910651;1429.0711037825497;1436.2029073863896;1440.992795036039;30227.697723022487;30993;31304;31848.840755796075;32356.35287294288;56338.718306408206;56914;57108;57123;57136.85747283773;641504;646942;647281;647838;647949.0410191675;42756.78621606872;43626;43687.78156109199;44100;44122.67631971046;46844.7657761709;47700.522994770996;48114;48209.75895120502;48765;32565;37976;39661.405078923264;40974.79512602418;41136;39497.80251098726;39728.80135599303;40254.79235622936;40265.72708652064;41292.79353603213;37911.43132852954;38471.230575388894;38876.22247554977;38902.610973889896;39141;34306.828465857514;34536.309273814884;35238.82380588183;35541.64458355383;36009.45985810267;25919.481610368064;25936.481270374108;25986.570738609556;26331.736682633695;26400.339991500365 05:55:21 INFO - PROCESS | 1662 | |2;jquery.html;365.51751687772133;371.5077522282975;381.6298190754967;386.9129445874677;399.1537939568114;19440.611187776252;20287.797122028776;21507.569848603038;21836.563268734637;21959.121635134576;10233.488325583729;10489.16086713063;11815.70460738482;11846.348450835201;12181.269123852575;4672.462666793328;4789.664723469358;5074.67014644047;5285.735713214333;5507.531859791922;3908.394198899175;5453.563714902798;5505.917411238835;5970.611910225822;6282.591631543958;6275.2783429905685;6285.402886725777;6304.432601065903;6311.179546658928;6321.431071203614;5058.974705126488;6090.025595904634;6182.072689096649;6226.283977342596;6252.812415627538;5156.639035267533;5863.8534036649;5906.493844069735;5907.320658124328;5909.4090590941;12920.22478651284;13284.933575332157;13320.800187997187;13323.86676133236;16505.504834854855;2235.3182279404773;2287.176616418088;2515.8113141514277;2903.2306438793735;2938.6473623165143;8176.591170441454;9570.042995700374;9730.805383892282;10152.289339746221;10166.644167454104;1490.9776353354707;1733.0554847608084;1797.694391953371;1808.9909550452296;1871.1299245850744;112860.43569782181;122787;125172.37413812873;125907;127596;9248.491332976617;11579.826302605468;11733;11740.765184696429;11948.283103013848;14435.927820361041;14579.927100364643;14603.97772155939;14643.194624295553;14644.341004654816;8263.586820659064;8409.369297302726;8532.914670853212;8665.220130188314;8704.04255531891;8447.619857106445;8454.112318206622;8477.576121193915;8602.78493037679;8630.136986301446;3666.6699996999864;4485.372047913294;4547.681662283609;4616.561426664462;4646.83736069236;1584.5008822220964;1639.737641977278;1672.5400514858268;1887.8955810850532;1952.0825212150266;818.2390376949376;932.1005229952992;990.6186118344489;997.3915911294105;1027.8509616105623;18486.445406637824;21794.01926913293;22144.446388840086;22165.335039948826;22523;925.1072714830221;944.9244060475146;950.9809803803885;958.8609651600618;989.6189966862665;8812;9743.658971935949;11643.53425862956;11695.532178712927;11718.648440546796;572347;578839;610347;612466.9376653088;621555;99992;133169;136256;136589;141411.29294353668;1002.3735165521549;1009.7728011197422;1012.8328825743818;1017.867677201959;1028.28534168752;18951.241950322383;19360.61278774445;19535.609287814448;19559.70660440123;19877.60244795125;52658.473415265355;53044.73477632587;55215.447845521034;56317.15524267221;56426;54967;81389;81510;82352;83808;7143.964280178566;7191.101112360955;7285.854282914206;7307.5980821055355;7342.265773422615;10230.437325947145;12026.579069732867;12169.756604868031;12306.876931230574;12441.751164976831;10568.471576421302;10625.25623206368;10669.46652667379;10682.32941764559;10785.676429707122;10296.845547316647;10406.687799366031;10449.529771160469;10492.527836247235;10607.151427885596;10580.15358771312;10614.522346494581;10639.89360106389;10663.520141593803;11006.944965275123;7049.224585295716;7193.928060719535;7208.855822883408;7308.744193953186;7419.517731347445;10540;10623;10714.357138571711;10797.29817561856;10925 05:55:21 INFO - PROCESS | 1662 | |3;mootools.html;1544.5289186798025;1584.049570257845;1806.3316572868032;1893.3184053740652;1894.176033425461;7984.800379990488;8450.450720703166;8615.483071015735;9096.45421274724;9115.635374585017;8437.451565648229;8646.91353086469;8739.300855931526;8751.956240218806;8760.737177884657;2316.6293393057113;2342.3207269891795;2360.303710405426;2368.27767530903;2371.1345358944036;2321.0599707118645;2331.5803155432013;2367.8934447949796;2370.182287110944;2379.92860214193;2322.4774425754154;2325.813934885205;2340.438294809242;2348.236823032513;2352.9647055294186;2318.420394901275;2326.988365058181;2327.185485080217;2335.5795956727784;2349.483113714997;1933.8452923766206;2252.1441852096264;2256.379495638696;2263.2983775029793;2267.2858049714287;8683.913160868373;8728;8733;8739.825203495959;8787.384883058188;5165.147750621143;5273.129933560957;5293.417724050351;5299.072662284085;5325.973370133163;3438.1232785639754;3510.8420121094614;3596.532450781408;3627.147620309225;3630.7276954228537;1048.1186270644212;1076.4563895232857;1087.3638921231088;1098.8901209778182;1100.3892839474088;10192.59229630814;11403.885961140448;11483.598074067451;11585.304881707125;11615.709607259801;4536.274196128604;4556.476005259371;4782.665213435026;4789.712617242976;4791.377120974251;10048.447335396477;10061.949690251502;10068.848967265498;10071.5467803949;10077;5309.309789727388;5333.839984800462;5338.199270109437;5344.091504444176;5409.24270602116;3994.6804255659476;4389.758563279051;4853.830115945995;4874.731889746027;4899.877503062381;3852.114013776791;3929.9803500982885;3950.1309711863346;3993.2213218422708;4022.8189731462153;1267.7781388257017;1294.4757373263844;1296.922184668904;1297.7988411796186;1321.253491777162;816.8243827577099;844.2317491083207;899.2581120575551;929.7210836748948;994.16986816008;5678.943210567924;5847.853803654943;5905.616134951214;6147.415995480422;6236.532260080512;417.4823219208221;437.31996745061736;440.47583375782716;442.89370551068157;447.7403106198397;3660.670539651444;4051.918961620751;4170.895727606834;4174.979125104355;4218.873433796991;10293.485325733684;10482.318649287772;10609.681709548726;10710.143188545053;10714.142868570496;10406.219533534864;10567.101796347242;10605.734856628646;10659.4137322448;10697.304675196086;8106.189381061965;8118.188181181953;8170.714025009096;8226.341892648694;8256.1331060239;5831.446012628793;6002.729877155626;6076.90884636722;6076.939230607637;6124.724387402489;9914.950425247827;9917.107460328605;9921.553530091307;9927;9986;9044;9910.554025068745;10102.24233182529;10144.49277536135;10179.643712470028;6971.721131154697;7386.0767404074495;7416.221296763762;7550.697972081055;7619.771406857803;8480.703175389079;8482.660693572188;8561;8566;8572.27135693473;7265.273472652692;7487.962560187164;7608.31525162738;7651.617419129133;7718.807029824075;7213.531120477152;7355.338019578049;7372.115346158495;7446.962765186356;7498.212687667717;6939.722411103499;6952.0267162596265;6995.96502017507;7014.824629384102;7033.507654464139;4974.527419895104;4982.252662100569;5003.399592048978;5101.69389836611;5212.843614691566;5043.218301163325;5092.567131793839;5192.5586325162785;5201.505856943584;5249.186376111708 05:55:21 INFO - PROCESS | 1662 | |4;prototype.html;300.37222205590325;303.5037713338691;313.58763226357337;315.38185157092096;316.12275934282377;5463.415609473258;5646;5732.5987180897355;5857.41425857414;5874.9118763218585;5668.036433806253;5723.170140329649;5728.971355143219;5732.0828667413225;5774.913376299359;3282.7045565899066;4258.849281113034;4341.479022517302;4349.891252718691;4395.648348132142;4046.3525835866267;4269.957300426987;4274.5084315303675;4360.36774667673;4390.319500477431;3855;4236.04688944988;4263.147370525891;4269.118345117049;4274.914501709964;3565.928681426357;3907.960920390788;4149.6265336119595;4241.236577416079;4276.679249056333;3108.4404807134706;3553.8450003748626;3696.168362118502;3698.6671199592165;3708.8145592720525;5518.724063796834;5527.668339899619;5554.278633315688;5580.720963951827;5590.462622778728;4308.319755295437;4332.981749288914;4921.434035085975;4922;4938.234573641092;5713.971430142864;5729.28383952006;6033.245844269466;6083.836405069339;6102.237220347457;4021.8135649983324;4026.832218656586;4035.556088830226;4038.6970977176534;4067.593240675909;5808.415255211433;5927.347991720907;6306.621602703806;6447.4197322241225;6459.709313080875;3332.6500717424806;3784.972022382083;4087.5912408758886;4123.690723195772;4126.442930204444;4106.3635136553885;4129.91740165201;4142.855000074983;4152.190322887008;4157;4900.828471003498;4909.975450122726;4918.827841025547;4920.975395123001;4921.261810728348;5833.854153646193;6089.48239399656;6101.267847858286;6133.478654314434;6207.751689932352;1210.9939450302868;1398.7062716829375;1420.3311109446358;1423.8077859489044;1425.8664361832368;786.6106277392727;836.4061516323356;838.8884727735774;858.5490521019457;867.2151702709058;4523.819047238139;4773.64197685175;4854.2233242681;4866.975665121652;4914.311996320518;4630.976845115821;5351.732413379315;5355.30381050461;5366.490183432567;5378.283966596843;4517.932231016537;4730.758359408713;4839.523945196678;4873.366462359871;4932.7421507515355;2450.901963921423;2805.9236165237576;2828.561572956195;2839.929001774972;2848.928776780597;5136.8715782105;5284.309021113284;5522.834314970557;5553.361363443256;5557.638378597269;5062.974685126551;5457.399686034533;5474.562035037267;5518.972405137949;5546.362168350692;4884.5603895649565;5337.332833395748;5360.812371566976;5448.591355648342;5490.56075513958;4602.7008244464005;5022.4977502249485;5348.331458567679;5379.865503362291;5422.945770542244;4795.592374648194;5244.977229440375;6244.125822384779;6295.905561416491;6332.271788744353;6063.818085457443;6627.436667883091;6631.966840165768;6645.734170633121;6653.900191497229;3876.786776727307;3957.713743033468;4019.0354314964784;4113.91772164549;4133.152703695675;6262.937370626236;6280.074953154279;6302.71637776292;6317.30509643948;6363.490920726238;5729.885402292014;6148.354422785543;6152.477039451696;6175.536834737502;6176.35148309421;5240.580753539632;5480.369757477941;5967.76128954837;6051.788187413419;6129.693515324305;5524.779008839601;5710.971445142748;5881.264841894763;6001.519878409629;6084.14821924922;5321.962217367731;5830.591858569859;6094.786682466092;6113.23584551931;6126.571140020156;5987.868370824118;6000.5898613826585;6003.969980150071;6016.4885984690045;6024.518038556993 05:55:21 INFO - PROCESS | 1662 | |5;yui.html;720.5352547606793;739.4454159380465;790.1150711203453;843.7721815109917;849.885265489159;15001.924990375046;15531.611709707264;15638.374465021414;15692.686146277068;15710.842891571081;14340.641483962907;14475.565733028;14485.782713259283;14509.274536273197;14517.20155391453;679.079846807576;832.8792325112855;841.5371545649899;869.5130726792985;870.8954925408959;860.9612567434481;866.8049688819997;874.6807415293404;876.3514998900799;879.8020445399798;929.4562680831722;933.1927882381725;935.4434111703525;936.1574582875398;936.9484678342689;924.1082355526949;924.8011677489338;924.8843894513186;925.9212966897821;928.4614923344444;689.3657834792003;691.7924622613247;692.3388164303129;693.3170826735661;693.3724978894058;14953.775693364609;14978.925105374512;14980.925095374454;15005.924970375187;15014.174220417983;14531.418743250257;14584.781228281585;14606.853931460655;14675.339609717588;14722.705545889023;11822.231554948901;11946.761064778655;12017.459214335377;12123.818142727867;12397;3887.378019516864;4035.3341698619693;4049.4735684360844;4077.368007958771;4078.0008897819926;106304;109314;109927;110266;110933;11188.944055279671;11245.325280483197;11440.713982150513;11718.70703232426;11879.10906681985;19325.226990920488;21139.365819025454;21256.36230913075;21675.566488670138;23426.297211083696;8039.638216280281;8130.674773009014;8195.590220488952;8296.170382961776;8386.287165590871;4207.179599978036;4257.276263035292;4304.182205380967;4399.560043995575;4430.069685366109;3407.1822762536813;3531.770434921722;3558.7864728116397;3560.64393560647;3563.127033876665;591.6450129922098;658.8517583543664;666.8899631560738;667.1893649216225;674.9898751518731;564.6865989375854;597.9910301345483;605.8485378655337;616.6793267500874;661.7525963558727;8774.95612521946;8875.822483550293;9078.137576930181;9103.089691030844;9115.36192466521;594.7085927895387;599.5203836930439;629.6725702634604;640.3276559612389;657.5561495990188;4203;4354.8258069677495;4370.104128653618;4422.159789639958;4470.061287129739;140337;143436;149443;158143;161550;117211.65576688419;120587;125104;132139;136695;90921;116831.83168168379;118705;119489;119689;9277.62889484413;9895.158911492605;9922.553485093333;9966.053224943618;9994.150497207527;55363.44636553583;63611.045834313445;63766.68116659573;65657;66341;97719.55701107529;98356.50821746132;100868;101164;102966.48516757369;13387.514734920844;13391.397387117408;13395.665108372368;13647.087048662672;13743.656408589864;14848.183349915858;15140.772888406462;15144.697106057596;15242.771358429854;15771.44799931997;13868.4452621894;13891.722165556834;13918.791218131533;14286.214258215898;14497.20265385414;13547.661308466973;13802.309884505936;13813.792793108312;13859;14609.853901460849;13482.93258533701;13612.047156698936;13618.727625447635;13662.658433539242;13700.45198192061;9714.174295184988;10541.367517948947;11310.83033754478;11607.709807254549;12235.69410764738;11221.775564488828;11335;11592.19201533233;11603.767924641628;11720.765584688428 05:55:21 INFO - PROCESS | 1662 | __end_tp_report 05:55:21 INFO - PROCESS | 1662 | __start_cc_report 05:55:21 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,458 05:55:21 INFO - PROCESS | 1662 | __end_cc_report 05:55:21 INFO - PROCESS | 1662 | __startTimestamp1469105721466__endTimestamp 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:55:21 INFO - PROCESS | 1662 | Number of tests: 6 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5890.99 Median:6133.24 stddev:667.08 (10.9%) stddev-sans-first:634.62 05:55:21 INFO - PROCESS | 1662 | Values: 3191.3 3434.5 3459.2 3473.8 3484.8 5957.3 6004.2 6023.9 6052.8 6075.1 5726.3 5749.9 5791.6 5887.0 5983.7 5271.8 5334.9 5429.8 5437.5 5480.9 5395.2 5418.6 5475.5 5522.0 5527.9 5081.8 5333.0 5397.1 5419.4 5453.6 5410.0 5425.4 5427.0 5442.2 5453.0 5358.6 5369.1 5426.1 5445.2 5453.7 4436.9 5795.4 5856.3 5919.9 6028.5 6239.3 6267.2 6304.4 6308.2 6314.2 6349.3 6363.5 6368.4 6395.5 6412.8 5925.3 6026.3 6101.1 6115.6 6145.4 6494.9 6500.4 6512.5 6515.4 6523.2 6207.6 6226.2 6284.7 6311.7 6316.7 6202.6 6294.5 6294.9 6310.9 6415.9 6189.8 6284.9 6285.7 6290.5 6295.6 4791.8 5918.2 6295.9 6316.2 6325.1 5004.7 5074.9 5083.5 5083.8 5129.7 3822.5 4584.1 4597.8 4619.1 4644.4 6013.0 6092.2 6096.4 6106.8 6109.2 6166.7 6265.9 6369.5 6394.7 6402.8 6099.2 6101.5 6112.7 6126.4 6131.5 5623.8 5627.7 5630.6 5641.0 5652.9 6321.2 6437.0 6474.8 6552.2 6572.5 6395.8 6411.8 6429.8 6450.6 6457.0 6516.2 6551.1 6580.7 6584.1 6602.2 6190.8 6215.1 6241.8 6351.5 6351.9 6297.0 6319.5 6332.6 6336.6 6374.3 6196.8 6233.3 6266.2 6269.4 6294.4 5528.4 6142.6 6220.4 6226.7 6268.9 6132.7 6133.0 6148.8 6209.6 6225.6 5716.7 5750.3 6295.4 6301.0 6306.5 6054.6 6133.2 6184.0 6213.2 6240.6 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:71681.71 Median:39724.30 stddev:163359.73 (411.2%) stddev-sans-first:163730.48 05:55:21 INFO - PROCESS | 1662 | Values: 460.9 528.4 546.9 562.0 573.6 37940.8 40121.4 40189.0 40221.0 40231.0 41475.2 41797.0 41878.2 41887.8 41920.8 9588.1 9773.1 9776.1 9785.5 9801.3 9525.0 9610.0 9614.5 9630.0 9641.0 9569.5 9619.8 9656.7 9659.9 9686.0 9491.3 9545.9 9570.2 9601.3 9627.1 9290.0 9419.9 9464.6 9477.1 9489.9 39077.6 39380.8 39514.8 39719.8 39740.8 3083.2 3333.4 3346.9 3460.4 3529.8 25606.7 28580.6 29913.3 30073.0 30431.8 2782.3 3095.0 3100.7 3109.9 3226.6 407332.0 419250.0 422257.9 426634.0 427865.0 32818.9 33078.0 33104.0 33161.0 33178.7 33984.8 34012.0 34060.8 35092.5 35120.6 16491.9 16625.8 16652.9 16672.1 16699.9 12727.7 12839.9 12846.1 12855.9 12882.7 19220.2 19272.7 19291.0 19292.5 19320.9 8151.5 8244.1 8247.0 8267.3 8316.7 888.7 918.1 956.7 1041.1 1044.3 24185.8 30089.0 30127.5 30388.2 30869.9 1035.2 1048.3 1069.0 1085.7 1107.7 15234.2 15372.8 15621.9 15807.1 15975.4 712040.0 718246.0 720704.8 720941.0 722316.0 58323.0 58440.7 58724.4 58920.7 59194.7 1394.4 1409.4 1429.1 1436.2 1441.0 30227.7 30993.0 31304.0 31848.8 32356.4 56338.7 56914.0 57108.0 57123.0 57136.9 641504.0 646942.0 647281.0 647838.0 647949.0 42756.8 43626.0 43687.8 44100.0 44122.7 46844.8 47700.5 48114.0 48209.8 48765.0 32565.0 37976.0 39661.4 40974.8 41136.0 39497.8 39728.8 40254.8 40265.7 41292.8 37911.4 38471.2 38876.2 38902.6 39141.0 34306.8 34536.3 35238.8 35541.6 36009.5 25919.5 25936.5 25986.6 26331.7 26400.3 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34565.00 Median:2401.49 stddev:100367.71 (4179.4%) stddev-sans-first:100616.41 05:55:21 INFO - PROCESS | 1662 | Values: 365.5 371.5 381.6 386.9 399.2 19440.6 20287.8 21507.6 21836.6 21959.1 10233.5 10489.2 11815.7 11846.3 12181.3 4672.5 4789.7 5074.7 5285.7 5507.5 3908.4 5453.6 5505.9 5970.6 6282.6 6275.3 6285.4 6304.4 6311.2 6321.4 5059.0 6090.0 6182.1 6226.3 6252.8 5156.6 5863.9 5906.5 5907.3 5909.4 12920.2 13284.9 13320.8 13323.9 16505.5 2235.3 2287.2 2515.8 2903.2 2938.6 8176.6 9570.0 9730.8 10152.3 10166.6 1491.0 1733.1 1797.7 1809.0 1871.1 112860.4 122787.0 125172.4 125907.0 127596.0 9248.5 11579.8 11733.0 11740.8 11948.3 14435.9 14579.9 14604.0 14643.2 14644.3 8263.6 8409.4 8532.9 8665.2 8704.0 8447.6 8454.1 8477.6 8602.8 8630.1 3666.7 4485.4 4547.7 4616.6 4646.8 1584.5 1639.7 1672.5 1887.9 1952.1 818.2 932.1 990.6 997.4 1027.9 18486.4 21794.0 22144.4 22165.3 22523.0 925.1 944.9 951.0 958.9 989.6 8812.0 9743.7 11643.5 11695.5 11718.6 572347.0 578839.0 610347.0 612466.9 621555.0 99992.0 133169.0 136256.0 136589.0 141411.3 1002.4 1009.8 1012.8 1017.9 1028.3 18951.2 19360.6 19535.6 19559.7 19877.6 52658.5 53044.7 55215.4 56317.2 56426.0 54967.0 81389.0 81510.0 82352.0 83808.0 7144.0 7191.1 7285.9 7307.6 7342.3 10230.4 12026.6 12169.8 12306.9 12441.8 10568.5 10625.3 10669.5 10682.3 10785.7 10296.8 10406.7 10449.5 10492.5 10607.2 10580.2 10614.5 10639.9 10663.5 11006.9 7049.2 7193.9 7208.9 7308.7 7419.5 10540.0 10623.0 10714.4 10797.3 10925.0 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5695.65 Median:4864.28 stddev:3187.66 (65.5%) stddev-sans-first:3181.34 05:55:21 INFO - PROCESS | 1662 | Values: 1544.5 1584.0 1806.3 1893.3 1894.2 7984.8 8450.5 8615.5 9096.5 9115.6 8437.5 8646.9 8739.3 8752.0 8760.7 2316.6 2342.3 2360.3 2368.3 2371.1 2321.1 2331.6 2367.9 2370.2 2379.9 2322.5 2325.8 2340.4 2348.2 2353.0 2318.4 2327.0 2327.2 2335.6 2349.5 1933.8 2252.1 2256.4 2263.3 2267.3 8683.9 8728.0 8733.0 8739.8 8787.4 5165.1 5273.1 5293.4 5299.1 5326.0 3438.1 3510.8 3596.5 3627.1 3630.7 1048.1 1076.5 1087.4 1098.9 1100.4 10192.6 11403.9 11483.6 11585.3 11615.7 4536.3 4556.5 4782.7 4789.7 4791.4 10048.4 10061.9 10068.8 10071.5 10077.0 5309.3 5333.8 5338.2 5344.1 5409.2 3994.7 4389.8 4853.8 4874.7 4899.9 3852.1 3930.0 3950.1 3993.2 4022.8 1267.8 1294.5 1296.9 1297.8 1321.3 816.8 844.2 899.3 929.7 994.2 5678.9 5847.9 5905.6 6147.4 6236.5 417.5 437.3 440.5 442.9 447.7 3660.7 4051.9 4170.9 4175.0 4218.9 10293.5 10482.3 10609.7 10710.1 10714.1 10406.2 10567.1 10605.7 10659.4 10697.3 8106.2 8118.2 8170.7 8226.3 8256.1 5831.4 6002.7 6076.9 6076.9 6124.7 9915.0 9917.1 9921.6 9927.0 9986.0 9044.0 9910.6 10102.2 10144.5 10179.6 6971.7 7386.1 7416.2 7550.7 7619.8 8480.7 8482.7 8561.0 8566.0 8572.3 7265.3 7488.0 7608.3 7651.6 7718.8 7213.5 7355.3 7372.1 7447.0 7498.2 6939.7 6952.0 6996.0 7014.8 7033.5 4974.5 4982.3 5003.4 5101.7 5212.8 5043.2 5092.6 5192.6 5201.5 5249.2 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4738.38 Median:5329.65 stddev:1495.86 (28.1%) stddev-sans-first:1462.50 05:55:21 INFO - PROCESS | 1662 | Values: 300.4 303.5 313.6 315.4 316.1 5463.4 5646.0 5732.6 5857.4 5874.9 5668.0 5723.2 5729.0 5732.1 5774.9 3282.7 4258.8 4341.5 4349.9 4395.6 4046.4 4270.0 4274.5 4360.4 4390.3 3855.0 4236.0 4263.1 4269.1 4274.9 3565.9 3908.0 4149.6 4241.2 4276.7 3108.4 3553.8 3696.2 3698.7 3708.8 5518.7 5527.7 5554.3 5580.7 5590.5 4308.3 4333.0 4921.4 4922.0 4938.2 5714.0 5729.3 6033.2 6083.8 6102.2 4021.8 4026.8 4035.6 4038.7 4067.6 5808.4 5927.3 6306.6 6447.4 6459.7 3332.7 3785.0 4087.6 4123.7 4126.4 4106.4 4129.9 4142.9 4152.2 4157.0 4900.8 4910.0 4918.8 4921.0 4921.3 5833.9 6089.5 6101.3 6133.5 6207.8 1211.0 1398.7 1420.3 1423.8 1425.9 786.6 836.4 838.9 858.5 867.2 4523.8 4773.6 4854.2 4867.0 4914.3 4631.0 5351.7 5355.3 5366.5 5378.3 4517.9 4730.8 4839.5 4873.4 4932.7 2450.9 2805.9 2828.6 2839.9 2848.9 5136.9 5284.3 5522.8 5553.4 5557.6 5063.0 5457.4 5474.6 5519.0 5546.4 4884.6 5337.3 5360.8 5448.6 5490.6 4602.7 5022.5 5348.3 5379.9 5422.9 4795.6 5245.0 6244.1 6295.9 6332.3 6063.8 6627.4 6632.0 6645.7 6653.9 3876.8 3957.7 4019.0 4113.9 4133.2 6262.9 6280.1 6302.7 6317.3 6363.5 5729.9 6148.4 6152.5 6175.5 6176.4 5240.6 5480.4 5967.8 6051.8 6129.7 5524.8 5711.0 5881.3 6001.5 6084.1 5322.0 5830.6 6094.8 6113.2 6126.6 5987.9 6000.6 6004.0 6016.5 6024.5 05:55:21 INFO - PROCESS | 1662 | 05:55:21 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25283.18 Median:13416.74 stddev:40195.20 (299.6%) stddev-sans-first:40265.65 05:55:21 INFO - PROCESS | 1662 | Values: 720.5 739.4 790.1 843.8 849.9 15001.9 15531.6 15638.4 15692.7 15710.8 14340.6 14475.6 14485.8 14509.3 14517.2 679.1 832.9 841.5 869.5 870.9 861.0 866.8 874.7 876.4 879.8 929.5 933.2 935.4 936.2 936.9 924.1 924.8 924.9 925.9 928.5 689.4 691.8 692.3 693.3 693.4 14953.8 14978.9 14980.9 15005.9 15014.2 14531.4 14584.8 14606.9 14675.3 14722.7 11822.2 11946.8 12017.5 12123.8 12397.0 3887.4 4035.3 4049.5 4077.4 4078.0 106304.0 109314.0 109927.0 110266.0 110933.0 11188.9 11245.3 11440.7 11718.7 11879.1 19325.2 21139.4 21256.4 21675.6 23426.3 8039.6 8130.7 8195.6 8296.2 8386.3 4207.2 4257.3 4304.2 4399.6 4430.1 3407.2 3531.8 3558.8 3560.6 3563.1 591.6 658.9 666.9 667.2 675.0 564.7 598.0 605.8 616.7 661.8 8775.0 8875.8 9078.1 9103.1 9115.4 594.7 599.5 629.7 640.3 657.6 4203.0 4354.8 4370.1 4422.2 4470.1 140337.0 143436.0 149443.0 158143.0 161550.0 117211.7 120587.0 125104.0 132139.0 136695.0 90921.0 116831.8 118705.0 119489.0 119689.0 9277.6 9895.2 9922.6 9966.1 9994.2 55363.4 63611.0 63766.7 65657.0 66341.0 97719.6 98356.5 100868.0 101164.0 102966.5 13387.5 13391.4 13395.7 13647.1 13743.7 14848.2 15140.8 15144.7 15242.8 15771.4 13868.4 13891.7 13918.8 14286.2 14497.2 13547.7 13802.3 13813.8 13859.0 14609.9 13482.9 13612.0 13618.7 13662.7 13700.5 9714.2 10541.4 11310.8 11607.7 12235.7 11221.8 11335.0 11592.2 11603.8 11720.8 05:55:21 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:55:21 INFO - PROCESS | 1662 | 05:55:22 INFO - TEST-INFO | 1662: exit 0 05:55:22 INFO - TEST-OK | dromaeo_css | took 1114352ms 05:55:22 INFO - TEST-START | kraken 05:55:22 INFO - operating with platform_type : mac_ 05:55:22 INFO - Initialising browser for kraken test... 05:55:22 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpb9yG0C/profile http://localhost:49272/getInfo.html) 05:55:24 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 05:55:24 INFO - PROCESS | 1669 | colorDepth:24 05:55:24 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 05:55:24 INFO - PROCESS | 1669 | __metrics 05:55:25 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:55:25 INFO - TEST-INFO | 1669: exit 0 05:55:25 INFO - Browser initialized. 05:55:25 INFO - Running cycle 1/1 for kraken test... 05:55:25 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpb9yG0C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:37 INFO - PROCESS | 1672 | RSS: Main: 254779392 05:55:37 INFO - PROCESS | 1672 | 05:55:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:41 INFO - PROCESS | 1672 | RSS: Main: 268230656 05:55:41 INFO - PROCESS | 1672 | 05:55:44 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 05:55:44 INFO - PROCESS | 1672 | RSS: Main: 271908864 05:55:44 INFO - PROCESS | 1672 | 05:55:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 05:55:48 INFO - PROCESS | 1672 | RSS: Main: 272457728 05:55:48 INFO - PROCESS | 1672 | 05:55:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 05:55:51 INFO - PROCESS | 1672 | RSS: Main: 273321984 05:55:51 INFO - PROCESS | 1672 | 05:55:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:54 INFO - PROCESS | 1672 | RSS: Main: 273969152 05:55:54 INFO - PROCESS | 1672 | 05:55:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:57 INFO - PROCESS | 1672 | RSS: Main: 274284544 05:55:57 INFO - PROCESS | 1672 | 05:56:00 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:01 INFO - PROCESS | 1672 | RSS: Main: 274472960 05:56:01 INFO - PROCESS | 1672 | 05:56:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 05:56:04 INFO - PROCESS | 1672 | RSS: Main: 274542592 05:56:04 INFO - PROCESS | 1672 | 05:56:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:07 INFO - PROCESS | 1672 | RSS: Main: 274325504 05:56:07 INFO - PROCESS | 1672 | 05:56:08 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:09 INFO - PROCESS | 1672 | RSS: Main: 274313216 05:56:09 INFO - PROCESS | 1672 | 05:56:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:12 INFO - PROCESS | 1672 | RSS: Main: 274513920 05:56:12 INFO - PROCESS | 1672 | 05:56:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:16 INFO - PROCESS | 1672 | RSS: Main: 274677760 05:56:16 INFO - PROCESS | 1672 | 05:56:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:19 INFO - PROCESS | 1672 | RSS: Main: 274817024 05:56:19 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 05:56:21 INFO - PROCESS | 1672 | RSS: Main: 275574784 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | __start_tp_report 05:56:21 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 05:56:21 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 05:56:21 INFO - PROCESS | 1672 | |i|pagename|runs| 05:56:21 INFO - PROCESS | 1672 | |0;ai-astar;118;117;110;117;115;121;95;167;165;116 05:56:21 INFO - PROCESS | 1672 | |1;audio-beat-detection;135;105;127;137;91;159;161;116;158;111 05:56:21 INFO - PROCESS | 1672 | |2;audio-dft;195;205;213;227;201;198;202;198;199;195 05:56:21 INFO - PROCESS | 1672 | |3;audio-fft;73;80;75;146;57;58;56;59;134;50 05:56:21 INFO - PROCESS | 1672 | |4;audio-oscillator;70;72;120;74;76;113;146;71;72;114 05:56:21 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;93;78;138;130;93;105;93;90;95;119 05:56:21 INFO - PROCESS | 1672 | |6;imaging-darkroom;97;98;97;98;97;98;99;98;98;120 05:56:21 INFO - PROCESS | 1672 | |7;imaging-desaturate;93;94;91;89;94;85;151;143;90;89 05:56:21 INFO - PROCESS | 1672 | |8;json-parse-financial;57;56;58;56;56;56;56;55;56;55 05:56:21 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;70;74;71;80;82;79;76;75;83;109 05:56:21 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;84;82;85;85;84;84;86;84;88;83 05:56:21 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;161;157;122;153;157;156;142;136;152;154 05:56:21 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;166;165;168;162;163;173;175;201;218;214 05:56:21 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;65;69;69;67;70;63;67;81;74;65 05:56:21 INFO - PROCESS | 1672 | __end_tp_report 05:56:21 INFO - PROCESS | 1672 | __start_cc_report 05:56:21 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1180 05:56:21 INFO - PROCESS | 1672 | __end_cc_report 05:56:21 INFO - PROCESS | 1672 | __startTimestamp1469105781628__endTimestamp 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | ------- Summary: start ------- 05:56:21 INFO - PROCESS | 1672 | Number of tests: 14 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:124.10 Median:119.50 stddev:23.23 (19.4%) stddev-sans-first:24.53 05:56:21 INFO - PROCESS | 1672 | Values: 118.0 117.0 110.0 117.0 115.0 121.0 95.0 167.0 165.0 116.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:147.50 stddev:24.43 (16.6%) stddev-sans-first:25.85 05:56:21 INFO - PROCESS | 1672 | Values: 135.0 105.0 127.0 137.0 91.0 159.0 161.0 116.0 158.0 111.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:203.30 Median:201.50 stddev:9.88 (4.9%) stddev-sans-first:10.01 05:56:21 INFO - PROCESS | 1672 | Values: 195.0 205.0 213.0 227.0 201.0 198.0 202.0 198.0 199.0 195.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:78.80 Median:58.50 stddev:33.77 (57.7%) stddev-sans-first:35.75 05:56:21 INFO - PROCESS | 1672 | Values: 73.0 80.0 75.0 146.0 57.0 58.0 56.0 59.0 134.0 50.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:71.50 stddev:27.74 (38.8%) stddev-sans-first:28.16 05:56:21 INFO - PROCESS | 1672 | Values: 70.0 72.0 120.0 74.0 76.0 113.0 146.0 71.0 72.0 114.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:103.40 Median:91.50 stddev:19.35 (21.1%) stddev-sans-first:20.16 05:56:21 INFO - PROCESS | 1672 | Values: 93.0 78.0 138.0 130.0 93.0 105.0 93.0 90.0 95.0 119.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:98.00 stddev:7.06 (7.2%) stddev-sans-first:7.40 05:56:21 INFO - PROCESS | 1672 | Values: 97.0 98.0 97.0 98.0 97.0 98.0 99.0 98.0 98.0 120.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:90.50 stddev:24.00 (26.5%) stddev-sans-first:25.24 05:56:21 INFO - PROCESS | 1672 | Values: 93.0 94.0 91.0 89.0 94.0 85.0 151.0 143.0 90.0 89.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 05:56:21 INFO - PROCESS | 1672 | Values: 57.0 56.0 58.0 56.0 56.0 56.0 56.0 55.0 56.0 55.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:79.90 Median:77.50 stddev:11.12 (14.3%) stddev-sans-first:11.20 05:56:21 INFO - PROCESS | 1672 | Values: 70.0 74.0 71.0 80.0 82.0 79.0 76.0 75.0 83.0 109.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:1.65 (2.0%) stddev-sans-first:1.74 05:56:21 INFO - PROCESS | 1672 | Values: 84.0 82.0 85.0 85.0 84.0 84.0 86.0 84.0 88.0 83.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:155.00 stddev:12.10 (7.8%) stddev-sans-first:12.03 05:56:21 INFO - PROCESS | 1672 | Values: 161.0 157.0 122.0 153.0 157.0 156.0 142.0 136.0 152.0 154.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:174.00 stddev:21.83 (12.5%) stddev-sans-first:22.52 05:56:21 INFO - PROCESS | 1672 | Values: 166.0 165.0 168.0 162.0 163.0 173.0 175.0 201.0 218.0 214.0 05:56:21 INFO - PROCESS | 1672 | 05:56:21 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:5.23 (7.6%) stddev-sans-first:5.34 05:56:21 INFO - PROCESS | 1672 | Values: 65.0 69.0 69.0 67.0 70.0 63.0 67.0 81.0 74.0 65.0 05:56:21 INFO - PROCESS | 1672 | -------- Summary: end -------- 05:56:21 INFO - PROCESS | 1672 | 05:56:22 INFO - TEST-INFO | 1672: exit 0 05:56:22 INFO - TEST-OK | kraken | took 60344ms 05:56:22 INFO - SUITE-END | took 1174s 05:56:22 INFO - Completed test suite (00:19:35) 05:56:22 INFO - javascript benchmark 05:56:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7376.824224756529, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3191.297914458819, 3434.536337594424, 3459.2389674271653, 3473.7742046766957, 3484.825758712065, 5957.255343082109, 6004.249468816398, 6023.909641355383, 6052.788152414666, 6075.088736689493, 5726.284214473191, 5749.856253593663, 5791.623544469617, 5886.969780288443, 5983.700814959257, 5271.841844744664, 5334.893302133955, 5429.782808687648, 5437.537809286196, 5480.91778623321, 5395.244665746799, 5418.593605479585, 5475.4524547545125, 5521.978433989705, 5527.889442211153, 5081.822136225214, 5333.040052790496, 5397.055515284809, 5419.403865574804, 5453.64551304164, 5409.999150157194, 5425.430329815352, 5427.0, 5442.156465747816, 5453.045716999549, 5358.571314294847, 5369.114096174127, 5426.077566813651, 5445.1832225166145, 5453.727313634303, 4436.889077773049, 5795.391483894173, 5856.297244330665, 5919.911201331984, 6028.487578555828, 6239.251289845248, 6267.2479302484, 6304.432601065881, 6308.179936608258, 6314.210723659543, 6349.2698339690605, 6363.459105975998, 6368.426841584233, 6395.456386207178, 6412.839679008062, 5925.259342582177, 6026.276846778414, 6101.0848372744, 6115.602485838406, 6145.371476558716, 6494.870102598016, 6500.414962653384, 6512.511561632897, 6515.446187074152, 6523.18460192476, 6207.6275423474735, 6226.159468471698, 6284.717187726564, 6311.684415779193, 6316.747330106744, 6202.596831206048, 6294.527910406738, 6294.874102517924, 6310.905336419957, 6415.903761443582, 6189.783357582553, 6284.874302514016, 6285.654289014056, 6290.528210384239, 6295.559310848288, 4791.784369703371, 5918.171455996164, 6295.905561416583, 6316.210473690789, 6325.114483972247, 5004.724740139327, 5074.949250507521, 5083.491650834961, 5083.847484575469, 5129.743512824344, 3822.50307460034, 4584.129015487113, 4597.816087356468, 4619.122366750306, 4644.373009643722, 6012.969935150296, 6092.238470191226, 6096.3903609639565, 6106.755729770848, 6109.175261339751, 6166.691665416712, 6265.8746825063245, 6369.45859601939, 6394.680265986682, 6402.775902843378, 6099.218990344071, 6101.47943246205, 6112.716259964539, 6126.356732543108, 6131.529590167202, 5623.803166889221, 5627.6904770237215, 5630.60585758993, 5641.0, 5652.8869422611315, 6321.241451025906, 6436.967815160894, 6474.805755827333, 6552.213734351908, 6572.474202063823, 6395.776147834804, 6411.807645770635, 6429.7749578764515, 6450.645214513247, 6456.999165129412, 6516.2180538333805, 6551.082848401133, 6580.670966451754, 6584.144061272004, 6602.240742314695, 6190.752369905334, 6215.12988181664, 6241.78153764616, 6351.523635727432, 6351.904721429275, 6296.968515157395, 6319.46284565817, 6332.556721029484, 6336.58812177207, 6374.298827129105, 6196.845078873064, 6233.345498722569, 6266.248050234001, 6269.404406581368, 6294.433500984934, 5528.391876893458, 6142.600730952474, 6220.440160385587, 6226.719797609027, 6268.874622507616, 6132.724027418688, 6132.998044146438, 6148.78479253224, 6209.627422354673, 6225.595336303126, 5716.685162412585, 5750.30996280449, 6295.401936815995, 6300.991841305369, 6306.46395056407, 6054.576179667381, 6133.2428548619655, 6184.0, 6213.2233470816145, 6240.625562466266], "value": 5848.7251312889875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.87095613228286, 528.3712382265104, 546.9371022332431, 562.0136660161418, 573.6386076771633, 37940.81029594852, 40121.39817902727, 40189.0, 40221.0, 40230.994225144386, 41475.17049659005, 41797.0, 41878.16243675125, 41887.79056104715, 41920.790396047974, 9588.137067663927, 9773.120419162275, 9776.071273229032, 9785.461799601018, 9801.264905132108, 9525.0, 9610.0, 9614.471204083773, 9629.988851170632, 9640.951795241013, 9569.473678947656, 9619.759506012335, 9656.71029869105, 9659.855102173473, 9686.031396860328, 9491.288153388488, 9545.90454095457, 9570.234381249518, 9601.327907046509, 9627.133557979816, 9289.953550232272, 9419.858702119474, 9464.621415143454, 9477.099675530813, 9489.90510094897, 39077.60922390768, 39380.80309598434, 39514.802425987975, 39719.8014009931, 39740.80129599333, 3083.1521331633758, 3333.3666603345287, 3346.916327091818, 3460.4046964776417, 3529.8411571479087, 25606.74393256062, 28580.571291430646, 29913.25216869574, 30073.0, 30431.847840760875, 2782.3044238940265, 3095.0, 3100.7364374028234, 3109.860056297472, 3226.58054452922, 407332.0, 419250.0, 422257.88871055754, 426634.0, 427865.0, 32818.85134020298, 33078.0, 33104.0, 33161.0, 33178.668213318044, 33984.830075849466, 34011.97964061082, 34060.82969585136, 35092.473612895825, 35120.64879351225, 16491.91754041222, 16625.7506137408, 16652.91673541649, 16672.083035432926, 16699.9145055571, 12727.745445091232, 12839.935800320938, 12846.100772945803, 12855.871441285655, 12882.67793305175, 19220.231190752493, 19272.710909336372, 19291.035448227532, 19292.517687057654, 19320.903395482932, 8151.470154439942, 8244.134365891616, 8246.958765206256, 8267.338612910953, 8316.667333306721, 888.6667499687617, 918.1094338491653, 956.7034219392011, 1041.1202533858877, 1044.3420644993605, 24185.79551700365, 30089.0, 30127.54808677828, 30388.24029399283, 30869.929902342832, 1035.1977217656226, 1048.3290693955873, 1069.04320633033, 1085.7122862441458, 1107.7230692326918, 15234.238288085551, 15372.769408458882, 15621.921890390702, 15807.13060781645, 15975.440859570092, 712040.0, 718246.0, 720704.7929520742, 720941.0, 722316.0, 58323.0, 58440.707796460745, 58724.41275587275, 58920.705396472746, 59194.704026479594, 1394.3655636685285, 1409.3728290910651, 1429.0711037825497, 1436.2029073863896, 1440.992795036039, 30227.697723022487, 30993.0, 31304.0, 31848.840755796075, 32356.35287294288, 56338.718306408206, 56914.0, 57108.0, 57123.0, 57136.85747283773, 641504.0, 646942.0, 647281.0, 647838.0, 647949.0410191675, 42756.78621606872, 43626.0, 43687.78156109199, 44100.0, 44122.67631971046, 46844.7657761709, 47700.522994770996, 48114.0, 48209.75895120502, 48765.0, 32565.0, 37976.0, 39661.405078923264, 40974.79512602418, 41136.0, 39497.80251098726, 39728.80135599303, 40254.79235622936, 40265.72708652064, 41292.79353603213, 37911.43132852954, 38471.230575388894, 38876.22247554977, 38902.610973889896, 39141.0, 34306.828465857514, 34536.309273814884, 35238.82380588183, 35541.64458355383, 36009.45985810267, 25919.481610368064, 25936.481270374108, 25986.570738609556, 26331.736682633695, 26400.339991500365], "value": 19843.0690112838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.51751687772133, 371.5077522282975, 381.6298190754967, 386.9129445874677, 399.1537939568114, 19440.611187776252, 20287.797122028776, 21507.569848603038, 21836.563268734637, 21959.121635134576, 10233.488325583729, 10489.16086713063, 11815.70460738482, 11846.348450835201, 12181.269123852575, 4672.462666793328, 4789.664723469358, 5074.67014644047, 5285.735713214333, 5507.531859791922, 3908.394198899175, 5453.563714902798, 5505.917411238835, 5970.611910225822, 6282.591631543958, 6275.2783429905685, 6285.402886725777, 6304.432601065903, 6311.179546658928, 6321.431071203614, 5058.974705126488, 6090.025595904634, 6182.072689096649, 6226.283977342596, 6252.812415627538, 5156.639035267533, 5863.8534036649, 5906.493844069735, 5907.320658124328, 5909.4090590941, 12920.22478651284, 13284.933575332157, 13320.800187997187, 13323.86676133236, 16505.504834854855, 2235.3182279404773, 2287.176616418088, 2515.8113141514277, 2903.2306438793735, 2938.6473623165143, 8176.591170441454, 9570.042995700374, 9730.805383892282, 10152.289339746221, 10166.644167454104, 1490.9776353354707, 1733.0554847608084, 1797.694391953371, 1808.9909550452296, 1871.1299245850744, 112860.43569782181, 122787.0, 125172.37413812873, 125907.0, 127596.0, 9248.491332976617, 11579.826302605468, 11733.0, 11740.765184696429, 11948.283103013848, 14435.927820361041, 14579.927100364643, 14603.97772155939, 14643.194624295553, 14644.341004654816, 8263.586820659064, 8409.369297302726, 8532.914670853212, 8665.220130188314, 8704.04255531891, 8447.619857106445, 8454.112318206622, 8477.576121193915, 8602.78493037679, 8630.136986301446, 3666.6699996999864, 4485.372047913294, 4547.681662283609, 4616.561426664462, 4646.83736069236, 1584.5008822220964, 1639.737641977278, 1672.5400514858268, 1887.8955810850532, 1952.0825212150266, 818.2390376949376, 932.1005229952992, 990.6186118344489, 997.3915911294105, 1027.8509616105623, 18486.445406637824, 21794.01926913293, 22144.446388840086, 22165.335039948826, 22523.0, 925.1072714830221, 944.9244060475146, 950.9809803803885, 958.8609651600618, 989.6189966862665, 8812.0, 9743.658971935949, 11643.53425862956, 11695.532178712927, 11718.648440546796, 572347.0, 578839.0, 610347.0, 612466.9376653088, 621555.0, 99992.0, 133169.0, 136256.0, 136589.0, 141411.29294353668, 1002.3735165521549, 1009.7728011197422, 1012.8328825743818, 1017.867677201959, 1028.28534168752, 18951.241950322383, 19360.61278774445, 19535.609287814448, 19559.70660440123, 19877.60244795125, 52658.473415265355, 53044.73477632587, 55215.447845521034, 56317.15524267221, 56426.0, 54967.0, 81389.0, 81510.0, 82352.0, 83808.0, 7143.964280178566, 7191.101112360955, 7285.854282914206, 7307.5980821055355, 7342.265773422615, 10230.437325947145, 12026.579069732867, 12169.756604868031, 12306.876931230574, 12441.751164976831, 10568.471576421302, 10625.25623206368, 10669.46652667379, 10682.32941764559, 10785.676429707122, 10296.845547316647, 10406.687799366031, 10449.529771160469, 10492.527836247235, 10607.151427885596, 10580.15358771312, 10614.522346494581, 10639.89360106389, 10663.520141593803, 11006.944965275123, 7049.224585295716, 7193.928060719535, 7208.855822883408, 7308.744193953186, 7419.517731347445, 10540.0, 10623.0, 10714.357138571711, 10797.29817561856, 10925.0], "value": 9135.031366067617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.5289186798025, 1584.049570257845, 1806.3316572868032, 1893.3184053740652, 1894.176033425461, 7984.800379990488, 8450.450720703166, 8615.483071015735, 9096.45421274724, 9115.635374585017, 8437.451565648229, 8646.91353086469, 8739.300855931526, 8751.956240218806, 8760.737177884657, 2316.6293393057113, 2342.3207269891795, 2360.303710405426, 2368.27767530903, 2371.1345358944036, 2321.0599707118645, 2331.5803155432013, 2367.8934447949796, 2370.182287110944, 2379.92860214193, 2322.4774425754154, 2325.813934885205, 2340.438294809242, 2348.236823032513, 2352.9647055294186, 2318.420394901275, 2326.988365058181, 2327.185485080217, 2335.5795956727784, 2349.483113714997, 1933.8452923766206, 2252.1441852096264, 2256.379495638696, 2263.2983775029793, 2267.2858049714287, 8683.913160868373, 8728.0, 8733.0, 8739.825203495959, 8787.384883058188, 5165.147750621143, 5273.129933560957, 5293.417724050351, 5299.072662284085, 5325.973370133163, 3438.1232785639754, 3510.8420121094614, 3596.532450781408, 3627.147620309225, 3630.7276954228537, 1048.1186270644212, 1076.4563895232857, 1087.3638921231088, 1098.8901209778182, 1100.3892839474088, 10192.59229630814, 11403.885961140448, 11483.598074067451, 11585.304881707125, 11615.709607259801, 4536.274196128604, 4556.476005259371, 4782.665213435026, 4789.712617242976, 4791.377120974251, 10048.447335396477, 10061.949690251502, 10068.848967265498, 10071.5467803949, 10077.0, 5309.309789727388, 5333.839984800462, 5338.199270109437, 5344.091504444176, 5409.24270602116, 3994.6804255659476, 4389.758563279051, 4853.830115945995, 4874.731889746027, 4899.877503062381, 3852.114013776791, 3929.9803500982885, 3950.1309711863346, 3993.2213218422708, 4022.8189731462153, 1267.7781388257017, 1294.4757373263844, 1296.922184668904, 1297.7988411796186, 1321.253491777162, 816.8243827577099, 844.2317491083207, 899.2581120575551, 929.7210836748948, 994.16986816008, 5678.943210567924, 5847.853803654943, 5905.616134951214, 6147.415995480422, 6236.532260080512, 417.4823219208221, 437.31996745061736, 440.47583375782716, 442.89370551068157, 447.7403106198397, 3660.670539651444, 4051.918961620751, 4170.895727606834, 4174.979125104355, 4218.873433796991, 10293.485325733684, 10482.318649287772, 10609.681709548726, 10710.143188545053, 10714.142868570496, 10406.219533534864, 10567.101796347242, 10605.734856628646, 10659.4137322448, 10697.304675196086, 8106.189381061965, 8118.188181181953, 8170.714025009096, 8226.341892648694, 8256.1331060239, 5831.446012628793, 6002.729877155626, 6076.90884636722, 6076.939230607637, 6124.724387402489, 9914.950425247827, 9917.107460328605, 9921.553530091307, 9927.0, 9986.0, 9044.0, 9910.554025068745, 10102.24233182529, 10144.49277536135, 10179.643712470028, 6971.721131154697, 7386.0767404074495, 7416.221296763762, 7550.697972081055, 7619.771406857803, 8480.703175389079, 8482.660693572188, 8561.0, 8566.0, 8572.27135693473, 7265.273472652692, 7487.962560187164, 7608.31525162738, 7651.617419129133, 7718.807029824075, 7213.531120477152, 7355.338019578049, 7372.115346158495, 7446.962765186356, 7498.212687667717, 6939.722411103499, 6952.0267162596265, 6995.96502017507, 7014.824629384102, 7033.507654464139, 4974.527419895104, 4982.252662100569, 5003.399592048978, 5101.69389836611, 5212.843614691566, 5043.218301163325, 5092.567131793839, 5192.5586325162785, 5201.505856943584, 5249.186376111708], "value": 4503.880509869263, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.37222205590325, 303.5037713338691, 313.58763226357337, 315.38185157092096, 316.12275934282377, 5463.415609473258, 5646.0, 5732.5987180897355, 5857.41425857414, 5874.9118763218585, 5668.036433806253, 5723.170140329649, 5728.971355143219, 5732.0828667413225, 5774.913376299359, 3282.7045565899066, 4258.849281113034, 4341.479022517302, 4349.891252718691, 4395.648348132142, 4046.3525835866267, 4269.957300426987, 4274.5084315303675, 4360.36774667673, 4390.319500477431, 3855.0, 4236.04688944988, 4263.147370525891, 4269.118345117049, 4274.914501709964, 3565.928681426357, 3907.960920390788, 4149.6265336119595, 4241.236577416079, 4276.679249056333, 3108.4404807134706, 3553.8450003748626, 3696.168362118502, 3698.6671199592165, 3708.8145592720525, 5518.724063796834, 5527.668339899619, 5554.278633315688, 5580.720963951827, 5590.462622778728, 4308.319755295437, 4332.981749288914, 4921.434035085975, 4922.0, 4938.234573641092, 5713.971430142864, 5729.28383952006, 6033.245844269466, 6083.836405069339, 6102.237220347457, 4021.8135649983324, 4026.832218656586, 4035.556088830226, 4038.6970977176534, 4067.593240675909, 5808.415255211433, 5927.347991720907, 6306.621602703806, 6447.4197322241225, 6459.709313080875, 3332.6500717424806, 3784.972022382083, 4087.5912408758886, 4123.690723195772, 4126.442930204444, 4106.3635136553885, 4129.91740165201, 4142.855000074983, 4152.190322887008, 4157.0, 4900.828471003498, 4909.975450122726, 4918.827841025547, 4920.975395123001, 4921.261810728348, 5833.854153646193, 6089.48239399656, 6101.267847858286, 6133.478654314434, 6207.751689932352, 1210.9939450302868, 1398.7062716829375, 1420.3311109446358, 1423.8077859489044, 1425.8664361832368, 786.6106277392727, 836.4061516323356, 838.8884727735774, 858.5490521019457, 867.2151702709058, 4523.819047238139, 4773.64197685175, 4854.2233242681, 4866.975665121652, 4914.311996320518, 4630.976845115821, 5351.732413379315, 5355.30381050461, 5366.490183432567, 5378.283966596843, 4517.932231016537, 4730.758359408713, 4839.523945196678, 4873.366462359871, 4932.7421507515355, 2450.901963921423, 2805.9236165237576, 2828.561572956195, 2839.929001774972, 2848.928776780597, 5136.8715782105, 5284.309021113284, 5522.834314970557, 5553.361363443256, 5557.638378597269, 5062.974685126551, 5457.399686034533, 5474.562035037267, 5518.972405137949, 5546.362168350692, 4884.5603895649565, 5337.332833395748, 5360.812371566976, 5448.591355648342, 5490.56075513958, 4602.7008244464005, 5022.4977502249485, 5348.331458567679, 5379.865503362291, 5422.945770542244, 4795.592374648194, 5244.977229440375, 6244.125822384779, 6295.905561416491, 6332.271788744353, 6063.818085457443, 6627.436667883091, 6631.966840165768, 6645.734170633121, 6653.900191497229, 3876.786776727307, 3957.713743033468, 4019.0354314964784, 4113.91772164549, 4133.152703695675, 6262.937370626236, 6280.074953154279, 6302.71637776292, 6317.30509643948, 6363.490920726238, 5729.885402292014, 6148.354422785543, 6152.477039451696, 6175.536834737502, 6176.35148309421, 5240.580753539632, 5480.369757477941, 5967.76128954837, 6051.788187413419, 6129.693515324305, 5524.779008839601, 5710.971445142748, 5881.264841894763, 6001.519878409629, 6084.14821924922, 5321.962217367731, 5830.591858569859, 6094.786682466092, 6113.23584551931, 6126.571140020156, 5987.868370824118, 6000.5898613826585, 6003.969980150071, 6016.4885984690045, 6024.518038556993], "value": 4249.884894139564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5352547606793, 739.4454159380465, 790.1150711203453, 843.7721815109917, 849.885265489159, 15001.924990375046, 15531.611709707264, 15638.374465021414, 15692.686146277068, 15710.842891571081, 14340.641483962907, 14475.565733028, 14485.782713259283, 14509.274536273197, 14517.20155391453, 679.079846807576, 832.8792325112855, 841.5371545649899, 869.5130726792985, 870.8954925408959, 860.9612567434481, 866.8049688819997, 874.6807415293404, 876.3514998900799, 879.8020445399798, 929.4562680831722, 933.1927882381725, 935.4434111703525, 936.1574582875398, 936.9484678342689, 924.1082355526949, 924.8011677489338, 924.8843894513186, 925.9212966897821, 928.4614923344444, 689.3657834792003, 691.7924622613247, 692.3388164303129, 693.3170826735661, 693.3724978894058, 14953.775693364609, 14978.925105374512, 14980.925095374454, 15005.924970375187, 15014.174220417983, 14531.418743250257, 14584.781228281585, 14606.853931460655, 14675.339609717588, 14722.705545889023, 11822.231554948901, 11946.761064778655, 12017.459214335377, 12123.818142727867, 12397.0, 3887.378019516864, 4035.3341698619693, 4049.4735684360844, 4077.368007958771, 4078.0008897819926, 106304.0, 109314.0, 109927.0, 110266.0, 110933.0, 11188.944055279671, 11245.325280483197, 11440.713982150513, 11718.70703232426, 11879.10906681985, 19325.226990920488, 21139.365819025454, 21256.36230913075, 21675.566488670138, 23426.297211083696, 8039.638216280281, 8130.674773009014, 8195.590220488952, 8296.170382961776, 8386.287165590871, 4207.179599978036, 4257.276263035292, 4304.182205380967, 4399.560043995575, 4430.069685366109, 3407.1822762536813, 3531.770434921722, 3558.7864728116397, 3560.64393560647, 3563.127033876665, 591.6450129922098, 658.8517583543664, 666.8899631560738, 667.1893649216225, 674.9898751518731, 564.6865989375854, 597.9910301345483, 605.8485378655337, 616.6793267500874, 661.7525963558727, 8774.95612521946, 8875.822483550293, 9078.137576930181, 9103.089691030844, 9115.36192466521, 594.7085927895387, 599.5203836930439, 629.6725702634604, 640.3276559612389, 657.5561495990188, 4203.0, 4354.8258069677495, 4370.104128653618, 4422.159789639958, 4470.061287129739, 140337.0, 143436.0, 149443.0, 158143.0, 161550.0, 117211.65576688419, 120587.0, 125104.0, 132139.0, 136695.0, 90921.0, 116831.83168168379, 118705.0, 119489.0, 119689.0, 9277.62889484413, 9895.158911492605, 9922.553485093333, 9966.053224943618, 9994.150497207527, 55363.44636553583, 63611.045834313445, 63766.68116659573, 65657.0, 66341.0, 97719.55701107529, 98356.50821746132, 100868.0, 101164.0, 102966.48516757369, 13387.514734920844, 13391.397387117408, 13395.665108372368, 13647.087048662672, 13743.656408589864, 14848.183349915858, 15140.772888406462, 15144.697106057596, 15242.771358429854, 15771.44799931997, 13868.4452621894, 13891.722165556834, 13918.791218131533, 14286.214258215898, 14497.20265385414, 13547.661308466973, 13802.309884505936, 13813.792793108312, 13859.0, 14609.853901460849, 13482.93258533701, 13612.047156698936, 13618.727625447635, 13662.658433539242, 13700.45198192061, 9714.174295184988, 10541.367517948947, 11310.83033754478, 11607.709807254549, 12235.69410764738, 11221.775564488828, 11335.0, 11592.19201533233, 11603.767924641628, 11720.765584688428], "value": 7940.1506042339615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 110.0, 117.0, 115.0, 121.0, 95.0, 167.0, 165.0, 116.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 105.0, 127.0, 137.0, 91.0, 159.0, 161.0, 116.0, 158.0, 111.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 205.0, 213.0, 227.0, 201.0, 198.0, 202.0, 198.0, 199.0, 195.0], "value": 203.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 75.0, 146.0, 57.0, 58.0, 56.0, 59.0, 134.0, 50.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 120.0, 74.0, 76.0, 113.0, 146.0, 71.0, 72.0, 114.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 78.0, 138.0, 130.0, 93.0, 105.0, 93.0, 90.0, 95.0, 119.0], "value": 103.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 98.0, 97.0, 98.0, 99.0, 98.0, 98.0, 120.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 91.0, 89.0, 94.0, 85.0, 151.0, 143.0, 90.0, 89.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 71.0, 80.0, 82.0, 79.0, 76.0, 75.0, 83.0, 109.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 85.0, 85.0, 84.0, 84.0, 86.0, 84.0, 88.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 122.0, 153.0, 157.0, 156.0, 142.0, 136.0, 152.0, 154.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 168.0, 162.0, 163.0, 173.0, 175.0, 201.0, 218.0, 214.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 69.0, 67.0, 70.0, 63.0, 67.0, 81.0, 74.0, 65.0], "value": 69.0, "unit": "score"}]}]} 05:56:22 INFO - Return code: 0 05:56:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:56:22 ERROR - # TBPL SUCCESS # 05:56:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:22 INFO - 2016-07-21 05:56:22.959 screenresolution[1677:11199] starting screenresolution argv=screenresolution get 05:56:22 INFO - 2016-07-21 05:56:22.961 screenresolution[1677:11199] Display 0: 1600x1200x32@60 05:56:22 INFO - 2016-07-21 05:56:22.967 screenresolution[1678:11202] starting screenresolution argv=screenresolution list 05:56:22 INFO - Available Modes on Display 0 05:56:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:23 INFO - Intel Iris: 05:56:23 INFO - Chipset Model: Intel Iris 05:56:23 INFO - Type: GPU 05:56:23 INFO - Bus: Built-In 05:56:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:23 INFO - Vendor: Intel (0x8086) 05:56:23 INFO - Device ID: 0x0a2e 05:56:23 INFO - Revision ID: 0x0009 05:56:23 INFO - Displays: 05:56:23 INFO - Display: 05:56:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:23 INFO - Display Serial Number: 1600x1200 60 05:56:23 INFO - Main Display: Yes 05:56:23 INFO - Mirror: Off 05:56:23 INFO - Online: Yes 05:56:23 INFO - Rotation: Supported 05:56:23 INFO - Return code: 0 05:56:23 INFO - Running post-action listener: _resource_record_post_action 05:56:23 INFO - [mozharness: 2016-07-21 12:56:23.202708Z] Finished run-tests step (success) 05:56:23 INFO - Running post-run listener: _resource_record_post_run 05:56:23 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 33790976; Write bytes: 709963264; Read time: 320; Write time: 1957 05:56:23 INFO - TinderboxPrint: CPU usage
54.3% 05:56:23 INFO - TinderboxPrint: I/O read bytes / time
33,790,976 / 320 05:56:23 INFO - TinderboxPrint: I/O write bytes / time
709,963,264 / 1,957 05:56:23 INFO - TinderboxPrint: CPU idle
2,214.2 (45.7%) 05:56:23 INFO - TinderboxPrint: CPU system
975.2 (20.1%) 05:56:23 INFO - TinderboxPrint: CPU user
1,656.2 (34.2%) 05:56:23 INFO - TinderboxPrint: Swap in / out
437,719,040 / 0 05:56:23 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 391199232; Write bytes: 385361920; Read time: 30083; Write time: 779 05:56:23 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 32865280; Write bytes: 299341312; Read time: 307; Write time: 1128 05:56:23 INFO - Running post-run listener: _upload_blobber_files 05:56:23 INFO - Blob upload gear active. 05:56:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:23 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 05:56:23 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'] 05:56:23 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 05:56:24 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:25 INFO - (blobuploader) - INFO - Done attempting. 05:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:26 INFO - (blobuploader) - INFO - Done attempting. 05:56:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:56:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:32 INFO - (blobuploader) - INFO - Done attempting. 05:56:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:32 INFO - Return code: 0 05:56:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed65726c8542807f2ff0c77a70c3ee864feb9c8af486006547917c7c1adcc6b05fe597eda682b2bb35b2ab5b42eb47c0eed6c9e6db680229808f3eaded06e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba84203f3c7a9aa7b70ea90d2e853bab16dfb1a5a59947f90374acb8015b6d0629bad3b1236d6119601b083651a41b29d9175572d67e1069a845cf98c64f09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed03c1d33f59c1ee05a3118beedad1ba75093f32398f038dec47426eb5c2d614b9996ac36ec4bc79a87f8b568d107cace4ed694d6599fa7d0cf8276527de2fa"} 05:56:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:32 INFO - Contents: 05:56:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed65726c8542807f2ff0c77a70c3ee864feb9c8af486006547917c7c1adcc6b05fe597eda682b2bb35b2ab5b42eb47c0eed6c9e6db680229808f3eaded06e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba84203f3c7a9aa7b70ea90d2e853bab16dfb1a5a59947f90374acb8015b6d0629bad3b1236d6119601b083651a41b29d9175572d67e1069a845cf98c64f09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed03c1d33f59c1ee05a3118beedad1ba75093f32398f038dec47426eb5c2d614b9996ac36ec4bc79a87f8b568d107cace4ed694d6599fa7d0cf8276527de2fa"} 05:56:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:32 INFO - Copying logs to upload dir... 05:56:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1346.557439 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-07-21 05:56:32.275213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:56:32.279471) ========= 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.t3tjyKyiGP/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.stynC5RunH/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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/fed65726c8542807f2ff0c77a70c3ee864feb9c8af486006547917c7c1adcc6b05fe597eda682b2bb35b2ab5b42eb47c0eed6c9e6db680229808f3eaded06e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba84203f3c7a9aa7b70ea90d2e853bab16dfb1a5a59947f90374acb8015b6d0629bad3b1236d6119601b083651a41b29d9175572d67e1069a845cf98c64f09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed03c1d33f59c1ee05a3118beedad1ba75093f32398f038dec47426eb5c2d614b9996ac36ec4bc79a87f8b568d107cace4ed694d6599fa7d0cf8276527de2fa"} build_url:https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/KaAnBh6-Qhyf6aVO4td3JA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fed65726c8542807f2ff0c77a70c3ee864feb9c8af486006547917c7c1adcc6b05fe597eda682b2bb35b2ab5b42eb47c0eed6c9e6db680229808f3eaded06e2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba84203f3c7a9aa7b70ea90d2e853bab16dfb1a5a59947f90374acb8015b6d0629bad3b1236d6119601b083651a41b29d9175572d67e1069a845cf98c64f09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed03c1d33f59c1ee05a3118beedad1ba75093f32398f038dec47426eb5c2d614b9996ac36ec4bc79a87f8b568d107cace4ed694d6599fa7d0cf8276527de2fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:56:32.312102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:56:32.312412) ========= 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.t3tjyKyiGP/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.stynC5RunH/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.004497 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:56:32.361502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:56:32.361806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:56:32.362166) ========= ========= Total master_lag: 0.17 =========