builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0088 starttime: 1477096671.6 results: success (0) buildid: 20161021141823 builduid: 3742a67569144fff8003ba2e86674350 revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.604171) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.604720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.605012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.640943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.641287) ========= 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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-21 17:37:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2016-10-21 17:37:51 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146937 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.810623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.810953) ========= 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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.026546 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:51.859835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 17:37:51.860213) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-21 17:37:51,510 truncating revision to first 12 chars 2016-10-21 17:37:51,510 Setting DEBUG logging. 2016-10-21 17:37:51,510 attempt 1/10 2016-10-21 17:37:51,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5639a9f476d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 17:37:52,446 unpacking tar archive at: fx-team-5639a9f476d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.190110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 17:37:53.072395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:53.072715) ========= script_repo_revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:53.073122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:53.073385) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 17:37:53.091237) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-21 17:37:53.091600) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:37:52 INFO - MultiFileLogger online at 20161021 17:37:52 in /builds/slave/test 17:37:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:37:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:52 INFO - {'append_to_log': False, 17:37:52 INFO - 'base_work_dir': '/builds/slave/test', 17:37:52 INFO - 'blob_upload_branch': 'Fx-Team', 17:37:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:52 INFO - 'branch': 'Fx-Team', 17:37:52 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:52 INFO - 'config_files': ('talos/mac_config.py',), 17:37:52 INFO - 'default_actions': ('clobber', 17:37:52 INFO - 'read-buildbot-config', 17:37:52 INFO - 'download-and-extract', 17:37:52 INFO - 'populate-webroot', 17:37:52 INFO - 'create-virtualenv', 17:37:52 INFO - 'install', 17:37:52 INFO - 'run-tests'), 17:37:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:52 INFO - 'download_minidump_stackwalk': True, 17:37:52 INFO - 'download_symbols': 'ondemand', 17:37:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:37:52 INFO - 'tooltool.py': '/tools/tooltool.py', 17:37:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:37:52 INFO - '/tools/misc-python/virtualenv.py')}, 17:37:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:52 INFO - 'installer_path': 'installer.exe', 17:37:52 INFO - 'log_level': 'info', 17:37:52 INFO - 'log_name': 'talos', 17:37:52 INFO - 'log_to_console': True, 17:37:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:37:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:37:52 INFO - 'opt_config_files': (), 17:37:52 INFO - 'pip_index': False, 17:37:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:52 INFO - 'cmd': ('bash', 17:37:52 INFO - '-c', 17:37:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:52 INFO - 'enabled': True, 17:37:52 INFO - 'halt_on_failure': False, 17:37:52 INFO - 'name': 'check_screen_resolution'},), 17:37:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:52 INFO - 'cmd': ('bash', 17:37:52 INFO - '-c', 17:37:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:52 INFO - 'enabled': True, 17:37:52 INFO - 'halt_on_failure': False, 17:37:52 INFO - 'name': 'check_screen_resolution'},), 17:37:52 INFO - 'run_cmd_checks_enabled': True, 17:37:52 INFO - 'sps_profile': False, 17:37:52 INFO - 'sps_profile_interval': 0, 17:37:52 INFO - 'suite': 'dromaeojs-e10s', 17:37:52 INFO - 'system_bits': '32', 17:37:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:52 INFO - 'title': 't-yosemite-r7-0088', 17:37:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:52 INFO - 'use_talos_json': True, 17:37:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:52 INFO - 'work_dir': 'build'} 17:37:52 INFO - [mozharness: 2016-10-22 00:37:52.870415Z] Running clobber step. 17:37:52 INFO - Running pre-action listener: _resource_record_pre_action 17:37:52 INFO - Running main action method: clobber 17:37:52 INFO - rmtree: /builds/slave/test/build 17:37:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:54 INFO - Running post-action listener: _resource_record_post_action 17:37:54 INFO - [mozharness: 2016-10-22 00:37:54.962294Z] Finished clobber step (success) 17:37:54 INFO - [mozharness: 2016-10-22 00:37:54.962424Z] Running read-buildbot-config step. 17:37:54 INFO - Running pre-action listener: _resource_record_pre_action 17:37:54 INFO - Running main action method: read_buildbot_config 17:37:54 INFO - Using buildbot properties: 17:37:54 INFO - { 17:37:54 INFO - "project": "", 17:37:54 INFO - "product": "firefox", 17:37:54 INFO - "script_repo_revision": "production", 17:37:54 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:37:54 INFO - "repository": "", 17:37:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:37:54 INFO - "buildid": "20161021141823", 17:37:54 INFO - "pgo_build": "False", 17:37:54 INFO - "basedir": "/builds/slave/test", 17:37:54 INFO - "buildnumber": 14, 17:37:54 INFO - "slavename": "t-yosemite-r7-0088", 17:37:54 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:37:54 INFO - "platform": "yosemite_r7", 17:37:54 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 17:37:54 INFO - "branch": "fx-team", 17:37:54 INFO - "repo_path": "integration/fx-team", 17:37:54 INFO - "revision": "5639a9f476d08f300c079117e61697f5026b6367", 17:37:54 INFO - "stage_platform": "macosx64", 17:37:54 INFO - "builduid": "3742a67569144fff8003ba2e86674350", 17:37:54 INFO - "slavebuilddir": "test" 17:37:54 INFO - } 17:37:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 17:37:54 INFO - Running post-action listener: _resource_record_post_action 17:37:54 INFO - [mozharness: 2016-10-22 00:37:54.965595Z] Finished read-buildbot-config step (success) 17:37:54 INFO - [mozharness: 2016-10-22 00:37:54.965705Z] Running download-and-extract step. 17:37:54 INFO - Running pre-action listener: _resource_record_pre_action 17:37:54 INFO - Running main action method: download_and_extract 17:37:54 INFO - mkdir: /builds/slave/test/build/tests 17:37: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')]} 17:37:54 INFO - trying https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 17:37:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 17:37:55 INFO - Downloaded 1199 bytes. 17:37:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:37:55 INFO - Using the following test package requirements: 17:37:55 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:37:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 17:37:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 17:37:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'jsshell-mac.zip'], 17:37:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 17:37:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:37:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 17:37:55 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 17:37:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 17:37:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 17:37:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:37:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:37:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:37:55 INFO - Fetch https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:37:56 INFO - Http code: 200 17:37:56 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 17:37:56 INFO - x-amz-cf-id: 7llqDcUUUQyLOjY9FgfyQHbNLXRv3y_W292EpJjC0vNHb7wN-RR_Hw== 17:37:56 INFO - x-amz-version-id: 2KWVb2gbo4PRZQ6IdBesOAc95G51icFO 17:37:56 INFO - Expected file size: 16420869 17:37:56 INFO - Obtained file size: 16420869 17:38:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:38:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:38:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:38:03 INFO - Fetch https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:38:03 INFO - Http code: 200 17:38:03 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:38:03 INFO - x-amz-cf-id: bF_VYZ-vvBbdYnkN2Vr4CXSa-1v2HhrH7P3bIFmziD3SqSiBoUAdcg== 17:38:03 INFO - x-amz-version-id: 2KWVb2gbo4PRZQ6IdBesOAc95G51icFO 17:38:04 INFO - Expected file size: 16420869 17:38:04 INFO - Obtained file size: 16420869 17:38:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 17:38:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:38:10 INFO - Fetch https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 17:38:11 INFO - Http code: 200 17:38:11 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 17:38:11 INFO - x-amz-cf-id: CA5NTU1CQge_TAYWmCETTpqbOv59oInVuJwKApZERJsoCWryNipz6g== 17:38:11 INFO - x-amz-version-id: aTHOq_HdktvKwd2G7rnUg7duj8VPZya0 17:38:11 INFO - Expected file size: 14409028 17:38:11 INFO - Obtained file size: 14409028 17:38:12 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')]} 17:38:12 INFO - trying https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:38:12 INFO - Downloading https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 17:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 17:38:15 INFO - Downloaded 111317510 bytes. 17:38:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:38:15 INFO - mkdir: /builds/slave/test/properties 17:38:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:15 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:15 INFO - Contents: 17:38:15 INFO - build_url:https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:38:15 INFO - Running post-action listener: _resource_record_post_action 17:38:15 INFO - Running post-action listener: set_extra_try_arguments 17:38:15 INFO - [mozharness: 2016-10-22 00:38:15.634705Z] Finished download-and-extract step (success) 17:38:15 INFO - [mozharness: 2016-10-22 00:38:15.634829Z] Running populate-webroot step. 17:38:15 INFO - Running pre-action listener: _resource_record_pre_action 17:38:15 INFO - Running main action method: populate_webroot 17:38:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:15 INFO - '--tppagecycles', 17:38:15 INFO - '7'], 17:38:15 INFO - 'tests': ['tsvgm']}}, 17:38:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:38:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:38:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['damp', 'tps']}, 17:38:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'tests': ['damp', 'tps']}, 17:38:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['dromaeo_dom']}, 17:38:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['basic_compositor_video']}, 17:38:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:38:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other-e10s': {'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tsvgx', 17:38:15 INFO - 'tsvgr_opacity', 17:38:15 INFO - 'tart', 17:38:15 INFO - 'tscrollx', 17:38:15 INFO - 'cart']}, 17:38:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:38:15 INFO - 'tsvgr_opacity', 17:38:15 INFO - 'tart', 17:38:15 INFO - 'tscrollx', 17:38:15 INFO - 'cart']}, 17:38:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tp5o']}, 17:38:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'tests': ['tp5o']}, 17:38:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s', 17:38:15 INFO - '--xperf_path', 17:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:15 INFO - 'tests': ['tp5n']}, 17:38:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--xperf_path', 17:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:15 INFO - 'tests': ['tp5n']}}, 17:38:15 INFO - 'talos.zip': {'path': '', 17:38:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:15 INFO - Running post-action listener: _resource_record_post_action 17:38:15 INFO - [mozharness: 2016-10-22 00:38:15.654179Z] Finished populate-webroot step (success) 17:38:15 INFO - [mozharness: 2016-10-22 00:38:15.654300Z] Running create-virtualenv step. 17:38:15 INFO - Running pre-action listener: _resource_record_pre_action 17:38:15 INFO - Running main action method: create_virtualenv 17:38:15 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:15 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 17:38:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:15 INFO - Using real prefix '/tools/python27' 17:38:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:19 INFO - Installing pip.................done. 17:38:19 INFO - Return code: 0 17:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:38:19 INFO - Reading from file tmpfile_stdout 17:38:19 INFO - Output received: 17:38:19 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) 17:38:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:19 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 17:38:19 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 17:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:19 INFO - 'HOME': '/Users/cltbld', 17:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:19 INFO - 'LOGNAME': 'cltbld', 17:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:19 INFO - 'MOZ_NO_REMOTE': '1', 17:38:19 INFO - 'NO_EM_RESTART': '1', 17:38:19 INFO - 'PAGER': '/bin/cat', 17:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:19 INFO - 'PWD': '/builds/slave/test', 17:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:19 INFO - 'SHELL': '/bin/bash', 17:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:19 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:19 INFO - 'USER': 'cltbld', 17:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:19 INFO - 'XPC_FLAGS': '0x0', 17:38:19 INFO - 'XPC_SERVICE_NAME': '0', 17:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:19 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 17:38:19 INFO - Cleaning up... 17:38:19 INFO - Return code: 0 17:38:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:19 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 17:38:19 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 17:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:19 INFO - 'HOME': '/Users/cltbld', 17:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:19 INFO - 'LOGNAME': 'cltbld', 17:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:19 INFO - 'MOZ_NO_REMOTE': '1', 17:38:19 INFO - 'NO_EM_RESTART': '1', 17:38:19 INFO - 'PAGER': '/bin/cat', 17:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:19 INFO - 'PWD': '/builds/slave/test', 17:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:19 INFO - 'SHELL': '/bin/bash', 17:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:19 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:19 INFO - 'USER': 'cltbld', 17:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:19 INFO - 'XPC_FLAGS': '0x0', 17:38:19 INFO - 'XPC_SERVICE_NAME': '0', 17:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:20 INFO - Downloading/unpacking psutil>=3.1.1 17:38:20 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 17:38:20 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 17:38:20 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 17:38:20 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 17:38:20 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 17:38:20 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 17:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:23 INFO - Installing collected packages: psutil 17:38:23 INFO - Running setup.py install for psutil 17:38:24 INFO - building 'psutil._psutil_osx' extension 17:38:24 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 17:38:24 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 17:38:24 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 17:38:24 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 17:38:24 INFO - building 'psutil._psutil_posix' extension 17:38:24 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 17:38:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:38:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:38:24 INFO - ^ 17:38:25 INFO - 1 warning generated. 17:38:25 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 17:38:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:25 INFO - Successfully installed psutil 17:38:25 INFO - Cleaning up... 17:38:25 INFO - Return code: 0 17:38:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:25 INFO - 'HOME': '/Users/cltbld', 17:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:25 INFO - 'LOGNAME': 'cltbld', 17:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:25 INFO - 'MOZ_NO_REMOTE': '1', 17:38:25 INFO - 'NO_EM_RESTART': '1', 17:38:25 INFO - 'PAGER': '/bin/cat', 17:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:25 INFO - 'PWD': '/builds/slave/test', 17:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:25 INFO - 'SHELL': '/bin/bash', 17:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:25 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:25 INFO - 'USER': 'cltbld', 17:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:25 INFO - 'XPC_FLAGS': '0x0', 17:38:25 INFO - 'XPC_SERVICE_NAME': '0', 17:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:38:28 INFO - Installing collected packages: mozsystemmonitor 17:38:28 INFO - Running setup.py install for mozsystemmonitor 17:38:28 INFO - Successfully installed mozsystemmonitor 17:38:28 INFO - Cleaning up... 17:38:28 INFO - Return code: 0 17:38:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:28 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:28 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 17:38:28 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 17:38:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:28 INFO - 'HOME': '/Users/cltbld', 17:38:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:28 INFO - 'LOGNAME': 'cltbld', 17:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:28 INFO - 'MOZ_NO_REMOTE': '1', 17:38:28 INFO - 'NO_EM_RESTART': '1', 17:38:28 INFO - 'PAGER': '/bin/cat', 17:38:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:28 INFO - 'PWD': '/builds/slave/test', 17:38:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:28 INFO - 'SHELL': '/bin/bash', 17:38:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:28 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:28 INFO - 'USER': 'cltbld', 17:38:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:28 INFO - 'XPC_FLAGS': '0x0', 17:38:28 INFO - 'XPC_SERVICE_NAME': '0', 17:38:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:28 INFO - Downloading/unpacking jsonschema==2.5.1 17:38:28 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 17:38:28 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 17:38:28 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 17:38:28 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 17:38:28 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 17:38:28 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 17:38:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:38:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:31 INFO - Downloading functools32-3.2.3-2.tar.gz 17:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:38:31 INFO - warning: no files found matching '*.txt' 17:38:31 INFO - no previously-included directories found matching 'build' 17:38:31 INFO - no previously-included directories found matching 'dist' 17:38:31 INFO - no previously-included directories found matching '.git*' 17:38:31 INFO - Installing collected packages: jsonschema, functools32 17:38:31 INFO - Running setup.py install for functools32 17:38:31 INFO - warning: no files found matching '*.txt' 17:38:31 INFO - no previously-included directories found matching 'build' 17:38:31 INFO - no previously-included directories found matching 'dist' 17:38:31 INFO - no previously-included directories found matching '.git*' 17:38:31 INFO - Successfully installed jsonschema functools32 17:38:31 INFO - Cleaning up... 17:38:31 INFO - Return code: 0 17:38:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:31 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:31 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 17:38:31 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 17:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:31 INFO - 'HOME': '/Users/cltbld', 17:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:31 INFO - 'LOGNAME': 'cltbld', 17:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:31 INFO - 'MOZ_NO_REMOTE': '1', 17:38:31 INFO - 'NO_EM_RESTART': '1', 17:38:31 INFO - 'PAGER': '/bin/cat', 17:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:31 INFO - 'PWD': '/builds/slave/test', 17:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:31 INFO - 'SHELL': '/bin/bash', 17:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:31 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:31 INFO - 'USER': 'cltbld', 17:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:31 INFO - 'XPC_FLAGS': '0x0', 17:38:31 INFO - 'XPC_SERVICE_NAME': '0', 17:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:38:31 INFO - Cleaning up... 17:38:31 INFO - Return code: 0 17:38:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:31 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:31 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 17:38:31 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 17:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:31 INFO - 'HOME': '/Users/cltbld', 17:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:31 INFO - 'LOGNAME': 'cltbld', 17:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:31 INFO - 'MOZ_NO_REMOTE': '1', 17:38:31 INFO - 'NO_EM_RESTART': '1', 17:38:31 INFO - 'PAGER': '/bin/cat', 17:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:31 INFO - 'PWD': '/builds/slave/test', 17:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:31 INFO - 'SHELL': '/bin/bash', 17:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:31 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:31 INFO - 'USER': 'cltbld', 17:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:31 INFO - 'XPC_FLAGS': '0x0', 17:38:31 INFO - 'XPC_SERVICE_NAME': '0', 17:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:32 INFO - Downloading/unpacking blobuploader==1.2.4 17: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 17: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 17: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 17: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 17: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 17: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 17:38:34 INFO - Downloading blobuploader-1.2.4.tar.gz 17:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:38:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:38:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:35 INFO - Downloading docopt-0.6.1.tar.gz 17:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:38:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:38:36 INFO - Running setup.py install for blobuploader 17:38:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:38:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:38:36 INFO - Running setup.py install for requests 17:38:36 INFO - Running setup.py install for docopt 17:38:36 INFO - Successfully installed blobuploader requests docopt 17:38:36 INFO - Cleaning up... 17:38:36 INFO - Return code: 0 17:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:36 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:36 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 17:38:36 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 17:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:36 INFO - 'HOME': '/Users/cltbld', 17:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:36 INFO - 'LOGNAME': 'cltbld', 17:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:36 INFO - 'MOZ_NO_REMOTE': '1', 17:38:36 INFO - 'NO_EM_RESTART': '1', 17:38:36 INFO - 'PAGER': '/bin/cat', 17:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:36 INFO - 'PWD': '/builds/slave/test', 17:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:36 INFO - 'SHELL': '/bin/bash', 17:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:36 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:36 INFO - 'USER': 'cltbld', 17:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:36 INFO - 'XPC_FLAGS': '0x0', 17:38:36 INFO - 'XPC_SERVICE_NAME': '0', 17:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-E4tT8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-y0Lj8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-R0bSA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-kJUT8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-RYUABK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-jIwdeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Gm_Ij4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:37 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-lZKJQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-9Gdyc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-fDS41z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-l4Vt92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-jnK_Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-0fRKpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-WCbsGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-taonxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-MvS7kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-mNJFk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:38:38 INFO - Running setup.py install for manifestparser 17:38:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for mozcrash 17:38:39 INFO - Running setup.py install for mozdebug 17:38:39 INFO - Running setup.py install for mozdevice 17:38:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for mozfile 17:38:39 INFO - Running setup.py install for mozhttpd 17:38:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for mozinfo 17:38:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Running setup.py install for mozInstall 17:38:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Running setup.py install for mozleak 17:38:40 INFO - Running setup.py install for mozlog 17:38:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Running setup.py install for moznetwork 17:38:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Running setup.py install for mozprocess 17:38:40 INFO - Running setup.py install for mozprofile 17:38:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Running setup.py install for mozrunner 17:38:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:38:41 INFO - Running setup.py install for mozscreenshot 17:38:41 INFO - Running setup.py install for moztest 17:38:41 INFO - Running setup.py install for mozversion 17:38:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:38:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:38:41 INFO - Cleaning up... 17:38:41 INFO - Return code: 0 17:38:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:41 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:41 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 17:38:41 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 17:38:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:41 INFO - 'HOME': '/Users/cltbld', 17:38:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:41 INFO - 'LOGNAME': 'cltbld', 17:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:41 INFO - 'MOZ_NO_REMOTE': '1', 17:38:41 INFO - 'NO_EM_RESTART': '1', 17:38:41 INFO - 'PAGER': '/bin/cat', 17:38:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:41 INFO - 'PWD': '/builds/slave/test', 17:38:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:41 INFO - 'SHELL': '/bin/bash', 17:38:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:41 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:41 INFO - 'USER': 'cltbld', 17:38:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:41 INFO - 'XPC_FLAGS': '0x0', 17:38:41 INFO - 'XPC_SERVICE_NAME': '0', 17:38:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:41 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-l3Vgrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_PZZvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-m8dgah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_cK_vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-xdKMsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-VscYVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-niOItL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-iQ3EWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ilrSiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-D4QFfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:42 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-d9CHFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:43 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)) 17:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:43 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-gbGCPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:43 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-NmNben-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:43 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)) 17:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:43 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-N5PqWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:43 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XFUSQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:43 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)) 17:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:43 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-fAItmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:43 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-QFaXGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:43 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)) 17:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:38:43 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)) 17:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:38:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17: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 17: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 17: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 17: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 17: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 17: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 17:38:46 INFO - Downloading blessings-1.6.tar.gz 17:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:38:46 INFO - Installing collected packages: blessings 17:38:46 INFO - Running setup.py install for blessings 17:38:46 INFO - Successfully installed blessings 17:38:46 INFO - Cleaning up... 17:38:46 INFO - Return code: 0 17:38:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:38:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:46 INFO - Reading from file tmpfile_stdout 17:38:46 INFO - Current package versions: 17:38:46 INFO - blessings == 1.6 17:38:46 INFO - blobuploader == 1.2.4 17:38:46 INFO - docopt == 0.6.1 17:38:46 INFO - functools32 == 3.2.3-2 17:38:46 INFO - jsonschema == 2.5.1 17:38:46 INFO - manifestparser == 1.1 17:38:46 INFO - mozInstall == 1.12 17:38:46 INFO - mozcrash == 0.17 17:38:46 INFO - mozdebug == 0.1 17:38:46 INFO - mozdevice == 0.48 17:38:46 INFO - mozfile == 1.2 17:38:46 INFO - mozhttpd == 0.7 17:38:46 INFO - mozinfo == 0.9 17:38:46 INFO - mozleak == 0.1 17:38:46 INFO - mozlog == 3.4 17:38:46 INFO - moznetwork == 0.27 17:38:46 INFO - mozprocess == 0.23 17:38:46 INFO - mozprofile == 0.28 17:38:46 INFO - mozrunner == 6.12 17:38:46 INFO - mozscreenshot == 0.1 17:38:46 INFO - mozsystemmonitor == 0.3 17:38:46 INFO - moztest == 0.7 17:38:46 INFO - mozversion == 1.4 17:38:46 INFO - psutil == 3.1.1 17:38:46 INFO - requests == 1.2.3 17:38:46 INFO - wsgiref == 0.1.2 17:38:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:46 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')]} 17:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:46 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')]} 17:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:46 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 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:46 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 17:38:46 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 17:38:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:46 INFO - 'HOME': '/Users/cltbld', 17:38:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:46 INFO - 'LOGNAME': 'cltbld', 17:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:46 INFO - 'MOZ_NO_REMOTE': '1', 17:38:46 INFO - 'NO_EM_RESTART': '1', 17:38:46 INFO - 'PAGER': '/bin/cat', 17:38:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:46 INFO - 'PWD': '/builds/slave/test', 17:38:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:46 INFO - 'SHELL': '/bin/bash', 17:38:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:46 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:46 INFO - 'USER': 'cltbld', 17:38:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:46 INFO - 'XPC_FLAGS': '0x0', 17:38:46 INFO - 'XPC_SERVICE_NAME': '0', 17:38:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:38:47 INFO - Cleaning up... 17:38:47 INFO - Return code: 0 17:38:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d139490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0e1d84690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, '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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 17:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:38:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:38:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:47 INFO - 'HOME': '/Users/cltbld', 17:38:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:47 INFO - 'LOGNAME': 'cltbld', 17:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:47 INFO - 'MOZ_NO_REMOTE': '1', 17:38:47 INFO - 'NO_EM_RESTART': '1', 17:38:47 INFO - 'PAGER': '/bin/cat', 17:38:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:47 INFO - 'PWD': '/builds/slave/test', 17:38:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:47 INFO - 'SHELL': '/bin/bash', 17:38:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:38:47 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:38:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:47 INFO - 'USER': 'cltbld', 17:38:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:47 INFO - 'XPC_FLAGS': '0x0', 17:38:47 INFO - 'XPC_SERVICE_NAME': '0', 17:38:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:38:47 INFO - Cleaning up... 17:38:47 INFO - Return code: 0 17:38:47 INFO - Running post-action listener: _resource_record_post_action 17:38:47 INFO - Running post-action listener: _start_resource_monitoring 17:38:47 INFO - Starting resource monitoring. 17:38:47 INFO - [mozharness: 2016-10-22 00:38:47.500770Z] Finished create-virtualenv step (success) 17:38:47 INFO - [mozharness: 2016-10-22 00:38:47.501857Z] Running install step. 17:38:47 INFO - Running pre-action listener: _resource_record_pre_action 17:38:47 INFO - Running main action method: install 17:38:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:47 INFO - Reading from file tmpfile_stdout 17:38:47 INFO - Detecting whether we're running mozinstall >=1.0... 17:38:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:38:47 INFO - Reading from file tmpfile_stdout 17:38:47 INFO - Output received: 17:38:47 INFO - Usage: mozinstall [options] installer 17:38:47 INFO - Options: 17:38:47 INFO - -h, --help show this help message and exit 17:38:47 INFO - -d DEST, --destination=DEST 17:38:47 INFO - Directory to install application into. [default: 17:38:47 INFO - "/builds/slave/test"] 17:38:47 INFO - --app=APP Application being installed. [default: firefox] 17:38:47 INFO - mkdir: /builds/slave/test/build/application 17:38:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:39:22 INFO - Reading from file tmpfile_stdout 17:39:22 INFO - Output received: 17:39:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:39:22 INFO - Running post-action listener: _resource_record_post_action 17:39:22 INFO - [mozharness: 2016-10-22 00:39:22.256385Z] Finished install step (success) 17:39:22 INFO - [mozharness: 2016-10-22 00:39:22.256514Z] Running run-tests step. 17:39:22 INFO - Running pre-action listener: _resource_record_pre_action 17:39:22 INFO - Running main action method: run_tests 17:39:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:39:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:39:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:39:22 INFO - 2016-10-21 17:39:22.270 screenresolution[1644:7808] starting screenresolution argv=screenresolution get 17:39:22 INFO - 2016-10-21 17:39:22.273 screenresolution[1644:7808] Display 0: 1600x1200x32@60 17:39:22 INFO - 2016-10-21 17:39:22.279 screenresolution[1645:7810] starting screenresolution argv=screenresolution list 17:39:22 INFO - Available Modes on Display 0 17:39:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:39:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:39:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:39:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:39:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:39:22 INFO - Intel Iris: 17:39:22 INFO - Chipset Model: Intel Iris 17:39:22 INFO - Type: GPU 17:39:22 INFO - Bus: Built-In 17:39:22 INFO - VRAM (Dynamic, Max): 1536 MB 17:39:22 INFO - Vendor: Intel (0x8086) 17:39:22 INFO - Device ID: 0x0a2e 17:39:22 INFO - Revision ID: 0x0009 17:39:22 INFO - Displays: 17:39:22 INFO - Display: 17:39:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:39:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:39:22 INFO - Display Serial Number: 1600x1200 60 17:39:22 INFO - Main Display: Yes 17:39:22 INFO - Mirror: Off 17:39:22 INFO - Online: Yes 17:39:22 INFO - Rotation: Supported 17:39:22 INFO - Return code: 0 17:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:22 INFO - Python 2.7.3 17:39:22 INFO - Return code: 0 17:39:22 INFO - grabbing minidump binary from tooltool 17:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:22 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 0x10cf4dd30>, '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 0x10cd73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf45b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:22 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 17:39:22 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 17:39:22 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 17:39:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:22 INFO - Return code: 0 17:39:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:39:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:39:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 17:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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 17:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bMcqHNOWgz/Render', 17:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:22 INFO - 'HOME': '/Users/cltbld', 17:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:22 INFO - 'LOGNAME': 'cltbld', 17:39:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:22 INFO - 'MOZ_NO_REMOTE': '1', 17:39:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:22 INFO - 'NO_EM_RESTART': '1', 17:39:22 INFO - 'PAGER': '/bin/cat', 17:39:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:22 INFO - 'PWD': '/builds/slave/test', 17:39:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:22 INFO - 'SHELL': '/bin/bash', 17:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Igd8RMZmYZ/Listeners', 17:39:22 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 17:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:22 INFO - 'USER': 'cltbld', 17:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:22 INFO - 'XPC_FLAGS': '0x0', 17:39:22 INFO - 'XPC_SERVICE_NAME': '0', 17:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 17:39:22 INFO - mozversion application_buildid: 20161021141823 17:39:22 INFO - mozversion application_changeset: 5639a9f476d08f300c079117e61697f5026b6367 17:39:22 INFO - mozversion application_display_name: Nightly 17:39:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:22 INFO - mozversion application_name: Firefox 17:39:22 INFO - mozversion application_remotingname: firefox 17:39:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:39:22 INFO - mozversion application_vendor: Mozilla 17:39:22 INFO - mozversion application_version: 52.0a1 17:39:22 INFO - mozversion platform_buildid: 20161021141823 17:39:22 INFO - mozversion platform_changeset: 5639a9f476d08f300c079117e61697f5026b6367 17:39:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:39:22 INFO - mozversion platform_version: 52.0a1 17:39:22 INFO - using testdate: 1477096762 17:39:22 INFO - actual date: 1477096762 17:39:22 INFO - starting webserver on 'localhost:49279' 17:39:22 INFO - SUITE-START | Running 2 tests 17:39:22 INFO - TEST-START | dromaeo_css 17:39:22 INFO - operating with platform_type : mac_ 17:39:22 INFO - Initialising browser for dromaeo_css test... 17:39:22 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpB1X5on/profile http://localhost:49279/getInfo.html) 17:39:25 INFO - PROCESS | 1655 | 2016-10-21 17:39:25.833 plugin-container[1657:7981] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 17:39:25 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:25 INFO - PROCESS | 1655 | 2016-10-21 17:39:25.836 plugin-container[1657:7981] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 17:39:25 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:25 INFO - PROCESS | 1655 | 2016-10-21 17:39:25.836 plugin-container[1657:7981] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:39:25 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 17:39:25 INFO - PROCESS | 1655 | colorDepth:24 17:39:25 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 17:39:25 INFO - PROCESS | 1655 | __metrics 17:39:25 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 17:39:26 INFO - TEST-INFO | 1655: exit 0 17:39:26 INFO - Browser initialized. 17:39:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:39:26 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpB1X5on/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:29 INFO - PROCESS | 1658 | 2016-10-21 17:39:29.003 plugin-container[1659:8097] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8743, name = 'com.apple.tsm.portname' 17:39:29 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:29 INFO - PROCESS | 1658 | 2016-10-21 17:39:29.004 plugin-container[1659:8097] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 17:39:29 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:29 INFO - PROCESS | 1658 | 2016-10-21 17:39:29.004 plugin-container[1659:8097] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:39:38 INFO - PROCESS | 1658 | RSS: Main: 236593152 17:39:38 INFO - PROCESS | 1658 | 17:40:28 INFO - PROCESS | 1658 | 1477096828234 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:42:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 17:42:44 INFO - PROCESS | 1658 | RSS: Main: 249212928 17:42:44 INFO - PROCESS | 1658 | 17:45:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 17:45:47 INFO - PROCESS | 1658 | RSS: Main: 263331840 17:45:47 INFO - PROCESS | 1658 | 17:48:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 17:48:49 INFO - PROCESS | 1658 | RSS: Main: 268046336 17:48:49 INFO - PROCESS | 1658 | 17:51:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 17:51:52 INFO - PROCESS | 1658 | RSS: Main: 267763712 17:51:52 INFO - PROCESS | 1658 | 17:54:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 17:54:55 INFO - PROCESS | 1658 | RSS: Main: 273993728 17:54:55 INFO - PROCESS | 1658 | 17:57:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 17:57:58 INFO - PROCESS | 1658 | RSS: Main: 277557248 17:57:58 INFO - PROCESS | 1658 | 17:57:58 INFO - PROCESS | 1658 | __start_tp_report 17:57:58 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 17:57:58 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 17:57:58 INFO - PROCESS | 1658 | |i|pagename|runs| 17:57:59 INFO - PROCESS | 1658 | |0;dojo.html;3286.0798976286646;3313.9668603313967;3351.882684106057;3378.2061215614326;3379.8479068441916;4592.196365636017;4885.804567817292;5473.452654734525;5489.752961116749;5517.172424136376;5563.193336966137;5580.497755202041;5585.1063829787245;5617.522510586595;5653.293338332708;5072.34059572257;5098.725318670333;5144.151215049513;5194.142966410538;5227.320448341729;4472.284434490482;5148.253503242027;5173.560247378978;5215.556677682402;5233.528982391584;3826.8136877568045;4361.869143925687;5003.674761140514;5204.401493828202;5236.1098613235845;4305.935410968838;4861.756912154378;4941.357623508921;5069;5095.770690318945;4544.909101817978;4547.317902314646;4798.352222449959;5106.617003724698;5108.540231379194;4266.637335826458;5433.728313584305;5587.580931430159;5591.580631452657;5713.171590119451;5936.881262374772;6021.488173505258;6123.050927106306;6138.8772224555705;6168.691565421711;6143.815685529441;6183.9381606183815;6201.255849298113;6211.0372892201785;6219.875602487925;5712.6001179917;5721.914171287434;5729.799457018984;5735.8852822944145;5759.884802303973;6138.5396095292135;6144.525313924626;6154.969225153845;6196.287426945869;6232.968835155886;6027.246594175728;6058.787942421994;6061.787837425669;6080.179175811298;6101.816945491642;5983.461488466059;6102.206713127265;6189.938100619026;6198.504119670506;6220.62676239418;5987.251593550806;6082.847928801815;6095.085737139465;6099.176611157437;6117.510599152057;6090.086487026982;6092.055731361646;6096.359882212392;6103.786367477117;6119.051547010221;4833.830815921426;4840.056189043174;4842.394700662418;4843;4844.128056949712;3635.9636403635627;4360.65114790816;4383.3863259143745;4392.209402307615;4393.011572396185;5465.07093794056;5696.430356964271;5710.371859095496;5725.341585717612;5836.124581312837;6159.969200153971;6175.598586091979;6177.505799536027;6192.040233763774;6224.875502490016;5727.4845263926445;5785.363610002896;5810.477057064884;5811.94188058114;5831.06702927538;5218.765155567932;5221.817236396708;5239.607029472805;5295.4439783822145;5298;6139.8601398601395;6140.8416929778305;6157.983932651152;6181.258249010148;6265.4361107500545;6163.260408750979;6192.195014648067;6196.256449226122;6204.844878878064;6214.5028397728975;6239.96880015597;6245.812625621239;6264.780732674334;6265.216847894013;6387.968060159669;5907.261592300963;5930.703464826655;5945.762169513171;5992.370801065826;6029.276486821609;4882.829100981448;6159.384061593805;6159.538034647329;6160.229971253593;6163.907541386972;4434.911301774011;5279.313689220377;5627.746751396279;5913.113033045078;5973.372795856546;4352.717073390219;5217.373915130209;5376.112941364788;5433.864153396196;5903.291605007426;4435;5151.2273159026445;5790.160426738184;5876.647401155944;6003.549733770072;5980.312264089512;5998.880022399615;5999.640021598718;6047.758089676364;6056.36408177135;5682.9431705684065;5684.857878553069;5722.513586345207;5843.152742852178;5860.970695146497 17:57:59 INFO - PROCESS | 1658 | |1;ext.html;479.319366499571;502.720989850633;509.673808762392;517.8265281130821;525.7607788456253;34028.659713402856;34341.82829085854;39754.00614984627;39785;39791.80624581264;41604.3358265669;42056;42141.57858421415;42142;42207.944801379905;9452.14930656239;9647.131758141766;9647.469389183592;9667.033296670346;9668.661596844111;9486.715398538021;9568.043195680446;9578.425294482353;9603.18372938301;9609.135177833994;9578.61685532578;9594.232461403071;9606;9622.422654640708;9637.518124093802;9494.098060684224;9519.904800951972;9548.856767148498;9576.138147566682;9579.802524684379;9485.525723713787;9562.235021198358;9575.569099390545;9592.184664303542;9597.088276613711;39201.01997450058;39381.80309098465;39677.20645587101;39704;39718.20563588712;3404.710599599037;3471.5139880416764;3581.964180358189;3837.9040523986846;4101.651359634435;24321;30239.546406803915;30739.692603073905;30794.692053079405;31207;3137.294108825519;3144.1510792086237;3159.178613560468;3173.0639461358955;3189.681031896815;354356;354418.22790886136;357972;359280.4071959273;359454;46487.67561621905;47879.76060119677;48299.27551086737;51861.740691296305;56890.715546422005;59413.702931485066;59588.70205648944;59890.70054649699;59948.700256498436;60047.79904401887;11791.29252244868;15637;15864.365425382855;15902.522924312289;15906.204689765696;12140.878591214152;12398.81401778956;12515.624531264077;12530.122891397697;12544.121911466109;15253.6186595336;15349.539513814603;15399.23003849803;15417.922910385376;15604;6290.968545157245;6400.39196276353;6458.38645328693;6479.254885688112;6496.090547323379;893.7095443980733;974.8001659659752;1005.3415013166388;1050.8738951325736;1101.1741194104422;24500;25054;29423.411531769245;29700.257493562833;30130.096097117123;936.5879013234155;1049.4700176410863;1056.2289528644133;1063.3141623652855;1106.181425744943;12127.454264558117;12544.372781360895;13414.865851341558;14987.625309367353;15421.845781542266;529607;640526;641432;642790;646222;55146;55605.16592251039;55812;55834.16248756272;56191;1163.7672465506932;1295.8574556798744;1349.0961056092247;1372.945082196721;1380.496118916588;29763.55354669725;29843.552346714383;30261.848690756404;30280.114975166547;30303.545446817876;46553;47205.29192062191;47235;47256.818579535786;47482.28776568285;488976;489746;489845;490893.54553227004;491513;24469.877650611634;24632;24881.626775598743;24909.377265568506;24953.500929980935;43595.34606980961;43824.56175438205;44013.779931100136;44124;44609.77695111504;36826.8158659205;36991.445128323634;37636.62363376331;38040.42939355967;38214.426783597715;36356;36364.81817590895;36812.26375472529;37167;37564;35723.64276357307;36298.092547686516;36815;36840.44739328859;36882.63117368792;29686.851565742032;30289.697103029568;32526.34947301088;32823.507647385784;32848.1787955303;24541.877290613433;24640.753592463847;24825.751742482345;24914.71813536883;25332 17:57:59 INFO - PROCESS | 1658 | |2;jquery.html;369.60083110240936;370.5368289637951;372.81731951343835;378.1453914154011;394.11324519830384;18862.339818106368;19568.90215548922;20166.89916550419;20182.78903265805;20405.693914591255;11549.076073914088;12004.579839705611;12167.817482737766;12199.451024703887;12247.02023838093;5213;5539.25220095288;5544.306961629796;5545.889082218353;5546.667199967995;3914.5106861642294;4115.444415003966;5392.865178370533;5843.561732870031;6151.969240153793;6155.169052177966;6184.165137706397;6190.226221722285;6205.22434695663;6207.162033125515;5865.35481097079;6061.636301821883;6091.42131497507;6095.390460953913;6105.053716673922;5090.905455327085;5388.7305634718105;5890.499307558863;5903.26209223847;5927.318358388754;13041.934790326082;13195.73608527824;13283.136596121318;13304.06871518994;16325.755113673304;2258.898349574257;2259.2544460328054;2354.4702441950594;2663.813533052687;2860.985695071532;9659.130678238922;9682.56428460721;9799;10134.037266459674;10298.691039268833;1741.3295881085746;1847.3257261099736;1853.3605905962422;1854.323172042195;1897.3643829317195;110164;116633.41683291529;119837.20651173942;120297;120581.99999999913;11348.886511134948;11450.370229637283;11550.595729149607;11634.825477617842;11716.648500544998;14459.927700361432;14532.273386330853;14537.927310363591;14548;14570.125792452487;8283.710070147516;8352.749417517483;8414.663413463515;8426.747197584082;8543.444676096035;8229.218224268805;8245.95877020611;8266.346730653893;8442.788930276669;8475.915240847637;3540.044188069207;4048.574899635496;4188.952761809548;4531.252343363374;4595.885102872455;1561.664242187935;1616.6524197297638;1654.3134599141463;1733.3673209278522;1932.5168707823045;770.2028400605459;874.3355050161796;887.0995939121797;896.0949441064572;929.256594724218;18593.90703046503;20739.4815129623;21628.4592885176;21879;21961.01175447077;794.5788731972063;886.7871710789364;972.1833659725864;1041.4844651897358;1072.104792498257;10964.725881853017;11108.333499989865;11332.546698131982;11357.716057098638;11466.2546934449;440888;521105;523294;523925.7607423953;543655.6215916314;101494.98505015003;128121;131476;132702.33648831694;138774.91837622444;895.8835351404276;987.3976874106789;1003.708924411927;1008.5360734062267;1040.2302296300684;16181.838181618505;19034.333798317548;19039.477696626167;19178.616427671088;19327.8067219326;45633.771831140635;51758.48241517687;52010;52170.71704935421;52560.47439525556;70492.64753676199;72567.82296531112;82115;82743.58628206821;82758;6745.426638735762;7979.9202007979175;8017.518948863087;8077.869098326357;8300.252977232078;9821.705348839547;12359.938200308941;12494.875051249372;12739.80890286628;12880.291583962971;9867.309288350034;10942.398168100832;11056.004959553678;11059.612913547988;11172.21794474379;10834.349939003685;10862.891371086504;11112.944435277772;11203.327800331681;11298.83051754208;8068.435209535276;10729.570817167227;11108.44457777124;11240.606578769704;11572.42137893085;8118.634661440367;8308.29379502749;8371.581420928807;8375;8387.412881098264;8865.911340886509;8867.334949878656;9029.954850225708;10212.978702129727;11399.658010259705 17:57:59 INFO - PROCESS | 1658 | |3;mootools.html;1538.7999560057192;1569.1997081488441;1840.861935354848;1874.09106583307;1945.2219112355056;6176.783812566561;8245.422820402575;8441.113683063282;9011.819763604724;9142.497162656051;8462.957685211566;8760.780980475476;8786.209241168293;8855.778605534864;8872.8669069964;2253.8196944244423;2299.310206937912;2308.7922087012166;2309.7921187093157;2317.6755254264417;2281.589313923493;2291.8281128915314;2325.360525855395;2326.6510023496444;2329.4409341758023;1996.4609555420027;2314.1553333033407;2333.9299821005397;2334.4980829121737;2340.847844890085;2297.3452566018605;2308.884555772213;2310.260716570698;2311.248844125666;2319.7564255753155;2296.1159953417887;2301.4476525633895;2301.9884900575557;2306.7923886850263;2309.8036666883336;8922.73231803047;8958.641654333884;8974.506402147945;8981.865272020925;9008.639654413815;5159.948400515985;5382.085045542267;5397.325334333208;5398.973005134989;5401.43284955078;3431.1422144463886;3515.5078289039557;3632.691221246197;3635.1820840310984;3650.963490365089;1024.3239461955147;1057.2810488867567;1061.124572227915;1082.9350238985608;1083.8916108389176;11535.423228838525;11537.653870383901;11659.88340116605;11664.708382290512;11667.94988451035;3352.8491217894766;4484.775761211927;4703.647226457961;4713.269443236304;4768.117898188777;9855.852162217572;9918.05778451046;9942.154916832005;9952.154066904393;9970.953049929798;5354.063038968165;5381.165919282517;5382.515573598316;5397.920415916832;5418.214358917935;4383;4543.295789152687;4888.242322440027;4934.284528743384;4938.308636790852;3844.231153769257;3852.845886164578;3944.1914407546383;3962.643362097425;3971.3050216212623;1242.3601845049807;1259.4269607328642;1260.0675500129837;1265.2598230035348;1265.6266401411606;789.9723509677134;931;931.2131249094505;932.6558817973053;954.9713508594754;5024.397072351341;5791.088940649575;5934.673592952343;6011.188489553854;6038.818835434944;419.6076668315135;425.85095216673915;434.83258945306284;436.1843352930041;440.6012558634441;3837.4458344370573;3910.4916360872903;4004.379321205218;4022.6580740637373;4024.0141165414075;10461.9476902615;10683.25217234786;10771.569137234423;10780.838287425695;10792.190585706103;10354.223433242387;10587;10744.570217191382;10792.190585706103;11059.115270778319;8190.54951977635;8278.296344810638;8290.585470726439;8297.12880147588;8312.70905518316;5038.470960549236;5708.886767080379;5883.470487656132;5911.142884281841;5936.079907614327;10017.849732254168;10040.548175332273;10078.546465409221;10101.343412678152;10184.134348580454;8922.375433719577;10034.297599167989;10159.136473399843;10291.022352876465;10386.324888882198;6911.412529934811;7093.3970612498515;7220.8916866246;7358.190599034209;7590.127135379502;8324.583770811314;8499.150084991452;8505.74482765518;8514.957425212835;8536.44513106646;7299.927000729925;7488.5506869588;7490.1386340571535;7497.737579184703;7600.46796724224;6546.541742078009;7218.494705370574;7374.815629609303;7425.257474252531;7470.514416562906;5904.261967254093;6936.34104760047;7021.613811240431;7023.086998690138;7046.541974771623;4772.427308722976;4807.134715751198;4810.687305325143;4852.975735121443;4891.437484689306;4746.311784791117;4856.660033797601;4918;4940.505949405031;4944.184209605375 17:57:59 INFO - PROCESS | 1658 | |4;prototype.html;255.65997223692492;297.5328733887796;305.46086157931256;310.02651673744447;312.31135346560836;4433.0247345584;5146.459621739719;5309.70796606187;5326.307580014597;5342.412334643191;4583.88540286493;4960.627952903528;5318.388385335687;5347.786088556453;5402.270693456382;4059.1881623675235;4074.9185016299803;4105.445764821756;4121;4122.381642753581;3429.588449386077;3959.9506130875197;4093.9181216375655;4112.670986321102;4126.381042843583;3713.6286371362785;4022.5776293489203;4066.6340029397347;4071.862272307033;4109.21924834282;3427.365937301607;3982.5308308848553;4051.210014047262;4083.387491876242;4115.382692596105;3167.4298626247264;3374.358871814372;3552.0587044433246;3556.76881002734;3585.8027808470524;4530.388397566319;4725.574698277137;4995.370072345711;5183.3002544656365;5188.766505507261;3856.5564960029396;4664.65015123867;4667.906641867144;4680.672352935262;4682.204025315705;5584.776608935637;5597.216389705444;5647.491725744661;5655.349634792011;5664.291963504562;3659.579148397915;3742.8128593570214;3879.7866117363533;3921.490206273195;3923.2545816295096;5043.646944713872;5762.205330414746;5783.744339707518;5898.380670029671;5914.556408269397;3891.8832435026993;3925.450436938831;3943.743656662308;3958.960410395917;3971.205758848242;3690.4279836625365;3922.2155568885764;4006.3990401439432;4024.678025757932;4034.8184331705143;4624.907501849944;4633.745144017112;4643.419572553431;4652.860414187512;4686.414198225222;4769.6661233714;5394.541463975527;5700.315962084576;5784.31029571243;5795.710214489259;1116.0914835631;1248.3945286536023;1259.471022170672;1306.4121145484569;1335.5459143891123;881.3742243007408;882.1531329923346;888.3870129610548;902.1159263921263;902.8420026495337;5317.7872885084935;5328.960852633699;5337.8131765388025;5347.385050719139;5368.436314186954;4956.801727930914;5763.50148961273;5805.577633479825;5821.27234095738;5844.824655260349;4396.824127034883;5005.998800239967;5182.637215394886;5219.329814459336;5271.604629652791;2159.6286358162365;2555.8754148174744;2565.653636759051;2593.753593408623;2599.6880374355196;4381.824727010948;4692.504084457101;5075.543201111917;5080.935251798546;5090.694558326512;4300.182965236595;4469.888252793706;4675.392199014106;5017.623678224148;5041.899162016739;4188.8324467020975;4900.338454308623;5056.443791183041;5109.540141387293;5118.411382690963;4216.903605062645;4318.5681431856565;4433.401490798701;4661.417322834645;4921.753912304442;4108.075682971427;4448.888777780581;4482.663800214932;4787.199488299384;5269.552088072557;4747.477777444409;6062.333143354315;6090.665013424305;6137.754489820536;6147.3587441481395;3260.853261603186;3868.593797651206;3878.204967981613;3881.7282790204413;3897.8440862366324;5628.761672432059;5782.421757824352;5838.474537291494;5866.67733274674;5871.266091738533;5596.852645207641;5669.546436285004;5681.630694004876;5687.857803554944;5699.945510080648;4598.908021839611;5609.185753687531;5637.378618942212;5681.17622944679;5725.227094342377;5244.632875698664;5566.582506312124;5567.7494512747835;5647.463490968352;5663.546916246608;5000.499950004971;5746.040788993755;5746.597738158289;5759.884802303846;5763.538916886555;5432.266644003009;5535.501804837584;5590;5608.195902048976;5620 17:57:59 INFO - PROCESS | 1658 | |5;yui.html;707.2715103443452;723.1177962885281;735.0701362776089;752.1650967426159;772.0118248641738;11525.769484610302;15582.532524024284;15939.84060159398;16280.755788663164;16417.75373369399;14266.215358155298;14304.284785760723;14411;14419.78370324446;14433.278336083207;869.0657543141117;883.425773247388;884.796496805735;885.6014793342989;885.7696998780299;691.6679993603049;713.2261496276546;863.0678866823847;882.6998820401062;891.6656253904786;940.534435454451;942.9198518125968;946.4841661294611;947;947.2185447006214;931.16660588773;939.6758118449159;940.219617717293;940.5814412586402;941.4915945389481;671.7380221713536;690.1442211657559;690.5304393012749;691.9827004324882;694.1080711286023;14761.77857332141;15002.949793514459;15086.54740357791;15107.244637768068;15171.620709482351;12322.445489952974;14563.344649490798;14616.26918654063;14621.70756584873;14788.482403115946;11692.649220523313;11740.947353688103;11809.114316426303;11964.222325548899;12094.697632559168;3753.361928472139;3793.2603142387247;3816.427535869614;3822.4266360045935;3829.617038296176;108701;112078;112823.43588282088;113399;114348.428257859;11218.270812397168;11254.831177532344;11263.32420054783;11516.251443656136;11727.589534366256;19000.90499547521;19055.99912009219;19809.40571782849;22011.669824952638;22849.428764280692;7056.259092795285;7926.207379262028;8169.509829410135;8348.624311905978;8382;4314.245007123741;4365.192439398721;4462.709923854939;4471.754053527022;4631.166390049823;3596.4245720684567;3697.242065376591;3720.3675375186285;3722.3858063419234;3759.079025638736;662.3376623376623;675.1560549313358;676.6853413162903;692.8371832619331;694.2952902803659;616.7101462312706;638.8019713888709;662.6388618203091;672.9259781424138;685.7976896815452;8953.59708813105;9057.547122643842;9343.345965782466;9450.243980481546;9485.810283794286;561.4497792163702;594.6432140715536;661.5732852310233;665.2582370656683;681.5161235522835;4519.276915693539;4681.602063824613;4682.214528752931;4712.64655150865;4788.808447662124;85193;111574.76850462945;146171;152138;157761;142297;142461;144372;144540;146886.2655686715;65314.34685653083;66058.66970665116;85854.57072714597;88843;96463.9999999986;7776.533407995538;8803.867941981003;8950.820983580423;9026.368154229142;9038.322125840457;57924.841503170544;60427.69786151041;68447.31552684409;68530.65734671295;69230.30769692239;78775.60612196902;91238.54380728054;91376.54311728399;92652.53673731588;97532;13000.08999370035;13179.802302965272;13241.602751917459;13333.066685331934;13489.190648561118;12327.69180770488;14805.18571478579;14907.595501164002;15221;15348.309326080576;13237.735245294847;13502.459901603826;13766.93116534411;13888.444462221398;14226.359813808196;10476.947615261875;13791.172529648253;13825.861741382458;14123.863687250645;14128.646783830487;11218.55125794959;13226.867731322563;13631.454741810614;13970.022098453011;14001.5099471518;11205.159613029218;11293.943530282297;11301.15241356885;11492.655220343404;11658.629270749914;10277.383356998604;10551.678381331105;10903.181423913917;11565.942170289094;11576.421178941187 17:57:59 INFO - PROCESS | 1658 | __end_tp_report 17:57:59 INFO - PROCESS | 1658 | __start_cc_report 17:57:59 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,361 17:57:59 INFO - PROCESS | 1658 | __end_cc_report 17:57:59 INFO - PROCESS | 1658 | __startTimestamp1477097878993__endTimestamp 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - PROCESS | 1658 | ------- Summary: start ------- 17:57:59 INFO - PROCESS | 1658 | Number of tests: 6 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5546.95 Median:5759.88 stddev:710.76 (12.3%) stddev-sans-first:690.46 17:57:59 INFO - PROCESS | 1658 | Values: 3286.1 3314.0 3351.9 3378.2 3379.8 4592.2 4885.8 5473.5 5489.8 5517.2 5563.2 5580.5 5585.1 5617.5 5653.3 5072.3 5098.7 5144.2 5194.1 5227.3 4472.3 5148.3 5173.6 5215.6 5233.5 3826.8 4361.9 5003.7 5204.4 5236.1 4305.9 4861.8 4941.4 5069.0 5095.8 4544.9 4547.3 4798.4 5106.6 5108.5 4266.6 5433.7 5587.6 5591.6 5713.2 5936.9 6021.5 6123.1 6138.9 6168.7 6143.8 6183.9 6201.3 6211.0 6219.9 5712.6 5721.9 5729.8 5735.9 5759.9 6138.5 6144.5 6155.0 6196.3 6233.0 6027.2 6058.8 6061.8 6080.2 6101.8 5983.5 6102.2 6189.9 6198.5 6220.6 5987.3 6082.8 6095.1 6099.2 6117.5 6090.1 6092.1 6096.4 6103.8 6119.1 4833.8 4840.1 4842.4 4843.0 4844.1 3636.0 4360.7 4383.4 4392.2 4393.0 5465.1 5696.4 5710.4 5725.3 5836.1 6160.0 6175.6 6177.5 6192.0 6224.9 5727.5 5785.4 5810.5 5811.9 5831.1 5218.8 5221.8 5239.6 5295.4 5298.0 6139.9 6140.8 6158.0 6181.3 6265.4 6163.3 6192.2 6196.3 6204.8 6214.5 6240.0 6245.8 6264.8 6265.2 6388.0 5907.3 5930.7 5945.8 5992.4 6029.3 4882.8 6159.4 6159.5 6160.2 6163.9 4434.9 5279.3 5627.7 5913.1 5973.4 4352.7 5217.4 5376.1 5433.9 5903.3 4435.0 5151.2 5790.2 5876.6 6003.5 5980.3 5998.9 5999.6 6047.8 6056.4 5682.9 5684.9 5722.5 5843.2 5861.0 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:62348.04 Median:38127.43 stddev:134000.08 (351.5%) stddev-sans-first:134295.47 17:57:59 INFO - PROCESS | 1658 | Values: 479.3 502.7 509.7 517.8 525.8 34028.7 34341.8 39754.0 39785.0 39791.8 41604.3 42056.0 42141.6 42142.0 42207.9 9452.1 9647.1 9647.5 9667.0 9668.7 9486.7 9568.0 9578.4 9603.2 9609.1 9578.6 9594.2 9606.0 9622.4 9637.5 9494.1 9519.9 9548.9 9576.1 9579.8 9485.5 9562.2 9575.6 9592.2 9597.1 39201.0 39381.8 39677.2 39704.0 39718.2 3404.7 3471.5 3582.0 3837.9 4101.7 24321.0 30239.5 30739.7 30794.7 31207.0 3137.3 3144.2 3159.2 3173.1 3189.7 354356.0 354418.2 357972.0 359280.4 359454.0 46487.7 47879.8 48299.3 51861.7 56890.7 59413.7 59588.7 59890.7 59948.7 60047.8 11791.3 15637.0 15864.4 15902.5 15906.2 12140.9 12398.8 12515.6 12530.1 12544.1 15253.6 15349.5 15399.2 15417.9 15604.0 6291.0 6400.4 6458.4 6479.3 6496.1 893.7 974.8 1005.3 1050.9 1101.2 24500.0 25054.0 29423.4 29700.3 30130.1 936.6 1049.5 1056.2 1063.3 1106.2 12127.5 12544.4 13414.9 14987.6 15421.8 529607.0 640526.0 641432.0 642790.0 646222.0 55146.0 55605.2 55812.0 55834.2 56191.0 1163.8 1295.9 1349.1 1372.9 1380.5 29763.6 29843.6 30261.8 30280.1 30303.5 46553.0 47205.3 47235.0 47256.8 47482.3 488976.0 489746.0 489845.0 490893.5 491513.0 24469.9 24632.0 24881.6 24909.4 24953.5 43595.3 43824.6 44013.8 44124.0 44609.8 36826.8 36991.4 37636.6 38040.4 38214.4 36356.0 36364.8 36812.3 37167.0 37564.0 35723.6 36298.1 36815.0 36840.4 36882.6 29686.9 30289.7 32526.3 32823.5 32848.2 24541.9 24640.8 24825.8 24914.7 25332.0 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:31801.43 Median:3200.51 stddev:86429.38 (2700.5%) stddev-sans-first:86639.61 17:57:59 INFO - PROCESS | 1658 | Values: 369.6 370.5 372.8 378.1 394.1 18862.3 19568.9 20166.9 20182.8 20405.7 11549.1 12004.6 12167.8 12199.5 12247.0 5213.0 5539.3 5544.3 5545.9 5546.7 3914.5 4115.4 5392.9 5843.6 6152.0 6155.2 6184.2 6190.2 6205.2 6207.2 5865.4 6061.6 6091.4 6095.4 6105.1 5090.9 5388.7 5890.5 5903.3 5927.3 13041.9 13195.7 13283.1 13304.1 16325.8 2258.9 2259.3 2354.5 2663.8 2861.0 9659.1 9682.6 9799.0 10134.0 10298.7 1741.3 1847.3 1853.4 1854.3 1897.4 110164.0 116633.4 119837.2 120297.0 120582.0 11348.9 11450.4 11550.6 11634.8 11716.6 14459.9 14532.3 14537.9 14548.0 14570.1 8283.7 8352.7 8414.7 8426.7 8543.4 8229.2 8246.0 8266.3 8442.8 8475.9 3540.0 4048.6 4189.0 4531.3 4595.9 1561.7 1616.7 1654.3 1733.4 1932.5 770.2 874.3 887.1 896.1 929.3 18593.9 20739.5 21628.5 21879.0 21961.0 794.6 886.8 972.2 1041.5 1072.1 10964.7 11108.3 11332.5 11357.7 11466.3 440888.0 521105.0 523294.0 523925.8 543655.6 101495.0 128121.0 131476.0 132702.3 138774.9 895.9 987.4 1003.7 1008.5 1040.2 16181.8 19034.3 19039.5 19178.6 19327.8 45633.8 51758.5 52010.0 52170.7 52560.5 70492.6 72567.8 82115.0 82743.6 82758.0 6745.4 7979.9 8017.5 8077.9 8300.3 9821.7 12359.9 12494.9 12739.8 12880.3 9867.3 10942.4 11056.0 11059.6 11172.2 10834.3 10862.9 11112.9 11203.3 11298.8 8068.4 10729.6 11108.4 11240.6 11572.4 8118.6 8308.3 8371.6 8375.0 8387.4 8865.9 8867.3 9030.0 10213.0 11399.7 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5659.75 Median:4757.21 stddev:3226.77 (67.8%) stddev-sans-first:3220.96 17:57:59 INFO - PROCESS | 1658 | Values: 1538.8 1569.2 1840.9 1874.1 1945.2 6176.8 8245.4 8441.1 9011.8 9142.5 8463.0 8760.8 8786.2 8855.8 8872.9 2253.8 2299.3 2308.8 2309.8 2317.7 2281.6 2291.8 2325.4 2326.7 2329.4 1996.5 2314.2 2333.9 2334.5 2340.8 2297.3 2308.9 2310.3 2311.2 2319.8 2296.1 2301.4 2302.0 2306.8 2309.8 8922.7 8958.6 8974.5 8981.9 9008.6 5159.9 5382.1 5397.3 5399.0 5401.4 3431.1 3515.5 3632.7 3635.2 3651.0 1024.3 1057.3 1061.1 1082.9 1083.9 11535.4 11537.7 11659.9 11664.7 11667.9 3352.8 4484.8 4703.6 4713.3 4768.1 9855.9 9918.1 9942.2 9952.2 9971.0 5354.1 5381.2 5382.5 5397.9 5418.2 4383.0 4543.3 4888.2 4934.3 4938.3 3844.2 3852.8 3944.2 3962.6 3971.3 1242.4 1259.4 1260.1 1265.3 1265.6 790.0 931.0 931.2 932.7 955.0 5024.4 5791.1 5934.7 6011.2 6038.8 419.6 425.9 434.8 436.2 440.6 3837.4 3910.5 4004.4 4022.7 4024.0 10461.9 10683.3 10771.6 10780.8 10792.2 10354.2 10587.0 10744.6 10792.2 11059.1 8190.5 8278.3 8290.6 8297.1 8312.7 5038.5 5708.9 5883.5 5911.1 5936.1 10017.8 10040.5 10078.5 10101.3 10184.1 8922.4 10034.3 10159.1 10291.0 10386.3 6911.4 7093.4 7220.9 7358.2 7590.1 8324.6 8499.2 8505.7 8515.0 8536.4 7299.9 7488.6 7490.1 7497.7 7600.5 6546.5 7218.5 7374.8 7425.3 7470.5 5904.3 6936.3 7021.6 7023.1 7046.5 4772.4 4807.1 4810.7 4853.0 4891.4 4746.3 4856.7 4918.0 4940.5 4944.2 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4442.79 Median:4778.43 stddev:1373.97 (28.8%) stddev-sans-first:1341.40 17:57:59 INFO - PROCESS | 1658 | Values: 255.7 297.5 305.5 310.0 312.3 4433.0 5146.5 5309.7 5326.3 5342.4 4583.9 4960.6 5318.4 5347.8 5402.3 4059.2 4074.9 4105.4 4121.0 4122.4 3429.6 3960.0 4093.9 4112.7 4126.4 3713.6 4022.6 4066.6 4071.9 4109.2 3427.4 3982.5 4051.2 4083.4 4115.4 3167.4 3374.4 3552.1 3556.8 3585.8 4530.4 4725.6 4995.4 5183.3 5188.8 3856.6 4664.7 4667.9 4680.7 4682.2 5584.8 5597.2 5647.5 5655.3 5664.3 3659.6 3742.8 3879.8 3921.5 3923.3 5043.6 5762.2 5783.7 5898.4 5914.6 3891.9 3925.5 3943.7 3959.0 3971.2 3690.4 3922.2 4006.4 4024.7 4034.8 4624.9 4633.7 4643.4 4652.9 4686.4 4769.7 5394.5 5700.3 5784.3 5795.7 1116.1 1248.4 1259.5 1306.4 1335.5 881.4 882.2 888.4 902.1 902.8 5317.8 5329.0 5337.8 5347.4 5368.4 4956.8 5763.5 5805.6 5821.3 5844.8 4396.8 5006.0 5182.6 5219.3 5271.6 2159.6 2555.9 2565.7 2593.8 2599.7 4381.8 4692.5 5075.5 5080.9 5090.7 4300.2 4469.9 4675.4 5017.6 5041.9 4188.8 4900.3 5056.4 5109.5 5118.4 4216.9 4318.6 4433.4 4661.4 4921.8 4108.1 4448.9 4482.7 4787.2 5269.6 4747.5 6062.3 6090.7 6137.8 6147.4 3260.9 3868.6 3878.2 3881.7 3897.8 5628.8 5782.4 5838.5 5866.7 5871.3 5596.9 5669.5 5681.6 5687.9 5699.9 4598.9 5609.2 5637.4 5681.2 5725.2 5244.6 5566.6 5567.7 5647.5 5663.5 5000.5 5746.0 5746.6 5759.9 5763.5 5432.3 5535.5 5590.0 5608.2 5620.0 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24030.51 Median:3804.84 stddev:38304.51 (1006.7%) stddev-sans-first:38371.93 17:57:59 INFO - PROCESS | 1658 | Values: 707.3 723.1 735.1 752.2 772.0 11525.8 15582.5 15939.8 16280.8 16417.8 14266.2 14304.3 14411.0 14419.8 14433.3 869.1 883.4 884.8 885.6 885.8 691.7 713.2 863.1 882.7 891.7 940.5 942.9 946.5 947.0 947.2 931.2 939.7 940.2 940.6 941.5 671.7 690.1 690.5 692.0 694.1 14761.8 15002.9 15086.5 15107.2 15171.6 12322.4 14563.3 14616.3 14621.7 14788.5 11692.6 11740.9 11809.1 11964.2 12094.7 3753.4 3793.3 3816.4 3822.4 3829.6 108701.0 112078.0 112823.4 113399.0 114348.4 11218.3 11254.8 11263.3 11516.3 11727.6 19000.9 19056.0 19809.4 22011.7 22849.4 7056.3 7926.2 8169.5 8348.6 8382.0 4314.2 4365.2 4462.7 4471.8 4631.2 3596.4 3697.2 3720.4 3722.4 3759.1 662.3 675.2 676.7 692.8 694.3 616.7 638.8 662.6 672.9 685.8 8953.6 9057.5 9343.3 9450.2 9485.8 561.4 594.6 661.6 665.3 681.5 4519.3 4681.6 4682.2 4712.6 4788.8 85193.0 111574.8 146171.0 152138.0 157761.0 142297.0 142461.0 144372.0 144540.0 146886.3 65314.3 66058.7 85854.6 88843.0 96464.0 7776.5 8803.9 8950.8 9026.4 9038.3 57924.8 60427.7 68447.3 68530.7 69230.3 78775.6 91238.5 91376.5 92652.5 97532.0 13000.1 13179.8 13241.6 13333.1 13489.2 12327.7 14805.2 14907.6 15221.0 15348.3 13237.7 13502.5 13766.9 13888.4 14226.4 10476.9 13791.2 13825.9 14123.9 14128.6 11218.6 13226.9 13631.5 13970.0 14001.5 11205.2 11293.9 11301.2 11492.7 11658.6 10277.4 10551.7 10903.2 11565.9 11576.4 17:57:59 INFO - PROCESS | 1658 | -------- Summary: end -------- 17:57:59 INFO - PROCESS | 1658 | 17:57:59 INFO - TEST-INFO | 1658: exit 0 17:57:59 INFO - TEST-OK | dromaeo_css | took 1116776ms 17:57:59 INFO - TEST-START | kraken 17:57:59 INFO - operating with platform_type : mac_ 17:57:59 INFO - Initialising browser for kraken test... 17:57:59 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpTjvaNX/profile http://localhost:49279/getInfo.html) 17:58:02 INFO - PROCESS | 1666 | 2016-10-21 17:58:02.128 plugin-container[1667:10360] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 17:58:02 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:58:02 INFO - PROCESS | 1666 | 2016-10-21 17:58:02.131 plugin-container[1667:10360] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.CFPasteboardClient' 17:58:02 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:58:02 INFO - PROCESS | 1666 | 2016-10-21 17:58:02.131 plugin-container[1667:10360] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:58:02 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 17:58:02 INFO - PROCESS | 1666 | colorDepth:24 17:58:02 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 17:58:02 INFO - PROCESS | 1666 | __metrics 17:58:02 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 17:58:02 INFO - TEST-INFO | 1666: exit 0 17:58:02 INFO - Browser initialized. 17:58:02 INFO - Running cycle 1/1 for kraken test... 17:58:02 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpTjvaNX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:05 INFO - PROCESS | 1668 | 2016-10-21 17:58:05.489 plugin-container[1669:10479] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 17:58:05 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:58:05 INFO - PROCESS | 1668 | 2016-10-21 17:58:05.489 plugin-container[1669:10479] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 17:58:05 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:58:05 INFO - PROCESS | 1668 | 2016-10-21 17:58:05.489 plugin-container[1669:10479] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:58:15 INFO - PROCESS | 1668 | RSS: Main: 236756992 17:58:15 INFO - PROCESS | 1668 | 17:58:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:18 INFO - PROCESS | 1668 | RSS: Main: 248946688 17:58:18 INFO - PROCESS | 1668 | 17:58:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 17:58:22 INFO - PROCESS | 1668 | RSS: Main: 256495616 17:58:22 INFO - PROCESS | 1668 | 17:58:25 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 17:58:26 INFO - PROCESS | 1668 | RSS: Main: 259534848 17:58:26 INFO - PROCESS | 1668 | 17:58:28 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 17:58:28 INFO - PROCESS | 1668 | RSS: Main: 261541888 17:58:28 INFO - PROCESS | 1668 | 17:58:30 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:58:31 INFO - PROCESS | 1668 | RSS: Main: 261533696 17:58:31 INFO - PROCESS | 1668 | 17:58:33 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 17:58:34 INFO - PROCESS | 1668 | RSS: Main: 262434816 17:58:34 INFO - PROCESS | 1668 | 17:58:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 17:58:38 INFO - PROCESS | 1668 | RSS: Main: 262291456 17:58:38 INFO - PROCESS | 1668 | 17:58:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 17:58:41 INFO - PROCESS | 1668 | RSS: Main: 262914048 17:58:41 INFO - PROCESS | 1668 | 17:58:43 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:44 INFO - PROCESS | 1668 | RSS: Main: 262492160 17:58:44 INFO - PROCESS | 1668 | 17:58:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:58:46 INFO - PROCESS | 1668 | RSS: Main: 262537216 17:58:46 INFO - PROCESS | 1668 | 17:58:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:49 INFO - PROCESS | 1668 | RSS: Main: 262524928 17:58:49 INFO - PROCESS | 1668 | 17:58:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:53 INFO - PROCESS | 1668 | RSS: Main: 262557696 17:58:53 INFO - PROCESS | 1668 | 17:58:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:58:57 INFO - PROCESS | 1668 | RSS: Main: 263024640 17:58:57 INFO - PROCESS | 1668 | 17:58:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 17:58:59 INFO - PROCESS | 1668 | RSS: Main: 264634368 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | __start_tp_report 17:58:59 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 17:58:59 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 17:58:59 INFO - PROCESS | 1668 | |i|pagename|runs| 17:58:59 INFO - PROCESS | 1668 | |0;ai-astar;111;117;122;117;119;119;117;98;115;122 17:58:59 INFO - PROCESS | 1668 | |1;audio-beat-detection;151;125;148;154;145;141;119;126;180;120 17:58:59 INFO - PROCESS | 1668 | |2;audio-dft;235;253;213;205;198;198;196;200;200;192 17:58:59 INFO - PROCESS | 1668 | |3;audio-fft;84;58;59;83;59;57;59;58;85;81 17:58:59 INFO - PROCESS | 1668 | |4;audio-oscillator;87;72;86;75;68;68;87;70;71;87 17:58:59 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;89;91;90;85;89;86;88;87;88;86 17:58:59 INFO - PROCESS | 1668 | |6;imaging-darkroom;106;97;94;96;94;94;96;96;95;105 17:58:59 INFO - PROCESS | 1668 | |7;imaging-desaturate;136;137;87;85;88;103;142;124;88;90 17:58:59 INFO - PROCESS | 1668 | |8;json-parse-financial;56;60;66;80;88;87;87;87;48;55 17:58:59 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;70;70;76;79;77;69;70;71;76;72 17:58:59 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;87;89;93;91;88;92;90;90;92;87 17:58:59 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;173;158;159;137;149;162;212;162;216;163 17:58:59 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;195;215;234;180;174;163;175;173;243;246 17:58:59 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;59;69;69;72;91;93;91;92;84;63 17:58:59 INFO - PROCESS | 1668 | __end_tp_report 17:58:59 INFO - PROCESS | 1668 | __start_cc_report 17:58:59 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,952 17:58:59 INFO - PROCESS | 1668 | __end_cc_report 17:58:59 INFO - PROCESS | 1668 | __startTimestamp1477097939198__endTimestamp 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | ------- Summary: start ------- 17:58:59 INFO - PROCESS | 1668 | Number of tests: 14 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:115.70 Median:119.00 stddev:7.01 (5.9%) stddev-sans-first:7.22 17:58:59 INFO - PROCESS | 1668 | Values: 111.0 117.0 122.0 117.0 119.0 119.0 117.0 98.0 115.0 122.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:146.50 stddev:19.03 (13.0%) stddev-sans-first:19.84 17:58:59 INFO - PROCESS | 1668 | Values: 151.0 125.0 148.0 154.0 145.0 141.0 119.0 126.0 180.0 120.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:209.00 Median:202.50 stddev:19.74 (9.7%) stddev-sans-first:18.56 17:58:59 INFO - PROCESS | 1668 | Values: 235.0 253.0 213.0 205.0 198.0 198.0 196.0 200.0 200.0 192.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:68.30 Median:70.00 stddev:12.92 (18.5%) stddev-sans-first:12.39 17:58:59 INFO - PROCESS | 1668 | Values: 84.0 58.0 59.0 83.0 59.0 57.0 59.0 58.0 85.0 81.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:80.50 stddev:8.54 (10.6%) stddev-sans-first:8.28 17:58:59 INFO - PROCESS | 1668 | Values: 87.0 72.0 86.0 75.0 68.0 68.0 87.0 70.0 71.0 87.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.50 stddev:1.91 (2.2%) stddev-sans-first:1.99 17:58:59 INFO - PROCESS | 1668 | Values: 89.0 91.0 90.0 85.0 89.0 86.0 88.0 87.0 88.0 86.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:95.50 stddev:4.45 (4.7%) stddev-sans-first:3.43 17:58:59 INFO - PROCESS | 1668 | Values: 106.0 97.0 94.0 96.0 94.0 94.0 96.0 96.0 95.0 105.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:108.00 Median:86.00 stddev:23.94 (27.8%) stddev-sans-first:23.14 17:58:59 INFO - PROCESS | 1668 | Values: 136.0 137.0 87.0 85.0 88.0 103.0 142.0 124.0 88.0 90.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:83.50 stddev:15.96 (19.1%) stddev-sans-first:15.93 17:58:59 INFO - PROCESS | 1668 | Values: 56.0 60.0 66.0 80.0 88.0 87.0 87.0 87.0 48.0 55.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:74.00 stddev:3.62 (4.9%) stddev-sans-first:3.67 17:58:59 INFO - PROCESS | 1668 | Values: 70.0 70.0 76.0 79.0 77.0 69.0 70.0 71.0 76.0 72.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:90.50 stddev:2.13 (2.4%) stddev-sans-first:1.99 17:58:59 INFO - PROCESS | 1668 | Values: 87.0 89.0 93.0 91.0 88.0 92.0 90.0 90.0 92.0 87.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:169.10 Median:162.50 stddev:25.50 (15.7%) stddev-sans-first:27.01 17:58:59 INFO - PROCESS | 1668 | Values: 173.0 158.0 159.0 137.0 149.0 162.0 212.0 162.0 216.0 163.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.80 Median:205.00 stddev:31.92 (15.6%) stddev-sans-first:33.81 17:58:59 INFO - PROCESS | 1668 | Values: 195.0 215.0 234.0 180.0 174.0 163.0 175.0 173.0 243.0 246.0 17:58:59 INFO - PROCESS | 1668 | 17:58:59 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:87.50 stddev:13.24 (15.1%) stddev-sans-first:12.06 17:58:59 INFO - PROCESS | 1668 | Values: 59.0 69.0 69.0 72.0 91.0 93.0 91.0 92.0 84.0 63.0 17:58:59 INFO - PROCESS | 1668 | -------- Summary: end -------- 17:58:59 INFO - PROCESS | 1668 | 17:59:00 INFO - TEST-INFO | 1668: exit 0 17:59:00 INFO - TEST-OK | kraken | took 60412ms 17:59:00 INFO - SUITE-END | took 1177s 17:59:00 INFO - Completed test suite (00:19:37) 17:59:00 INFO - javascript benchmark 17:59:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7130.186742780667, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.0798976286646, 3313.9668603313967, 3351.882684106057, 3378.2061215614326, 3379.8479068441916, 4592.196365636017, 4885.804567817292, 5473.452654734525, 5489.752961116749, 5517.172424136376, 5563.193336966137, 5580.497755202041, 5585.1063829787245, 5617.522510586595, 5653.293338332708, 5072.34059572257, 5098.725318670333, 5144.151215049513, 5194.142966410538, 5227.320448341729, 4472.284434490482, 5148.253503242027, 5173.560247378978, 5215.556677682402, 5233.528982391584, 3826.8136877568045, 4361.869143925687, 5003.674761140514, 5204.401493828202, 5236.1098613235845, 4305.935410968838, 4861.756912154378, 4941.357623508921, 5069.0, 5095.770690318945, 4544.909101817978, 4547.317902314646, 4798.352222449959, 5106.617003724698, 5108.540231379194, 4266.637335826458, 5433.728313584305, 5587.580931430159, 5591.580631452657, 5713.171590119451, 5936.881262374772, 6021.488173505258, 6123.050927106306, 6138.8772224555705, 6168.691565421711, 6143.815685529441, 6183.9381606183815, 6201.255849298113, 6211.0372892201785, 6219.875602487925, 5712.6001179917, 5721.914171287434, 5729.799457018984, 5735.8852822944145, 5759.884802303973, 6138.5396095292135, 6144.525313924626, 6154.969225153845, 6196.287426945869, 6232.968835155886, 6027.246594175728, 6058.787942421994, 6061.787837425669, 6080.179175811298, 6101.816945491642, 5983.461488466059, 6102.206713127265, 6189.938100619026, 6198.504119670506, 6220.62676239418, 5987.251593550806, 6082.847928801815, 6095.085737139465, 6099.176611157437, 6117.510599152057, 6090.086487026982, 6092.055731361646, 6096.359882212392, 6103.786367477117, 6119.051547010221, 4833.830815921426, 4840.056189043174, 4842.394700662418, 4843.0, 4844.128056949712, 3635.9636403635627, 4360.65114790816, 4383.3863259143745, 4392.209402307615, 4393.011572396185, 5465.07093794056, 5696.430356964271, 5710.371859095496, 5725.341585717612, 5836.124581312837, 6159.969200153971, 6175.598586091979, 6177.505799536027, 6192.040233763774, 6224.875502490016, 5727.4845263926445, 5785.363610002896, 5810.477057064884, 5811.94188058114, 5831.06702927538, 5218.765155567932, 5221.817236396708, 5239.607029472805, 5295.4439783822145, 5298.0, 6139.8601398601395, 6140.8416929778305, 6157.983932651152, 6181.258249010148, 6265.4361107500545, 6163.260408750979, 6192.195014648067, 6196.256449226122, 6204.844878878064, 6214.5028397728975, 6239.96880015597, 6245.812625621239, 6264.780732674334, 6265.216847894013, 6387.968060159669, 5907.261592300963, 5930.703464826655, 5945.762169513171, 5992.370801065826, 6029.276486821609, 4882.829100981448, 6159.384061593805, 6159.538034647329, 6160.229971253593, 6163.907541386972, 4434.911301774011, 5279.313689220377, 5627.746751396279, 5913.113033045078, 5973.372795856546, 4352.717073390219, 5217.373915130209, 5376.112941364788, 5433.864153396196, 5903.291605007426, 4435.0, 5151.2273159026445, 5790.160426738184, 5876.647401155944, 6003.549733770072, 5980.312264089512, 5998.880022399615, 5999.640021598718, 6047.758089676364, 6056.36408177135, 5682.9431705684065, 5684.857878553069, 5722.513586345207, 5843.152742852178, 5860.970695146497], "value": 5502.2869458329915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.319366499571, 502.720989850633, 509.673808762392, 517.8265281130821, 525.7607788456253, 34028.659713402856, 34341.82829085854, 39754.00614984627, 39785.0, 39791.80624581264, 41604.3358265669, 42056.0, 42141.57858421415, 42142.0, 42207.944801379905, 9452.14930656239, 9647.131758141766, 9647.469389183592, 9667.033296670346, 9668.661596844111, 9486.715398538021, 9568.043195680446, 9578.425294482353, 9603.18372938301, 9609.135177833994, 9578.61685532578, 9594.232461403071, 9606.0, 9622.422654640708, 9637.518124093802, 9494.098060684224, 9519.904800951972, 9548.856767148498, 9576.138147566682, 9579.802524684379, 9485.525723713787, 9562.235021198358, 9575.569099390545, 9592.184664303542, 9597.088276613711, 39201.01997450058, 39381.80309098465, 39677.20645587101, 39704.0, 39718.20563588712, 3404.710599599037, 3471.5139880416764, 3581.964180358189, 3837.9040523986846, 4101.651359634435, 24321.0, 30239.546406803915, 30739.692603073905, 30794.692053079405, 31207.0, 3137.294108825519, 3144.1510792086237, 3159.178613560468, 3173.0639461358955, 3189.681031896815, 354356.0, 354418.22790886136, 357972.0, 359280.4071959273, 359454.0, 46487.67561621905, 47879.76060119677, 48299.27551086737, 51861.740691296305, 56890.715546422005, 59413.702931485066, 59588.70205648944, 59890.70054649699, 59948.700256498436, 60047.79904401887, 11791.29252244868, 15637.0, 15864.365425382855, 15902.522924312289, 15906.204689765696, 12140.878591214152, 12398.81401778956, 12515.624531264077, 12530.122891397697, 12544.121911466109, 15253.6186595336, 15349.539513814603, 15399.23003849803, 15417.922910385376, 15604.0, 6290.968545157245, 6400.39196276353, 6458.38645328693, 6479.254885688112, 6496.090547323379, 893.7095443980733, 974.8001659659752, 1005.3415013166388, 1050.8738951325736, 1101.1741194104422, 24500.0, 25054.0, 29423.411531769245, 29700.257493562833, 30130.096097117123, 936.5879013234155, 1049.4700176410863, 1056.2289528644133, 1063.3141623652855, 1106.181425744943, 12127.454264558117, 12544.372781360895, 13414.865851341558, 14987.625309367353, 15421.845781542266, 529607.0, 640526.0, 641432.0, 642790.0, 646222.0, 55146.0, 55605.16592251039, 55812.0, 55834.16248756272, 56191.0, 1163.7672465506932, 1295.8574556798744, 1349.0961056092247, 1372.945082196721, 1380.496118916588, 29763.55354669725, 29843.552346714383, 30261.848690756404, 30280.114975166547, 30303.545446817876, 46553.0, 47205.29192062191, 47235.0, 47256.818579535786, 47482.28776568285, 488976.0, 489746.0, 489845.0, 490893.54553227004, 491513.0, 24469.877650611634, 24632.0, 24881.626775598743, 24909.377265568506, 24953.500929980935, 43595.34606980961, 43824.56175438205, 44013.779931100136, 44124.0, 44609.77695111504, 36826.8158659205, 36991.445128323634, 37636.62363376331, 38040.42939355967, 38214.426783597715, 36356.0, 36364.81817590895, 36812.26375472529, 37167.0, 37564.0, 35723.64276357307, 36298.092547686516, 36815.0, 36840.44739328859, 36882.63117368792, 29686.851565742032, 30289.697103029568, 32526.34947301088, 32823.507647385784, 32848.1787955303, 24541.877290613433, 24640.753592463847, 24825.751742482345, 24914.71813536883, 25332.0], "value": 18929.409461644602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.60083110240936, 370.5368289637951, 372.81731951343835, 378.1453914154011, 394.11324519830384, 18862.339818106368, 19568.90215548922, 20166.89916550419, 20182.78903265805, 20405.693914591255, 11549.076073914088, 12004.579839705611, 12167.817482737766, 12199.451024703887, 12247.02023838093, 5213.0, 5539.25220095288, 5544.306961629796, 5545.889082218353, 5546.667199967995, 3914.5106861642294, 4115.444415003966, 5392.865178370533, 5843.561732870031, 6151.969240153793, 6155.169052177966, 6184.165137706397, 6190.226221722285, 6205.22434695663, 6207.162033125515, 5865.35481097079, 6061.636301821883, 6091.42131497507, 6095.390460953913, 6105.053716673922, 5090.905455327085, 5388.7305634718105, 5890.499307558863, 5903.26209223847, 5927.318358388754, 13041.934790326082, 13195.73608527824, 13283.136596121318, 13304.06871518994, 16325.755113673304, 2258.898349574257, 2259.2544460328054, 2354.4702441950594, 2663.813533052687, 2860.985695071532, 9659.130678238922, 9682.56428460721, 9799.0, 10134.037266459674, 10298.691039268833, 1741.3295881085746, 1847.3257261099736, 1853.3605905962422, 1854.323172042195, 1897.3643829317195, 110164.0, 116633.41683291529, 119837.20651173942, 120297.0, 120581.99999999913, 11348.886511134948, 11450.370229637283, 11550.595729149607, 11634.825477617842, 11716.648500544998, 14459.927700361432, 14532.273386330853, 14537.927310363591, 14548.0, 14570.125792452487, 8283.710070147516, 8352.749417517483, 8414.663413463515, 8426.747197584082, 8543.444676096035, 8229.218224268805, 8245.95877020611, 8266.346730653893, 8442.788930276669, 8475.915240847637, 3540.044188069207, 4048.574899635496, 4188.952761809548, 4531.252343363374, 4595.885102872455, 1561.664242187935, 1616.6524197297638, 1654.3134599141463, 1733.3673209278522, 1932.5168707823045, 770.2028400605459, 874.3355050161796, 887.0995939121797, 896.0949441064572, 929.256594724218, 18593.90703046503, 20739.4815129623, 21628.4592885176, 21879.0, 21961.01175447077, 794.5788731972063, 886.7871710789364, 972.1833659725864, 1041.4844651897358, 1072.104792498257, 10964.725881853017, 11108.333499989865, 11332.546698131982, 11357.716057098638, 11466.2546934449, 440888.0, 521105.0, 523294.0, 523925.7607423953, 543655.6215916314, 101494.98505015003, 128121.0, 131476.0, 132702.33648831694, 138774.91837622444, 895.8835351404276, 987.3976874106789, 1003.708924411927, 1008.5360734062267, 1040.2302296300684, 16181.838181618505, 19034.333798317548, 19039.477696626167, 19178.616427671088, 19327.8067219326, 45633.771831140635, 51758.48241517687, 52010.0, 52170.71704935421, 52560.47439525556, 70492.64753676199, 72567.82296531112, 82115.0, 82743.58628206821, 82758.0, 6745.426638735762, 7979.9202007979175, 8017.518948863087, 8077.869098326357, 8300.252977232078, 9821.705348839547, 12359.938200308941, 12494.875051249372, 12739.80890286628, 12880.291583962971, 9867.309288350034, 10942.398168100832, 11056.004959553678, 11059.612913547988, 11172.21794474379, 10834.349939003685, 10862.891371086504, 11112.944435277772, 11203.327800331681, 11298.83051754208, 8068.435209535276, 10729.570817167227, 11108.44457777124, 11240.606578769704, 11572.42137893085, 8118.634661440367, 8308.29379502749, 8371.581420928807, 8375.0, 8387.412881098264, 8865.911340886509, 8867.334949878656, 9029.954850225708, 10212.978702129727, 11399.658010259705], "value": 9060.999980255327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.7999560057192, 1569.1997081488441, 1840.861935354848, 1874.09106583307, 1945.2219112355056, 6176.783812566561, 8245.422820402575, 8441.113683063282, 9011.819763604724, 9142.497162656051, 8462.957685211566, 8760.780980475476, 8786.209241168293, 8855.778605534864, 8872.8669069964, 2253.8196944244423, 2299.310206937912, 2308.7922087012166, 2309.7921187093157, 2317.6755254264417, 2281.589313923493, 2291.8281128915314, 2325.360525855395, 2326.6510023496444, 2329.4409341758023, 1996.4609555420027, 2314.1553333033407, 2333.9299821005397, 2334.4980829121737, 2340.847844890085, 2297.3452566018605, 2308.884555772213, 2310.260716570698, 2311.248844125666, 2319.7564255753155, 2296.1159953417887, 2301.4476525633895, 2301.9884900575557, 2306.7923886850263, 2309.8036666883336, 8922.73231803047, 8958.641654333884, 8974.506402147945, 8981.865272020925, 9008.639654413815, 5159.948400515985, 5382.085045542267, 5397.325334333208, 5398.973005134989, 5401.43284955078, 3431.1422144463886, 3515.5078289039557, 3632.691221246197, 3635.1820840310984, 3650.963490365089, 1024.3239461955147, 1057.2810488867567, 1061.124572227915, 1082.9350238985608, 1083.8916108389176, 11535.423228838525, 11537.653870383901, 11659.88340116605, 11664.708382290512, 11667.94988451035, 3352.8491217894766, 4484.775761211927, 4703.647226457961, 4713.269443236304, 4768.117898188777, 9855.852162217572, 9918.05778451046, 9942.154916832005, 9952.154066904393, 9970.953049929798, 5354.063038968165, 5381.165919282517, 5382.515573598316, 5397.920415916832, 5418.214358917935, 4383.0, 4543.295789152687, 4888.242322440027, 4934.284528743384, 4938.308636790852, 3844.231153769257, 3852.845886164578, 3944.1914407546383, 3962.643362097425, 3971.3050216212623, 1242.3601845049807, 1259.4269607328642, 1260.0675500129837, 1265.2598230035348, 1265.6266401411606, 789.9723509677134, 931.0, 931.2131249094505, 932.6558817973053, 954.9713508594754, 5024.397072351341, 5791.088940649575, 5934.673592952343, 6011.188489553854, 6038.818835434944, 419.6076668315135, 425.85095216673915, 434.83258945306284, 436.1843352930041, 440.6012558634441, 3837.4458344370573, 3910.4916360872903, 4004.379321205218, 4022.6580740637373, 4024.0141165414075, 10461.9476902615, 10683.25217234786, 10771.569137234423, 10780.838287425695, 10792.190585706103, 10354.223433242387, 10587.0, 10744.570217191382, 10792.190585706103, 11059.115270778319, 8190.54951977635, 8278.296344810638, 8290.585470726439, 8297.12880147588, 8312.70905518316, 5038.470960549236, 5708.886767080379, 5883.470487656132, 5911.142884281841, 5936.079907614327, 10017.849732254168, 10040.548175332273, 10078.546465409221, 10101.343412678152, 10184.134348580454, 8922.375433719577, 10034.297599167989, 10159.136473399843, 10291.022352876465, 10386.324888882198, 6911.412529934811, 7093.3970612498515, 7220.8916866246, 7358.190599034209, 7590.127135379502, 8324.583770811314, 8499.150084991452, 8505.74482765518, 8514.957425212835, 8536.44513106646, 7299.927000729925, 7488.5506869588, 7490.1386340571535, 7497.737579184703, 7600.46796724224, 6546.541742078009, 7218.494705370574, 7374.815629609303, 7425.257474252531, 7470.514416562906, 5904.261967254093, 6936.34104760047, 7021.613811240431, 7023.086998690138, 7046.541974771623, 4772.427308722976, 4807.134715751198, 4810.687305325143, 4852.975735121443, 4891.437484689306, 4746.311784791117, 4856.660033797601, 4918.0, 4940.505949405031, 4944.184209605375], "value": 4461.30791151372, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.65997223692492, 297.5328733887796, 305.46086157931256, 310.02651673744447, 312.31135346560836, 4433.0247345584, 5146.459621739719, 5309.70796606187, 5326.307580014597, 5342.412334643191, 4583.88540286493, 4960.627952903528, 5318.388385335687, 5347.786088556453, 5402.270693456382, 4059.1881623675235, 4074.9185016299803, 4105.445764821756, 4121.0, 4122.381642753581, 3429.588449386077, 3959.9506130875197, 4093.9181216375655, 4112.670986321102, 4126.381042843583, 3713.6286371362785, 4022.5776293489203, 4066.6340029397347, 4071.862272307033, 4109.21924834282, 3427.365937301607, 3982.5308308848553, 4051.210014047262, 4083.387491876242, 4115.382692596105, 3167.4298626247264, 3374.358871814372, 3552.0587044433246, 3556.76881002734, 3585.8027808470524, 4530.388397566319, 4725.574698277137, 4995.370072345711, 5183.3002544656365, 5188.766505507261, 3856.5564960029396, 4664.65015123867, 4667.906641867144, 4680.672352935262, 4682.204025315705, 5584.776608935637, 5597.216389705444, 5647.491725744661, 5655.349634792011, 5664.291963504562, 3659.579148397915, 3742.8128593570214, 3879.7866117363533, 3921.490206273195, 3923.2545816295096, 5043.646944713872, 5762.205330414746, 5783.744339707518, 5898.380670029671, 5914.556408269397, 3891.8832435026993, 3925.450436938831, 3943.743656662308, 3958.960410395917, 3971.205758848242, 3690.4279836625365, 3922.2155568885764, 4006.3990401439432, 4024.678025757932, 4034.8184331705143, 4624.907501849944, 4633.745144017112, 4643.419572553431, 4652.860414187512, 4686.414198225222, 4769.6661233714, 5394.541463975527, 5700.315962084576, 5784.31029571243, 5795.710214489259, 1116.0914835631, 1248.3945286536023, 1259.471022170672, 1306.4121145484569, 1335.5459143891123, 881.3742243007408, 882.1531329923346, 888.3870129610548, 902.1159263921263, 902.8420026495337, 5317.7872885084935, 5328.960852633699, 5337.8131765388025, 5347.385050719139, 5368.436314186954, 4956.801727930914, 5763.50148961273, 5805.577633479825, 5821.27234095738, 5844.824655260349, 4396.824127034883, 5005.998800239967, 5182.637215394886, 5219.329814459336, 5271.604629652791, 2159.6286358162365, 2555.8754148174744, 2565.653636759051, 2593.753593408623, 2599.6880374355196, 4381.824727010948, 4692.504084457101, 5075.543201111917, 5080.935251798546, 5090.694558326512, 4300.182965236595, 4469.888252793706, 4675.392199014106, 5017.623678224148, 5041.899162016739, 4188.8324467020975, 4900.338454308623, 5056.443791183041, 5109.540141387293, 5118.411382690963, 4216.903605062645, 4318.5681431856565, 4433.401490798701, 4661.417322834645, 4921.753912304442, 4108.075682971427, 4448.888777780581, 4482.663800214932, 4787.199488299384, 5269.552088072557, 4747.477777444409, 6062.333143354315, 6090.665013424305, 6137.754489820536, 6147.3587441481395, 3260.853261603186, 3868.593797651206, 3878.204967981613, 3881.7282790204413, 3897.8440862366324, 5628.761672432059, 5782.421757824352, 5838.474537291494, 5866.67733274674, 5871.266091738533, 5596.852645207641, 5669.546436285004, 5681.630694004876, 5687.857803554944, 5699.945510080648, 4598.908021839611, 5609.185753687531, 5637.378618942212, 5681.17622944679, 5725.227094342377, 5244.632875698664, 5566.582506312124, 5567.7494512747835, 5647.463490968352, 5663.546916246608, 5000.499950004971, 5746.040788993755, 5746.597738158289, 5759.884802303846, 5763.538916886555, 5432.266644003009, 5535.501804837584, 5590.0, 5608.195902048976, 5620.0], "value": 4002.8905223981446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2715103443452, 723.1177962885281, 735.0701362776089, 752.1650967426159, 772.0118248641738, 11525.769484610302, 15582.532524024284, 15939.84060159398, 16280.755788663164, 16417.75373369399, 14266.215358155298, 14304.284785760723, 14411.0, 14419.78370324446, 14433.278336083207, 869.0657543141117, 883.425773247388, 884.796496805735, 885.6014793342989, 885.7696998780299, 691.6679993603049, 713.2261496276546, 863.0678866823847, 882.6998820401062, 891.6656253904786, 940.534435454451, 942.9198518125968, 946.4841661294611, 947.0, 947.2185447006214, 931.16660588773, 939.6758118449159, 940.219617717293, 940.5814412586402, 941.4915945389481, 671.7380221713536, 690.1442211657559, 690.5304393012749, 691.9827004324882, 694.1080711286023, 14761.77857332141, 15002.949793514459, 15086.54740357791, 15107.244637768068, 15171.620709482351, 12322.445489952974, 14563.344649490798, 14616.26918654063, 14621.70756584873, 14788.482403115946, 11692.649220523313, 11740.947353688103, 11809.114316426303, 11964.222325548899, 12094.697632559168, 3753.361928472139, 3793.2603142387247, 3816.427535869614, 3822.4266360045935, 3829.617038296176, 108701.0, 112078.0, 112823.43588282088, 113399.0, 114348.428257859, 11218.270812397168, 11254.831177532344, 11263.32420054783, 11516.251443656136, 11727.589534366256, 19000.90499547521, 19055.99912009219, 19809.40571782849, 22011.669824952638, 22849.428764280692, 7056.259092795285, 7926.207379262028, 8169.509829410135, 8348.624311905978, 8382.0, 4314.245007123741, 4365.192439398721, 4462.709923854939, 4471.754053527022, 4631.166390049823, 3596.4245720684567, 3697.242065376591, 3720.3675375186285, 3722.3858063419234, 3759.079025638736, 662.3376623376623, 675.1560549313358, 676.6853413162903, 692.8371832619331, 694.2952902803659, 616.7101462312706, 638.8019713888709, 662.6388618203091, 672.9259781424138, 685.7976896815452, 8953.59708813105, 9057.547122643842, 9343.345965782466, 9450.243980481546, 9485.810283794286, 561.4497792163702, 594.6432140715536, 661.5732852310233, 665.2582370656683, 681.5161235522835, 4519.276915693539, 4681.602063824613, 4682.214528752931, 4712.64655150865, 4788.808447662124, 85193.0, 111574.76850462945, 146171.0, 152138.0, 157761.0, 142297.0, 142461.0, 144372.0, 144540.0, 146886.2655686715, 65314.34685653083, 66058.66970665116, 85854.57072714597, 88843.0, 96463.9999999986, 7776.533407995538, 8803.867941981003, 8950.820983580423, 9026.368154229142, 9038.322125840457, 57924.841503170544, 60427.69786151041, 68447.31552684409, 68530.65734671295, 69230.30769692239, 78775.60612196902, 91238.54380728054, 91376.54311728399, 92652.53673731588, 97532.0, 13000.08999370035, 13179.802302965272, 13241.602751917459, 13333.066685331934, 13489.190648561118, 12327.69180770488, 14805.18571478579, 14907.595501164002, 15221.0, 15348.309326080576, 13237.735245294847, 13502.459901603826, 13766.93116534411, 13888.444462221398, 14226.359813808196, 10476.947615261875, 13791.172529648253, 13825.861741382458, 14123.863687250645, 14128.646783830487, 11218.55125794959, 13226.867731322563, 13631.454741810614, 13970.022098453011, 14001.5099471518, 11205.159613029218, 11293.943530282297, 11301.15241356885, 11492.655220343404, 11658.629270749914, 10277.383356998604, 10551.678381331105, 10903.181423913917, 11565.942170289094, 11576.421178941187], "value": 7795.916891371637, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 122.0, 117.0, 119.0, 119.0, 117.0, 98.0, 115.0, 122.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 148.0, 154.0, 145.0, 141.0, 119.0, 126.0, 180.0, 120.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [235.0, 253.0, 213.0, 205.0, 198.0, 198.0, 196.0, 200.0, 200.0, 192.0], "value": 209.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 83.0, 59.0, 57.0, 59.0, 58.0, 85.0, 81.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 86.0, 75.0, 68.0, 68.0, 87.0, 70.0, 71.0, 87.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 90.0, 85.0, 89.0, 86.0, 88.0, 87.0, 88.0, 86.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 97.0, 94.0, 96.0, 94.0, 94.0, 96.0, 96.0, 95.0, 105.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 87.0, 85.0, 88.0, 103.0, 142.0, 124.0, 88.0, 90.0], "value": 108.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 66.0, 80.0, 88.0, 87.0, 87.0, 87.0, 48.0, 55.0], "value": 71.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 76.0, 79.0, 77.0, 69.0, 70.0, 71.0, 76.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 93.0, 91.0, 88.0, 92.0, 90.0, 90.0, 92.0, 87.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 158.0, 159.0, 137.0, 149.0, 162.0, 212.0, 162.0, 216.0, 163.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 215.0, 234.0, 180.0, 174.0, 163.0, 175.0, 173.0, 243.0, 246.0], "value": 199.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 69.0, 69.0, 72.0, 91.0, 93.0, 91.0, 92.0, 84.0, 63.0], "value": 78.3, "unit": "score"}]}]} 17:59:00 INFO - Return code: 0 17:59:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:59:00 ERROR - # TBPL SUCCESS # 17:59:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:00 INFO - 2016-10-21 17:59:00.558 screenresolution[1673:10861] starting screenresolution argv=screenresolution get 17:59:00 INFO - 2016-10-21 17:59:00.561 screenresolution[1673:10861] Display 0: 1600x1200x32@60 17:59:00 INFO - 2016-10-21 17:59:00.567 screenresolution[1674:10864] starting screenresolution argv=screenresolution list 17:59:00 INFO - Available Modes on Display 0 17:59:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:00 INFO - Intel Iris: 17:59:00 INFO - Chipset Model: Intel Iris 17:59:00 INFO - Type: GPU 17:59:00 INFO - Bus: Built-In 17:59:00 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:00 INFO - Vendor: Intel (0x8086) 17:59:00 INFO - Device ID: 0x0a2e 17:59:00 INFO - Revision ID: 0x0009 17:59:00 INFO - Displays: 17:59:00 INFO - Display: 17:59:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:00 INFO - Display Serial Number: 1600x1200 60 17:59:00 INFO - Main Display: Yes 17:59:00 INFO - Mirror: Off 17:59:00 INFO - Online: Yes 17:59:00 INFO - Rotation: Supported 17:59:00 INFO - Return code: 0 17:59:00 INFO - Running post-action listener: _resource_record_post_action 17:59:00 INFO - [mozharness: 2016-10-22 00:59:00.802578Z] Finished run-tests step (success) 17:59:00 INFO - Running post-run listener: _resource_record_post_run 17:59:00 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 39365120; Write bytes: 709707264; Read time: 380; Write time: 2171 17:59:00 INFO - TinderboxPrint: CPU usage
54.5% 17:59:00 INFO - TinderboxPrint: I/O read bytes / time
39,365,120 / 380 17:59:00 INFO - TinderboxPrint: I/O write bytes / time
709,707,264 / 2,171 17:59:00 INFO - TinderboxPrint: CPU idle
2,205.5 (45.5%) 17:59:00 INFO - TinderboxPrint: CPU system
983.8 (20.3%) 17:59:00 INFO - TinderboxPrint: CPU user
1,660.5 (34.2%) 17:59:00 INFO - TinderboxPrint: Swap in / out
444,416,000 / 0 17:59:00 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394922496; Write bytes: 384624128; Read time: 28974; Write time: 813 17:59:00 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 33124864; Write bytes: 301367296; Read time: 301; Write time: 1307 17:59:01 INFO - Running post-run listener: _upload_blobber_files 17:59:01 INFO - Blob upload gear active. 17:59:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:01 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 17:59:01 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:59:01 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:59:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:59:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:59:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:03 INFO - (blobuploader) - INFO - Done attempting. 17:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:04 INFO - (blobuploader) - INFO - Done attempting. 17:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:07 INFO - (blobuploader) - INFO - Done attempting. 17:59:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:07 INFO - Return code: 0 17:59:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/200d602ccc0893f3058d811a0c2d5c607a8d78ee83ce1416da0982ef68e810d6b46537eca61071872d9eec7f8893aad95fa6d5f5bd3d6bdedda5cf3f745be74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee99ae53a58ec8ab2facb761ff6ceebc5580be1e1f1aa9af18dfcdfa8feb1b966cb2208091fcd3fdfb7b2914a99b9e8d9627c162b1b5a03cda1b661f60a61bc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b8bbc4fc1aedfd3506b953e3084095d359350af5ec48f0ee8e2228b703afef2062dd8345bf5916f7cd7bab0b91cfc43913572a317dc557a1d608b8e3e3a4445"} 17:59:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:07 INFO - Contents: 17:59:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/200d602ccc0893f3058d811a0c2d5c607a8d78ee83ce1416da0982ef68e810d6b46537eca61071872d9eec7f8893aad95fa6d5f5bd3d6bdedda5cf3f745be74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee99ae53a58ec8ab2facb761ff6ceebc5580be1e1f1aa9af18dfcdfa8feb1b966cb2208091fcd3fdfb7b2914a99b9e8d9627c162b1b5a03cda1b661f60a61bc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b8bbc4fc1aedfd3506b953e3084095d359350af5ec48f0ee8e2228b703afef2062dd8345bf5916f7cd7bab0b91cfc43913572a317dc557a1d608b8e3e3a4445"} 17:59:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:07 INFO - Copying logs to upload dir... 17:59:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.796112 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-21 17:59:08.063396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 17:59:08.067322) ========= 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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/Fx-Team/sha512/200d602ccc0893f3058d811a0c2d5c607a8d78ee83ce1416da0982ef68e810d6b46537eca61071872d9eec7f8893aad95fa6d5f5bd3d6bdedda5cf3f745be74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee99ae53a58ec8ab2facb761ff6ceebc5580be1e1f1aa9af18dfcdfa8feb1b966cb2208091fcd3fdfb7b2914a99b9e8d9627c162b1b5a03cda1b661f60a61bc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b8bbc4fc1aedfd3506b953e3084095d359350af5ec48f0ee8e2228b703afef2062dd8345bf5916f7cd7bab0b91cfc43913572a317dc557a1d608b8e3e3a4445"} build_url:https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/IqNXsHHeRQa79fWKDxFxSg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/200d602ccc0893f3058d811a0c2d5c607a8d78ee83ce1416da0982ef68e810d6b46537eca61071872d9eec7f8893aad95fa6d5f5bd3d6bdedda5cf3f745be74c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee99ae53a58ec8ab2facb761ff6ceebc5580be1e1f1aa9af18dfcdfa8feb1b966cb2208091fcd3fdfb7b2914a99b9e8d9627c162b1b5a03cda1b661f60a61bc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b8bbc4fc1aedfd3506b953e3084095d359350af5ec48f0ee8e2228b703afef2062dd8345bf5916f7cd7bab0b91cfc43913572a317dc557a1d608b8e3e3a4445"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 17:59:08.099612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 17:59:08.099956) ========= 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.bMcqHNOWgz/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.Igd8RMZmYZ/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 17:59:08.148761) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 17:59:08.149097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 17:59:08.149445) ========= ========= Total master_lag: 0.31 =========