builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0371 starttime: 1485347883.16 results: success (0) buildid: 20170125030214 builduid: 027a16c06f7e464b96c79a810c6321f1 revision: 6dccae211ae5fec6a1c1244b878ce0b93860154f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.164215) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.164788) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.165133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.191209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.191674) ========= 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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-25 04:38:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 69.1M=0s 2017-01-25 04:38:03 (69.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.362567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.363020) ========= 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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.020850 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:03.412495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 04:38:03.413001) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6dccae211ae5fec6a1c1244b878ce0b93860154f --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 6dccae211ae5fec6a1c1244b878ce0b93860154f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-25 04:38:03,508 truncating revision to first 12 chars 2017-01-25 04:38:03,508 Setting DEBUG logging. 2017-01-25 04:38:03,508 attempt 1/10 2017-01-25 04:38:03,508 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6dccae211ae5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 04:38:04,285 unpacking tar archive at: mozilla-central-6dccae211ae5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.037748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 04:38:04.475034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:04.475438) ========= script_repo_revision: 6dccae211ae5fec6a1c1244b878ce0b93860154f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:04.475894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:04.476251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 04:38:04.496037) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-25 04:38:04.496420) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:38:04 INFO - MultiFileLogger online at 20170125 04:38:04 in /builds/slave/test 04:38:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:38:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:04 INFO - {'append_to_log': False, 04:38:04 INFO - 'base_work_dir': '/builds/slave/test', 04:38:04 INFO - 'blob_upload_branch': 'Firefox', 04:38:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:04 INFO - 'branch': 'Firefox', 04:38:04 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:04 INFO - 'config_files': ('talos/mac_config.py',), 04:38:04 INFO - 'default_actions': ('clobber', 04:38:04 INFO - 'read-buildbot-config', 04:38:04 INFO - 'download-and-extract', 04:38:04 INFO - 'populate-webroot', 04:38:04 INFO - 'create-virtualenv', 04:38:04 INFO - 'install', 04:38:04 INFO - 'run-tests'), 04:38:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:04 INFO - 'download_minidump_stackwalk': True, 04:38:04 INFO - 'download_symbols': 'ondemand', 04:38:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:04 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:04 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:04 INFO - 'installer_path': 'installer.exe', 04:38:04 INFO - 'log_level': 'info', 04:38:04 INFO - 'log_name': 'talos', 04:38:04 INFO - 'log_to_console': True, 04:38:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:04 INFO - 'opt_config_files': (), 04:38:04 INFO - 'pip_index': False, 04:38:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:04 INFO - 'cmd': ('bash', 04:38:04 INFO - '-c', 04:38:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:04 INFO - 'enabled': True, 04:38:04 INFO - 'halt_on_failure': False, 04:38:04 INFO - 'name': 'check_screen_resolution'},), 04:38:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:04 INFO - 'cmd': ('bash', 04:38:04 INFO - '-c', 04:38:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:04 INFO - 'enabled': True, 04:38:04 INFO - 'halt_on_failure': False, 04:38:04 INFO - 'name': 'check_screen_resolution'},), 04:38:04 INFO - 'run_cmd_checks_enabled': True, 04:38:04 INFO - 'sps_profile': False, 04:38:04 INFO - 'sps_profile_interval': 0, 04:38:04 INFO - 'suite': 'dromaeojs-e10s', 04:38:04 INFO - 'system_bits': '32', 04:38:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:04 INFO - 'title': 't-yosemite-r7-0371', 04:38:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:04 INFO - 'use_talos_json': True, 04:38:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:04 INFO - 'work_dir': 'build'} 04:38:04 INFO - [mozharness: 2017-01-25 12:38:04.708989Z] Running clobber step. 04:38:04 INFO - Running pre-action listener: _resource_record_pre_action 04:38:04 INFO - Running main action method: clobber 04:38:04 INFO - rmtree: /builds/slave/test/build 04:38:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:05 INFO - Running post-action listener: _resource_record_post_action 04:38:05 INFO - [mozharness: 2017-01-25 12:38:05.647359Z] Finished clobber step (success) 04:38:05 INFO - [mozharness: 2017-01-25 12:38:05.647529Z] Running read-buildbot-config step. 04:38:05 INFO - Running pre-action listener: _resource_record_pre_action 04:38:05 INFO - Running main action method: read_buildbot_config 04:38:05 INFO - Using buildbot properties: 04:38:05 INFO - { 04:38:05 INFO - "project": "", 04:38:05 INFO - "product": "firefox", 04:38:05 INFO - "script_repo_revision": "production", 04:38:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:38:05 INFO - "repository": "", 04:38:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:38:05 INFO - "buildid": "20170125030214", 04:38:05 INFO - "stage_platform": "macosx64", 04:38:05 INFO - "basedir": "/builds/slave/test", 04:38:05 INFO - "nightly_build": "True", 04:38:05 INFO - "buildnumber": 129, 04:38:05 INFO - "slavename": "t-yosemite-r7-0371", 04:38:05 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:38:05 INFO - "platform": "yosemite_r7", 04:38:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:38:05 INFO - "branch": "mozilla-central", 04:38:05 INFO - "repo_path": "mozilla-central", 04:38:05 INFO - "revision": "6dccae211ae5fec6a1c1244b878ce0b93860154f", 04:38:05 INFO - "pgo_build": "False", 04:38:05 INFO - "builduid": "027a16c06f7e464b96c79a810c6321f1", 04:38:05 INFO - "slavebuilddir": "test" 04:38:05 INFO - } 04:38:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:38:05 INFO - Running post-action listener: _resource_record_post_action 04:38:05 INFO - [mozharness: 2017-01-25 12:38:05.652091Z] Finished read-buildbot-config step (success) 04:38:05 INFO - [mozharness: 2017-01-25 12:38:05.652248Z] Running download-and-extract step. 04:38:05 INFO - Running pre-action listener: _resource_record_pre_action 04:38:05 INFO - Running main action method: download_and_extract 04:38:05 INFO - mkdir: /builds/slave/test/build/tests 04:38: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:05 INFO - trying https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:38:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:38:06 INFO - Downloaded 1199 bytes. 04:38:06 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:38:06 INFO - Using the following test package requirements: 04:38:06 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:38:06 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:06 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:38:06 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'jsshell-mac.zip'], 04:38:06 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:38:06 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:38:06 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:38:06 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:38:06 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:38:06 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:38:06 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:06 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:38:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:06 INFO - Fetch https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:38:08 INFO - Expected file size: 16351804 04:38:08 INFO - Obtained file size: 16351804 04:38:15 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:38:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:38:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:15 INFO - Fetch https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:38:15 INFO - Expected file size: 16351804 04:38:15 INFO - Obtained file size: 16351804 04:38:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:38:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:38:22 INFO - Fetch https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:38:24 INFO - Expected file size: 14403431 04:38:24 INFO - Obtained file size: 14403431 04:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:24 INFO - trying https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:38:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:38:27 INFO - Downloaded 69954132 bytes. 04:38:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:38:27 INFO - mkdir: /builds/slave/test/properties 04:38:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:38:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:38:27 INFO - Contents: 04:38:27 INFO - build_url:https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:38:28 INFO - Running post-action listener: _resource_record_post_action 04:38:28 INFO - Running post-action listener: set_extra_try_arguments 04:38:28 INFO - [mozharness: 2017-01-25 12:38:28.337663Z] Finished download-and-extract step (success) 04:38:28 INFO - [mozharness: 2017-01-25 12:38:28.337798Z] Running populate-webroot step. 04:38:28 INFO - Running pre-action listener: _resource_record_pre_action 04:38:28 INFO - Running main action method: populate_webroot 04:38:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:38:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:38:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:38:28 INFO - '--tppagecycles', 04:38:28 INFO - '7'], 04:38:28 INFO - 'tests': ['tsvgm']}}, 04:38:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:38:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:38:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:38:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:38:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:38:28 INFO - 'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:38:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:38:28 INFO - 'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['damp', 'tps']}, 04:38:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:38:28 INFO - 'tests': ['damp', 'tps']}, 04:38:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['dromaeo_dom']}, 04:38:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:38:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['basic_compositor_video']}, 04:38:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:38:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['a11yr', 04:38:28 INFO - 'ts_paint', 04:38:28 INFO - 'tpaint', 04:38:28 INFO - 'sessionrestore', 04:38:28 INFO - 'sessionrestore_no_auto_restore', 04:38:28 INFO - 'tabpaint']}, 04:38:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:38:28 INFO - 'ts_paint', 04:38:28 INFO - 'tpaint', 04:38:28 INFO - 'sessionrestore', 04:38:28 INFO - 'sessionrestore_no_auto_restore', 04:38:28 INFO - 'tabpaint']}, 04:38:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:38:28 INFO - 'ts_paint', 04:38:28 INFO - 'tpaint', 04:38:28 INFO - 'sessionrestore', 04:38:28 INFO - 'sessionrestore_no_auto_restore', 04:38:28 INFO - 'tabpaint']}, 04:38:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:38:28 INFO - 'ts_paint', 04:38:28 INFO - 'tpaint', 04:38:28 INFO - 'sessionrestore', 04:38:28 INFO - 'sessionrestore_no_auto_restore', 04:38:28 INFO - 'tabpaint']}, 04:38:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['a11yr', 04:38:28 INFO - 'ts_paint', 04:38:28 INFO - 'tpaint', 04:38:28 INFO - 'sessionrestore', 04:38:28 INFO - 'sessionrestore_no_auto_restore', 04:38:28 INFO - 'tabpaint']}, 04:38:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['a11yr', 04:38:28 INFO - 'ts_paint', 04:38:28 INFO - 'tpaint', 04:38:28 INFO - 'sessionrestore', 04:38:28 INFO - 'sessionrestore_no_auto_restore', 04:38:28 INFO - 'tabpaint']}, 04:38:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['tsvgx', 04:38:28 INFO - 'tsvgr_opacity', 04:38:28 INFO - 'tart', 04:38:28 INFO - 'tscrollx', 04:38:28 INFO - 'cart', 04:38:28 INFO - 'tsvg_static']}, 04:38:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:38:28 INFO - 'tsvgr_opacity', 04:38:28 INFO - 'tart', 04:38:28 INFO - 'tscrollx', 04:38:28 INFO - 'cart', 04:38:28 INFO - 'tsvg_static']}, 04:38:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:38:28 INFO - 'talos_options': ['--disable-e10s'], 04:38:28 INFO - 'tests': ['tp5o']}, 04:38:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:38:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:38:28 INFO - 'talos_options': ['--disable-e10s', 04:38:28 INFO - '--xperf_path', 04:38:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:28 INFO - 'tests': ['tp5n']}, 04:38:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:38:28 INFO - 'talos_options': ['--xperf_path', 04:38:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:28 INFO - 'tests': ['tp5n']}}, 04:38:28 INFO - 'talos.zip': {'path': '', 04:38:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:38:28 INFO - Running post-action listener: _resource_record_post_action 04:38:28 INFO - [mozharness: 2017-01-25 12:38:28.356344Z] Finished populate-webroot step (success) 04:38:28 INFO - [mozharness: 2017-01-25 12:38:28.356475Z] Running create-virtualenv step. 04:38:28 INFO - Running pre-action listener: _resource_record_pre_action 04:38:28 INFO - Running main action method: create_virtualenv 04:38:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:38:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:38:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:38:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:38:28 INFO - Using real prefix '/tools/python27' 04:38:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:38:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:38:32 INFO - Installing pip.................done. 04:38:32 INFO - Return code: 0 04:38:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:38:32 INFO - Reading from file tmpfile_stdout 04:38:32 INFO - Output received: 04:38:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:38:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:32 INFO - 'HOME': '/Users/cltbld', 04:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:32 INFO - 'LOGNAME': 'cltbld', 04:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:32 INFO - 'MOZ_NO_REMOTE': '1', 04:38:32 INFO - 'NO_EM_RESTART': '1', 04:38:32 INFO - 'PAGER': '/bin/cat', 04:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:32 INFO - 'PWD': '/builds/slave/test', 04:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:32 INFO - 'SHELL': '/bin/bash', 04:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:32 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:32 INFO - 'USER': 'cltbld', 04:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:32 INFO - 'XPC_FLAGS': '0x0', 04:38:32 INFO - 'XPC_SERVICE_NAME': '0', 04:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:38:32 INFO - Cleaning up... 04:38:32 INFO - Return code: 0 04:38:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:32 INFO - 'HOME': '/Users/cltbld', 04:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:32 INFO - 'LOGNAME': 'cltbld', 04:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:32 INFO - 'MOZ_NO_REMOTE': '1', 04:38:32 INFO - 'NO_EM_RESTART': '1', 04:38:32 INFO - 'PAGER': '/bin/cat', 04:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:32 INFO - 'PWD': '/builds/slave/test', 04:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:32 INFO - 'SHELL': '/bin/bash', 04:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:32 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:32 INFO - 'USER': 'cltbld', 04:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:32 INFO - 'XPC_FLAGS': '0x0', 04:38:32 INFO - 'XPC_SERVICE_NAME': '0', 04:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:32 INFO - Downloading/unpacking psutil>=3.1.1 04:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:38:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:36 INFO - Installing collected packages: psutil 04:38:36 INFO - Running setup.py install for psutil 04:38:36 INFO - building 'psutil._psutil_osx' extension 04:38:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:38:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:38:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:38:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:38:37 INFO - building 'psutil._psutil_posix' extension 04:38:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:38:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:38:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:38:37 INFO - ^ 04:38:37 INFO - 1 warning generated. 04:38:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:38:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:37 INFO - Successfully installed psutil 04:38:37 INFO - Cleaning up... 04:38:37 INFO - Return code: 0 04:38:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:37 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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:37 INFO - 'HOME': '/Users/cltbld', 04:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:37 INFO - 'LOGNAME': 'cltbld', 04:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:37 INFO - 'MOZ_NO_REMOTE': '1', 04:38:37 INFO - 'NO_EM_RESTART': '1', 04:38:37 INFO - 'PAGER': '/bin/cat', 04:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:37 INFO - 'PWD': '/builds/slave/test', 04:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:37 INFO - 'SHELL': '/bin/bash', 04:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:37 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:37 INFO - 'USER': 'cltbld', 04:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:37 INFO - 'XPC_FLAGS': '0x0', 04:38:37 INFO - 'XPC_SERVICE_NAME': '0', 04:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:38:40 INFO - Installing collected packages: mozsystemmonitor 04:38:40 INFO - Running setup.py install for mozsystemmonitor 04:38:40 INFO - Successfully installed mozsystemmonitor 04:38:40 INFO - Cleaning up... 04:38:40 INFO - Return code: 0 04:38:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:40 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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:40 INFO - 'HOME': '/Users/cltbld', 04:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:40 INFO - 'LOGNAME': 'cltbld', 04:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:40 INFO - 'MOZ_NO_REMOTE': '1', 04:38:40 INFO - 'NO_EM_RESTART': '1', 04:38:40 INFO - 'PAGER': '/bin/cat', 04:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:40 INFO - 'PWD': '/builds/slave/test', 04:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:40 INFO - 'SHELL': '/bin/bash', 04:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:40 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:40 INFO - 'USER': 'cltbld', 04:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:40 INFO - 'XPC_FLAGS': '0x0', 04:38:40 INFO - 'XPC_SERVICE_NAME': '0', 04:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:44 INFO - warning: no files found matching '*.txt' 04:38:44 INFO - no previously-included directories found matching 'build' 04:38:44 INFO - no previously-included directories found matching 'dist' 04:38:44 INFO - no previously-included directories found matching '.git*' 04:38:44 INFO - Installing collected packages: jsonschema, functools32 04:38:44 INFO - Running setup.py install for functools32 04:38:44 INFO - warning: no files found matching '*.txt' 04:38:44 INFO - no previously-included directories found matching 'build' 04:38:44 INFO - no previously-included directories found matching 'dist' 04:38:44 INFO - no previously-included directories found matching '.git*' 04:38:44 INFO - Successfully installed jsonschema functools32 04:38:44 INFO - Cleaning up... 04:38:44 INFO - Return code: 0 04:38:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:38: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:38: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 functools32==3.2.3-2 04:38:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:44 INFO - 'HOME': '/Users/cltbld', 04:38:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:44 INFO - 'LOGNAME': 'cltbld', 04:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:44 INFO - 'MOZ_NO_REMOTE': '1', 04:38:44 INFO - 'NO_EM_RESTART': '1', 04:38:44 INFO - 'PAGER': '/bin/cat', 04:38:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:44 INFO - 'PWD': '/builds/slave/test', 04:38:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:44 INFO - 'SHELL': '/bin/bash', 04:38:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:44 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:44 INFO - 'USER': 'cltbld', 04:38:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:44 INFO - 'XPC_FLAGS': '0x0', 04:38:44 INFO - 'XPC_SERVICE_NAME': '0', 04:38:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:38:44 INFO - Cleaning up... 04:38:44 INFO - Return code: 0 04:38:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:38: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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', '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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:38: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 blobuploader==1.2.4 04:38:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:44 INFO - 'HOME': '/Users/cltbld', 04:38:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:44 INFO - 'LOGNAME': 'cltbld', 04:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:44 INFO - 'MOZ_NO_REMOTE': '1', 04:38:44 INFO - 'NO_EM_RESTART': '1', 04:38:44 INFO - 'PAGER': '/bin/cat', 04:38:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:44 INFO - 'PWD': '/builds/slave/test', 04:38:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:44 INFO - 'SHELL': '/bin/bash', 04:38:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:44 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:44 INFO - 'USER': 'cltbld', 04:38:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:44 INFO - 'XPC_FLAGS': '0x0', 04:38:44 INFO - 'XPC_SERVICE_NAME': '0', 04:38:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:38:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:48 INFO - Downloading docopt-0.6.1.tar.gz 04:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:48 INFO - Running setup.py install for blobuploader 04:38:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:49 INFO - Running setup.py install for requests 04:38:49 INFO - Running setup.py install for docopt 04:38:49 INFO - Successfully installed blobuploader requests docopt 04:38:49 INFO - Cleaning up... 04:38:49 INFO - Return code: 0 04:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:49 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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:49 INFO - 'HOME': '/Users/cltbld', 04:38:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:49 INFO - 'LOGNAME': 'cltbld', 04:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:49 INFO - 'MOZ_NO_REMOTE': '1', 04:38:49 INFO - 'NO_EM_RESTART': '1', 04:38:49 INFO - 'PAGER': '/bin/cat', 04:38:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:49 INFO - 'PWD': '/builds/slave/test', 04:38:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:49 INFO - 'SHELL': '/bin/bash', 04:38:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:49 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:49 INFO - 'USER': 'cltbld', 04:38:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:49 INFO - 'XPC_FLAGS': '0x0', 04:38:49 INFO - 'XPC_SERVICE_NAME': '0', 04:38:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-O3YjYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-OUKyWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-TQM7Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Ww0vmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-xVMHeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-YcDJi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-74XRRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-9R0g0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:50 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-d4jL2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-bk5MqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Wg2rIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-D5GuI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ccH9Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-cPU2i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-mA02kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-oT8RzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:51 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-FZLcei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:51 INFO - Running setup.py install for manifestparser 04:38:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:52 INFO - Running setup.py install for mozcrash 04:38:52 INFO - Running setup.py install for mozdebug 04:38:52 INFO - Running setup.py install for mozdevice 04:38:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:52 INFO - Running setup.py install for mozfile 04:38:52 INFO - Running setup.py install for mozhttpd 04:38:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:52 INFO - Running setup.py install for mozinfo 04:38:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:52 INFO - Running setup.py install for mozInstall 04:38:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Running setup.py install for mozleak 04:38:53 INFO - Running setup.py install for mozlog 04:38:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Running setup.py install for moznetwork 04:38:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Running setup.py install for mozprocess 04:38:53 INFO - Running setup.py install for mozprofile 04:38:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:53 INFO - Running setup.py install for mozrunner 04:38:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:54 INFO - Running setup.py install for mozscreenshot 04:38:54 INFO - Running setup.py install for moztest 04:38:54 INFO - Running setup.py install for mozversion 04:38:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:54 INFO - Cleaning up... 04:38:54 INFO - Return code: 0 04:38:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:54 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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:38:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:54 INFO - 'HOME': '/Users/cltbld', 04:38:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:54 INFO - 'LOGNAME': 'cltbld', 04:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:54 INFO - 'MOZ_NO_REMOTE': '1', 04:38:54 INFO - 'NO_EM_RESTART': '1', 04:38:54 INFO - 'PAGER': '/bin/cat', 04:38:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:54 INFO - 'PWD': '/builds/slave/test', 04:38:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:54 INFO - 'SHELL': '/bin/bash', 04:38:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:38:54 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:38:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:54 INFO - 'USER': 'cltbld', 04:38:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:54 INFO - 'XPC_FLAGS': '0x0', 04:38:54 INFO - 'XPC_SERVICE_NAME': '0', 04:38:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-6fhKpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-VqANq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ZWI_9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-jn02xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Uu5NlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-bLgKRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-1VrChp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-i9BXqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-G5Lidp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-kYohNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-A6gG3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:55 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-9tmchD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-iftywd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-m5UghZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-mEL_Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-0OxxGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:56 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-J1rWlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:59 INFO - Downloading blessings-1.6.tar.gz 04:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:59 INFO - Installing collected packages: blessings 04:38:59 INFO - Running setup.py install for blessings 04:39:00 INFO - Successfully installed blessings 04:39:00 INFO - Cleaning up... 04:39:00 INFO - Return code: 0 04:39:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:00 INFO - Reading from file tmpfile_stdout 04:39:00 INFO - Current package versions: 04:39:00 INFO - blessings == 1.6 04:39:00 INFO - blobuploader == 1.2.4 04:39:00 INFO - docopt == 0.6.1 04:39:00 INFO - functools32 == 3.2.3-2 04:39:00 INFO - jsonschema == 2.5.1 04:39:00 INFO - manifestparser == 1.1 04:39:00 INFO - mozInstall == 1.12 04:39:00 INFO - mozcrash == 1.0 04:39:00 INFO - mozdebug == 0.1 04:39:00 INFO - mozdevice == 0.49 04:39:00 INFO - mozfile == 1.2 04:39:00 INFO - mozhttpd == 0.7 04:39:00 INFO - mozinfo == 0.9 04:39:00 INFO - mozleak == 0.1 04:39:00 INFO - mozlog == 3.4 04:39:00 INFO - moznetwork == 0.27 04:39:00 INFO - mozprocess == 0.24 04:39:00 INFO - mozprofile == 0.28 04:39:00 INFO - mozrunner == 6.13 04:39:00 INFO - mozscreenshot == 0.1 04:39:00 INFO - mozsystemmonitor == 0.3 04:39:00 INFO - moztest == 0.8 04:39:00 INFO - mozversion == 1.4 04:39:00 INFO - psutil == 3.1.1 04:39:00 INFO - requests == 1.2.3 04:39:00 INFO - wsgiref == 0.1.2 04:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:00 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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:00 INFO - 'HOME': '/Users/cltbld', 04:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:00 INFO - 'LOGNAME': 'cltbld', 04:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:00 INFO - 'MOZ_NO_REMOTE': '1', 04:39:00 INFO - 'NO_EM_RESTART': '1', 04:39:00 INFO - 'PAGER': '/bin/cat', 04:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:00 INFO - 'PWD': '/builds/slave/test', 04:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:00 INFO - 'SHELL': '/bin/bash', 04:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:39:00 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:00 INFO - 'USER': 'cltbld', 04:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:00 INFO - 'XPC_FLAGS': '0x0', 04:39:00 INFO - 'XPC_SERVICE_NAME': '0', 04:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:01 INFO - Cleaning up... 04:39:01 INFO - Return code: 0 04:39:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:01 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 0x104e8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa659583fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, '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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:01 INFO - 'HOME': '/Users/cltbld', 04:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:01 INFO - 'LOGNAME': 'cltbld', 04:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:01 INFO - 'MOZ_NO_REMOTE': '1', 04:39:01 INFO - 'NO_EM_RESTART': '1', 04:39:01 INFO - 'PAGER': '/bin/cat', 04:39:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:01 INFO - 'PWD': '/builds/slave/test', 04:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:01 INFO - 'SHELL': '/bin/bash', 04:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:39:01 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:01 INFO - 'USER': 'cltbld', 04:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:01 INFO - 'XPC_FLAGS': '0x0', 04:39:01 INFO - 'XPC_SERVICE_NAME': '0', 04:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:39:01 INFO - Cleaning up... 04:39:01 INFO - Return code: 0 04:39:01 INFO - Running post-action listener: _resource_record_post_action 04:39:01 INFO - Running post-action listener: _start_resource_monitoring 04:39:01 INFO - Starting resource monitoring. 04:39:01 INFO - [mozharness: 2017-01-25 12:39:01.478509Z] Finished create-virtualenv step (success) 04:39:01 INFO - [mozharness: 2017-01-25 12:39:01.479667Z] Running install step. 04:39:01 INFO - Running pre-action listener: _resource_record_pre_action 04:39:01 INFO - Running main action method: install 04:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:01 INFO - Reading from file tmpfile_stdout 04:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:01 INFO - Reading from file tmpfile_stdout 04:39:01 INFO - Output received: 04:39:01 INFO - Usage: mozinstall [options] installer 04:39:01 INFO - Options: 04:39:01 INFO - -h, --help show this help message and exit 04:39:01 INFO - -d DEST, --destination=DEST 04:39:01 INFO - Directory to install application into. [default: 04:39:01 INFO - "/builds/slave/test"] 04:39:01 INFO - --app=APP Application being installed. [default: firefox] 04:39:01 INFO - mkdir: /builds/slave/test/build/application 04:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:39:24 INFO - Reading from file tmpfile_stdout 04:39:24 INFO - Output received: 04:39:24 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:39:24 INFO - Running post-action listener: _resource_record_post_action 04:39:24 INFO - [mozharness: 2017-01-25 12:39:24.047023Z] Finished install step (success) 04:39:24 INFO - [mozharness: 2017-01-25 12:39:24.047162Z] Running run-tests step. 04:39:24 INFO - Running pre-action listener: _resource_record_pre_action 04:39:24 INFO - Running main action method: run_tests 04:39:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:24 INFO - 2017-01-25 04:39:24.062 screenresolution[30757:298166] starting screenresolution argv=screenresolution get 04:39:24 INFO - 2017-01-25 04:39:24.065 screenresolution[30757:298166] Display 0: 1600x1200x32@60 04:39:24 INFO - 2017-01-25 04:39:24.071 screenresolution[30758:298168] starting screenresolution argv=screenresolution list 04:39:24 INFO - Available Modes on Display 0 04:39:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:24 INFO - Intel Iris: 04:39:24 INFO - Chipset Model: Intel Iris 04:39:24 INFO - Type: GPU 04:39:24 INFO - Bus: Built-In 04:39:24 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:24 INFO - Vendor: Intel (0x8086) 04:39:24 INFO - Device ID: 0x0a2e 04:39:24 INFO - Revision ID: 0x0009 04:39:24 INFO - Displays: 04:39:24 INFO - Display: 04:39:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:24 INFO - Display Serial Number: 1600x1200 60 04:39:24 INFO - Main Display: Yes 04:39:24 INFO - Mirror: Off 04:39:24 INFO - Online: Yes 04:39:24 INFO - Rotation: Supported 04:39:24 INFO - Return code: 0 04:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:24 INFO - Python 2.7.3 04:39:24 INFO - Return code: 0 04:39:24 INFO - grabbing minidump binary from tooltool 04:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:24 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 0x104c6ad30>, '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 0x104b91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c5fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:39:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:39:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:39:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:24 INFO - Return code: 0 04:39:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:39:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:39:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:24 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/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:39:24 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/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0371 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UfKd9KgSrB/Render', 04:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:24 INFO - 'HOME': '/Users/cltbld', 04:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:24 INFO - 'LOGNAME': 'cltbld', 04:39:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:24 INFO - 'MOZ_NO_REMOTE': '1', 04:39:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:24 INFO - 'NO_EM_RESTART': '1', 04:39:24 INFO - 'PAGER': '/bin/cat', 04:39:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:24 INFO - 'PWD': '/builds/slave/test', 04:39:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:24 INFO - 'SHELL': '/bin/bash', 04:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZDOpCjKV5H/Listeners', 04:39:24 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 04:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:24 INFO - 'USER': 'cltbld', 04:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:24 INFO - 'XPC_FLAGS': '0x0', 04:39:24 INFO - 'XPC_SERVICE_NAME': '0', 04:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:24 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/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:39:24 INFO - mozversion application_buildid: 20170125030214 04:39:24 INFO - mozversion application_changeset: 6dccae211ae5fec6a1c1244b878ce0b93860154f 04:39:24 INFO - mozversion application_display_name: Nightly 04:39:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:24 INFO - mozversion application_name: Firefox 04:39:24 INFO - mozversion application_remotingname: firefox 04:39:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:39:24 INFO - mozversion application_vendor: Mozilla 04:39:24 INFO - mozversion application_version: 54.0a1 04:39:24 INFO - mozversion platform_buildid: 20170125030214 04:39:24 INFO - mozversion platform_changeset: 6dccae211ae5fec6a1c1244b878ce0b93860154f 04:39:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:39:24 INFO - mozversion platform_version: 54.0a1 04:39:24 INFO - using testdate: 1485347964 04:39:24 INFO - actual date: 1485347964 04:39:24 INFO - starting webserver on 'localhost:56459' 04:39:24 INFO - SUITE-START | Running 2 tests 04:39:24 INFO - TEST-START | dromaeo_css 04:39:24 INFO - operating with platform_type : mac_ 04:39:24 INFO - Initialising browser for dromaeo_css test... 04:39:24 INFO - TEST-INFO | started process 30768 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpfflkVc/profile http://localhost:56459/getInfo.html) 04:39:27 INFO - PROCESS | 30768 | 2017-01-25 04:39:27.975 plugin-container[30771:298327] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d37, name = 'com.apple.tsm.portname' 04:39:27 INFO - PROCESS | 30768 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:39:27 INFO - PROCESS | 30768 | 2017-01-25 04:39:27.976 plugin-container[30771:298327] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9703, name = 'com.apple.CFPasteboardClient' 04:39:27 INFO - PROCESS | 30768 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:39:27 INFO - PROCESS | 30768 | 2017-01-25 04:39:27.976 plugin-container[30771:298327] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:39:28 INFO - PROCESS | 30768 | __metrics Screen width/height:1600/1200 04:39:28 INFO - PROCESS | 30768 | colorDepth:24 04:39:28 INFO - PROCESS | 30768 | Browser inner width/height: 1024/689 04:39:28 INFO - PROCESS | 30768 | __metrics 04:39:28 ERROR - PROCESS | 30768 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 04:39:28 INFO - TEST-INFO | 30768: exit 0 04:39:28 INFO - Browser initialized. 04:39:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:39:28 INFO - TEST-INFO | started process 30772 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpfflkVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:31 INFO - PROCESS | 30772 | 2017-01-25 04:39:31.300 plugin-container[30773:298449] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 04:39:31 INFO - PROCESS | 30772 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:39:31 INFO - PROCESS | 30772 | 2017-01-25 04:39:31.301 plugin-container[30773:298449] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f13, name = 'com.apple.CFPasteboardClient' 04:39:31 INFO - PROCESS | 30772 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:39:31 INFO - PROCESS | 30772 | 2017-01-25 04:39:31.301 plugin-container[30773:298449] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:39:40 INFO - PROCESS | 30772 | RSS: Main: 233504768 04:39:40 INFO - PROCESS | 30772 | 04:42:42 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:56459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56459/tests/dromaeo/cssquery-ext.html) 04:42:44 INFO - PROCESS | 30772 | RSS: Main: 251994112 04:42:44 INFO - PROCESS | 30772 | 04:44:29 INFO - PROCESS | 30772 | ************************* 04:44:29 INFO - PROCESS | 30772 | A coding exception was thrown and uncaught in a Task. 04:44:29 INFO - PROCESS | 30772 | 04:44:29 ERROR - PROCESS | 30772 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:44:29 INFO - PROCESS | 30772 | Full stack: 04:44:29 INFO - PROCESS | 30772 | ************************* 04:45:47 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:56459/tests/dromaeo/cssquery-ext.html (next: http://localhost:56459/tests/dromaeo/cssquery-jquery.html) 04:45:47 INFO - PROCESS | 30772 | RSS: Main: 265027584 04:45:47 INFO - PROCESS | 30772 | 04:48:49 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:56459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56459/tests/dromaeo/cssquery-mootools.html) 04:48:50 INFO - PROCESS | 30772 | RSS: Main: 272723968 04:48:50 INFO - PROCESS | 30772 | 04:51:52 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:56459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56459/tests/dromaeo/cssquery-prototype.html) 04:51:52 INFO - PROCESS | 30772 | RSS: Main: 268902400 04:51:52 INFO - PROCESS | 30772 | 04:54:55 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:56459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56459/tests/dromaeo/cssquery-yui.html) 04:54:56 INFO - PROCESS | 30772 | RSS: Main: 274853888 04:54:56 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:56459/tests/dromaeo/cssquery-yui.html (next: http://localhost:56459/tests/dromaeo/cssquery-dojo.html) 04:57:59 INFO - PROCESS | 30772 | RSS: Main: 276942848 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | __start_tp_report 04:57:59 INFO - PROCESS | 30772 | _x_x_mozilla_page_load 04:57:59 INFO - PROCESS | 30772 | _x_x_mozilla_page_load_details 04:57:59 INFO - PROCESS | 30772 | |i|pagename|runs| 04:57:59 INFO - PROCESS | 30772 | |0;dojo.html;2764.7926405519593;2889.436559870823;3095.6130483689535;3232.1757951722307;3320.7841490303113;4231.873043808683;5638.210650508927;5713.571482138836;5728.856778580533;5770.307563092435;5590;5669.09294512877;5692.37383887772;5696.003199440102;5727.799527016556;5093.872653183663;5130.153524668444;5175.964807038588;5191.091558977183;5242.449542798008;4720.62785521847;5190.688558686472;5222.164453687411;5239.345081864767;5322.600804939645;5042.0168067226905;5240.475952404767;5249.86875328116;5255.500727430888;5288.444713305105;5047.64666473347;5051.545360917535;5066.847994560169;5102.566281866046;5183.922241166386;5059.772310246048;5088.567471764904;5125.487451254882;5132.944973470953;5133.4609865964285;4383.145286669069;5439.864003399907;5450.91823622646;5621.718914054321;5679.772809087632;6072.908906366408;6133.294671112834;6148.754049838001;6173.691315434256;6199.659018753967;5208.531232189083;6240.906386404207;6252.374762523711;6285.057241413779;6298.3701629837105;4823.589994850442;5822.446867547576;5845.006348920694;5858.443447872445;5863.2670916135485;6166.475849552839;6171;6181.938180618226;6230.283517395557;6268.968655156787;6102.099711414106;6124.472479235491;6142.989934931851;6146.139540464339;6159.907601385983;6180.3201647818705;6209.9068513972325;6230.844228894314;6248.343923888017;6260;6060.939390606126;6120.477608373095;6132.171952247653;6142.262928448615;6232.096346029891;4540.02389486262;5912.793052243151;6238.500919926395;6277.183966084471;6278.340774218641;4090.986250212183;4817.205161148371;4949.653524253267;4964.67729597575;4991.5258050485145;4355.0854320593035;4375.496817865923;4393.319035549495;4452.844150454718;4481.75350355727;5124;5798.797042103506;5848.853778655568;5946.464818166386;5950.2264705587995;5266.262723218752;6237.877182107264;6264.718087686065;6268.059791031382;6285.528585356025;5315.920261196085;5349.063913815066;5623.5220006299105;5695.515881150149;5839.007368747323;5364.892702145935;5389.622726409192;5424.376196737347;5442.455754424526;5470.316210473691;6298.622082675054;6311.779087731908;6314.463270622048;6315.242170939425;6331.810045698637;6089.360617135137;6146.78486252979;6164.352742962104;6165.414285642857;6197.163382943425;6140.201773769381;6164.506839452923;6177.980633195472;6194.38056194377;6341.365863413622;6085.878282434415;6126.816195514141;6176.413240742122;6179.28938172116;6193.597416167935;6153.107799369156;6156.969215153896;6227.688615569294;6250.468710159687;6275.090111933835;5923.437273459187;6065.3934606539;6080.118382834553;6088.939110608837;6143.72353244114;6140.565599444613;6149.846253843511;6154;6159.106929495288;6170.969145154246;4940.258961155711;5825.70871456417;5883.852903677271;6033.215681961493;6077.4226448487325;6109.283207920518;6123.540734444845;6135;6199.070139479114;6228.532860035425;6068.757249709962;6071.392860713893;6074.483668888017;6075.696215189311;6078.574499784972 04:57:59 INFO - PROCESS | 30772 | |1;ext.html;453.56457800511487;455.33066392403157;466.79461037143653;476.5829898838516;481.559373173546;37524;40180.39729404061;40214;40222;40237.59762402375;34484.827575862146;41092.17815643685;41696.58303416965;41730;41937.580624193746;8113.553754543498;8377;8571.699990500334;9116.95441522793;9343.084667643117;11248.437578121102;11572.768544629102;11573.710657233594;11730.35483048432;11731.237469564494;11475.655730328062;11530.481128349244;11549.595764148256;11563.653090407259;11575.479103440322;11473.196876218668;11555.942220288845;11558.8266176007;11569.42152892352;11584.47869845859;10150.847737283946;11370.772584548346;11453.026492748126;11459.541618335257;11478;40812.591874081474;40910.181796363904;41025.38461923043;41230.79384603088;41385;4030.7380020298588;4043.8786836394956;4147.523034851;4149;4228.851990180329;30401.695983040107;31300.217494562592;31609.525857112163;31675.891343802858;31743.365132697218;3122.6252849658185;3236.8219747913854;3254.804711717281;3296.5055241713935;3301.2572171261513;388513;464007;465723.6713816443;467569;468113;46454;59689;62727.431814204094;66814.33185668082;66919;56299;59002;69980.3001969984;70345.2965470349;70352.2964770356;16282.348706051862;16832.32670693183;16847.74728379075;16849.747253791204;16887.240074196692;11510.424478776027;11850.76298474043;12246.632601021984;12688;12862.871371286354;12657.810132848015;15535.533933981998;15563.377464901503;15611.765823512656;15703.68592628141;5560.193771903051;6216.228285624897;6298.212723409574;6383.776567820104;6447.774327898501;854.9914500855036;859.26532814444;859.3383095016802;862.215384000569;866.0386970462781;29829.403411932075;30436.239094022825;30556.54165187524;30723;31227;856.9185927336893;929.5166513412987;999.4003597841382;1049.8740151181908;1176.8117101263756;15753;15874.365025398854;15990.600234994217;16084.276207570687;16260.349586016664;549587;551402;553926.9214615686;554765;554798;57831.4216857826;57916.71041644849;57993;58007;58095.709521452125;1358.2936872826076;1415.6956254405352;1417.1143035602543;1417.5534706567398;1417.907835990678;23266;28481;29069.563956541093;29681.85159074191;30599.54100688536;50164.49835501598;50602;50648;50731.23903141382;50744.492555075456;507712;509550;510191;510643;511029.44485278823;23297.301080967598;23927.401814954766;24126.39684007914;24852;39880;40301.74568577684;40432.3935140979;40479.79760101181;40832.591674082876;41166.58833411628;28085.297867553476;32688.673113269513;33831;34663.65336346705;35904.28191436209;35675;36028.91913242607;36141;36606.084847879014;37007.62992370042;35113.297734045686;35220;35490.467642985896;35631;35745.64254357527;29900.700992990664;30615.54076688807;30851.228719282197;30936.845315773277;30949.226269342547;21091.683624745947;23244.418889527897;23381.649275261225;23572.882135589898;24091.63862542028 04:57:59 INFO - PROCESS | 30772 | |2;jquery.html;316.7893350921637;384.89415410762035;385.35645472061674;400.5033758139907;414.6226933490522;19706.605867882652;21104.472388190305;21118.99999999998;21319.786802131974;21334.786652133473;21345;21858.89070554649;21909.890450547726;22054.33836984889;22389.664155037688;5807.332156801958;5930.466258036776;6092.329843717188;6171.506279497629;6252.531060170482;3992.4610177626087;4987.850364489072;6133.907991380132;6167.660778657172;6205.441510264075;6757.526973111884;6884.414824739903;6891.1041564596535;6893.7931862044215;6897.379235868771;6174;6176.505879529627;6226.688665566703;6234.283057448406;6869.484788640872;5771.769129234825;6011.75952961881;6076.939230607726;6092.5430592705725;6094.329623741385;11159;13818.37817298224;13847.930760346235;13853.584392468241;13880.652983675387;2645.9603105953233;2647.7219891911263;2661.5209262332774;2665.0805472112093;2678.6116013178175;10200.540975656113;10244.129249013842;10275.588976440933;10563.577456901714;10791.46042697862;1638.6394993101499;1847.5473508990383;1896.82928536431;1907.9523011924673;1909.799471055533;116894;137392;145026;145430.27284863614;147297;11813.527458901548;11827.112966527546;11977.52089916411;12062;12184.634460966185;15521.767173492406;15551.455699050704;15627.062376257461;15627.843721562866;15646.982946108466;7200.855982880313;8326.542040187727;8637.654493820302;8647;8810.647574097093;8251.910802931221;8343.165683431609;8423.241908228289;8451.661933522713;8589.226969572768;4190.895227619273;4472.418585583853;4669.9726060266685;4823.986962737864;4829.613630909519;1428.4072110074203;1732.3503686117706;1992.9302474413325;2062.2885104638876;2065.0397565131984;893.7765558610347;964.252704154286;978.1685567267765;1021.7279487038685;1045.639254457211;21530;21838.730450322615;21864.299806682026;21959.52354802976;21986.340409787732;1013.7972405518926;1022.8721409823772;1032.932859364139;1063.8191507443753;1064.4571268653042;11291.887081129247;11472.713182170346;11490.310581364978;11529.365884876412;11540.769184616262;659376;678446;703734;711272;717961;153566;155309.13944896255;155850.22074889552;157166.21416892842;162378;857.3912522109248;956.258899353007;985.7584891701579;1003.4781913404988;1006.3559322033905;17747.201375938374;19081;19393.515162120497;19427.12577933968;19609.31367402134;58812.58905582013;59559;60108.098378523486;61630.69184654048;61649.76700465876;60673.69663151656;81236.59381703053;85188.57405712931;86401;86696.1330386688;5693.28833895763;7417.851642967003;7506.128061539784;7610.6194690266375;7818.257265559762;12483.93758031204;12839.229646221256;12842.422091006114;13410.530631427853;13518.324083795967;9582.94587595378;11313.434328283718;11427.60003399877;11458.255213411101;11588.710282243012;10976.835347469634;11198.83201751958;11354.205205635526;11564.190506664789;11734.530618775154;6049.818505444844;7068.823279418056;11348.035416989318;11390.37352945596;11395.544178233109;6307.463865571478;7500.812479688051;7570.16728159913;7629.6566654499575;7683.807904802201;10204.336718113596;10859.131269498579;11402.82895756581;11532.25040372373;11656.06751459898 04:57:59 INFO - PROCESS | 30772 | |3;mootools.html;1411;1434.7847822826575;1440.2438719672177;1442.0050165385883;1459.7372472954864;7416.480846340744;7633.656485458154;7909.960450197748;8412.074671786106;8419.536925469096;7888.80277993049;8144.511329320245;8169.101398846137;8221.671133154681;8318.70884519042;2268.1834539565743;2318.6985691860036;2320.4546931471177;2323.3494621506006;2327.406511339606;2079.095593416861;2163.6862654915026;2288.5079707862806;2334.078039174525;2347.1315613223132;1973.4868934077172;2245.5733410652006;2313.4910319729634;2317.1310758465575;2328.382978510696;2288.4507718147693;2294.4608017115966;2311.28350211435;2312;2319.478117423583;1886.4812176651394;2315.5947709151;2328.5342931413784;2348.436375269923;2360.996576455017;7120.359167674934;8332.7083552076;8359.791005224857;8375.612950309194;8385.664573417056;4265.402843601898;4320.395144679747;4467.441569803775;5047.0915235257635;5182.393458028024;3200.9199770005703;3365.0914253151755;3435.7594968352223;3441.8623255069765;3444.793312401264;987.5506644476745;1093.94530273486;1123.0341905960868;1160.7794519041356;1183.1185766603849;10571.207159462994;10631;10691.037806597365;10692.358458492437;10727.980841820015;4083.4079058536345;4596.908061838744;4671.579557839811;4673.228917228619;4685.437747470257;9280.02559731232;9308.627654893864;9386.014468480847;9389.154976052052;9397.671081512115;5139.408967968731;5228.581713462914;5234.738263086907;5238.978399212117;5264.52619264268;4212.53662097169;4548.952971162924;4788.61691064714;4793.400824896888;4800.543948324904;3813.8474461021246;3872.0707030313088;3882.1265215326325;3921.3725803871816;3939.684825213976;1145.7021174494525;1180.6340034589305;1265.7911444611536;1271.319843883518;1275.05645822091;760.7831767946109;762.9656665450068;787.1105650614769;808.4825711544617;832.317499650293;5190.143626301618;5478.726063696879;5521.365043020024;5573.498385145275;5733.799317023884;843.9704610338608;952.8094381123803;965.2471072563412;965.8454647256406;995.7908839143861;3678.3378991781738;3689.317476266899;3744.4570537271943;3769.4722738816586;3810.1427178885083;9266.629334826532;9800.852987205197;9850.408975461496;9852.753681158028;9867.555959981819;9702.320837541445;9753.414795112316;9788.119069283655;9822.557984890555;9838.36050656705;7694.384449244047;7809.804754881174;7836.177201393885;7837.1379148293645;7861.960690196627;4774;5321.36143662763;5378.40837507866;5440.265564148789;5532.751026203911;9024.593893274687;9051.27589792828;9206.539673016188;9209.815803684023;9319.58061887203;9234.399764015317;9258.768530786785;9287.349885507949;9362.672306469241;9427.245820334494;6216.751329946752;7031.753888613874;7189.964050179716;7204.819879503054;7213.531120477152;7400.370968467741;7734.265244801735;7761.534307941542;7810.297073263434;7900.960495197487;6375.87248255023;7041.616779853794;7143.392811611071;7175.641217939186;7216.603086830275;7021.613811240431;7044.295570442915;7059.223485416497;7117.964410177916;7142.642867856483;6380.138681277968;6398.168238129014;6451.645159516272;6466.191726034246;6488.578242414228;4047.4535937648043;4921.4832442593015;4952.034353301072;5034.546890779848;5145.768440420115;4178.916421671489;4988.551030407136;5080.974595127001;5118.078745825787;5134.5635620972635 04:57:59 INFO - PROCESS | 30772 | |4;prototype.html;310.55745562573327;350.08627482271277;352.7019668380218;356.02271764007793;369.6303696303696;4356.063446359036;4591.471980722218;5133.845984620458;5169.612279079075;5240.44975277596;4645.698029628072;5273.525382715555;5334.759935802888;5363.302770639812;5369.328833895763;3532.9646703532894;3608.2963822054708;3754.4556039374274;4210.189618464059;4247.978760106195;4080.3879418087226;4215.936760948588;4247.532771395144;4253.936190957123;4259.508187710193;3903.863364782233;4092.6112019358116;4169.916601667965;4189.245935731567;4200.432941552897;3717.680223520665;3982;3989.5212574490956;4118.5263694675195;4209.34755112958;3699.278640665071;3706.610805865372;3709.9443508347395;3727.2172843702856;3742.4947632069593;4302.913941721179;4611.2852507861335;4849.714825571226;4966.6590020694575;5129.538341549279;3726.7329108103377;4399.780010999437;4841.886366135774;4853.126437241295;4865.978144589605;5102.515261050232;5449;5669.6314739541795;5694.6867922264255;5749.942500574983;3274.5579346788118;3315.651856555051;3598.712103031751;3691.870784522529;3900.668443182333;5300.754322734155;5328.653637513549;5696.379665353942;5971.343152253248;6107.083937409379;3368.309496553201;3835.328817456934;3950.6839452843706;3960.5643379228263;3966.345552983725;3763.2661630982243;3976.8608098716404;4010;4033.74953764334;4038.1116154445976;4687.6874475147015;4696.158823911553;4714.104320179155;4726.740029298421;4753.548412900769;4796.760161991887;5515.503604675519;5618.4662457066515;5758.452946970031;5767.625104368287;1176.8999635030948;1237.4369661803858;1258.6853286678331;1283.4545318239711;1286.9871301286867;782.9469363705806;832.800127969283;860.3438381116326;862.7627402464248;866.787637028932;4958.0083983202785;4973.035650917939;5121.8463446096675;5143.819966301162;5157.974210128926;4927.630427717935;4987.0524600325825;5150.690958542499;5603.103503439512;5692.943070569324;4486.904036215001;4628.791704373311;4724.976375118171;4734.242521196661;5172.431032586413;2497.737737537532;2614.41175735458;2914.9562756558666;2967.807092538978;2976.8511574421627;4832.864276894927;5028.698278103326;5653.240595004276;5742.167385729046;5775.826725198251;5275.683458992396;5517.806876759294;5592.064166312718;5731.971340143273;5841.532677385799;5010.699358038456;5106.617003724661;5248.711320877388;5375.543078838265;5844.970775146097;4902.916260589307;5114.846554603368;5342.839714808562;5460.863478413072;5662.207290979349;4832.589229915497;5111.488851114858;5368;5514.944850551443;5565.4991050804;5741.531141609148;5806.361300256884;5847.502962248086;5856.4143585641095;5860.648361098348;3369.966300336965;3533.611302756746;3659.6212461898913;3747.6439738224826;3813.8093095345675;4539.341795439576;4831.777382404133;5492.368377636623;5867.044949376472;5885.61743486672;5461.9686074229185;5504.504594586507;5596.468335508121;5729.169270455677;5781.352314590322;5345.305110335787;5478.479544443271;5717.828465146053;5755.683437410982;5761.164631128379;5181.948180518147;5352.197170424468;5635.492805647511;5655.7454914528125;5676.403977582295;4779.5220477951925;5007.347575300215;5324.151578905267;5588.720563971704;5688.715564221689;4465.910681786411;5643.971780141073;5670.829875103754;5673.461021202979;5676.347220069745 04:57:59 INFO - PROCESS | 30772 | |5;yui.html;636.8312397214736;762.7063580521498;765.6248438265252;805.1143741883928;827.29266477162;13316.467341306336;15121.243937803094;15562.37750489979;16391.262393192304;16394.34422623095;12622.116451848375;15020.173890436048;15022.849771502282;15028.248587570604;15040.09759414436;670.4937771982171;695.6035060015793;822.5270469480043;851.940364174508;856.3235044314983;861.7285555050139;871.559862269553;872.2237208884098;872.3980453487105;873.0963452826326;788.5938741548107;937.610891480035;938.3853575907791;939.2204470289644;939.3706216834737;929.5259417696956;931.2363861633463;932.5756780664815;932.7528205025674;933.780561568031;690.1614538335946;690.3821080133303;691.0912150522047;692.3249831414381;692.8475735338218;15309.46416875404;15608.375664973388;15638.609034774108;15956.361745530165;16184.19079046043;14715.852841471662;14760.040597361138;14773.999999999893;14780.852191478056;14831.258437078212;9876.35803672766;9910.653127140515;11878.762424751456;11963.282203067756;12267.754644907141;3742.288965096623;3753.230587729509;3755.455458958436;3780.3384407728813;3899.200663863901;110103;113527.43236283766;114257.42871285674;114329;114918;8876.822463550821;9065.912090549044;10978.725531861768;11048.723781905517;11135;22263.777362226494;22344;22682.546349073255;22779.430514237276;22782.31653050411;8011.038675358877;8084.474509156886;8104.230098140667;8106.959465202636;8131.349492040623;4297.5702429756775;4333.783310834446;4360.869173924787;4380.518143004267;4413.7351758894565;3496.1609213789015;3603.279344131184;3637.418013117888;3641.817909104534;3644.344018076719;665.3446355339986;665.7270519087151;671.9865602687919;674.1169068520254;683.1835956032593;563.4731526023181;629.9181106456132;644.5166125405946;664.2759392262457;687.1136234257751;9591.808163836824;9980.401175929468;10303.948480257552;10519.368837869752;10609.522571484302;691.4192078653854;694.8193469697915;694.9200841903145;706.2584286499258;726.9236730143365;4762.166620841339;5031.7987280509105;5032.597392208614;5054.418741844662;5100.0819852426175;100717.49641251747;106319.40520892193;108554.45722771336;109428.4528577352;110835;83849.16150838535;84121.15878841134;84374.15625843786;93653;97843;59115.40884591185;76331.23668763241;76824.61587692138;79761.60119199367;85388;11004.724881878017;11190.048845847869;11333;11430;11473.655790326304;54482.72758636181;54658.726706366215;54977.72511137579;55165.44834551764;55352.06267780608;69450.30549694438;72254.63872680604;72358.55282894419;73151;73346.33073385451;12770.61688149357;12795.808062878878;12936.870631293566;12992.935035324763;13010;12606;13943.790843137564;14941.62645933817;15531.5340539784;15685.215739213221;12403.503859845505;13006.47974081064;13359.465621375424;14188.432462701376;14403.711925761636;12264.32546209967;13342.93328533351;14156.292185390896;14748.33632486562;14843.851561484247;13357.13178643385;13616.727665446833;13764.380602873094;13810.723785524435;14251.429942802171;11053.447327633425;11196.38419886914;11333.094070263733;11395.430228488376;11535.826962595736;9505.192058674813;10372.222083343628;11185.66443006711;11334.60328888485;11381.260218085798 04:57:59 INFO - PROCESS | 30772 | __end_tp_report 04:57:59 INFO - PROCESS | 30772 | __start_cc_report 04:57:59 INFO - PROCESS | 30772 | _x_x_mozilla_cycle_collect,383 04:57:59 INFO - PROCESS | 30772 | __end_cc_report 04:57:59 INFO - PROCESS | 30772 | __startTimestamp1485349079397__endTimestamp 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | ------- Summary: start ------- 04:57:59 INFO - PROCESS | 30772 | Number of tests: 6 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | [#0] dojo.html Cycles:165 Average:5659.86 Median:5950.23 stddev:716.09 (12.0%) stddev-sans-first:681.32 04:57:59 INFO - PROCESS | 30772 | Values: 2764.8 2889.4 3095.6 3232.2 3320.8 4231.9 5638.2 5713.6 5728.9 5770.3 5590.0 5669.1 5692.4 5696.0 5727.8 5093.9 5130.2 5176.0 5191.1 5242.4 4720.6 5190.7 5222.2 5239.3 5322.6 5042.0 5240.5 5249.9 5255.5 5288.4 5047.6 5051.5 5066.8 5102.6 5183.9 5059.8 5088.6 5125.5 5132.9 5133.5 4383.1 5439.9 5450.9 5621.7 5679.8 6072.9 6133.3 6148.8 6173.7 6199.7 5208.5 6240.9 6252.4 6285.1 6298.4 4823.6 5822.4 5845.0 5858.4 5863.3 6166.5 6171.0 6181.9 6230.3 6269.0 6102.1 6124.5 6143.0 6146.1 6159.9 6180.3 6209.9 6230.8 6248.3 6260.0 6060.9 6120.5 6132.2 6142.3 6232.1 4540.0 5912.8 6238.5 6277.2 6278.3 4091.0 4817.2 4949.7 4964.7 4991.5 4355.1 4375.5 4393.3 4452.8 4481.8 5124.0 5798.8 5848.9 5946.5 5950.2 5266.3 6237.9 6264.7 6268.1 6285.5 5315.9 5349.1 5623.5 5695.5 5839.0 5364.9 5389.6 5424.4 5442.5 5470.3 6298.6 6311.8 6314.5 6315.2 6331.8 6089.4 6146.8 6164.4 6165.4 6197.2 6140.2 6164.5 6178.0 6194.4 6341.4 6085.9 6126.8 6176.4 6179.3 6193.6 6153.1 6157.0 6227.7 6250.5 6275.1 5923.4 6065.4 6080.1 6088.9 6143.7 6140.6 6149.8 6154.0 6159.1 6171.0 4940.3 5825.7 5883.9 6033.2 6077.4 6109.3 6123.5 6135.0 6199.1 6228.5 6068.8 6071.4 6074.5 6075.7 6078.6 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | [#1] ext.html Cycles:180 Average:64360.60 Median:35710.32 stddev:134887.95 (377.7%) stddev-sans-first:135181.00 04:57:59 INFO - PROCESS | 30772 | Values: 453.6 455.3 466.8 476.6 481.6 37524.0 40180.4 40214.0 40222.0 40237.6 34484.8 41092.2 41696.6 41730.0 41937.6 8113.6 8377.0 8571.7 9117.0 9343.1 11248.4 11572.8 11573.7 11730.4 11731.2 11475.7 11530.5 11549.6 11563.7 11575.5 11473.2 11555.9 11558.8 11569.4 11584.5 10150.8 11370.8 11453.0 11459.5 11478.0 40812.6 40910.2 41025.4 41230.8 41385.0 4030.7 4043.9 4147.5 4149.0 4228.9 30401.7 31300.2 31609.5 31675.9 31743.4 3122.6 3236.8 3254.8 3296.5 3301.3 388513.0 464007.0 465723.7 467569.0 468113.0 46454.0 59689.0 62727.4 66814.3 66919.0 56299.0 59002.0 69980.3 70345.3 70352.3 16282.3 16832.3 16847.7 16849.7 16887.2 11510.4 11850.8 12246.6 12688.0 12862.9 12657.8 15535.5 15563.4 15611.8 15703.7 5560.2 6216.2 6298.2 6383.8 6447.8 855.0 859.3 859.3 862.2 866.0 29829.4 30436.2 30556.5 30723.0 31227.0 856.9 929.5 999.4 1049.9 1176.8 15753.0 15874.4 15990.6 16084.3 16260.3 549587.0 551402.0 553926.9 554765.0 554798.0 57831.4 57916.7 57993.0 58007.0 58095.7 1358.3 1415.7 1417.1 1417.6 1417.9 23266.0 28481.0 29069.6 29681.9 30599.5 50164.5 50602.0 50648.0 50731.2 50744.5 507712.0 509550.0 510191.0 510643.0 511029.4 23297.3 23927.4 24126.4 24852.0 39880.0 40301.7 40432.4 40479.8 40832.6 41166.6 28085.3 32688.7 33831.0 34663.7 35904.3 35675.0 36028.9 36141.0 36606.1 37007.6 35113.3 35220.0 35490.5 35631.0 35745.6 29900.7 30615.5 30851.2 30936.8 30949.2 21091.7 23244.4 23381.6 23572.9 24091.6 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | [#2] jquery.html Cycles:180 Average:39130.16 Median:21887.10 stddev:116386.36 (531.8%) stddev-sans-first:116676.37 04:57:59 INFO - PROCESS | 30772 | Values: 316.8 384.9 385.4 400.5 414.6 19706.6 21104.5 21119.0 21319.8 21334.8 21345.0 21858.9 21909.9 22054.3 22389.7 5807.3 5930.5 6092.3 6171.5 6252.5 3992.5 4987.9 6133.9 6167.7 6205.4 6757.5 6884.4 6891.1 6893.8 6897.4 6174.0 6176.5 6226.7 6234.3 6869.5 5771.8 6011.8 6076.9 6092.5 6094.3 11159.0 13818.4 13847.9 13853.6 13880.7 2646.0 2647.7 2661.5 2665.1 2678.6 10200.5 10244.1 10275.6 10563.6 10791.5 1638.6 1847.5 1896.8 1908.0 1909.8 116894.0 137392.0 145026.0 145430.3 147297.0 11813.5 11827.1 11977.5 12062.0 12184.6 15521.8 15551.5 15627.1 15627.8 15647.0 7200.9 8326.5 8637.7 8647.0 8810.6 8251.9 8343.2 8423.2 8451.7 8589.2 4190.9 4472.4 4670.0 4824.0 4829.6 1428.4 1732.4 1992.9 2062.3 2065.0 893.8 964.3 978.2 1021.7 1045.6 21530.0 21838.7 21864.3 21959.5 21986.3 1013.8 1022.9 1032.9 1063.8 1064.5 11291.9 11472.7 11490.3 11529.4 11540.8 659376.0 678446.0 703734.0 711272.0 717961.0 153566.0 155309.1 155850.2 157166.2 162378.0 857.4 956.3 985.8 1003.5 1006.4 17747.2 19081.0 19393.5 19427.1 19609.3 58812.6 59559.0 60108.1 61630.7 61649.8 60673.7 81236.6 85188.6 86401.0 86696.1 5693.3 7417.9 7506.1 7610.6 7818.3 12483.9 12839.2 12842.4 13410.5 13518.3 9582.9 11313.4 11427.6 11458.3 11588.7 10976.8 11198.8 11354.2 11564.2 11734.5 6049.8 7068.8 11348.0 11390.4 11395.5 6307.5 7500.8 7570.2 7629.7 7683.8 10204.3 10859.1 11402.8 11532.3 11656.1 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | [#3] mootools.html Cycles:180 Average:5351.11 Median:5292.94 stddev:2928.43 (55.3%) stddev-sans-first:2921.68 04:57:59 INFO - PROCESS | 30772 | Values: 1411.0 1434.8 1440.2 1442.0 1459.7 7416.5 7633.7 7910.0 8412.1 8419.5 7888.8 8144.5 8169.1 8221.7 8318.7 2268.2 2318.7 2320.5 2323.3 2327.4 2079.1 2163.7 2288.5 2334.1 2347.1 1973.5 2245.6 2313.5 2317.1 2328.4 2288.5 2294.5 2311.3 2312.0 2319.5 1886.5 2315.6 2328.5 2348.4 2361.0 7120.4 8332.7 8359.8 8375.6 8385.7 4265.4 4320.4 4467.4 5047.1 5182.4 3200.9 3365.1 3435.8 3441.9 3444.8 987.6 1093.9 1123.0 1160.8 1183.1 10571.2 10631.0 10691.0 10692.4 10728.0 4083.4 4596.9 4671.6 4673.2 4685.4 9280.0 9308.6 9386.0 9389.2 9397.7 5139.4 5228.6 5234.7 5239.0 5264.5 4212.5 4549.0 4788.6 4793.4 4800.5 3813.8 3872.1 3882.1 3921.4 3939.7 1145.7 1180.6 1265.8 1271.3 1275.1 760.8 763.0 787.1 808.5 832.3 5190.1 5478.7 5521.4 5573.5 5733.8 844.0 952.8 965.2 965.8 995.8 3678.3 3689.3 3744.5 3769.5 3810.1 9266.6 9800.9 9850.4 9852.8 9867.6 9702.3 9753.4 9788.1 9822.6 9838.4 7694.4 7809.8 7836.2 7837.1 7862.0 4774.0 5321.4 5378.4 5440.3 5532.8 9024.6 9051.3 9206.5 9209.8 9319.6 9234.4 9258.8 9287.3 9362.7 9427.2 6216.8 7031.8 7190.0 7204.8 7213.5 7400.4 7734.3 7761.5 7810.3 7901.0 6375.9 7041.6 7143.4 7175.6 7216.6 7021.6 7044.3 7059.2 7118.0 7142.6 6380.1 6398.2 6451.6 6466.2 6488.6 4047.5 4921.5 4952.0 5034.5 5145.8 4178.9 4988.6 5081.0 5118.1 5134.6 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | [#4] prototype.html Cycles:180 Average:4485.94 Median:4969.85 stddev:1367.05 (27.5%) stddev-sans-first:1334.48 04:57:59 INFO - PROCESS | 30772 | Values: 310.6 350.1 352.7 356.0 369.6 4356.1 4591.5 5133.8 5169.6 5240.4 4645.7 5273.5 5334.8 5363.3 5369.3 3533.0 3608.3 3754.5 4210.2 4248.0 4080.4 4215.9 4247.5 4253.9 4259.5 3903.9 4092.6 4169.9 4189.2 4200.4 3717.7 3982.0 3989.5 4118.5 4209.3 3699.3 3706.6 3709.9 3727.2 3742.5 4302.9 4611.3 4849.7 4966.7 5129.5 3726.7 4399.8 4841.9 4853.1 4866.0 5102.5 5449.0 5669.6 5694.7 5749.9 3274.6 3315.7 3598.7 3691.9 3900.7 5300.8 5328.7 5696.4 5971.3 6107.1 3368.3 3835.3 3950.7 3960.6 3966.3 3763.3 3976.9 4010.0 4033.7 4038.1 4687.7 4696.2 4714.1 4726.7 4753.5 4796.8 5515.5 5618.5 5758.5 5767.6 1176.9 1237.4 1258.7 1283.5 1287.0 782.9 832.8 860.3 862.8 866.8 4958.0 4973.0 5121.8 5143.8 5158.0 4927.6 4987.1 5150.7 5603.1 5692.9 4486.9 4628.8 4725.0 4734.2 5172.4 2497.7 2614.4 2915.0 2967.8 2976.9 4832.9 5028.7 5653.2 5742.2 5775.8 5275.7 5517.8 5592.1 5732.0 5841.5 5010.7 5106.6 5248.7 5375.5 5845.0 4902.9 5114.8 5342.8 5460.9 5662.2 4832.6 5111.5 5368.0 5514.9 5565.5 5741.5 5806.4 5847.5 5856.4 5860.6 3370.0 3533.6 3659.6 3747.6 3813.8 4539.3 4831.8 5492.4 5867.0 5885.6 5462.0 5504.5 5596.5 5729.2 5781.4 5345.3 5478.5 5717.8 5755.7 5761.2 5181.9 5352.2 5635.5 5655.7 5676.4 4779.5 5007.3 5324.2 5588.7 5688.7 4465.9 5644.0 5670.8 5673.5 5676.3 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - PROCESS | 30772 | [#5] yui.html Cycles:180 Average:21115.39 Median:3767.90 stddev:30564.05 (811.2%) stddev-sans-first:30611.11 04:57:59 INFO - PROCESS | 30772 | Values: 636.8 762.7 765.6 805.1 827.3 13316.5 15121.2 15562.4 16391.3 16394.3 12622.1 15020.2 15022.8 15028.2 15040.1 670.5 695.6 822.5 851.9 856.3 861.7 871.6 872.2 872.4 873.1 788.6 937.6 938.4 939.2 939.4 929.5 931.2 932.6 932.8 933.8 690.2 690.4 691.1 692.3 692.8 15309.5 15608.4 15638.6 15956.4 16184.2 14715.9 14760.0 14774.0 14780.9 14831.3 9876.4 9910.7 11878.8 11963.3 12267.8 3742.3 3753.2 3755.5 3780.3 3899.2 110103.0 113527.4 114257.4 114329.0 114918.0 8876.8 9065.9 10978.7 11048.7 11135.0 22263.8 22344.0 22682.5 22779.4 22782.3 8011.0 8084.5 8104.2 8107.0 8131.3 4297.6 4333.8 4360.9 4380.5 4413.7 3496.2 3603.3 3637.4 3641.8 3644.3 665.3 665.7 672.0 674.1 683.2 563.5 629.9 644.5 664.3 687.1 9591.8 9980.4 10303.9 10519.4 10609.5 691.4 694.8 694.9 706.3 726.9 4762.2 5031.8 5032.6 5054.4 5100.1 100717.5 106319.4 108554.5 109428.5 110835.0 83849.2 84121.2 84374.2 93653.0 97843.0 59115.4 76331.2 76824.6 79761.6 85388.0 11004.7 11190.0 11333.0 11430.0 11473.7 54482.7 54658.7 54977.7 55165.4 55352.1 69450.3 72254.6 72358.6 73151.0 73346.3 12770.6 12795.8 12936.9 12992.9 13010.0 12606.0 13943.8 14941.6 15531.5 15685.2 12403.5 13006.5 13359.5 14188.4 14403.7 12264.3 13342.9 14156.3 14748.3 14843.9 13357.1 13616.7 13764.4 13810.7 14251.4 11053.4 11196.4 11333.1 11395.4 11535.8 9505.2 10372.2 11185.7 11334.6 11381.3 04:57:59 INFO - PROCESS | 30772 | -------- Summary: end -------- 04:57:59 INFO - PROCESS | 30772 | 04:57:59 INFO - TEST-INFO | 30772: exit 0 04:58:00 INFO - TEST-OK | dromaeo_css | took 1115370ms 04:58:00 INFO - TEST-START | kraken 04:58:00 INFO - operating with platform_type : mac_ 04:58:00 INFO - Initialising browser for kraken test... 04:58:00 INFO - TEST-INFO | started process 30777 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmp9EWpM4/profile http://localhost:56459/getInfo.html) 04:58:02 INFO - PROCESS | 30777 | 2017-01-25 04:58:02.811 plugin-container[30779:300337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 04:58:02 INFO - PROCESS | 30777 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:02 INFO - PROCESS | 30777 | 2017-01-25 04:58:02.811 plugin-container[30779:300337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:58:02 INFO - PROCESS | 30777 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:02 INFO - PROCESS | 30777 | 2017-01-25 04:58:02.811 plugin-container[30779:300337] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:02 INFO - PROCESS | 30777 | __metrics Screen width/height:1600/1200 04:58:02 INFO - PROCESS | 30777 | colorDepth:24 04:58:02 INFO - PROCESS | 30777 | Browser inner width/height: 1024/689 04:58:02 INFO - PROCESS | 30777 | __metrics 04:58:02 ERROR - PROCESS | 30777 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 04:58:03 INFO - TEST-INFO | 30777: exit 0 04:58:03 INFO - Browser initialized. 04:58:03 INFO - Running cycle 1/1 for kraken test... 04:58:03 INFO - TEST-INFO | started process 30780 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmp9EWpM4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:06 INFO - PROCESS | 30780 | 2017-01-25 04:58:06.288 plugin-container[30781:300456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 04:58:06 INFO - PROCESS | 30780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:06 INFO - PROCESS | 30780 | 2017-01-25 04:58:06.289 plugin-container[30781:300456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:58:06 INFO - PROCESS | 30780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:06 INFO - PROCESS | 30780 | 2017-01-25 04:58:06.289 plugin-container[30781:300456] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:15 INFO - PROCESS | 30780 | RSS: Main: 233529344 04:58:15 INFO - PROCESS | 30780 | 04:58:19 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56459/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:20 INFO - PROCESS | 30780 | RSS: Main: 247050240 04:58:20 INFO - PROCESS | 30780 | 04:58:22 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56459/tests/kraken/driver.html?testName=audio-dft) 04:58:23 INFO - PROCESS | 30780 | RSS: Main: 254898176 04:58:23 INFO - PROCESS | 30780 | 04:58:27 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56459/tests/kraken/driver.html?testName=audio-fft) 04:58:27 INFO - PROCESS | 30780 | RSS: Main: 257581056 04:58:27 INFO - PROCESS | 30780 | 04:58:29 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56459/tests/kraken/driver.html?testName=audio-oscillator) 04:58:30 INFO - PROCESS | 30780 | RSS: Main: 259211264 04:58:30 INFO - PROCESS | 30780 | 04:58:32 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:58:33 INFO - PROCESS | 30780 | RSS: Main: 258994176 04:58:33 INFO - PROCESS | 30780 | 04:58:36 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56459/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:36 INFO - PROCESS | 30780 | RSS: Main: 266223616 04:58:36 INFO - PROCESS | 30780 | 04:58:39 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56459/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:40 INFO - PROCESS | 30780 | RSS: Main: 265056256 04:58:40 INFO - PROCESS | 30780 | 04:58:43 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56459/tests/kraken/driver.html?testName=json-parse-financial) 04:58:44 INFO - PROCESS | 30780 | RSS: Main: 265113600 04:58:44 INFO - PROCESS | 30780 | 04:58:45 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:46 INFO - PROCESS | 30780 | RSS: Main: 264577024 04:58:46 INFO - PROCESS | 30780 | 04:58:48 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:49 INFO - PROCESS | 30780 | RSS: Main: 264519680 04:58:49 INFO - PROCESS | 30780 | 04:58:51 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:51 INFO - PROCESS | 30780 | RSS: Main: 264597504 04:58:51 INFO - PROCESS | 30780 | 04:58:54 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:55 INFO - PROCESS | 30780 | RSS: Main: 264949760 04:58:55 INFO - PROCESS | 30780 | 04:58:58 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:59 INFO - PROCESS | 30780 | RSS: Main: 264847360 04:58:59 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | Cycle 1(1): loaded http://localhost:56459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56459/tests/kraken/driver.html?testName=ai-astar) 04:59:01 INFO - PROCESS | 30780 | RSS: Main: 268206080 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | __start_tp_report 04:59:01 INFO - PROCESS | 30780 | _x_x_mozilla_page_load 04:59:01 INFO - PROCESS | 30780 | _x_x_mozilla_page_load_details 04:59:01 INFO - PROCESS | 30780 | |i|pagename|runs| 04:59:01 INFO - PROCESS | 30780 | |0;ai-astar;110;122;126;175;96;173;175;116;174;173 04:59:01 INFO - PROCESS | 30780 | |1;audio-beat-detection;147;113;111;151;115;119;116;116;150;148 04:59:01 INFO - PROCESS | 30780 | |2;audio-dft;204;250;194;244;278;197;266;236;279;202 04:59:01 INFO - PROCESS | 30780 | |3;audio-fft;85;49;64;77;60;55;53;83;98;85 04:59:01 INFO - PROCESS | 30780 | |4;audio-oscillator;91;71;82;87;100;103;113;77;70;81 04:59:01 INFO - PROCESS | 30780 | |5;imaging-gaussian-blur;92;99;92;90;92;89;76;134;135;89 04:59:01 INFO - PROCESS | 30780 | |6;imaging-darkroom;101;132;171;104;104;102;104;103;105;103 04:59:01 INFO - PROCESS | 30780 | |7;imaging-desaturate;92;96;90;92;118;140;117;92;91;93 04:59:01 INFO - PROCESS | 30780 | |8;json-parse-financial;60;63;61;62;62;62;62;64;69;72 04:59:01 INFO - PROCESS | 30780 | |9;json-stringify-tinderbox;69;75;80;78;73;70;85;96;106;109 04:59:01 INFO - PROCESS | 30780 | |10;stanford-crypto-aes;87;88;90;91;88;89;91;86;85;99 04:59:01 INFO - PROCESS | 30780 | |11;stanford-crypto-ccm;138;142;168;139;147;160;157;164;176;182 04:59:01 INFO - PROCESS | 30780 | |12;stanford-crypto-pbkdf2;177;177;177;179;176;173;174;178;176;177 04:59:01 INFO - PROCESS | 30780 | |13;stanford-crypto-sha256-iterative;67;69;73;67;70;64;70;89;89;84 04:59:01 INFO - PROCESS | 30780 | __end_tp_report 04:59:01 INFO - PROCESS | 30780 | __start_cc_report 04:59:01 INFO - PROCESS | 30780 | _x_x_mozilla_cycle_collect,944 04:59:01 INFO - PROCESS | 30780 | __end_cc_report 04:59:01 INFO - PROCESS | 30780 | __startTimestamp1485349141379__endTimestamp 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | ------- Summary: start ------- 04:59:01 INFO - PROCESS | 30780 | Number of tests: 14 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#0] ai-astar Cycles:10 Average:144.00 Median:173.50 stddev:32.58 (18.8%) stddev-sans-first:32.16 04:59:01 INFO - PROCESS | 30780 | Values: 110.0 122.0 126.0 175.0 96.0 173.0 175.0 116.0 174.0 173.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:133.00 stddev:17.71 (13.3%) stddev-sans-first:17.49 04:59:01 INFO - PROCESS | 30780 | Values: 147.0 113.0 111.0 151.0 115.0 119.0 116.0 116.0 150.0 148.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#2] audio-dft Cycles:10 Average:235.00 Median:247.00 stddev:33.71 (13.6%) stddev-sans-first:33.84 04:59:01 INFO - PROCESS | 30780 | Values: 204.0 250.0 194.0 244.0 278.0 197.0 266.0 236.0 279.0 202.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#3] audio-fft Cycles:10 Average:70.90 Median:80.00 stddev:16.78 (21.0%) stddev-sans-first:17.01 04:59:01 INFO - PROCESS | 30780 | Values: 85.0 49.0 64.0 77.0 60.0 55.0 53.0 83.0 98.0 85.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:79.00 stddev:14.22 (18.0%) stddev-sans-first:15.03 04:59:01 INFO - PROCESS | 30780 | Values: 91.0 71.0 82.0 87.0 100.0 103.0 113.0 77.0 70.0 81.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:91.00 stddev:19.66 (21.6%) stddev-sans-first:20.69 04:59:01 INFO - PROCESS | 30780 | Values: 92.0 99.0 92.0 90.0 92.0 89.0 76.0 134.0 135.0 89.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#6] imaging-darkroom Cycles:10 Average:112.90 Median:104.00 stddev:22.35 (21.5%) stddev-sans-first:23.29 04:59:01 INFO - PROCESS | 30780 | Values: 101.0 132.0 171.0 104.0 104.0 102.0 104.0 103.0 105.0 103.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:92.00 stddev:17.02 (18.5%) stddev-sans-first:17.65 04:59:01 INFO - PROCESS | 30780 | Values: 92.0 96.0 90.0 92.0 118.0 140.0 117.0 92.0 91.0 93.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:62.50 stddev:3.80 (6.1%) stddev-sans-first:3.79 04:59:01 INFO - PROCESS | 30780 | Values: 60.0 63.0 61.0 62.0 62.0 62.0 62.0 64.0 69.0 72.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#9] json-stringify-tinderbox Cycles:10 Average:84.10 Median:76.50 stddev:14.64 (19.1%) stddev-sans-first:14.47 04:59:01 INFO - PROCESS | 30780 | Values: 69.0 75.0 80.0 78.0 73.0 70.0 85.0 96.0 106.0 109.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:89.50 stddev:3.92 (4.4%) stddev-sans-first:4.06 04:59:01 INFO - PROCESS | 30780 | Values: 87.0 88.0 90.0 91.0 88.0 89.0 91.0 86.0 85.0 99.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#11] stanford-crypto-ccm Cycles:10 Average:157.30 Median:162.00 stddev:15.54 (9.6%) stddev-sans-first:14.83 04:59:01 INFO - PROCESS | 30780 | Values: 138.0 142.0 168.0 139.0 147.0 160.0 157.0 164.0 176.0 182.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:177.00 stddev:1.78 (1.0%) stddev-sans-first:1.87 04:59:01 INFO - PROCESS | 30780 | Values: 177.0 177.0 177.0 179.0 176.0 173.0 174.0 178.0 176.0 177.0 04:59:01 INFO - PROCESS | 30780 | 04:59:01 INFO - PROCESS | 30780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:71.50 stddev:9.46 (13.2%) stddev-sans-first:9.67 04:59:01 INFO - PROCESS | 30780 | Values: 67.0 69.0 73.0 67.0 70.0 64.0 70.0 89.0 89.0 84.0 04:59:01 INFO - PROCESS | 30780 | -------- Summary: end -------- 04:59:01 INFO - PROCESS | 30780 | 04:59:02 INFO - TEST-INFO | 30780: exit 0 04:59:02 INFO - TEST-OK | kraken | took 62228ms 04:59:02 INFO - SUITE-END | took 1177s 04:59:02 INFO - Completed test suite (00:19:37) 04:59:02 INFO - javascript benchmark 04:59:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7235.092107698566, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2764.7926405519593, 2889.436559870823, 3095.6130483689535, 3232.1757951722307, 3320.7841490303113, 4231.873043808683, 5638.210650508927, 5713.571482138836, 5728.856778580533, 5770.307563092435, 5590.0, 5669.09294512877, 5692.37383887772, 5696.003199440102, 5727.799527016556, 5093.872653183663, 5130.153524668444, 5175.964807038588, 5191.091558977183, 5242.449542798008, 4720.62785521847, 5190.688558686472, 5222.164453687411, 5239.345081864767, 5322.600804939645, 5042.0168067226905, 5240.475952404767, 5249.86875328116, 5255.500727430888, 5288.444713305105, 5047.64666473347, 5051.545360917535, 5066.847994560169, 5102.566281866046, 5183.922241166386, 5059.772310246048, 5088.567471764904, 5125.487451254882, 5132.944973470953, 5133.4609865964285, 4383.145286669069, 5439.864003399907, 5450.91823622646, 5621.718914054321, 5679.772809087632, 6072.908906366408, 6133.294671112834, 6148.754049838001, 6173.691315434256, 6199.659018753967, 5208.531232189083, 6240.906386404207, 6252.374762523711, 6285.057241413779, 6298.3701629837105, 4823.589994850442, 5822.446867547576, 5845.006348920694, 5858.443447872445, 5863.2670916135485, 6166.475849552839, 6171.0, 6181.938180618226, 6230.283517395557, 6268.968655156787, 6102.099711414106, 6124.472479235491, 6142.989934931851, 6146.139540464339, 6159.907601385983, 6180.3201647818705, 6209.9068513972325, 6230.844228894314, 6248.343923888017, 6260.0, 6060.939390606126, 6120.477608373095, 6132.171952247653, 6142.262928448615, 6232.096346029891, 4540.02389486262, 5912.793052243151, 6238.500919926395, 6277.183966084471, 6278.340774218641, 4090.986250212183, 4817.205161148371, 4949.653524253267, 4964.67729597575, 4991.5258050485145, 4355.0854320593035, 4375.496817865923, 4393.319035549495, 4452.844150454718, 4481.75350355727, 5124.0, 5798.797042103506, 5848.853778655568, 5946.464818166386, 5950.2264705587995, 5266.262723218752, 6237.877182107264, 6264.718087686065, 6268.059791031382, 6285.528585356025, 5315.920261196085, 5349.063913815066, 5623.5220006299105, 5695.515881150149, 5839.007368747323, 5364.892702145935, 5389.622726409192, 5424.376196737347, 5442.455754424526, 5470.316210473691, 6298.622082675054, 6311.779087731908, 6314.463270622048, 6315.242170939425, 6331.810045698637, 6089.360617135137, 6146.78486252979, 6164.352742962104, 6165.414285642857, 6197.163382943425, 6140.201773769381, 6164.506839452923, 6177.980633195472, 6194.38056194377, 6341.365863413622, 6085.878282434415, 6126.816195514141, 6176.413240742122, 6179.28938172116, 6193.597416167935, 6153.107799369156, 6156.969215153896, 6227.688615569294, 6250.468710159687, 6275.090111933835, 5923.437273459187, 6065.3934606539, 6080.118382834553, 6088.939110608837, 6143.72353244114, 6140.565599444613, 6149.846253843511, 6154.0, 6159.106929495288, 6170.969145154246, 4940.258961155711, 5825.70871456417, 5883.852903677271, 6033.215681961493, 6077.4226448487325, 6109.283207920518, 6123.540734444845, 6135.0, 6199.070139479114, 6228.532860035425, 6068.757249709962, 6071.392860713893, 6074.483668888017, 6075.696215189311, 6078.574499784972], "value": 5611.415671229034, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.56457800511487, 455.33066392403157, 466.79461037143653, 476.5829898838516, 481.559373173546, 37524.0, 40180.39729404061, 40214.0, 40222.0, 40237.59762402375, 34484.827575862146, 41092.17815643685, 41696.58303416965, 41730.0, 41937.580624193746, 8113.553754543498, 8377.0, 8571.699990500334, 9116.95441522793, 9343.084667643117, 11248.437578121102, 11572.768544629102, 11573.710657233594, 11730.35483048432, 11731.237469564494, 11475.655730328062, 11530.481128349244, 11549.595764148256, 11563.653090407259, 11575.479103440322, 11473.196876218668, 11555.942220288845, 11558.8266176007, 11569.42152892352, 11584.47869845859, 10150.847737283946, 11370.772584548346, 11453.026492748126, 11459.541618335257, 11478.0, 40812.591874081474, 40910.181796363904, 41025.38461923043, 41230.79384603088, 41385.0, 4030.7380020298588, 4043.8786836394956, 4147.523034851, 4149.0, 4228.851990180329, 30401.695983040107, 31300.217494562592, 31609.525857112163, 31675.891343802858, 31743.365132697218, 3122.6252849658185, 3236.8219747913854, 3254.804711717281, 3296.5055241713935, 3301.2572171261513, 388513.0, 464007.0, 465723.6713816443, 467569.0, 468113.0, 46454.0, 59689.0, 62727.431814204094, 66814.33185668082, 66919.0, 56299.0, 59002.0, 69980.3001969984, 70345.2965470349, 70352.2964770356, 16282.348706051862, 16832.32670693183, 16847.74728379075, 16849.747253791204, 16887.240074196692, 11510.424478776027, 11850.76298474043, 12246.632601021984, 12688.0, 12862.871371286354, 12657.810132848015, 15535.533933981998, 15563.377464901503, 15611.765823512656, 15703.68592628141, 5560.193771903051, 6216.228285624897, 6298.212723409574, 6383.776567820104, 6447.774327898501, 854.9914500855036, 859.26532814444, 859.3383095016802, 862.215384000569, 866.0386970462781, 29829.403411932075, 30436.239094022825, 30556.54165187524, 30723.0, 31227.0, 856.9185927336893, 929.5166513412987, 999.4003597841382, 1049.8740151181908, 1176.8117101263756, 15753.0, 15874.365025398854, 15990.600234994217, 16084.276207570687, 16260.349586016664, 549587.0, 551402.0, 553926.9214615686, 554765.0, 554798.0, 57831.4216857826, 57916.71041644849, 57993.0, 58007.0, 58095.709521452125, 1358.2936872826076, 1415.6956254405352, 1417.1143035602543, 1417.5534706567398, 1417.907835990678, 23266.0, 28481.0, 29069.563956541093, 29681.85159074191, 30599.54100688536, 50164.49835501598, 50602.0, 50648.0, 50731.23903141382, 50744.492555075456, 507712.0, 509550.0, 510191.0, 510643.0, 511029.44485278823, 23297.301080967598, 23927.401814954766, 24126.39684007914, 24852.0, 39880.0, 40301.74568577684, 40432.3935140979, 40479.79760101181, 40832.591674082876, 41166.58833411628, 28085.297867553476, 32688.673113269513, 33831.0, 34663.65336346705, 35904.28191436209, 35675.0, 36028.91913242607, 36141.0, 36606.084847879014, 37007.62992370042, 35113.297734045686, 35220.0, 35490.467642985896, 35631.0, 35745.64254357527, 29900.700992990664, 30615.54076688807, 30851.228719282197, 30936.845315773277, 30949.226269342547, 21091.683624745947, 23244.418889527897, 23381.649275261225, 23572.882135589898, 24091.63862542028], "value": 19544.275219984127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.7893350921637, 384.89415410762035, 385.35645472061674, 400.5033758139907, 414.6226933490522, 19706.605867882652, 21104.472388190305, 21118.99999999998, 21319.786802131974, 21334.786652133473, 21345.0, 21858.89070554649, 21909.890450547726, 22054.33836984889, 22389.664155037688, 5807.332156801958, 5930.466258036776, 6092.329843717188, 6171.506279497629, 6252.531060170482, 3992.4610177626087, 4987.850364489072, 6133.907991380132, 6167.660778657172, 6205.441510264075, 6757.526973111884, 6884.414824739903, 6891.1041564596535, 6893.7931862044215, 6897.379235868771, 6174.0, 6176.505879529627, 6226.688665566703, 6234.283057448406, 6869.484788640872, 5771.769129234825, 6011.75952961881, 6076.939230607726, 6092.5430592705725, 6094.329623741385, 11159.0, 13818.37817298224, 13847.930760346235, 13853.584392468241, 13880.652983675387, 2645.9603105953233, 2647.7219891911263, 2661.5209262332774, 2665.0805472112093, 2678.6116013178175, 10200.540975656113, 10244.129249013842, 10275.588976440933, 10563.577456901714, 10791.46042697862, 1638.6394993101499, 1847.5473508990383, 1896.82928536431, 1907.9523011924673, 1909.799471055533, 116894.0, 137392.0, 145026.0, 145430.27284863614, 147297.0, 11813.527458901548, 11827.112966527546, 11977.52089916411, 12062.0, 12184.634460966185, 15521.767173492406, 15551.455699050704, 15627.062376257461, 15627.843721562866, 15646.982946108466, 7200.855982880313, 8326.542040187727, 8637.654493820302, 8647.0, 8810.647574097093, 8251.910802931221, 8343.165683431609, 8423.241908228289, 8451.661933522713, 8589.226969572768, 4190.895227619273, 4472.418585583853, 4669.9726060266685, 4823.986962737864, 4829.613630909519, 1428.4072110074203, 1732.3503686117706, 1992.9302474413325, 2062.2885104638876, 2065.0397565131984, 893.7765558610347, 964.252704154286, 978.1685567267765, 1021.7279487038685, 1045.639254457211, 21530.0, 21838.730450322615, 21864.299806682026, 21959.52354802976, 21986.340409787732, 1013.7972405518926, 1022.8721409823772, 1032.932859364139, 1063.8191507443753, 1064.4571268653042, 11291.887081129247, 11472.713182170346, 11490.310581364978, 11529.365884876412, 11540.769184616262, 659376.0, 678446.0, 703734.0, 711272.0, 717961.0, 153566.0, 155309.13944896255, 155850.22074889552, 157166.21416892842, 162378.0, 857.3912522109248, 956.258899353007, 985.7584891701579, 1003.4781913404988, 1006.3559322033905, 17747.201375938374, 19081.0, 19393.515162120497, 19427.12577933968, 19609.31367402134, 58812.58905582013, 59559.0, 60108.098378523486, 61630.69184654048, 61649.76700465876, 60673.69663151656, 81236.59381703053, 85188.57405712931, 86401.0, 86696.1330386688, 5693.28833895763, 7417.851642967003, 7506.128061539784, 7610.6194690266375, 7818.257265559762, 12483.93758031204, 12839.229646221256, 12842.422091006114, 13410.530631427853, 13518.324083795967, 9582.94587595378, 11313.434328283718, 11427.60003399877, 11458.255213411101, 11588.710282243012, 10976.835347469634, 11198.83201751958, 11354.205205635526, 11564.190506664789, 11734.530618775154, 6049.818505444844, 7068.823279418056, 11348.035416989318, 11390.37352945596, 11395.544178233109, 6307.463865571478, 7500.812479688051, 7570.16728159913, 7629.6566654499575, 7683.807904802201, 10204.336718113596, 10859.131269498579, 11402.82895756581, 11532.25040372373, 11656.06751459898], "value": 9719.119487995815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.0, 1434.7847822826575, 1440.2438719672177, 1442.0050165385883, 1459.7372472954864, 7416.480846340744, 7633.656485458154, 7909.960450197748, 8412.074671786106, 8419.536925469096, 7888.80277993049, 8144.511329320245, 8169.101398846137, 8221.671133154681, 8318.70884519042, 2268.1834539565743, 2318.6985691860036, 2320.4546931471177, 2323.3494621506006, 2327.406511339606, 2079.095593416861, 2163.6862654915026, 2288.5079707862806, 2334.078039174525, 2347.1315613223132, 1973.4868934077172, 2245.5733410652006, 2313.4910319729634, 2317.1310758465575, 2328.382978510696, 2288.4507718147693, 2294.4608017115966, 2311.28350211435, 2312.0, 2319.478117423583, 1886.4812176651394, 2315.5947709151, 2328.5342931413784, 2348.436375269923, 2360.996576455017, 7120.359167674934, 8332.7083552076, 8359.791005224857, 8375.612950309194, 8385.664573417056, 4265.402843601898, 4320.395144679747, 4467.441569803775, 5047.0915235257635, 5182.393458028024, 3200.9199770005703, 3365.0914253151755, 3435.7594968352223, 3441.8623255069765, 3444.793312401264, 987.5506644476745, 1093.94530273486, 1123.0341905960868, 1160.7794519041356, 1183.1185766603849, 10571.207159462994, 10631.0, 10691.037806597365, 10692.358458492437, 10727.980841820015, 4083.4079058536345, 4596.908061838744, 4671.579557839811, 4673.228917228619, 4685.437747470257, 9280.02559731232, 9308.627654893864, 9386.014468480847, 9389.154976052052, 9397.671081512115, 5139.408967968731, 5228.581713462914, 5234.738263086907, 5238.978399212117, 5264.52619264268, 4212.53662097169, 4548.952971162924, 4788.61691064714, 4793.400824896888, 4800.543948324904, 3813.8474461021246, 3872.0707030313088, 3882.1265215326325, 3921.3725803871816, 3939.684825213976, 1145.7021174494525, 1180.6340034589305, 1265.7911444611536, 1271.319843883518, 1275.05645822091, 760.7831767946109, 762.9656665450068, 787.1105650614769, 808.4825711544617, 832.317499650293, 5190.143626301618, 5478.726063696879, 5521.365043020024, 5573.498385145275, 5733.799317023884, 843.9704610338608, 952.8094381123803, 965.2471072563412, 965.8454647256406, 995.7908839143861, 3678.3378991781738, 3689.317476266899, 3744.4570537271943, 3769.4722738816586, 3810.1427178885083, 9266.629334826532, 9800.852987205197, 9850.408975461496, 9852.753681158028, 9867.555959981819, 9702.320837541445, 9753.414795112316, 9788.119069283655, 9822.557984890555, 9838.36050656705, 7694.384449244047, 7809.804754881174, 7836.177201393885, 7837.1379148293645, 7861.960690196627, 4774.0, 5321.36143662763, 5378.40837507866, 5440.265564148789, 5532.751026203911, 9024.593893274687, 9051.27589792828, 9206.539673016188, 9209.815803684023, 9319.58061887203, 9234.399764015317, 9258.768530786785, 9287.349885507949, 9362.672306469241, 9427.245820334494, 6216.751329946752, 7031.753888613874, 7189.964050179716, 7204.819879503054, 7213.531120477152, 7400.370968467741, 7734.265244801735, 7761.534307941542, 7810.297073263434, 7900.960495197487, 6375.87248255023, 7041.616779853794, 7143.392811611071, 7175.641217939186, 7216.603086830275, 7021.613811240431, 7044.295570442915, 7059.223485416497, 7117.964410177916, 7142.642867856483, 6380.138681277968, 6398.168238129014, 6451.645159516272, 6466.191726034246, 6488.578242414228, 4047.4535937648043, 4921.4832442593015, 4952.034353301072, 5034.546890779848, 5145.768440420115, 4178.916421671489, 4988.551030407136, 5080.974595127001, 5118.078745825787, 5134.5635620972635], "value": 4336.581888056639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.55745562573327, 350.08627482271277, 352.7019668380218, 356.02271764007793, 369.6303696303696, 4356.063446359036, 4591.471980722218, 5133.845984620458, 5169.612279079075, 5240.44975277596, 4645.698029628072, 5273.525382715555, 5334.759935802888, 5363.302770639812, 5369.328833895763, 3532.9646703532894, 3608.2963822054708, 3754.4556039374274, 4210.189618464059, 4247.978760106195, 4080.3879418087226, 4215.936760948588, 4247.532771395144, 4253.936190957123, 4259.508187710193, 3903.863364782233, 4092.6112019358116, 4169.916601667965, 4189.245935731567, 4200.432941552897, 3717.680223520665, 3982.0, 3989.5212574490956, 4118.5263694675195, 4209.34755112958, 3699.278640665071, 3706.610805865372, 3709.9443508347395, 3727.2172843702856, 3742.4947632069593, 4302.913941721179, 4611.2852507861335, 4849.714825571226, 4966.6590020694575, 5129.538341549279, 3726.7329108103377, 4399.780010999437, 4841.886366135774, 4853.126437241295, 4865.978144589605, 5102.515261050232, 5449.0, 5669.6314739541795, 5694.6867922264255, 5749.942500574983, 3274.5579346788118, 3315.651856555051, 3598.712103031751, 3691.870784522529, 3900.668443182333, 5300.754322734155, 5328.653637513549, 5696.379665353942, 5971.343152253248, 6107.083937409379, 3368.309496553201, 3835.328817456934, 3950.6839452843706, 3960.5643379228263, 3966.345552983725, 3763.2661630982243, 3976.8608098716404, 4010.0, 4033.74953764334, 4038.1116154445976, 4687.6874475147015, 4696.158823911553, 4714.104320179155, 4726.740029298421, 4753.548412900769, 4796.760161991887, 5515.503604675519, 5618.4662457066515, 5758.452946970031, 5767.625104368287, 1176.8999635030948, 1237.4369661803858, 1258.6853286678331, 1283.4545318239711, 1286.9871301286867, 782.9469363705806, 832.800127969283, 860.3438381116326, 862.7627402464248, 866.787637028932, 4958.0083983202785, 4973.035650917939, 5121.8463446096675, 5143.819966301162, 5157.974210128926, 4927.630427717935, 4987.0524600325825, 5150.690958542499, 5603.103503439512, 5692.943070569324, 4486.904036215001, 4628.791704373311, 4724.976375118171, 4734.242521196661, 5172.431032586413, 2497.737737537532, 2614.41175735458, 2914.9562756558666, 2967.807092538978, 2976.8511574421627, 4832.864276894927, 5028.698278103326, 5653.240595004276, 5742.167385729046, 5775.826725198251, 5275.683458992396, 5517.806876759294, 5592.064166312718, 5731.971340143273, 5841.532677385799, 5010.699358038456, 5106.617003724661, 5248.711320877388, 5375.543078838265, 5844.970775146097, 4902.916260589307, 5114.846554603368, 5342.839714808562, 5460.863478413072, 5662.207290979349, 4832.589229915497, 5111.488851114858, 5368.0, 5514.944850551443, 5565.4991050804, 5741.531141609148, 5806.361300256884, 5847.502962248086, 5856.4143585641095, 5860.648361098348, 3369.966300336965, 3533.611302756746, 3659.6212461898913, 3747.6439738224826, 3813.8093095345675, 4539.341795439576, 4831.777382404133, 5492.368377636623, 5867.044949376472, 5885.61743486672, 5461.9686074229185, 5504.504594586507, 5596.468335508121, 5729.169270455677, 5781.352314590322, 5345.305110335787, 5478.479544443271, 5717.828465146053, 5755.683437410982, 5761.164631128379, 5181.948180518147, 5352.197170424468, 5635.492805647511, 5655.7454914528125, 5676.403977582295, 4779.5220477951925, 5007.347575300215, 5324.151578905267, 5588.720563971704, 5688.715564221689, 4465.910681786411, 5643.971780141073, 5670.829875103754, 5673.461021202979, 5676.347220069745], "value": 4056.7960269896985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.8312397214736, 762.7063580521498, 765.6248438265252, 805.1143741883928, 827.29266477162, 13316.467341306336, 15121.243937803094, 15562.37750489979, 16391.262393192304, 16394.34422623095, 12622.116451848375, 15020.173890436048, 15022.849771502282, 15028.248587570604, 15040.09759414436, 670.4937771982171, 695.6035060015793, 822.5270469480043, 851.940364174508, 856.3235044314983, 861.7285555050139, 871.559862269553, 872.2237208884098, 872.3980453487105, 873.0963452826326, 788.5938741548107, 937.610891480035, 938.3853575907791, 939.2204470289644, 939.3706216834737, 929.5259417696956, 931.2363861633463, 932.5756780664815, 932.7528205025674, 933.780561568031, 690.1614538335946, 690.3821080133303, 691.0912150522047, 692.3249831414381, 692.8475735338218, 15309.46416875404, 15608.375664973388, 15638.609034774108, 15956.361745530165, 16184.19079046043, 14715.852841471662, 14760.040597361138, 14773.999999999893, 14780.852191478056, 14831.258437078212, 9876.35803672766, 9910.653127140515, 11878.762424751456, 11963.282203067756, 12267.754644907141, 3742.288965096623, 3753.230587729509, 3755.455458958436, 3780.3384407728813, 3899.200663863901, 110103.0, 113527.43236283766, 114257.42871285674, 114329.0, 114918.0, 8876.822463550821, 9065.912090549044, 10978.725531861768, 11048.723781905517, 11135.0, 22263.777362226494, 22344.0, 22682.546349073255, 22779.430514237276, 22782.31653050411, 8011.038675358877, 8084.474509156886, 8104.230098140667, 8106.959465202636, 8131.349492040623, 4297.5702429756775, 4333.783310834446, 4360.869173924787, 4380.518143004267, 4413.7351758894565, 3496.1609213789015, 3603.279344131184, 3637.418013117888, 3641.817909104534, 3644.344018076719, 665.3446355339986, 665.7270519087151, 671.9865602687919, 674.1169068520254, 683.1835956032593, 563.4731526023181, 629.9181106456132, 644.5166125405946, 664.2759392262457, 687.1136234257751, 9591.808163836824, 9980.401175929468, 10303.948480257552, 10519.368837869752, 10609.522571484302, 691.4192078653854, 694.8193469697915, 694.9200841903145, 706.2584286499258, 726.9236730143365, 4762.166620841339, 5031.7987280509105, 5032.597392208614, 5054.418741844662, 5100.0819852426175, 100717.49641251747, 106319.40520892193, 108554.45722771336, 109428.4528577352, 110835.0, 83849.16150838535, 84121.15878841134, 84374.15625843786, 93653.0, 97843.0, 59115.40884591185, 76331.23668763241, 76824.61587692138, 79761.60119199367, 85388.0, 11004.724881878017, 11190.048845847869, 11333.0, 11430.0, 11473.655790326304, 54482.72758636181, 54658.726706366215, 54977.72511137579, 55165.44834551764, 55352.06267780608, 69450.30549694438, 72254.63872680604, 72358.55282894419, 73151.0, 73346.33073385451, 12770.61688149357, 12795.808062878878, 12936.870631293566, 12992.935035324763, 13010.0, 12606.0, 13943.790843137564, 14941.62645933817, 15531.5340539784, 15685.215739213221, 12403.503859845505, 13006.47974081064, 13359.465621375424, 14188.432462701376, 14403.711925761636, 12264.32546209967, 13342.93328533351, 14156.292185390896, 14748.33632486562, 14843.851561484247, 13357.13178643385, 13616.727665446833, 13764.380602873094, 13810.723785524435, 14251.429942802171, 11053.447327633425, 11196.38419886914, 11333.094070263733, 11395.430228488376, 11535.826962595736, 9505.192058674813, 10372.222083343628, 11185.66443006711, 11334.60328888485, 11381.260218085798], "value": 7648.329979828945, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1624.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 126.0, 175.0, 96.0, 173.0, 175.0, 116.0, 174.0, 173.0], "value": 144.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 111.0, 151.0, 115.0, 119.0, 116.0, 116.0, 150.0, 148.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 250.0, 194.0, 244.0, 278.0, 197.0, 266.0, 236.0, 279.0, 202.0], "value": 235.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 49.0, 64.0, 77.0, 60.0, 55.0, 53.0, 83.0, 98.0, 85.0], "value": 70.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 82.0, 87.0, 100.0, 103.0, 113.0, 77.0, 70.0, 81.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 99.0, 92.0, 90.0, 92.0, 89.0, 76.0, 134.0, 135.0, 89.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 132.0, 171.0, 104.0, 104.0, 102.0, 104.0, 103.0, 105.0, 103.0], "value": 112.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 90.0, 92.0, 118.0, 140.0, 117.0, 92.0, 91.0, 93.0], "value": 102.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 61.0, 62.0, 62.0, 62.0, 62.0, 64.0, 69.0, 72.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 80.0, 78.0, 73.0, 70.0, 85.0, 96.0, 106.0, 109.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 90.0, 91.0, 88.0, 89.0, 91.0, 86.0, 85.0, 99.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 168.0, 139.0, 147.0, 160.0, 157.0, 164.0, 176.0, 182.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 177.0, 179.0, 176.0, 173.0, 174.0, 178.0, 176.0, 177.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 73.0, 67.0, 70.0, 64.0, 70.0, 89.0, 89.0, 84.0], "value": 74.2, "unit": "score"}]}]} 04:59:02 INFO - Return code: 0 04:59:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:59:02 ERROR - # TBPL SUCCESS # 04:59:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:02 INFO - 2017-01-25 04:59:02.695 screenresolution[30785:300862] starting screenresolution argv=screenresolution get 04:59:02 INFO - 2017-01-25 04:59:02.698 screenresolution[30785:300862] Display 0: 1600x1200x32@60 04:59:02 INFO - 2017-01-25 04:59:02.704 screenresolution[30786:300865] starting screenresolution argv=screenresolution list 04:59:02 INFO - Available Modes on Display 0 04:59:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:02 INFO - Intel Iris: 04:59:02 INFO - Chipset Model: Intel Iris 04:59:02 INFO - Type: GPU 04:59:02 INFO - Bus: Built-In 04:59:02 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:02 INFO - Vendor: Intel (0x8086) 04:59:02 INFO - Device ID: 0x0a2e 04:59:02 INFO - Revision ID: 0x0009 04:59:02 INFO - Displays: 04:59:02 INFO - Display: 04:59:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:02 INFO - Display Serial Number: 1600x1200 60 04:59:02 INFO - Main Display: Yes 04:59:02 INFO - Mirror: Off 04:59:02 INFO - Online: Yes 04:59:02 INFO - Rotation: Supported 04:59:02 INFO - Return code: 0 04:59:02 INFO - Running post-action listener: _resource_record_post_action 04:59:02 INFO - [mozharness: 2017-01-25 12:59:02.939560Z] Finished run-tests step (success) 04:59:02 INFO - Running post-run listener: _resource_record_post_run 04:59:02 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 439296; Write bytes: 552429056; Read time: 3; Write time: 1724 04:59:02 INFO - TinderboxPrint: CPU usage
54.5% 04:59:02 INFO - TinderboxPrint: I/O read bytes / time
439,296 / 3 04:59:02 INFO - TinderboxPrint: I/O write bytes / time
552,429,056 / 1,724 04:59:02 INFO - TinderboxPrint: CPU idle
2,184.1 (45.5%) 04:59:02 INFO - TinderboxPrint: CPU system
971.9 (20.2%) 04:59:02 INFO - TinderboxPrint: CPU user
1,645.7 (34.3%) 04:59:02 INFO - TinderboxPrint: Swap in / out
250,818,560 / 0 04:59:03 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 240785920; Write bytes: 233786368; Read time: 17566; Write time: 515 04:59:03 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 439296; Write bytes: 299235840; Read time: 3; Write time: 1155 04:59:03 INFO - Running post-run listener: _upload_blobber_files 04:59:03 INFO - Blob upload gear active. 04:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:04 INFO - (blobuploader) - INFO - Done attempting. 04:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:05 INFO - (blobuploader) - INFO - Done attempting. 04:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:06 INFO - (blobuploader) - INFO - Done attempting. 04:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:08 INFO - (blobuploader) - INFO - Done attempting. 04:59:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:08 INFO - Return code: 0 04:59:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5176766b69a4ca83f4fe3bea8f27217108f2bc89e10cdef4e2c040edf1f83f82231fc5c91dbd37473e95df2ce054b925b0e3999e4dd890ca928eb112be95c78a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de35661223014031a362a081c3e24afbdd67231761326a4600caa36a3a278149a7527f7c4508a02535730a478e312582a452a5674dce488f35630283bef2cc54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257dc97f0b6af3953751211ee02243a57b01d3f7bc24e7761ce2503bc50d6c108f556603922394bf2747ce28ea6c7c60bf5f98a5932be65c607bb08c2ee0d780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84af815b5aa2c628b939910179f9409b38d4ee7bcd1a97bb106759ef5e4c6ff74a57b756b58d81c1291b606582551b6df37f659a7773381f72697e3d5385f512"} 04:59:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:08 INFO - Contents: 04:59:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5176766b69a4ca83f4fe3bea8f27217108f2bc89e10cdef4e2c040edf1f83f82231fc5c91dbd37473e95df2ce054b925b0e3999e4dd890ca928eb112be95c78a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de35661223014031a362a081c3e24afbdd67231761326a4600caa36a3a278149a7527f7c4508a02535730a478e312582a452a5674dce488f35630283bef2cc54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257dc97f0b6af3953751211ee02243a57b01d3f7bc24e7761ce2503bc50d6c108f556603922394bf2747ce28ea6c7c60bf5f98a5932be65c607bb08c2ee0d780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84af815b5aa2c628b939910179f9409b38d4ee7bcd1a97bb106759ef5e4c6ff74a57b756b58d81c1291b606582551b6df37f659a7773381f72697e3d5385f512"} 04:59:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:08 INFO - Copying logs to upload dir... 04:59:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.414571 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-25 04:59:08.953464) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 04:59:08.956776) ========= 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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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/5176766b69a4ca83f4fe3bea8f27217108f2bc89e10cdef4e2c040edf1f83f82231fc5c91dbd37473e95df2ce054b925b0e3999e4dd890ca928eb112be95c78a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de35661223014031a362a081c3e24afbdd67231761326a4600caa36a3a278149a7527f7c4508a02535730a478e312582a452a5674dce488f35630283bef2cc54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257dc97f0b6af3953751211ee02243a57b01d3f7bc24e7761ce2503bc50d6c108f556603922394bf2747ce28ea6c7c60bf5f98a5932be65c607bb08c2ee0d780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84af815b5aa2c628b939910179f9409b38d4ee7bcd1a97bb106759ef5e4c6ff74a57b756b58d81c1291b606582551b6df37f659a7773381f72697e3d5385f512"} build_url:https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/NXU9QcT0SaeCVZjZaK_swA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5176766b69a4ca83f4fe3bea8f27217108f2bc89e10cdef4e2c040edf1f83f82231fc5c91dbd37473e95df2ce054b925b0e3999e4dd890ca928eb112be95c78a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de35661223014031a362a081c3e24afbdd67231761326a4600caa36a3a278149a7527f7c4508a02535730a478e312582a452a5674dce488f35630283bef2cc54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/257dc97f0b6af3953751211ee02243a57b01d3f7bc24e7761ce2503bc50d6c108f556603922394bf2747ce28ea6c7c60bf5f98a5932be65c607bb08c2ee0d780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84af815b5aa2c628b939910179f9409b38d4ee7bcd1a97bb106759ef5e4c6ff74a57b756b58d81c1291b606582551b6df37f659a7773381f72697e3d5385f512"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 04:59:08.992169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 04:59:08.992564) ========= 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.UfKd9KgSrB/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.ZDOpCjKV5H/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 04:59:09.042644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 04:59:09.043005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 04:59:09.043499) ========= ========= Total master_lag: 0.19 =========