builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0206 starttime: 1475794193.68 results: success (0) buildid: 20161006133800 builduid: ffce8636b9444dc0a305ccb79315a3dc revision: 37f78aca862224d7151c0fcae1ed8373fe11c83b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.683343) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.683920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.684385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.714636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.715235) ========= 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.44yqObOpU8/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.ie4eXlxV9b/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-06 15:49:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 33.2M=0s 2016-10-06 15:49:53 (33.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148035 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.888852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.892191) ========= 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.44yqObOpU8/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.ie4eXlxV9b/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.021618 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:53.942061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 15:49:53.942397) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 37f78aca862224d7151c0fcae1ed8373fe11c83b --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 37f78aca862224d7151c0fcae1ed8373fe11c83b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.44yqObOpU8/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.ie4eXlxV9b/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-06 15:49:54,026 truncating revision to first 12 chars 2016-10-06 15:49:54,026 Setting DEBUG logging. 2016-10-06 15:49:54,026 attempt 1/10 2016-10-06 15:49:54,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/37f78aca8622?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 15:49:56,236 unpacking tar archive at: fx-team-37f78aca8622/testing/mozharness/ program finished with exit code 0 elapsedTime=2.470479 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 15:49:56.437464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:56.437786) ========= script_repo_revision: 37f78aca862224d7151c0fcae1ed8373fe11c83b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:56.441210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:56.441483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 15:49:56.459345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-06 15:49:56.459685) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.44yqObOpU8/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.ie4eXlxV9b/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:49:56 INFO - MultiFileLogger online at 20161006 15:49:56 in /builds/slave/test 15:49:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:49:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:49:56 INFO - {'append_to_log': False, 15:49:56 INFO - 'base_work_dir': '/builds/slave/test', 15:49:56 INFO - 'blob_upload_branch': 'Fx-Team', 15:49:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:49:56 INFO - 'branch': 'Fx-Team', 15:49:56 INFO - 'buildbot_json_path': 'buildprops.json', 15:49:56 INFO - 'config_files': ('talos/mac_config.py',), 15:49:56 INFO - 'default_actions': ('clobber', 15:49:56 INFO - 'read-buildbot-config', 15:49:56 INFO - 'download-and-extract', 15:49:56 INFO - 'populate-webroot', 15:49:56 INFO - 'create-virtualenv', 15:49:56 INFO - 'install', 15:49:56 INFO - 'run-tests'), 15:49:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:49:56 INFO - 'download_minidump_stackwalk': True, 15:49:56 INFO - 'download_symbols': 'ondemand', 15:49:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:49:56 INFO - 'tooltool.py': '/tools/tooltool.py', 15:49:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:49:56 INFO - '/tools/misc-python/virtualenv.py')}, 15:49:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:49:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:49:56 INFO - 'installer_path': 'installer.exe', 15:49:56 INFO - 'log_level': 'info', 15:49:56 INFO - 'log_name': 'talos', 15:49:56 INFO - 'log_to_console': True, 15:49:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:49:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:49:56 INFO - 'opt_config_files': (), 15:49:56 INFO - 'pip_index': False, 15:49:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:49:56 INFO - 'cmd': ('bash', 15:49:56 INFO - '-c', 15:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:49:56 INFO - 'enabled': True, 15:49:56 INFO - 'halt_on_failure': False, 15:49:56 INFO - 'name': 'check_screen_resolution'},), 15:49:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:49:56 INFO - 'cmd': ('bash', 15:49:56 INFO - '-c', 15:49:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:49:56 INFO - 'enabled': True, 15:49:56 INFO - 'halt_on_failure': False, 15:49:56 INFO - 'name': 'check_screen_resolution'},), 15:49:56 INFO - 'run_cmd_checks_enabled': True, 15:49:56 INFO - 'sps_profile': False, 15:49:56 INFO - 'sps_profile_interval': 0, 15:49:56 INFO - 'suite': 'dromaeojs', 15:49:56 INFO - 'system_bits': '32', 15:49:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:49:56 INFO - 'title': 't-yosemite-r7-0206', 15:49:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:49:56 INFO - 'use_talos_json': True, 15:49:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:49:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:49:56 INFO - 'work_dir': 'build'} 15:49:56 INFO - [mozharness: 2016-10-06 22:49:56.660115Z] Running clobber step. 15:49:56 INFO - Running pre-action listener: _resource_record_pre_action 15:49:56 INFO - Running main action method: clobber 15:49:56 INFO - rmtree: /builds/slave/test/build 15:49:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:49:58 INFO - Running post-action listener: _resource_record_post_action 15:49:58 INFO - [mozharness: 2016-10-06 22:49:58.524123Z] Finished clobber step (success) 15:49:58 INFO - [mozharness: 2016-10-06 22:49:58.524346Z] Running read-buildbot-config step. 15:49:58 INFO - Running pre-action listener: _resource_record_pre_action 15:49:58 INFO - Running main action method: read_buildbot_config 15:49:58 INFO - Using buildbot properties: 15:49:58 INFO - { 15:49:58 INFO - "project": "", 15:49:58 INFO - "product": "firefox", 15:49:58 INFO - "script_repo_revision": "production", 15:49:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:49:58 INFO - "repository": "", 15:49:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:49:58 INFO - "buildid": "20161006133800", 15:49:58 INFO - "pgo_build": "False", 15:49:58 INFO - "basedir": "/builds/slave/test", 15:49:58 INFO - "buildnumber": 180, 15:49:58 INFO - "slavename": "t-yosemite-r7-0206", 15:49:58 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:49:58 INFO - "platform": "yosemite_r7", 15:49:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:49:58 INFO - "branch": "fx-team", 15:49:58 INFO - "repo_path": "integration/fx-team", 15:49:58 INFO - "revision": "37f78aca862224d7151c0fcae1ed8373fe11c83b", 15:49:58 INFO - "stage_platform": "macosx64", 15:49:58 INFO - "builduid": "ffce8636b9444dc0a305ccb79315a3dc", 15:49:58 INFO - "slavebuilddir": "test" 15:49:58 INFO - } 15:49:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:49:58 INFO - Running post-action listener: _resource_record_post_action 15:49:58 INFO - [mozharness: 2016-10-06 22:49:58.529961Z] Finished read-buildbot-config step (success) 15:49:58 INFO - [mozharness: 2016-10-06 22:49:58.530126Z] Running download-and-extract step. 15:49:58 INFO - Running pre-action listener: _resource_record_pre_action 15:49:58 INFO - Running main action method: download_and_extract 15:49:58 INFO - mkdir: /builds/slave/test/build/tests 15:49:58 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')]} 15:49:58 INFO - trying https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:49:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/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 15:49:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/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 15:49:59 INFO - Downloaded 1199 bytes. 15:49:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:49:59 INFO - Using the following test package requirements: 15:49:59 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:49:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:49:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:49:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'jsshell-mac.zip'], 15:49:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:49:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:49:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:49:59 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:49:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:49:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:49:59 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:49:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:49:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:49:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:49:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:50:00 INFO - Http code: 200 15:50:00 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 15:50:00 INFO - x-amz-cf-id: UnDbfdP8R3-pAdZJHlXa0ESnDRCaeUEORYcSye5RM47aE0pXlgqj1Q== 15:50:00 INFO - x-amz-version-id: mOEHTrnOkg2RzjC_b7oQWA2JfAPmw1qf 15:50:00 INFO - Expected file size: 16478289 15:50:00 INFO - Obtained file size: 16478289 15:50:06 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 15:50:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:50:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:50:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:50:07 INFO - Http code: 200 15:50:07 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 15:50:07 INFO - x-amz-cf-id: 7c0vWduSz8Io4qGu8Oog9b6Ro3wmiwOQBAPh2lMQxwk6FEgtC01Yuw== 15:50:07 INFO - x-amz-version-id: mOEHTrnOkg2RzjC_b7oQWA2JfAPmw1qf 15:50:07 INFO - Expected file size: 16478289 15:50:07 INFO - Obtained file size: 16478289 15:50:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:50:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:50:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:50:14 INFO - Http code: 200 15:50:14 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 15:50:14 INFO - x-amz-cf-id: 8vbo8w_8DNzIr4uPUj__PbtlV9aM4W2KuFxe7pVhXOAzffq-RTJEgA== 15:50:14 INFO - x-amz-version-id: tIrZDQKilGLHjJcOg43P8k6VBXN4w6mQ 15:50:14 INFO - Expected file size: 14409006 15:50:14 INFO - Obtained file size: 14409006 15:50:15 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')]} 15:50:15 INFO - trying https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:50:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/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 15:50:17 INFO - Downloaded 111661133 bytes. 15:50:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:50:17 INFO - mkdir: /builds/slave/test/properties 15:50:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:17 INFO - Contents: 15:50:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:50:18 INFO - Running post-action listener: _resource_record_post_action 15:50:18 INFO - Running post-action listener: set_extra_try_arguments 15:50:18 INFO - [mozharness: 2016-10-06 22:50:18.993821Z] Finished download-and-extract step (success) 15:50:18 INFO - [mozharness: 2016-10-06 22:50:18.993945Z] Running populate-webroot step. 15:50:18 INFO - Running pre-action listener: _resource_record_pre_action 15:50:18 INFO - Running main action method: populate_webroot 15:50:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:50:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:50:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:50:19 INFO - '--tppagecycles', 15:50:19 INFO - '7'], 15:50:19 INFO - 'tests': ['tsvgm']}}, 15:50:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:50:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:50:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['damp', 'tps']}, 15:50:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'tests': ['damp', 'tps']}, 15:50:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['dromaeo_dom']}, 15:50:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['basic_compositor_video']}, 15:50:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:50:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['a11yr', 15:50:19 INFO - 'ts_paint', 15:50:19 INFO - 'tpaint', 15:50:19 INFO - 'sessionrestore', 15:50:19 INFO - 'sessionrestore_no_auto_restore', 15:50:19 INFO - 'tabpaint']}, 15:50:19 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:19 INFO - 'ts_paint', 15:50:19 INFO - 'tpaint', 15:50:19 INFO - 'sessionrestore', 15:50:19 INFO - 'sessionrestore_no_auto_restore', 15:50:19 INFO - 'tabpaint']}, 15:50:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:50:19 INFO - 'ts_paint', 15:50:19 INFO - 'tpaint', 15:50:19 INFO - 'sessionrestore', 15:50:19 INFO - 'sessionrestore_no_auto_restore', 15:50:19 INFO - 'tabpaint']}, 15:50:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:50:19 INFO - 'ts_paint', 15:50:19 INFO - 'tpaint', 15:50:19 INFO - 'sessionrestore', 15:50:19 INFO - 'sessionrestore_no_auto_restore', 15:50:19 INFO - 'tabpaint']}, 15:50:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['a11yr', 15:50:19 INFO - 'ts_paint', 15:50:19 INFO - 'tpaint', 15:50:19 INFO - 'sessionrestore', 15:50:19 INFO - 'sessionrestore_no_auto_restore', 15:50:19 INFO - 'tabpaint']}, 15:50:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['a11yr', 15:50:19 INFO - 'ts_paint', 15:50:19 INFO - 'tpaint', 15:50:19 INFO - 'sessionrestore', 15:50:19 INFO - 'sessionrestore_no_auto_restore', 15:50:19 INFO - 'tabpaint']}, 15:50:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['tsvgx', 15:50:19 INFO - 'tsvgr_opacity', 15:50:19 INFO - 'tart', 15:50:19 INFO - 'tscrollx', 15:50:19 INFO - 'cart']}, 15:50:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:19 INFO - 'tsvgr_opacity', 15:50:19 INFO - 'tart', 15:50:19 INFO - 'tscrollx', 15:50:19 INFO - 'cart']}, 15:50:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'talos_options': ['--disable-e10s'], 15:50:19 INFO - 'tests': ['tp5o']}, 15:50:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'tests': ['tp5o']}, 15:50:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'talos_options': ['--disable-e10s', 15:50:19 INFO - '--xperf_path', 15:50:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:19 INFO - 'tests': ['tp5n']}, 15:50:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:50:19 INFO - 'talos_options': ['--xperf_path', 15:50:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:19 INFO - 'tests': ['tp5n']}}, 15:50:19 INFO - 'talos.zip': {'path': '', 15:50:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:50:19 INFO - Running post-action listener: _resource_record_post_action 15:50:19 INFO - [mozharness: 2016-10-06 22:50:19.012530Z] Finished populate-webroot step (success) 15:50:19 INFO - [mozharness: 2016-10-06 22:50:19.012659Z] Running create-virtualenv step. 15:50:19 INFO - Running pre-action listener: _resource_record_pre_action 15:50:19 INFO - Running main action method: create_virtualenv 15:50:19 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:19 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 15:50:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:50:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:19 INFO - Using real prefix '/tools/python27' 15:50:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:19 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:22 INFO - Installing pip.................done. 15:50:22 INFO - Return code: 0 15:50:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:50:22 INFO - Reading from file tmpfile_stdout 15:50:22 INFO - Output received: 15:50:22 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) 15:50:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50: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')]} 15:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50: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')]} 15:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:50:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:22 INFO - 'HOME': '/Users/cltbld', 15:50:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:22 INFO - 'LOGNAME': 'cltbld', 15:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:22 INFO - 'MOZ_NO_REMOTE': '1', 15:50:22 INFO - 'NO_EM_RESTART': '1', 15:50:22 INFO - 'PAGER': '/bin/cat', 15:50:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:22 INFO - 'PWD': '/builds/slave/test', 15:50:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:22 INFO - 'SHELL': '/bin/bash', 15:50:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:22 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:22 INFO - 'USER': 'cltbld', 15:50:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:22 INFO - 'XPC_FLAGS': '0x0', 15:50:22 INFO - 'XPC_SERVICE_NAME': '0', 15:50:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:23 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 15:50:23 INFO - Cleaning up... 15:50:23 INFO - Return code: 0 15:50:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:23 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 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:23 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 15:50:23 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 15:50:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:23 INFO - 'HOME': '/Users/cltbld', 15:50:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:23 INFO - 'LOGNAME': 'cltbld', 15:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:23 INFO - 'MOZ_NO_REMOTE': '1', 15:50:23 INFO - 'NO_EM_RESTART': '1', 15:50:23 INFO - 'PAGER': '/bin/cat', 15:50:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:23 INFO - 'PWD': '/builds/slave/test', 15:50:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:23 INFO - 'SHELL': '/bin/bash', 15:50:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:23 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:23 INFO - 'USER': 'cltbld', 15:50:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:23 INFO - 'XPC_FLAGS': '0x0', 15:50:23 INFO - 'XPC_SERVICE_NAME': '0', 15:50:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:23 INFO - Downloading/unpacking psutil>=3.1.1 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:26 INFO - Installing collected packages: psutil 15:50:26 INFO - Running setup.py install for psutil 15:50:27 INFO - building 'psutil._psutil_osx' extension 15:50:27 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 15:50:27 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 15:50:27 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 15:50:27 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 15:50:27 INFO - building 'psutil._psutil_posix' extension 15:50:27 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 15:50:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:50:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:50:27 INFO - ^ 15:50:27 INFO - 1 warning generated. 15:50:27 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 15:50:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:27 INFO - Successfully installed psutil 15:50:27 INFO - Cleaning up... 15:50:27 INFO - Return code: 0 15:50:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:27 INFO - 'HOME': '/Users/cltbld', 15:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:27 INFO - 'LOGNAME': 'cltbld', 15:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:27 INFO - 'MOZ_NO_REMOTE': '1', 15:50:27 INFO - 'NO_EM_RESTART': '1', 15:50:27 INFO - 'PAGER': '/bin/cat', 15:50:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:27 INFO - 'PWD': '/builds/slave/test', 15:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:27 INFO - 'SHELL': '/bin/bash', 15:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:27 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:27 INFO - 'USER': 'cltbld', 15:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:27 INFO - 'XPC_FLAGS': '0x0', 15:50:27 INFO - 'XPC_SERVICE_NAME': '0', 15:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:30 INFO - Installing collected packages: mozsystemmonitor 15:50:30 INFO - Running setup.py install for mozsystemmonitor 15:50:30 INFO - Successfully installed mozsystemmonitor 15:50:30 INFO - Cleaning up... 15:50:30 INFO - Return code: 0 15:50:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:30 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 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:30 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 15:50:30 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 15:50:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:30 INFO - 'HOME': '/Users/cltbld', 15:50:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:30 INFO - 'LOGNAME': 'cltbld', 15:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:30 INFO - 'MOZ_NO_REMOTE': '1', 15:50:30 INFO - 'NO_EM_RESTART': '1', 15:50:30 INFO - 'PAGER': '/bin/cat', 15:50:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:30 INFO - 'PWD': '/builds/slave/test', 15:50:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:30 INFO - 'SHELL': '/bin/bash', 15:50:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:30 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:30 INFO - 'USER': 'cltbld', 15:50:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:30 INFO - 'XPC_FLAGS': '0x0', 15:50:30 INFO - 'XPC_SERVICE_NAME': '0', 15:50:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:31 INFO - Downloading/unpacking jsonschema==2.5.1 15:50:31 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 15:50:31 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 15:50:31 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 15:50:31 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 15:50:31 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 15:50:31 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 15:50:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:50:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:50:33 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 15:50:33 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 15:50:33 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 15:50:33 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 15:50:33 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 15:50:33 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 15:50:34 INFO - Downloading functools32-3.2.3-2.tar.gz 15:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:50:34 INFO - warning: no files found matching '*.txt' 15:50:34 INFO - no previously-included directories found matching 'build' 15:50:34 INFO - no previously-included directories found matching 'dist' 15:50:34 INFO - no previously-included directories found matching '.git*' 15:50:34 INFO - Installing collected packages: jsonschema, functools32 15:50:34 INFO - Running setup.py install for functools32 15:50:34 INFO - warning: no files found matching '*.txt' 15:50:34 INFO - no previously-included directories found matching 'build' 15:50:34 INFO - no previously-included directories found matching 'dist' 15:50:34 INFO - no previously-included directories found matching '.git*' 15:50:34 INFO - Successfully installed jsonschema functools32 15:50:34 INFO - Cleaning up... 15:50:34 INFO - Return code: 0 15:50:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:34 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 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:34 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 15:50:34 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 15:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:34 INFO - 'HOME': '/Users/cltbld', 15:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:34 INFO - 'LOGNAME': 'cltbld', 15:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:34 INFO - 'MOZ_NO_REMOTE': '1', 15:50:34 INFO - 'NO_EM_RESTART': '1', 15:50:34 INFO - 'PAGER': '/bin/cat', 15:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:34 INFO - 'PWD': '/builds/slave/test', 15:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:34 INFO - 'SHELL': '/bin/bash', 15:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:34 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:34 INFO - 'USER': 'cltbld', 15:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:34 INFO - 'XPC_FLAGS': '0x0', 15:50:34 INFO - 'XPC_SERVICE_NAME': '0', 15:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:50:34 INFO - Cleaning up... 15:50:34 INFO - Return code: 0 15:50:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:34 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 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:34 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 15:50:34 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 15:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:34 INFO - 'HOME': '/Users/cltbld', 15:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:34 INFO - 'LOGNAME': 'cltbld', 15:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:34 INFO - 'MOZ_NO_REMOTE': '1', 15:50:34 INFO - 'NO_EM_RESTART': '1', 15:50:34 INFO - 'PAGER': '/bin/cat', 15:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:34 INFO - 'PWD': '/builds/slave/test', 15:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:34 INFO - 'SHELL': '/bin/bash', 15:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:34 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:34 INFO - 'USER': 'cltbld', 15:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:34 INFO - 'XPC_FLAGS': '0x0', 15:50:34 INFO - 'XPC_SERVICE_NAME': '0', 15:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50: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 15:50:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:50:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:50:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:50:38 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 15:50:38 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 15:50:38 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 15:50:38 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 15:50:38 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 15:50:38 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 15:50:38 INFO - Downloading docopt-0.6.1.tar.gz 15:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:50:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:50:38 INFO - Running setup.py install for blobuploader 15:50:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:50:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:50:38 INFO - Running setup.py install for requests 15:50:39 INFO - Running setup.py install for docopt 15:50:39 INFO - Successfully installed blobuploader requests docopt 15:50:39 INFO - Cleaning up... 15:50:39 INFO - Return code: 0 15:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:39 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 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:39 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 15:50:39 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 15:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:39 INFO - 'HOME': '/Users/cltbld', 15:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:39 INFO - 'LOGNAME': 'cltbld', 15:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:39 INFO - 'MOZ_NO_REMOTE': '1', 15:50:39 INFO - 'NO_EM_RESTART': '1', 15:50:39 INFO - 'PAGER': '/bin/cat', 15:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:39 INFO - 'PWD': '/builds/slave/test', 15:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:39 INFO - 'SHELL': '/bin/bash', 15:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:39 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:39 INFO - 'USER': 'cltbld', 15:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:39 INFO - 'XPC_FLAGS': '0x0', 15:50:39 INFO - 'XPC_SERVICE_NAME': '0', 15:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:39 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-nUCNsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:39 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-PJRl25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:39 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-_JzvXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-LA4odJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-k_4KoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ZZiJbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-G0xq79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-x6FQQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-hg4XAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-u9fk62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-UN4_Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:40 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-cSJj46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:41 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-MN5Z4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:41 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-SfnhP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:41 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-mxMWmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:41 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-R25L94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:41 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-fFKWzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:50:41 INFO - Running setup.py install for manifestparser 15:50:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:50:41 INFO - Running setup.py install for mozcrash 15:50:41 INFO - Running setup.py install for mozdebug 15:50:41 INFO - Running setup.py install for mozdevice 15:50:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Running setup.py install for mozfile 15:50:42 INFO - Running setup.py install for mozhttpd 15:50:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Running setup.py install for mozinfo 15:50:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Running setup.py install for mozInstall 15:50:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:50:42 INFO - Running setup.py install for mozleak 15:50:42 INFO - Running setup.py install for mozlog 15:50:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:50:43 INFO - Running setup.py install for moznetwork 15:50:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:50:43 INFO - Running setup.py install for mozprocess 15:50:43 INFO - Running setup.py install for mozprofile 15:50:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:50:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:50:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:50:43 INFO - Running setup.py install for mozrunner 15:50:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:50:43 INFO - Running setup.py install for mozscreenshot 15:50:43 INFO - Running setup.py install for moztest 15:50:43 INFO - Running setup.py install for mozversion 15:50:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:50:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:50:44 INFO - Cleaning up... 15:50:44 INFO - Return code: 0 15:50:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:44 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 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:44 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 15:50:44 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 15:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:44 INFO - 'HOME': '/Users/cltbld', 15:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:44 INFO - 'LOGNAME': 'cltbld', 15:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:44 INFO - 'MOZ_NO_REMOTE': '1', 15:50:44 INFO - 'NO_EM_RESTART': '1', 15:50:44 INFO - 'PAGER': '/bin/cat', 15:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:44 INFO - 'PWD': '/builds/slave/test', 15:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:44 INFO - 'SHELL': '/bin/bash', 15:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:44 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:44 INFO - 'USER': 'cltbld', 15:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:44 INFO - 'XPC_FLAGS': '0x0', 15:50:44 INFO - 'XPC_SERVICE_NAME': '0', 15:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:50:44 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-xfjiWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:50:44 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)) 15:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:50:44 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-NkI_IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:50:44 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)) 15:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:50:44 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-06WRx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:50:44 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)) 15:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:50:44 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-grbmdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:50:44 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)) 15:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:50:44 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-VE1Bc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:50:44 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)) 15:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:50:44 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-adlskn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-jBVxJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-7VzAch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-t4XzvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Z2T3Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Kc7U2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-gkEmy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-qHrlpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-zCs4fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-irlH4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:50:45 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)) 15:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:50:45 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-DpTKkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:50:46 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)) 15:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:50:46 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-78Ojz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:50:46 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)) 15:50:46 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)) 15:50:46 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)) 15:50:46 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)) 15:50:46 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)) 15:50:46 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)) 15:50:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:50:46 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 15:50:46 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 15:50:46 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 15:50:46 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 15:50:46 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 15:50:46 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 15:50:48 INFO - Downloading blessings-1.6.tar.gz 15:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:50:48 INFO - Installing collected packages: blessings 15:50:48 INFO - Running setup.py install for blessings 15:50:48 INFO - Successfully installed blessings 15:50:48 INFO - Cleaning up... 15:50:49 INFO - Return code: 0 15:50:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:50:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:49 INFO - Reading from file tmpfile_stdout 15:50:49 INFO - Current package versions: 15:50:49 INFO - blessings == 1.6 15:50:49 INFO - blobuploader == 1.2.4 15:50:49 INFO - docopt == 0.6.1 15:50:49 INFO - functools32 == 3.2.3-2 15:50:49 INFO - jsonschema == 2.5.1 15:50:49 INFO - manifestparser == 1.1 15:50:49 INFO - mozInstall == 1.12 15:50:49 INFO - mozcrash == 0.17 15:50:49 INFO - mozdebug == 0.1 15:50:49 INFO - mozdevice == 0.48 15:50:49 INFO - mozfile == 1.2 15:50:49 INFO - mozhttpd == 0.7 15:50:49 INFO - mozinfo == 0.9 15:50:49 INFO - mozleak == 0.1 15:50:49 INFO - mozlog == 3.4 15:50:49 INFO - moznetwork == 0.27 15:50:49 INFO - mozprocess == 0.23 15:50:49 INFO - mozprofile == 0.28 15:50:49 INFO - mozrunner == 6.12 15:50:49 INFO - mozscreenshot == 0.1 15:50:49 INFO - mozsystemmonitor == 0.3 15:50:49 INFO - moztest == 0.7 15:50:49 INFO - mozversion == 1.4 15:50:49 INFO - psutil == 3.1.1 15:50:49 INFO - requests == 1.2.3 15:50:49 INFO - wsgiref == 0.1.2 15:50:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:49 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 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:49 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 15:50:49 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 15:50:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:49 INFO - 'HOME': '/Users/cltbld', 15:50:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:49 INFO - 'LOGNAME': 'cltbld', 15:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:49 INFO - 'MOZ_NO_REMOTE': '1', 15:50:49 INFO - 'NO_EM_RESTART': '1', 15:50:49 INFO - 'PAGER': '/bin/cat', 15:50:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:49 INFO - 'PWD': '/builds/slave/test', 15:50:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:49 INFO - 'SHELL': '/bin/bash', 15:50:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:49 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:49 INFO - 'USER': 'cltbld', 15:50:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:49 INFO - 'XPC_FLAGS': '0x0', 15:50:49 INFO - 'XPC_SERVICE_NAME': '0', 15:50:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 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)) 15:50:49 INFO - Cleaning up... 15:50:49 INFO - Return code: 0 15:50:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff55490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fecb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a8d74fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, '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.44yqObOpU8/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.ie4eXlxV9b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 15:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:50:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:50:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:50:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:50:49 INFO - 'HOME': '/Users/cltbld', 15:50:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:50:49 INFO - 'LOGNAME': 'cltbld', 15:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:49 INFO - 'MOZ_NO_REMOTE': '1', 15:50:49 INFO - 'NO_EM_RESTART': '1', 15:50:49 INFO - 'PAGER': '/bin/cat', 15:50:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:49 INFO - 'PWD': '/builds/slave/test', 15:50:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:50:49 INFO - 'SHELL': '/bin/bash', 15:50:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:50:49 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:50:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:50:49 INFO - 'USER': 'cltbld', 15:50:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:50:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:49 INFO - 'XPC_FLAGS': '0x0', 15:50:49 INFO - 'XPC_SERVICE_NAME': '0', 15:50:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:50:50 INFO - Cleaning up... 15:50:50 INFO - Return code: 0 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - Running post-action listener: _start_resource_monitoring 15:50:50 INFO - Starting resource monitoring. 15:50:50 INFO - [mozharness: 2016-10-06 22:50:50.275762Z] Finished create-virtualenv step (success) 15:50:50 INFO - [mozharness: 2016-10-06 22:50:50.276777Z] Running install step. 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: install 15:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:50:50 INFO - Reading from file tmpfile_stdout 15:50:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:50:50 INFO - Reading from file tmpfile_stdout 15:50:50 INFO - Output received: 15:50:50 INFO - Usage: mozinstall [options] installer 15:50:50 INFO - Options: 15:50:50 INFO - -h, --help show this help message and exit 15:50:50 INFO - -d DEST, --destination=DEST 15:50:50 INFO - Directory to install application into. [default: 15:50:50 INFO - "/builds/slave/test"] 15:50:50 INFO - --app=APP Application being installed. [default: firefox] 15:50:50 INFO - mkdir: /builds/slave/test/build/application 15:50:50 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'] 15:50:50 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 15:51:25 INFO - Reading from file tmpfile_stdout 15:51:25 INFO - Output received: 15:51:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:51:25 INFO - Running post-action listener: _resource_record_post_action 15:51:25 INFO - [mozharness: 2016-10-06 22:51:25.342177Z] Finished install step (success) 15:51:25 INFO - [mozharness: 2016-10-06 22:51:25.342311Z] Running run-tests step. 15:51:25 INFO - Running pre-action listener: _resource_record_pre_action 15:51:25 INFO - Running main action method: run_tests 15:51:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:51:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:51:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:51:25 INFO - 2016-10-06 15:51:25.357 screenresolution[1992:11352] starting screenresolution argv=screenresolution get 15:51:25 INFO - 2016-10-06 15:51:25.360 screenresolution[1992:11352] Display 0: 1600x1200x32@60 15:51:25 INFO - 2016-10-06 15:51:25.365 screenresolution[1993:11354] starting screenresolution argv=screenresolution list 15:51:25 INFO - Available Modes on Display 0 15:51:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:51:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:51:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:51:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:51:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:51:25 INFO - Intel Iris: 15:51:25 INFO - Chipset Model: Intel Iris 15:51:25 INFO - Type: GPU 15:51:25 INFO - Bus: Built-In 15:51:25 INFO - VRAM (Dynamic, Max): 1536 MB 15:51:25 INFO - Vendor: Intel (0x8086) 15:51:25 INFO - Device ID: 0x0a2e 15:51:25 INFO - Revision ID: 0x0009 15:51:25 INFO - Displays: 15:51:25 INFO - Display: 15:51:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:51:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:51:25 INFO - Display Serial Number: 1600x1200 60 15:51:25 INFO - Main Display: Yes 15:51:25 INFO - Mirror: Off 15:51:25 INFO - Online: Yes 15:51:25 INFO - Rotation: Supported 15:51:25 INFO - Return code: 0 15:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:25 INFO - Python 2.7.3 15:51:25 INFO - Return code: 0 15:51:25 INFO - grabbing minidump binary from tooltool 15:51: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')]} 15:51:25 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 0x10fd69d30>, '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 0x10fb8fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:25 INFO - Return code: 0 15:51:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:51:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:51:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:25 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:51:25 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0206 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.44yqObOpU8/Render', 15:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:25 INFO - 'HOME': '/Users/cltbld', 15:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:25 INFO - 'LOGNAME': 'cltbld', 15:51:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:25 INFO - 'MOZ_NO_REMOTE': '1', 15:51:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:25 INFO - 'NO_EM_RESTART': '1', 15:51:25 INFO - 'PAGER': '/bin/cat', 15:51:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:25 INFO - 'PWD': '/builds/slave/test', 15:51:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:25 INFO - 'SHELL': '/bin/bash', 15:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ie4eXlxV9b/Listeners', 15:51:25 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 15:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:25 INFO - 'USER': 'cltbld', 15:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:25 INFO - 'XPC_FLAGS': '0x0', 15:51:25 INFO - 'XPC_SERVICE_NAME': '0', 15:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:51:25 INFO - mozversion application_buildid: 20161006133800 15:51:25 INFO - mozversion application_changeset: 37f78aca862224d7151c0fcae1ed8373fe11c83b 15:51:25 INFO - mozversion application_display_name: Nightly 15:51:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:25 INFO - mozversion application_name: Firefox 15:51:25 INFO - mozversion application_remotingname: firefox 15:51:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:51:25 INFO - mozversion application_vendor: Mozilla 15:51:25 INFO - mozversion application_version: 52.0a1 15:51:25 INFO - mozversion platform_buildid: 20161006133800 15:51:25 INFO - mozversion platform_changeset: 37f78aca862224d7151c0fcae1ed8373fe11c83b 15:51:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:51:25 INFO - mozversion platform_version: 52.0a1 15:51:25 INFO - using testdate: 1475794285 15:51:25 INFO - actual date: 1475794285 15:51:25 INFO - starting webserver on 'localhost:49405' 15:51:25 INFO - SUITE-START | Running 2 tests 15:51:25 INFO - TEST-START | dromaeo_css 15:51:25 INFO - operating with platform_type : mac_ 15:51:25 INFO - Initialising browser for dromaeo_css test... 15:51:25 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpyLQypi/profile http://localhost:49405/getInfo.html) 15:51:28 INFO - PROCESS | 2003 | __metrics Screen width/height:1600/1200 15:51:28 INFO - PROCESS | 2003 | colorDepth:24 15:51:28 INFO - PROCESS | 2003 | Browser inner width/height: 1024/689 15:51:28 INFO - PROCESS | 2003 | __metrics 15:51:28 INFO - PROCESS | 2003 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:51:28 INFO - PROCESS | 2003 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:29 INFO - TEST-INFO | 2003: exit 0 15:51:29 INFO - Browser initialized. 15:51:29 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:29 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpyLQypi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:41 INFO - PROCESS | 2005 | RSS: Main: 244289536 15:51:41 INFO - PROCESS | 2005 | 15:52:32 INFO - PROCESS | 2005 | 1475794352263 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] 15:54:45 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49405/tests/dromaeo/cssquery-ext.html) 15:54:47 INFO - PROCESS | 2005 | RSS: Main: 415019008 15:54:47 INFO - PROCESS | 2005 | 15:57:50 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49405/tests/dromaeo/cssquery-ext.html (next: http://localhost:49405/tests/dromaeo/cssquery-jquery.html) 15:57:51 INFO - PROCESS | 2005 | RSS: Main: 369754112 15:57:51 INFO - PROCESS | 2005 | 16:00:53 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49405/tests/dromaeo/cssquery-mootools.html) 16:00:54 INFO - PROCESS | 2005 | RSS: Main: 342667264 16:00:54 INFO - PROCESS | 2005 | 16:03:56 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49405/tests/dromaeo/cssquery-prototype.html) 16:03:57 INFO - PROCESS | 2005 | RSS: Main: 341061632 16:03:57 INFO - PROCESS | 2005 | 16:07:00 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49405/tests/dromaeo/cssquery-yui.html) 16:07:01 INFO - PROCESS | 2005 | RSS: Main: 336044032 16:07:01 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49405/tests/dromaeo/cssquery-yui.html (next: http://localhost:49405/tests/dromaeo/cssquery-dojo.html) 16:10:04 INFO - PROCESS | 2005 | RSS: Main: 376074240 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | __start_tp_report 16:10:04 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 16:10:04 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 16:10:04 INFO - PROCESS | 2005 | |i|pagename|runs| 16:10:04 INFO - PROCESS | 2005 | |0;dojo.html;3300.306935543536;3306.5205545195945;3314.38683843489;3351.46376579747;3372.5278461015464;5565;5637.182608521762;5658.122990936401;5717.056685646869;5725.685087320196;5612.102063669814;5653.265075540174;5719.428057194278;5733.226014488053;5758.5393168546525;5061.063703214899;5061.316722242505;5108.770105345268;5127.435982041972;5182.093133701606;5258.290130832346;5260.8684782880355;5270;5281.339832520935;5326.014687282865;5228.346456692913;5251.737413129366;5257.605679574047;5276.762545685453;5330.680159190441;5047.4447810740785;5112.821051263188;5115.8209462669;5125.410577783566;5176.715280659562;5126.538611524943;5128.615353848476;5148.227765835118;5148.691078535262;5154.046501397253;5674.687892165929;5700.914486282668;5721.456461636138;5770.826875193751;5793.913091303634;6085.6348619083;6105.793350785086;6121.81881567809;6200.348963358828;6260.530460215502;6145.402195429176;6154.892119418503;6183.227096612924;6268.279147898004;6270.31026587075;5756.050251708505;5760.337561180434;5769.221155144001;5772.595918285764;5812.476877081083;5346.251524786533;6211.596246243979;6216.2540495139965;6277.7175027123885;6288.937110628926;6008.008678568075;6059.939400605937;6102.024902777868;6122.081687746784;6157.107219453154;6256.499480041586;6258.843528911722;6263.686815659199;6278.4035516625845;6279.497640188774;6008.549358798107;6159.538034647419;6216.844578885564;6219.47134493564;6231.283402408691;6135.846603834851;6152.569320147636;6159.168512250879;6161.907571386433;6165.506759459233;4905.362302900671;4907.435644900882;4921.0157968406465;4921.4832442593015;4939.234418665113;4368.191884501377;4387.495438024668;4401.713888597231;4425.955740442554;4452.799624016862;5670.234518340054;5754.568407369464;5756.597038207369;5761.88476230473;5779.566532509994;6250.937490625036;6287.434130928238;6289.559730818799;6292.96166132583;6315.778947736807;5585.972070139624;5625.71871406428;5641.830745077655;5651.180578816131;5813.82558523245;5325.946740532545;5375.865603359869;5384.811531596453;5395.271638328775;5446.183072539151;6304.464120549805;6323.905141422974;6327.367263273728;6334.3665633436285;6335.683215839097;6097.887666312884;6155.446009859134;6167.5682702210415;6188.195534580475;6237.532185086227;6289.654069026247;6299.055141728777;6300.779472718433;6312.684365781784;6318.747250109944;6165.5375846810775;6195.845103872439;6199.411055949678;6207.224096987877;6223.782167624111;5953.226080609493;6136.140940268277;6192.628442293477;6266.592671476339;6281.12064311006;4842.58837998774;5973.044312909914;6017.398260174123;6022.849428764316;6037.275526936795;6007.3992600739575;6019.729112189874;6027.547933904887;6051.515878729603;6140.815775526741;5873.9412605873395;5916.467517923407;5920.763169473173;5928;5934.317553481233;6098.664573448325;6111.419415155553;6120.387961203844;6121.816345509642;6132.5707200495535;5621.606487545832;5667.574931880208;5859.355470898113;5871.178035075008;5887.0580707088375 16:10:04 INFO - PROCESS | 2005 | |1;ext.html;505.81537738725365;516.7390467813754;518.6810111781255;525.5401523666792;541.4125673644096;30677.38645227094;40778.796106019465;42239.366409503884;42253.36619950699;42272.9431764206;42836.78581607095;43179.35230971538;43242.783786081105;43243;43266.567334326646;9681.70954871355;9880.604775808995;9883.258755593324;9889.75275618108;9897.653582124627;9658.034196580356;9761.97499262578;9771.26715496337;9773.41359518431;9799.853002204973;9758.365706229108;9833.262505312094;9836.655717049905;9846.60613575456;9849.60601575936;9677.64512968185;9735.123838854466;9743.707688769347;9748.610055597768;9775;9840.26198035143;9889.406635601887;9907.256955728277;9915.256355773274;9934.25493088014;41070.79464602658;41518.79240603778;41523;41539.75380738582;41542.37686434706;3205.4710972689477;3211.277462570926;3354.480055591387;3487.1805125795418;3658.615845336228;31086.222844428845;31260.531092033638;31391.37217255665;31765.46648100254;31908.042758717274;3096;3254.886078987248;3259.5762550868235;3260.739140868725;3369.9157521061925;507505.46247268526;509119;511995;512264;512772;52288;63766.04350934739;63858;63945.36054639487;64016;34901.65098349035;35417.82291088528;35701.82149089238;36392;66356;16471.34114635425;16596.419125330554;16630.251638676287;16642.417515387144;16648.833511664972;12658.303793291274;12775;12779.744405111845;12798.872011279955;12807.871921280854;19199.52001199981;19213;19217.903910480636;19237.248736496247;19240.518987025436;7046.753363632351;7619.847603047908;7799.5320280783335;7865.764027079083;7936.801579960547;836.573347592732;1015.8425444056184;1020.3622735790132;1049.3284298049255;1056.9788604227872;30016.54975175374;30056.54915176274;30599.38801223963;30876;30948.690513095033;1005.7133716890651;1028.7325295423095;1069.4332004037872;1079.2121751121724;1112.777444511101;13975.440982360591;15313.693726125415;15667.921660391854;15757.369705211662;15807.063769169685;635593;649534;650713.7464312648;652726;654515;58116;58708.82582348415;58777.70611147003;58811;58840;1220.560598184653;1240.6154092231436;1323.6492329532682;1357.362039841273;1366.269046060353;28545.714542854304;30414.087577372713;31410.528842067844;31865.203369915936;32465;55727;55793.1631025543;55825.16262255988;55879.44120558905;55998.72000639971;572446;586302;589422;589845;591951;35381.46927796137;35542;42292.78853605712;42591.57408425876;42832.500862469664;47235;47561.04877902492;47847;47988;48753.5124648749;39328;39359;39365.80317098396;40665.39001915033;41047.589524104376;39093.80453097716;39187.80406097951;39273.410898837115;40610.78167654975;40616.796916016414;37771;38531;38737.418938715375;38939.6106038936;38997;30699.38601227918;34034.489482657285;34364;34489.65510344865;34638.82680586581;25175.74824251734;25546.361340966625;25565.3608659785;25659.098407366037;26077.217683469527 16:10:04 INFO - PROCESS | 2005 | |2;jquery.html;359.0914985087728;364.51883513761845;370.22068545711267;384.3139995108728;393.79916242716223;19801.801981980178;20175.19299228031;21082.789172108274;21106.894465527672;21282.89358553209;11931.463084161212;12357.258564486137;12381.38093095346;12389.25664460133;16514.42199523017;5263.657862238952;5626.381098079208;5626.9437305626825;5627.184058311543;5632.957902787997;3946.4474973503734;4120.09357941254;4219.936700949473;4261.637760790321;5480.7533660985355;7075.009498670164;7090.610016449094;7098;7107.5735455872555;7117.537360071578;6249.375062493759;6250.093736408241;6304.338044505307;6314.463270622003;7060.929390706078;5047.520485553867;6135.2024236849375;6152.3847615238565;6152.84617884552;6162.630242185483;12691.746165076647;13143.60569182926;13319.866801332057;13353.666158346023;13367.197968121944;2001.539645881441;2059.238081909703;2087.3424871165535;2254.6730724045087;2309.353381053291;10382.3251488653;11141.498632561474;12692.85764281219;15310;16266.75599866003;1845.9446216613524;1858.3031363238786;1860.5534671678836;1866.141574875559;1918.9424317270505;98432;123315.76684233222;127460.36269818684;131249;138482.30758846243;10513.52689128991;11221.60724374643;11698.649040528799;11884.940575297069;12168.087393445527;14717.411303547738;14742.189179595225;14759.262036898112;14762;14799.112053276838;8312.293455056388;8618.353623478264;8624.741257762276;8774.60514276859;8776.517291549026;7937.444378893422;8499.61751721174;8522.74431767048;8523.55099633064;8697.739067827975;4474.306482495218;4564.269716845355;4570.7257564546235;4637.281221410687;4653.837115700934;1752.808988764045;1836.5344873090844;1865.8507319414414;1924.4130540185097;1930.6331796958532;791.4618059719446;840.7351684219451;897.2194191053825;916.4318122763929;949.0604301741226;19960.60078798416;21737.23919662804;21741.78258217429;21755.238566650092;21802;906.4923642760075;919.4069824962861;922.5064590444215;948.4214629076258;1011.3628414099071;10379.896201038044;11409.771804564029;11415.942920285512;11443.02481354837;11465.598704045486;485847;493560;494496;566928;600111;129872.05191922128;143001;144929;148126;148943.46543337652;910.7040211931148;940.3088729783603;949.6960972488737;954.9045095490534;992.8609994600906;18363.54091147732;19149.808501914802;19178.328758493386;19238.422847314603;19241.711374329116;54797.72601136969;55510;55694.88610227692;57024.42975570191;57388.71305643445;61268.08097878446;82568;84770.15229847623;84906;85430.57284713537;7912.723054693058;8070.435069545076;8165.101838797608;8289.129641387808;8328.791780205544;12546;12873.35633218354;13005.869941300465;13199.736005279648;13408.463661453823;10818.02637762605;10852.348859068481;10945.507452164831;11102.500387482422;11179.441027948733;10151.238657100896;11032.944835275772;11068.169887258327;11232.494537745984;11256.324620522468;11321.264117832314;11323.32060076398;11526.88473115258;11545.82681259765;11554.653360399201;7946.7615971520945;8012.479188852706;8177.141400152898;8239.423240373117;8367.163283671583;8303.377246706401;10440.791184176425;10749.89250107489;10791.730206744895;11170.994610485095 16:10:04 INFO - PROCESS | 2005 | |3;mootools.html;1392.7005693775839;1500.849915008499;1655.2137734576079;1842.3459671816513;1859.302761464451;8374.455660382071;8886.555672216387;8909.509976951265;8914.598843052063;8915.108489151082;7874.448788584801;8132.91867081329;8434.789130271747;8694.956525217365;8710.91289087109;2334.2763743239566;2357.481354102095;2358.811295096388;2359.2686267257204;2363.3382652857226;2314.745378008418;2331.160782118436;2356.493353928905;2359.1742889988536;2364.196173301077;2331.5336932613545;2352.2825538210923;2352.752960939102;2354.929352119439;2369.537940101672;2310.976890231093;2319.4665226997718;2328.4062564046058;2330.813534917211;2345.777151170636;2315.444293369596;2323.5585238804574;2324.2562380038394;2329.324495896188;2333.8132949364012;8550.358723095793;8600.311975041981;8657.0044444889;8664.740057798275;8676.60955257015;5023.472535383768;5162.3030890830005;5173.301604283449;5335.706536140511;5337.786488540453;3506.9824650876835;3595.334863050344;3675.4854320395166;3690.8708195213308;3722.981385093084;1047.7956798424311;1070.3791800755544;1085.6580177244143;1103.6688993302057;1107.5625128074366;11762.117841161948;11862.28826270418;11877.227980181175;11878.287302761775;11881.34652594107;4498.482674492409;4644.976775116171;4706.552877476634;4768.523147685204;4775.307580400822;9949.602015919281;9958.153556947596;9958.30291879576;9967.40195588267;9971.700848974542;5268.2097685346735;5282.234076059027;5290.100682883919;5292;5295.4969277918535;4354.9564504355185;4446.822127114944;4550.49944506104;4843.539863712942;4849.175640141114;3830.2148059647707;3849.4418309345547;3958.7030972677167;3975.6421922027157;3989.401589761501;1198.688341031338;1214.5081242096965;1217.6103646833105;1254.1597129922973;1282.69215388308;804.412778671573;846.386369881843;890.3678388344218;900.104396125859;922.9030951750104;5866.1494083357675;5915.674637894871;5932.406759324033;6047.516198704093;6072.605280656831;861.9956900215459;887.5163036145316;900.8783814185132;937.1237892570332;981.7790997025612;3625.3111908737255;3841.3469710149343;3876.9612303877166;3915.569287378386;4006.2988976928923;10603.41681207541;10880.836787448194;10957.616483423202;10979.670609881716;11006.889931100746;10924.563017479211;10926.344419334866;10926.508307126198;10940.781184376427;10950.780984380428;7844.450888437868;8218.589070546448;8264.917350826536;8275.50346979183;8284.46151000183;5812.651240925558;5865.237519122486;6028.33688294296;6032.969835150796;6049.062395328731;9944.30389872702;10080.143187829117;10109.848352274576;10113.898861011296;10122;9620.855687164558;10152.644657436955;10236.590536378462;10402.635907743193;10463.94768026155;7598.772036838904;7800.6099695016155;8006.959965200137;8027.678892844221;8175.264226219669;8289.33685305162;8379.413441059067;8463.407561470884;8482.321414286718;8499.702510412106;7404.345184137423;7511.211322811245;7512.286332798375;7532.472726909064;7553.697852086075;7313.853722925618;7339.77980660581;7353.338199562065;7387.261273872569;7446.404287657083;6858.177018757581;7026.508144430045;7035.718571257297;7042.260562640849;7042.929570704227;4043.8989025274605;4900.69385077233;5023.196288593807;5072.163093089599;5125.615578831528;4398.032432864765;4431.809097449831;4452.532484089124;4524.117797029548;4571.405717256735 16:10:04 INFO - PROCESS | 2005 | |4;prototype.html;253.7297777866572;272.93827012919735;297.4526870558173;305.77678294844753;315.54876526567;5233.65981211221;5301.17831736081;5307.946920530793;5316.3354580677415;5332.933413317338;5064.341635587369;5159.896802063966;5232.895342093166;5267.55225805806;5291.206319052144;3341.365140623286;3448.913777155566;3568.1436455250814;3569.3575156471825;3726.4037753959374;3303.537504749325;3958.0896393829435;3972.860949866755;3995.781286707553;4018.975161333856;3429.537012503305;3735.9439608405896;3899.1032062625613;3904;3947.6447119759214;3152.511360739089;3515.5781306243157;3725.869594564177;3958.9802050989706;3961.6434520893113;2745.3685652300082;2857.7570906472974;3406.4890266459984;3421.6920477157178;3426.3489936911906;3919.941200881989;4425.380446737459;4549.997001978678;4932.950670493285;4950.925736113961;4325.891852703676;4483.30508771141;4490.663200259961;4493.326001099828;4510.977445112786;4583.899864032608;4586.165533786479;4847.224444088964;5361.276227709287;5436.91844622331;3033.1810411188853;3152.338009018086;3732.42147467143;3777.660010599059;3816.8473261069526;5189.273501709764;5231.947680523184;5626.381098079208;5653.717314134276;5662.490375866192;3575.8927232183078;3797.7531460454984;3831.4635950966886;3847.7498962567342;3886.9187353278944;3868.845246190177;3888.3280189518214;3894.3768996960353;3899.5515515715488;3929.351656976567;3971.72197946141;4463.196624607537;4464.986134359295;4580.97709511457;4585.816567337336;4577.450705915311;4625.5836974671765;5183.922241166386;5444.863878403072;5469.343678758574;1153.405995912089;1162.0529268646026;1283.794592865137;1304.30871638032;1314.3625341709264;733.8238822682517;775.6393277126164;790.5138339921023;806.1857523900902;818.5702506184301;4311.736338422291;4647.814087436533;4964;5029.17018691919;5034.295198672189;4955.677880937799;5333.599980001515;5601.5238704710555;5642.476531336516;5663.830085097454;4451.421315229064;5106.391486681683;5109.514596113363;5142.228665700175;5225.779043906401;2701.8378897266225;2901.6518017837993;2926.941461170807;2934.471795076907;2940.6765255821842;5099.36257967754;5120.92318615221;5763.682997435098;5789.118536475662;5791.362950075489;4775.946343072512;5326.707031113326;5676.829695109153;5677.858053548612;5752.884942301131;5281.521174071267;5575.633969677455;5735.369109397963;5741.110127930177;5758.654480731169;4891.413030436228;5314.893702125859;5490.752916118864;5537.750801214036;5563.916541251965;4976.875578110431;5212.895742085061;5478.863028424162;5510.008198524304;5567.832965011056;4819.373481447389;5467.289252397163;5768.826935191951;5781.537477001913;5806.274215723035;3319.435695931649;3407.4718418645148;3711.9049880284842;3727.4595183698752;3736.7668669339596;4488.685791994529;5277.868053298698;5340.012097761926;5360.597955153301;5552.194931734956;4291.570842915684;4966.8758281043265;5409.2427060212385;5434.75543600531;5450.184870590681;4827.937853672186;5059.46875578059;5265.447128051499;5416.891662166813;5439.117267848047;4598.218302888584;4630.888586739091;5022;5061.848144555669;5354.223637572608;4208.5581013994315;4482.641388688962;5094.083065048327;5347.465253474621;5431.4296998816135;4383.342498625232;4944.406671199479;5243.764030618708;5273.6572122811895;5294.364676238876 16:10:04 INFO - PROCESS | 2005 | |5;yui.html;702.4029574861368;760.9992859389902;773.416070866496;805.7341077444444;853.5561508015834;14726.484573039947;14861.182634955074;15341.693166136685;15348.232588370593;15891.44379946702;14021.859781402183;14349.928250358733;14372.856271437282;14374.20941848198;14379.496717614886;676.607567610787;698.7624207769358;831.9792005199873;857.6697971281039;859.8194379180379;552.9695866727328;825.3562221467265;853.7908212487918;865.273170536749;868.0581568997645;919.3794188922484;923.2291036984126;923.7644400677817;923.8429466990627;925.5372313843078;709.1313141401793;909.0682050897816;909.7134402663206;914.5975770660955;915.9358844880861;541.0909671751456;632.996835015822;656.7471523463453;662.0863208771912;662.7580932959484;13025.348732563429;14846.1834599097;14846.851531484763;14864.777028344584;14889.957702960797;13069.738605227938;13398.263095529743;13503.324833758372;13584.592462226148;13905.235212063333;10567.395377888819;12038.398080096047;12211.755764884652;12221.93889030558;12351.073669474825;4414.6688998324935;4416.138852923681;4511.6165125964335;4631.16639004979;4634.467036290802;110950;111370.44314778375;113234;114571;117532;10607.15142788575;10710.357378557312;10815.134789216843;10930.781384372269;11185.66443006711;20754.688679669816;20778.48053798637;20799.376018719464;20815.37553873386;20832.895835520725;7603.809904752315;7824.295813376823;7906.644201010969;7994.480358776777;8008.27925486709;4117.958820411817;4144.191882582928;4242.215190189825;4286.914261714748;4368.4102646143;3320.9335813284083;3424.828758562062;3428.297199074184;3428.8628454862023;3438.209211881281;627.078195053271;642.5823214910253;656.1207981305074;659.7794080950204;661.7088481068314;479.44863407082136;507.307525228061;516.4886762105564;534.5376249544116;661.4840424468922;8130.878036829452;8780.78048048791;8787.105359856258;9458.290628202774;9477.194438472807;491.62300278154805;582.6911736779514;612.595686846688;626.7148447456397;669.1735706402588;4162.396452514368;4347.456567929009;4648.372469716613;4685.742284174403;4726.361941137971;124593.37703311606;138328;149232.82288182605;150779;152495;127639;128914;130164;131898.02152967712;136154.3192284052;113350.86649133403;115058;115156.42421788172;115522.42238788921;117951;8798;8825.205731484197;8920.840290762158;8991.23574496149;9021.909780902108;62285;62534;63975.720485589096;64556.35443645503;65789.67105164443;81510.14714484964;85619;86370;91416;91955.08044919465;11383.943080284545;11492.540298388305;11523.871160451967;11634.12744044217;11805.173637845268;12745.362731863555;12774.552890648783;12797.680057998625;12877.420516076612;13467.393967271692;11847.466863990969;11960.820587691018;11976.940115299367;12098.576549820715;12280.692982675504;11908.16642835028;11926.395737235758;12002.75994480088;12028.27830330183;12385.752284954431;11901.702457438634;12003.699907502032;12235.816462753244;12407.813882791947;12507.74984500323;8999.145081217273;9243.701673729987;9327.880654321525;9495.810083798424;10017.949910250401;9462;9834.213262938805;9943.453110078726;9966.950165249127;10237.84643230367 16:10:04 INFO - PROCESS | 2005 | __end_tp_report 16:10:04 INFO - PROCESS | 2005 | __start_cc_report 16:10:04 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,1805 16:10:04 INFO - PROCESS | 2005 | __end_cc_report 16:10:04 INFO - PROCESS | 2005 | __startTimestamp1475795404820__endTimestamp 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | ------- Summary: start ------- 16:10:04 INFO - PROCESS | 2005 | Number of tests: 6 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | [#0] dojo.html Cycles:165 Average:5709.79 Median:5887.06 stddev:640.12 (10.9%) stddev-sans-first:613.54 16:10:04 INFO - PROCESS | 2005 | Values: 3300.3 3306.5 3314.4 3351.5 3372.5 5565.0 5637.2 5658.1 5717.1 5725.7 5612.1 5653.3 5719.4 5733.2 5758.5 5061.1 5061.3 5108.8 5127.4 5182.1 5258.3 5260.9 5270.0 5281.3 5326.0 5228.3 5251.7 5257.6 5276.8 5330.7 5047.4 5112.8 5115.8 5125.4 5176.7 5126.5 5128.6 5148.2 5148.7 5154.0 5674.7 5700.9 5721.5 5770.8 5793.9 6085.6 6105.8 6121.8 6200.3 6260.5 6145.4 6154.9 6183.2 6268.3 6270.3 5756.1 5760.3 5769.2 5772.6 5812.5 5346.3 6211.6 6216.3 6277.7 6288.9 6008.0 6059.9 6102.0 6122.1 6157.1 6256.5 6258.8 6263.7 6278.4 6279.5 6008.5 6159.5 6216.8 6219.5 6231.3 6135.8 6152.6 6159.2 6161.9 6165.5 4905.4 4907.4 4921.0 4921.5 4939.2 4368.2 4387.5 4401.7 4426.0 4452.8 5670.2 5754.6 5756.6 5761.9 5779.6 6250.9 6287.4 6289.6 6293.0 6315.8 5586.0 5625.7 5641.8 5651.2 5813.8 5325.9 5375.9 5384.8 5395.3 5446.2 6304.5 6323.9 6327.4 6334.4 6335.7 6097.9 6155.4 6167.6 6188.2 6237.5 6289.7 6299.1 6300.8 6312.7 6318.7 6165.5 6195.8 6199.4 6207.2 6223.8 5953.2 6136.1 6192.6 6266.6 6281.1 4842.6 5973.0 6017.4 6022.8 6037.3 6007.4 6019.7 6027.5 6051.5 6140.8 5873.9 5916.5 5920.8 5928.0 5934.3 6098.7 6111.4 6120.4 6121.8 6132.6 5621.6 5667.6 5859.4 5871.2 5887.1 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | [#1] ext.html Cycles:180 Average:71572.01 Median:40913.19 stddev:156148.87 (381.7%) stddev-sans-first:156495.74 16:10:04 INFO - PROCESS | 2005 | Values: 505.8 516.7 518.7 525.5 541.4 30677.4 40778.8 42239.4 42253.4 42272.9 42836.8 43179.4 43242.8 43243.0 43266.6 9681.7 9880.6 9883.3 9889.8 9897.7 9658.0 9762.0 9771.3 9773.4 9799.9 9758.4 9833.3 9836.7 9846.6 9849.6 9677.6 9735.1 9743.7 9748.6 9775.0 9840.3 9889.4 9907.3 9915.3 9934.3 41070.8 41518.8 41523.0 41539.8 41542.4 3205.5 3211.3 3354.5 3487.2 3658.6 31086.2 31260.5 31391.4 31765.5 31908.0 3096.0 3254.9 3259.6 3260.7 3369.9 507505.5 509119.0 511995.0 512264.0 512772.0 52288.0 63766.0 63858.0 63945.4 64016.0 34901.7 35417.8 35701.8 36392.0 66356.0 16471.3 16596.4 16630.3 16642.4 16648.8 12658.3 12775.0 12779.7 12798.9 12807.9 19199.5 19213.0 19217.9 19237.2 19240.5 7046.8 7619.8 7799.5 7865.8 7936.8 836.6 1015.8 1020.4 1049.3 1057.0 30016.5 30056.5 30599.4 30876.0 30948.7 1005.7 1028.7 1069.4 1079.2 1112.8 13975.4 15313.7 15667.9 15757.4 15807.1 635593.0 649534.0 650713.7 652726.0 654515.0 58116.0 58708.8 58777.7 58811.0 58840.0 1220.6 1240.6 1323.6 1357.4 1366.3 28545.7 30414.1 31410.5 31865.2 32465.0 55727.0 55793.2 55825.2 55879.4 55998.7 572446.0 586302.0 589422.0 589845.0 591951.0 35381.5 35542.0 42292.8 42591.6 42832.5 47235.0 47561.0 47847.0 47988.0 48753.5 39328.0 39359.0 39365.8 40665.4 41047.6 39093.8 39187.8 39273.4 40610.8 40616.8 37771.0 38531.0 38737.4 38939.6 38997.0 30699.4 34034.5 34364.0 34489.7 34638.8 25175.7 25546.4 25565.4 25659.1 26077.2 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | [#2] jquery.html Cycles:180 Average:33387.07 Median:21778.62 stddev:90003.70 (413.3%) stddev-sans-first:90222.02 16:10:04 INFO - PROCESS | 2005 | Values: 359.1 364.5 370.2 384.3 393.8 19801.8 20175.2 21082.8 21106.9 21282.9 11931.5 12357.3 12381.4 12389.3 16514.4 5263.7 5626.4 5626.9 5627.2 5633.0 3946.4 4120.1 4219.9 4261.6 5480.8 7075.0 7090.6 7098.0 7107.6 7117.5 6249.4 6250.1 6304.3 6314.5 7060.9 5047.5 6135.2 6152.4 6152.8 6162.6 12691.7 13143.6 13319.9 13353.7 13367.2 2001.5 2059.2 2087.3 2254.7 2309.4 10382.3 11141.5 12692.9 15310.0 16266.8 1845.9 1858.3 1860.6 1866.1 1918.9 98432.0 123315.8 127460.4 131249.0 138482.3 10513.5 11221.6 11698.6 11884.9 12168.1 14717.4 14742.2 14759.3 14762.0 14799.1 8312.3 8618.4 8624.7 8774.6 8776.5 7937.4 8499.6 8522.7 8523.6 8697.7 4474.3 4564.3 4570.7 4637.3 4653.8 1752.8 1836.5 1865.9 1924.4 1930.6 791.5 840.7 897.2 916.4 949.1 19960.6 21737.2 21741.8 21755.2 21802.0 906.5 919.4 922.5 948.4 1011.4 10379.9 11409.8 11415.9 11443.0 11465.6 485847.0 493560.0 494496.0 566928.0 600111.0 129872.1 143001.0 144929.0 148126.0 148943.5 910.7 940.3 949.7 954.9 992.9 18363.5 19149.8 19178.3 19238.4 19241.7 54797.7 55510.0 55694.9 57024.4 57388.7 61268.1 82568.0 84770.2 84906.0 85430.6 7912.7 8070.4 8165.1 8289.1 8328.8 12546.0 12873.4 13005.9 13199.7 13408.5 10818.0 10852.3 10945.5 11102.5 11179.4 10151.2 11032.9 11068.2 11232.5 11256.3 11321.3 11323.3 11526.9 11545.8 11554.7 7946.8 8012.5 8177.1 8239.4 8367.2 8303.4 10440.8 10749.9 10791.7 11171.0 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | [#3] mootools.html Cycles:180 Average:5721.08 Median:4771.92 stddev:3248.55 (68.1%) stddev-sans-first:3241.38 16:10:04 INFO - PROCESS | 2005 | Values: 1392.7 1500.8 1655.2 1842.3 1859.3 8374.5 8886.6 8909.5 8914.6 8915.1 7874.4 8132.9 8434.8 8695.0 8710.9 2334.3 2357.5 2358.8 2359.3 2363.3 2314.7 2331.2 2356.5 2359.2 2364.2 2331.5 2352.3 2352.8 2354.9 2369.5 2311.0 2319.5 2328.4 2330.8 2345.8 2315.4 2323.6 2324.3 2329.3 2333.8 8550.4 8600.3 8657.0 8664.7 8676.6 5023.5 5162.3 5173.3 5335.7 5337.8 3507.0 3595.3 3675.5 3690.9 3723.0 1047.8 1070.4 1085.7 1103.7 1107.6 11762.1 11862.3 11877.2 11878.3 11881.3 4498.5 4645.0 4706.6 4768.5 4775.3 9949.6 9958.2 9958.3 9967.4 9971.7 5268.2 5282.2 5290.1 5292.0 5295.5 4355.0 4446.8 4550.5 4843.5 4849.2 3830.2 3849.4 3958.7 3975.6 3989.4 1198.7 1214.5 1217.6 1254.2 1282.7 804.4 846.4 890.4 900.1 922.9 5866.1 5915.7 5932.4 6047.5 6072.6 862.0 887.5 900.9 937.1 981.8 3625.3 3841.3 3877.0 3915.6 4006.3 10603.4 10880.8 10957.6 10979.7 11006.9 10924.6 10926.3 10926.5 10940.8 10950.8 7844.5 8218.6 8264.9 8275.5 8284.5 5812.7 5865.2 6028.3 6033.0 6049.1 9944.3 10080.1 10109.8 10113.9 10122.0 9620.9 10152.6 10236.6 10402.6 10463.9 7598.8 7800.6 8007.0 8027.7 8175.3 8289.3 8379.4 8463.4 8482.3 8499.7 7404.3 7511.2 7512.3 7532.5 7553.7 7313.9 7339.8 7353.3 7387.3 7446.4 6858.2 7026.5 7035.7 7042.3 7042.9 4043.9 4900.7 5023.2 5072.2 5125.6 4398.0 4431.8 4452.5 4524.1 4571.4 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | [#4] prototype.html Cycles:180 Average:4328.81 Median:4869.32 stddev:1346.37 (27.7%) stddev-sans-first:1314.95 16:10:04 INFO - PROCESS | 2005 | Values: 253.7 272.9 297.5 305.8 315.5 5233.7 5301.2 5307.9 5316.3 5332.9 5064.3 5159.9 5232.9 5267.6 5291.2 3341.4 3448.9 3568.1 3569.4 3726.4 3303.5 3958.1 3972.9 3995.8 4019.0 3429.5 3735.9 3899.1 3904.0 3947.6 3152.5 3515.6 3725.9 3959.0 3961.6 2745.4 2857.8 3406.5 3421.7 3426.3 3919.9 4425.4 4550.0 4933.0 4950.9 4325.9 4483.3 4490.7 4493.3 4511.0 4583.9 4586.2 4847.2 5361.3 5436.9 3033.2 3152.3 3732.4 3777.7 3816.8 5189.3 5231.9 5626.4 5653.7 5662.5 3575.9 3797.8 3831.5 3847.7 3886.9 3868.8 3888.3 3894.4 3899.6 3929.4 3971.7 4463.2 4465.0 4581.0 4585.8 4577.5 4625.6 5183.9 5444.9 5469.3 1153.4 1162.1 1283.8 1304.3 1314.4 733.8 775.6 790.5 806.2 818.6 4311.7 4647.8 4964.0 5029.2 5034.3 4955.7 5333.6 5601.5 5642.5 5663.8 4451.4 5106.4 5109.5 5142.2 5225.8 2701.8 2901.7 2926.9 2934.5 2940.7 5099.4 5120.9 5763.7 5789.1 5791.4 4775.9 5326.7 5676.8 5677.9 5752.9 5281.5 5575.6 5735.4 5741.1 5758.7 4891.4 5314.9 5490.8 5537.8 5563.9 4976.9 5212.9 5478.9 5510.0 5567.8 4819.4 5467.3 5768.8 5781.5 5806.3 3319.4 3407.5 3711.9 3727.5 3736.8 4488.7 5277.9 5340.0 5360.6 5552.2 4291.6 4966.9 5409.2 5434.8 5450.2 4827.9 5059.5 5265.4 5416.9 5439.1 4598.2 4630.9 5022.0 5061.8 5354.2 4208.6 4482.6 5094.1 5347.5 5431.4 4383.3 4944.4 5243.8 5273.7 5294.4 16:10:04 INFO - PROCESS | 2005 | 16:10:04 INFO - PROCESS | 2005 | [#5] yui.html Cycles:180 Average:24563.25 Median:4264.56 stddev:39799.34 (933.3%) stddev-sans-first:39870.67 16:10:04 INFO - PROCESS | 2005 | Values: 702.4 761.0 773.4 805.7 853.6 14726.5 14861.2 15341.7 15348.2 15891.4 14021.9 14349.9 14372.9 14374.2 14379.5 676.6 698.8 832.0 857.7 859.8 553.0 825.4 853.8 865.3 868.1 919.4 923.2 923.8 923.8 925.5 709.1 909.1 909.7 914.6 915.9 541.1 633.0 656.7 662.1 662.8 13025.3 14846.2 14846.9 14864.8 14890.0 13069.7 13398.3 13503.3 13584.6 13905.2 10567.4 12038.4 12211.8 12221.9 12351.1 4414.7 4416.1 4511.6 4631.2 4634.5 110950.0 111370.4 113234.0 114571.0 117532.0 10607.2 10710.4 10815.1 10930.8 11185.7 20754.7 20778.5 20799.4 20815.4 20832.9 7603.8 7824.3 7906.6 7994.5 8008.3 4118.0 4144.2 4242.2 4286.9 4368.4 3320.9 3424.8 3428.3 3428.9 3438.2 627.1 642.6 656.1 659.8 661.7 479.4 507.3 516.5 534.5 661.5 8130.9 8780.8 8787.1 9458.3 9477.2 491.6 582.7 612.6 626.7 669.2 4162.4 4347.5 4648.4 4685.7 4726.4 124593.4 138328.0 149232.8 150779.0 152495.0 127639.0 128914.0 130164.0 131898.0 136154.3 113350.9 115058.0 115156.4 115522.4 117951.0 8798.0 8825.2 8920.8 8991.2 9021.9 62285.0 62534.0 63975.7 64556.4 65789.7 81510.1 85619.0 86370.0 91416.0 91955.1 11383.9 11492.5 11523.9 11634.1 11805.2 12745.4 12774.6 12797.7 12877.4 13467.4 11847.5 11960.8 11976.9 12098.6 12280.7 11908.2 11926.4 12002.8 12028.3 12385.8 11901.7 12003.7 12235.8 12407.8 12507.7 8999.1 9243.7 9327.9 9495.8 10017.9 9462.0 9834.2 9943.5 9967.0 10237.8 16:10:04 INFO - PROCESS | 2005 | -------- Summary: end -------- 16:10:04 INFO - PROCESS | 2005 | 16:10:05 INFO - TEST-INFO | 2005: exit 0 16:10:05 INFO - TEST-OK | dromaeo_css | took 1119508ms 16:10:05 INFO - TEST-START | kraken 16:10:05 INFO - operating with platform_type : mac_ 16:10:05 INFO - Initialising browser for kraken test... 16:10:05 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmprotr5I/profile http://localhost:49405/getInfo.html) 16:10:07 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 16:10:07 INFO - PROCESS | 2008 | colorDepth:24 16:10:07 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 16:10:07 INFO - PROCESS | 2008 | __metrics 16:10:08 INFO - PROCESS | 2008 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:10:08 INFO - PROCESS | 2008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:10:08 INFO - TEST-INFO | 2008: exit 0 16:10:08 INFO - Browser initialized. 16:10:08 INFO - Running cycle 1/1 for kraken test... 16:10:08 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmprotr5I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:20 INFO - PROCESS | 2009 | RSS: Main: 235823104 16:10:20 INFO - PROCESS | 2009 | 16:10:23 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49405/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:24 INFO - PROCESS | 2009 | RSS: Main: 294809600 16:10:24 INFO - PROCESS | 2009 | 16:10:27 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49405/tests/kraken/driver.html?testName=audio-dft) 16:10:27 INFO - PROCESS | 2009 | RSS: Main: 293711872 16:10:27 INFO - PROCESS | 2009 | 16:10:31 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49405/tests/kraken/driver.html?testName=audio-fft) 16:10:31 INFO - PROCESS | 2009 | RSS: Main: 385220608 16:10:31 INFO - PROCESS | 2009 | 16:10:33 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49405/tests/kraken/driver.html?testName=audio-oscillator) 16:10:34 INFO - PROCESS | 2009 | RSS: Main: 290050048 16:10:34 INFO - PROCESS | 2009 | 16:10:36 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:36 INFO - PROCESS | 2009 | RSS: Main: 291815424 16:10:36 INFO - PROCESS | 2009 | 16:10:39 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49405/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:40 INFO - PROCESS | 2009 | RSS: Main: 329240576 16:10:40 INFO - PROCESS | 2009 | 16:10:43 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49405/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:43 INFO - PROCESS | 2009 | RSS: Main: 330551296 16:10:43 INFO - PROCESS | 2009 | 16:10:46 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49405/tests/kraken/driver.html?testName=json-parse-financial) 16:10:47 INFO - PROCESS | 2009 | RSS: Main: 330067968 16:10:47 INFO - PROCESS | 2009 | 16:10:48 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:49 INFO - PROCESS | 2009 | RSS: Main: 301006848 16:10:49 INFO - PROCESS | 2009 | 16:10:51 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:52 INFO - PROCESS | 2009 | RSS: Main: 304680960 16:10:52 INFO - PROCESS | 2009 | 16:10:54 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:55 INFO - PROCESS | 2009 | RSS: Main: 306995200 16:10:55 INFO - PROCESS | 2009 | 16:10:58 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:58 INFO - PROCESS | 2009 | RSS: Main: 327385088 16:10:58 INFO - PROCESS | 2009 | 16:11:01 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:02 INFO - PROCESS | 2009 | RSS: Main: 320528384 16:11:02 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49405/tests/kraken/driver.html?testName=ai-astar) 16:11:04 INFO - PROCESS | 2009 | RSS: Main: 364388352 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | __start_tp_report 16:11:04 INFO - PROCESS | 2009 | _x_x_mozilla_page_load 16:11:04 INFO - PROCESS | 2009 | _x_x_mozilla_page_load_details 16:11:04 INFO - PROCESS | 2009 | |i|pagename|runs| 16:11:04 INFO - PROCESS | 2009 | |0;ai-astar;113;111;113;117;112;113;113;114;113;113 16:11:04 INFO - PROCESS | 2009 | |1;audio-beat-detection;150;113;115;173;144;144;143;114;144;112 16:11:04 INFO - PROCESS | 2009 | |2;audio-dft;183;185;183;184;184;185;184;180;183;182 16:11:04 INFO - PROCESS | 2009 | |3;audio-fft;80;58;59;89;59;59;60;58;84;58 16:11:04 INFO - PROCESS | 2009 | |4;audio-oscillator;86;69;94;69;69;68;92;68;69;90 16:11:04 INFO - PROCESS | 2009 | |5;imaging-gaussian-blur;90;88;91;88;91;86;92;89;91;86 16:11:04 INFO - PROCESS | 2009 | |6;imaging-darkroom;151;98;99;99;98;98;98;99;104;98 16:11:04 INFO - PROCESS | 2009 | |7;imaging-desaturate;88;86;86;84;85;85;86;84;85;84 16:11:04 INFO - PROCESS | 2009 | |8;json-parse-financial;55;52;52;53;54;55;53;55;53;53 16:11:04 INFO - PROCESS | 2009 | |9;json-stringify-tinderbox;65;75;70;75;74;72;97;104;104;72 16:11:04 INFO - PROCESS | 2009 | |10;stanford-crypto-aes;88;84;78;97;106;94;85;83;87;89 16:11:04 INFO - PROCESS | 2009 | |11;stanford-crypto-ccm;151;156;153;166;144;179;183;150;192;164 16:11:04 INFO - PROCESS | 2009 | |12;stanford-crypto-pbkdf2;179;168;173;172;172;173;164;174;169;172 16:11:04 INFO - PROCESS | 2009 | |13;stanford-crypto-sha256-iterative;70;69;69;69;71;65;82;86;86;87 16:11:04 INFO - PROCESS | 2009 | __end_tp_report 16:11:04 INFO - PROCESS | 2009 | __start_cc_report 16:11:04 INFO - PROCESS | 2009 | _x_x_mozilla_cycle_collect,1974 16:11:04 INFO - PROCESS | 2009 | __end_cc_report 16:11:04 INFO - PROCESS | 2009 | __startTimestamp1475795464478__endTimestamp 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | ------- Summary: start ------- 16:11:04 INFO - PROCESS | 2009 | Number of tests: 14 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:1.55 (1.4%) stddev-sans-first:1.64 16:11:04 INFO - PROCESS | 2009 | Values: 113.0 111.0 113.0 117.0 112.0 113.0 113.0 114.0 113.0 113.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:144.00 stddev:20.63 (14.3%) stddev-sans-first:21.17 16:11:04 INFO - PROCESS | 2009 | Values: 150.0 113.0 115.0 173.0 144.0 144.0 143.0 114.0 144.0 112.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.49 (0.8%) stddev-sans-first:1.58 16:11:04 INFO - PROCESS | 2009 | Values: 183.0 185.0 183.0 184.0 184.0 185.0 184.0 180.0 183.0 182.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#3] audio-fft Cycles:10 Average:66.40 Median:59.50 stddev:12.57 (21.1%) stddev-sans-first:12.33 16:11:04 INFO - PROCESS | 2009 | Values: 80.0 58.0 59.0 89.0 59.0 59.0 60.0 58.0 84.0 58.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:77.50 stddev:11.45 (14.8%) stddev-sans-first:11.72 16:11:04 INFO - PROCESS | 2009 | Values: 86.0 69.0 94.0 69.0 69.0 68.0 92.0 68.0 69.0 90.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:90.50 stddev:2.15 (2.4%) stddev-sans-first:2.26 16:11:04 INFO - PROCESS | 2009 | Values: 90.0 88.0 91.0 88.0 91.0 86.0 92.0 89.0 91.0 86.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:98.00 stddev:16.54 (16.9%) stddev-sans-first:1.94 16:11:04 INFO - PROCESS | 2009 | Values: 151.0 98.0 99.0 99.0 98.0 98.0 98.0 99.0 104.0 98.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:0.87 16:11:04 INFO - PROCESS | 2009 | Values: 88.0 86.0 86.0 84.0 85.0 85.0 86.0 84.0 85.0 84.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:1.18 (2.2%) stddev-sans-first:1.12 16:11:04 INFO - PROCESS | 2009 | Values: 55.0 52.0 52.0 53.0 54.0 55.0 53.0 55.0 53.0 53.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#9] json-stringify-tinderbox Cycles:10 Average:80.80 Median:73.00 stddev:14.81 (20.3%) stddev-sans-first:14.56 16:11:04 INFO - PROCESS | 2009 | Values: 65.0 75.0 70.0 75.0 74.0 72.0 97.0 104.0 104.0 72.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:87.50 stddev:8.03 (9.2%) stddev-sans-first:8.51 16:11:04 INFO - PROCESS | 2009 | Values: 88.0 84.0 78.0 97.0 106.0 94.0 85.0 83.0 87.0 89.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#11] stanford-crypto-ccm Cycles:10 Average:163.80 Median:165.00 stddev:16.07 (9.7%) stddev-sans-first:16.36 16:11:04 INFO - PROCESS | 2009 | Values: 151.0 156.0 153.0 166.0 144.0 179.0 183.0 150.0 192.0 164.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.50 stddev:3.98 (2.3%) stddev-sans-first:3.19 16:11:04 INFO - PROCESS | 2009 | Values: 179.0 168.0 173.0 172.0 172.0 173.0 164.0 174.0 169.0 172.0 16:11:04 INFO - PROCESS | 2009 | 16:11:04 INFO - PROCESS | 2009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:76.50 stddev:8.71 (11.4%) stddev-sans-first:9.01 16:11:04 INFO - PROCESS | 2009 | Values: 70.0 69.0 69.0 69.0 71.0 65.0 82.0 86.0 86.0 87.0 16:11:04 INFO - PROCESS | 2009 | -------- Summary: end -------- 16:11:04 INFO - PROCESS | 2009 | 16:11:05 INFO - TEST-INFO | 2009: exit 0 16:11:05 INFO - TEST-OK | kraken | took 59939ms 16:11:05 INFO - SUITE-END | took 1179s 16:11:05 INFO - Completed test suite (00:19:39) 16:11:05 INFO - javascript benchmark 16:11:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.306935543536, 3306.5205545195945, 3314.38683843489, 3351.46376579747, 3372.5278461015464, 5565.0, 5637.182608521762, 5658.122990936401, 5717.056685646869, 5725.685087320196, 5612.102063669814, 5653.265075540174, 5719.428057194278, 5733.226014488053, 5758.5393168546525, 5061.063703214899, 5061.316722242505, 5108.770105345268, 5127.435982041972, 5182.093133701606, 5258.290130832346, 5260.8684782880355, 5270.0, 5281.339832520935, 5326.014687282865, 5228.346456692913, 5251.737413129366, 5257.605679574047, 5276.762545685453, 5330.680159190441, 5047.4447810740785, 5112.821051263188, 5115.8209462669, 5125.410577783566, 5176.715280659562, 5126.538611524943, 5128.615353848476, 5148.227765835118, 5148.691078535262, 5154.046501397253, 5674.687892165929, 5700.914486282668, 5721.456461636138, 5770.826875193751, 5793.913091303634, 6085.6348619083, 6105.793350785086, 6121.81881567809, 6200.348963358828, 6260.530460215502, 6145.402195429176, 6154.892119418503, 6183.227096612924, 6268.279147898004, 6270.31026587075, 5756.050251708505, 5760.337561180434, 5769.221155144001, 5772.595918285764, 5812.476877081083, 5346.251524786533, 6211.596246243979, 6216.2540495139965, 6277.7175027123885, 6288.937110628926, 6008.008678568075, 6059.939400605937, 6102.024902777868, 6122.081687746784, 6157.107219453154, 6256.499480041586, 6258.843528911722, 6263.686815659199, 6278.4035516625845, 6279.497640188774, 6008.549358798107, 6159.538034647419, 6216.844578885564, 6219.47134493564, 6231.283402408691, 6135.846603834851, 6152.569320147636, 6159.168512250879, 6161.907571386433, 6165.506759459233, 4905.362302900671, 4907.435644900882, 4921.0157968406465, 4921.4832442593015, 4939.234418665113, 4368.191884501377, 4387.495438024668, 4401.713888597231, 4425.955740442554, 4452.799624016862, 5670.234518340054, 5754.568407369464, 5756.597038207369, 5761.88476230473, 5779.566532509994, 6250.937490625036, 6287.434130928238, 6289.559730818799, 6292.96166132583, 6315.778947736807, 5585.972070139624, 5625.71871406428, 5641.830745077655, 5651.180578816131, 5813.82558523245, 5325.946740532545, 5375.865603359869, 5384.811531596453, 5395.271638328775, 5446.183072539151, 6304.464120549805, 6323.905141422974, 6327.367263273728, 6334.3665633436285, 6335.683215839097, 6097.887666312884, 6155.446009859134, 6167.5682702210415, 6188.195534580475, 6237.532185086227, 6289.654069026247, 6299.055141728777, 6300.779472718433, 6312.684365781784, 6318.747250109944, 6165.5375846810775, 6195.845103872439, 6199.411055949678, 6207.224096987877, 6223.782167624111, 5953.226080609493, 6136.140940268277, 6192.628442293477, 6266.592671476339, 6281.12064311006, 4842.58837998774, 5973.044312909914, 6017.398260174123, 6022.849428764316, 6037.275526936795, 6007.3992600739575, 6019.729112189874, 6027.547933904887, 6051.515878729603, 6140.815775526741, 5873.9412605873395, 5916.467517923407, 5920.763169473173, 5928.0, 5934.317553481233, 6098.664573448325, 6111.419415155553, 6120.387961203844, 6121.816345509642, 6132.5707200495535, 5621.606487545832, 5667.574931880208, 5859.355470898113, 5871.178035075008, 5887.0580707088375], "value": 5668.480916752745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.81537738725365, 516.7390467813754, 518.6810111781255, 525.5401523666792, 541.4125673644096, 30677.38645227094, 40778.796106019465, 42239.366409503884, 42253.36619950699, 42272.9431764206, 42836.78581607095, 43179.35230971538, 43242.783786081105, 43243.0, 43266.567334326646, 9681.70954871355, 9880.604775808995, 9883.258755593324, 9889.75275618108, 9897.653582124627, 9658.034196580356, 9761.97499262578, 9771.26715496337, 9773.41359518431, 9799.853002204973, 9758.365706229108, 9833.262505312094, 9836.655717049905, 9846.60613575456, 9849.60601575936, 9677.64512968185, 9735.123838854466, 9743.707688769347, 9748.610055597768, 9775.0, 9840.26198035143, 9889.406635601887, 9907.256955728277, 9915.256355773274, 9934.25493088014, 41070.79464602658, 41518.79240603778, 41523.0, 41539.75380738582, 41542.37686434706, 3205.4710972689477, 3211.277462570926, 3354.480055591387, 3487.1805125795418, 3658.615845336228, 31086.222844428845, 31260.531092033638, 31391.37217255665, 31765.46648100254, 31908.042758717274, 3096.0, 3254.886078987248, 3259.5762550868235, 3260.739140868725, 3369.9157521061925, 507505.46247268526, 509119.0, 511995.0, 512264.0, 512772.0, 52288.0, 63766.04350934739, 63858.0, 63945.36054639487, 64016.0, 34901.65098349035, 35417.82291088528, 35701.82149089238, 36392.0, 66356.0, 16471.34114635425, 16596.419125330554, 16630.251638676287, 16642.417515387144, 16648.833511664972, 12658.303793291274, 12775.0, 12779.744405111845, 12798.872011279955, 12807.871921280854, 19199.52001199981, 19213.0, 19217.903910480636, 19237.248736496247, 19240.518987025436, 7046.753363632351, 7619.847603047908, 7799.5320280783335, 7865.764027079083, 7936.801579960547, 836.573347592732, 1015.8425444056184, 1020.3622735790132, 1049.3284298049255, 1056.9788604227872, 30016.54975175374, 30056.54915176274, 30599.38801223963, 30876.0, 30948.690513095033, 1005.7133716890651, 1028.7325295423095, 1069.4332004037872, 1079.2121751121724, 1112.777444511101, 13975.440982360591, 15313.693726125415, 15667.921660391854, 15757.369705211662, 15807.063769169685, 635593.0, 649534.0, 650713.7464312648, 652726.0, 654515.0, 58116.0, 58708.82582348415, 58777.70611147003, 58811.0, 58840.0, 1220.560598184653, 1240.6154092231436, 1323.6492329532682, 1357.362039841273, 1366.269046060353, 28545.714542854304, 30414.087577372713, 31410.528842067844, 31865.203369915936, 32465.0, 55727.0, 55793.1631025543, 55825.16262255988, 55879.44120558905, 55998.72000639971, 572446.0, 586302.0, 589422.0, 589845.0, 591951.0, 35381.46927796137, 35542.0, 42292.78853605712, 42591.57408425876, 42832.500862469664, 47235.0, 47561.04877902492, 47847.0, 47988.0, 48753.5124648749, 39328.0, 39359.0, 39365.80317098396, 40665.39001915033, 41047.589524104376, 39093.80453097716, 39187.80406097951, 39273.410898837115, 40610.78167654975, 40616.796916016414, 37771.0, 38531.0, 38737.418938715375, 38939.6106038936, 38997.0, 30699.38601227918, 34034.489482657285, 34364.0, 34489.65510344865, 34638.82680586581, 25175.74824251734, 25546.361340966625, 25565.3608659785, 25659.098407366037, 26077.217683469527], "value": 20305.56709030794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.0914985087728, 364.51883513761845, 370.22068545711267, 384.3139995108728, 393.79916242716223, 19801.801981980178, 20175.19299228031, 21082.789172108274, 21106.894465527672, 21282.89358553209, 11931.463084161212, 12357.258564486137, 12381.38093095346, 12389.25664460133, 16514.42199523017, 5263.657862238952, 5626.381098079208, 5626.9437305626825, 5627.184058311543, 5632.957902787997, 3946.4474973503734, 4120.09357941254, 4219.936700949473, 4261.637760790321, 5480.7533660985355, 7075.009498670164, 7090.610016449094, 7098.0, 7107.5735455872555, 7117.537360071578, 6249.375062493759, 6250.093736408241, 6304.338044505307, 6314.463270622003, 7060.929390706078, 5047.520485553867, 6135.2024236849375, 6152.3847615238565, 6152.84617884552, 6162.630242185483, 12691.746165076647, 13143.60569182926, 13319.866801332057, 13353.666158346023, 13367.197968121944, 2001.539645881441, 2059.238081909703, 2087.3424871165535, 2254.6730724045087, 2309.353381053291, 10382.3251488653, 11141.498632561474, 12692.85764281219, 15310.0, 16266.75599866003, 1845.9446216613524, 1858.3031363238786, 1860.5534671678836, 1866.141574875559, 1918.9424317270505, 98432.0, 123315.76684233222, 127460.36269818684, 131249.0, 138482.30758846243, 10513.52689128991, 11221.60724374643, 11698.649040528799, 11884.940575297069, 12168.087393445527, 14717.411303547738, 14742.189179595225, 14759.262036898112, 14762.0, 14799.112053276838, 8312.293455056388, 8618.353623478264, 8624.741257762276, 8774.60514276859, 8776.517291549026, 7937.444378893422, 8499.61751721174, 8522.74431767048, 8523.55099633064, 8697.739067827975, 4474.306482495218, 4564.269716845355, 4570.7257564546235, 4637.281221410687, 4653.837115700934, 1752.808988764045, 1836.5344873090844, 1865.8507319414414, 1924.4130540185097, 1930.6331796958532, 791.4618059719446, 840.7351684219451, 897.2194191053825, 916.4318122763929, 949.0604301741226, 19960.60078798416, 21737.23919662804, 21741.78258217429, 21755.238566650092, 21802.0, 906.4923642760075, 919.4069824962861, 922.5064590444215, 948.4214629076258, 1011.3628414099071, 10379.896201038044, 11409.771804564029, 11415.942920285512, 11443.02481354837, 11465.598704045486, 485847.0, 493560.0, 494496.0, 566928.0, 600111.0, 129872.05191922128, 143001.0, 144929.0, 148126.0, 148943.46543337652, 910.7040211931148, 940.3088729783603, 949.6960972488737, 954.9045095490534, 992.8609994600906, 18363.54091147732, 19149.808501914802, 19178.328758493386, 19238.422847314603, 19241.711374329116, 54797.72601136969, 55510.0, 55694.88610227692, 57024.42975570191, 57388.71305643445, 61268.08097878446, 82568.0, 84770.15229847623, 84906.0, 85430.57284713537, 7912.723054693058, 8070.435069545076, 8165.101838797608, 8289.129641387808, 8328.791780205544, 12546.0, 12873.35633218354, 13005.869941300465, 13199.736005279648, 13408.463661453823, 10818.02637762605, 10852.348859068481, 10945.507452164831, 11102.500387482422, 11179.441027948733, 10151.238657100896, 11032.944835275772, 11068.169887258327, 11232.494537745984, 11256.324620522468, 11321.264117832314, 11323.32060076398, 11526.88473115258, 11545.82681259765, 11554.653360399201, 7946.7615971520945, 8012.479188852706, 8177.141400152898, 8239.423240373117, 8367.163283671583, 8303.377246706401, 10440.791184176425, 10749.89250107489, 10791.730206744895, 11170.994610485095], "value": 9356.395304148322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.7005693775839, 1500.849915008499, 1655.2137734576079, 1842.3459671816513, 1859.302761464451, 8374.455660382071, 8886.555672216387, 8909.509976951265, 8914.598843052063, 8915.108489151082, 7874.448788584801, 8132.91867081329, 8434.789130271747, 8694.956525217365, 8710.91289087109, 2334.2763743239566, 2357.481354102095, 2358.811295096388, 2359.2686267257204, 2363.3382652857226, 2314.745378008418, 2331.160782118436, 2356.493353928905, 2359.1742889988536, 2364.196173301077, 2331.5336932613545, 2352.2825538210923, 2352.752960939102, 2354.929352119439, 2369.537940101672, 2310.976890231093, 2319.4665226997718, 2328.4062564046058, 2330.813534917211, 2345.777151170636, 2315.444293369596, 2323.5585238804574, 2324.2562380038394, 2329.324495896188, 2333.8132949364012, 8550.358723095793, 8600.311975041981, 8657.0044444889, 8664.740057798275, 8676.60955257015, 5023.472535383768, 5162.3030890830005, 5173.301604283449, 5335.706536140511, 5337.786488540453, 3506.9824650876835, 3595.334863050344, 3675.4854320395166, 3690.8708195213308, 3722.981385093084, 1047.7956798424311, 1070.3791800755544, 1085.6580177244143, 1103.6688993302057, 1107.5625128074366, 11762.117841161948, 11862.28826270418, 11877.227980181175, 11878.287302761775, 11881.34652594107, 4498.482674492409, 4644.976775116171, 4706.552877476634, 4768.523147685204, 4775.307580400822, 9949.602015919281, 9958.153556947596, 9958.30291879576, 9967.40195588267, 9971.700848974542, 5268.2097685346735, 5282.234076059027, 5290.100682883919, 5292.0, 5295.4969277918535, 4354.9564504355185, 4446.822127114944, 4550.49944506104, 4843.539863712942, 4849.175640141114, 3830.2148059647707, 3849.4418309345547, 3958.7030972677167, 3975.6421922027157, 3989.401589761501, 1198.688341031338, 1214.5081242096965, 1217.6103646833105, 1254.1597129922973, 1282.69215388308, 804.412778671573, 846.386369881843, 890.3678388344218, 900.104396125859, 922.9030951750104, 5866.1494083357675, 5915.674637894871, 5932.406759324033, 6047.516198704093, 6072.605280656831, 861.9956900215459, 887.5163036145316, 900.8783814185132, 937.1237892570332, 981.7790997025612, 3625.3111908737255, 3841.3469710149343, 3876.9612303877166, 3915.569287378386, 4006.2988976928923, 10603.41681207541, 10880.836787448194, 10957.616483423202, 10979.670609881716, 11006.889931100746, 10924.563017479211, 10926.344419334866, 10926.508307126198, 10940.781184376427, 10950.780984380428, 7844.450888437868, 8218.589070546448, 8264.917350826536, 8275.50346979183, 8284.46151000183, 5812.651240925558, 5865.237519122486, 6028.33688294296, 6032.969835150796, 6049.062395328731, 9944.30389872702, 10080.143187829117, 10109.848352274576, 10113.898861011296, 10122.0, 9620.855687164558, 10152.644657436955, 10236.590536378462, 10402.635907743193, 10463.94768026155, 7598.772036838904, 7800.6099695016155, 8006.959965200137, 8027.678892844221, 8175.264226219669, 8289.33685305162, 8379.413441059067, 8463.407561470884, 8482.321414286718, 8499.702510412106, 7404.345184137423, 7511.211322811245, 7512.286332798375, 7532.472726909064, 7553.697852086075, 7313.853722925618, 7339.77980660581, 7353.338199562065, 7387.261273872569, 7446.404287657083, 6858.177018757581, 7026.508144430045, 7035.718571257297, 7042.260562640849, 7042.929570704227, 4043.8989025274605, 4900.69385077233, 5023.196288593807, 5072.163093089599, 5125.615578831528, 4398.032432864765, 4431.809097449831, 4452.532484089124, 4524.117797029548, 4571.405717256735], "value": 4576.413114825308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.7297777866572, 272.93827012919735, 297.4526870558173, 305.77678294844753, 315.54876526567, 5233.65981211221, 5301.17831736081, 5307.946920530793, 5316.3354580677415, 5332.933413317338, 5064.341635587369, 5159.896802063966, 5232.895342093166, 5267.55225805806, 5291.206319052144, 3341.365140623286, 3448.913777155566, 3568.1436455250814, 3569.3575156471825, 3726.4037753959374, 3303.537504749325, 3958.0896393829435, 3972.860949866755, 3995.781286707553, 4018.975161333856, 3429.537012503305, 3735.9439608405896, 3899.1032062625613, 3904.0, 3947.6447119759214, 3152.511360739089, 3515.5781306243157, 3725.869594564177, 3958.9802050989706, 3961.6434520893113, 2745.3685652300082, 2857.7570906472974, 3406.4890266459984, 3421.6920477157178, 3426.3489936911906, 3919.941200881989, 4425.380446737459, 4549.997001978678, 4932.950670493285, 4950.925736113961, 4325.891852703676, 4483.30508771141, 4490.663200259961, 4493.326001099828, 4510.977445112786, 4583.899864032608, 4586.165533786479, 4847.224444088964, 5361.276227709287, 5436.91844622331, 3033.1810411188853, 3152.338009018086, 3732.42147467143, 3777.660010599059, 3816.8473261069526, 5189.273501709764, 5231.947680523184, 5626.381098079208, 5653.717314134276, 5662.490375866192, 3575.8927232183078, 3797.7531460454984, 3831.4635950966886, 3847.7498962567342, 3886.9187353278944, 3868.845246190177, 3888.3280189518214, 3894.3768996960353, 3899.5515515715488, 3929.351656976567, 3971.72197946141, 4463.196624607537, 4464.986134359295, 4580.97709511457, 4585.816567337336, 4577.450705915311, 4625.5836974671765, 5183.922241166386, 5444.863878403072, 5469.343678758574, 1153.405995912089, 1162.0529268646026, 1283.794592865137, 1304.30871638032, 1314.3625341709264, 733.8238822682517, 775.6393277126164, 790.5138339921023, 806.1857523900902, 818.5702506184301, 4311.736338422291, 4647.814087436533, 4964.0, 5029.17018691919, 5034.295198672189, 4955.677880937799, 5333.599980001515, 5601.5238704710555, 5642.476531336516, 5663.830085097454, 4451.421315229064, 5106.391486681683, 5109.514596113363, 5142.228665700175, 5225.779043906401, 2701.8378897266225, 2901.6518017837993, 2926.941461170807, 2934.471795076907, 2940.6765255821842, 5099.36257967754, 5120.92318615221, 5763.682997435098, 5789.118536475662, 5791.362950075489, 4775.946343072512, 5326.707031113326, 5676.829695109153, 5677.858053548612, 5752.884942301131, 5281.521174071267, 5575.633969677455, 5735.369109397963, 5741.110127930177, 5758.654480731169, 4891.413030436228, 5314.893702125859, 5490.752916118864, 5537.750801214036, 5563.916541251965, 4976.875578110431, 5212.895742085061, 5478.863028424162, 5510.008198524304, 5567.832965011056, 4819.373481447389, 5467.289252397163, 5768.826935191951, 5781.537477001913, 5806.274215723035, 3319.435695931649, 3407.4718418645148, 3711.9049880284842, 3727.4595183698752, 3736.7668669339596, 4488.685791994529, 5277.868053298698, 5340.012097761926, 5360.597955153301, 5552.194931734956, 4291.570842915684, 4966.8758281043265, 5409.2427060212385, 5434.75543600531, 5450.184870590681, 4827.937853672186, 5059.46875578059, 5265.447128051499, 5416.891662166813, 5439.117267848047, 4598.218302888584, 4630.888586739091, 5022.0, 5061.848144555669, 5354.223637572608, 4208.5581013994315, 4482.641388688962, 5094.083065048327, 5347.465253474621, 5431.4296998816135, 4383.342498625232, 4944.406671199479, 5243.764030618708, 5273.6572122811895, 5294.364676238876], "value": 3894.5347146916897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.4029574861368, 760.9992859389902, 773.416070866496, 805.7341077444444, 853.5561508015834, 14726.484573039947, 14861.182634955074, 15341.693166136685, 15348.232588370593, 15891.44379946702, 14021.859781402183, 14349.928250358733, 14372.856271437282, 14374.20941848198, 14379.496717614886, 676.607567610787, 698.7624207769358, 831.9792005199873, 857.6697971281039, 859.8194379180379, 552.9695866727328, 825.3562221467265, 853.7908212487918, 865.273170536749, 868.0581568997645, 919.3794188922484, 923.2291036984126, 923.7644400677817, 923.8429466990627, 925.5372313843078, 709.1313141401793, 909.0682050897816, 909.7134402663206, 914.5975770660955, 915.9358844880861, 541.0909671751456, 632.996835015822, 656.7471523463453, 662.0863208771912, 662.7580932959484, 13025.348732563429, 14846.1834599097, 14846.851531484763, 14864.777028344584, 14889.957702960797, 13069.738605227938, 13398.263095529743, 13503.324833758372, 13584.592462226148, 13905.235212063333, 10567.395377888819, 12038.398080096047, 12211.755764884652, 12221.93889030558, 12351.073669474825, 4414.6688998324935, 4416.138852923681, 4511.6165125964335, 4631.16639004979, 4634.467036290802, 110950.0, 111370.44314778375, 113234.0, 114571.0, 117532.0, 10607.15142788575, 10710.357378557312, 10815.134789216843, 10930.781384372269, 11185.66443006711, 20754.688679669816, 20778.48053798637, 20799.376018719464, 20815.37553873386, 20832.895835520725, 7603.809904752315, 7824.295813376823, 7906.644201010969, 7994.480358776777, 8008.27925486709, 4117.958820411817, 4144.191882582928, 4242.215190189825, 4286.914261714748, 4368.4102646143, 3320.9335813284083, 3424.828758562062, 3428.297199074184, 3428.8628454862023, 3438.209211881281, 627.078195053271, 642.5823214910253, 656.1207981305074, 659.7794080950204, 661.7088481068314, 479.44863407082136, 507.307525228061, 516.4886762105564, 534.5376249544116, 661.4840424468922, 8130.878036829452, 8780.78048048791, 8787.105359856258, 9458.290628202774, 9477.194438472807, 491.62300278154805, 582.6911736779514, 612.595686846688, 626.7148447456397, 669.1735706402588, 4162.396452514368, 4347.456567929009, 4648.372469716613, 4685.742284174403, 4726.361941137971, 124593.37703311606, 138328.0, 149232.82288182605, 150779.0, 152495.0, 127639.0, 128914.0, 130164.0, 131898.02152967712, 136154.3192284052, 113350.86649133403, 115058.0, 115156.42421788172, 115522.42238788921, 117951.0, 8798.0, 8825.205731484197, 8920.840290762158, 8991.23574496149, 9021.909780902108, 62285.0, 62534.0, 63975.720485589096, 64556.35443645503, 65789.67105164443, 81510.14714484964, 85619.0, 86370.0, 91416.0, 91955.08044919465, 11383.943080284545, 11492.540298388305, 11523.871160451967, 11634.12744044217, 11805.173637845268, 12745.362731863555, 12774.552890648783, 12797.680057998625, 12877.420516076612, 13467.393967271692, 11847.466863990969, 11960.820587691018, 11976.940115299367, 12098.576549820715, 12280.692982675504, 11908.16642835028, 11926.395737235758, 12002.75994480088, 12028.27830330183, 12385.752284954431, 11901.702457438634, 12003.699907502032, 12235.816462753244, 12407.813882791947, 12507.74984500323, 8999.145081217273, 9243.701673729987, 9327.880654321525, 9495.810083798424, 10017.949910250401, 9462.0, 9834.213262938805, 9943.453110078726, 9966.950165249127, 10237.84643230367], "value": 7531.709901749858, "unit": "score"}], "name": "dromaeo_css", "value": 7244.675318996964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 117.0, 112.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 115.0, 173.0, 144.0, 144.0, 143.0, 114.0, 144.0, 112.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 183.0, 184.0, 184.0, 185.0, 184.0, 180.0, 183.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 89.0, 59.0, 59.0, 60.0, 58.0, 84.0, 58.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 94.0, 69.0, 69.0, 68.0, 92.0, 68.0, 69.0, 90.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 88.0, 91.0, 86.0, 92.0, 89.0, 91.0, 86.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 98.0, 99.0, 99.0, 98.0, 98.0, 98.0, 99.0, 104.0, 98.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 84.0, 85.0, 85.0, 86.0, 84.0, 85.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 53.0, 54.0, 55.0, 53.0, 55.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 70.0, 75.0, 74.0, 72.0, 97.0, 104.0, 104.0, 72.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 78.0, 97.0, 106.0, 94.0, 85.0, 83.0, 87.0, 89.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 156.0, 153.0, 166.0, 144.0, 179.0, 183.0, 150.0, 192.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 168.0, 173.0, 172.0, 172.0, 173.0, 164.0, 174.0, 169.0, 172.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 71.0, 65.0, 82.0, 86.0, 86.0, 87.0], "value": 75.4, "unit": "score"}], "name": "kraken", "value": 1488.3999999999999, "alertThreshold": 2.0}]} 16:11:05 INFO - Return code: 0 16:11:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:11:05 INFO - # TBPL SUCCESS # 16:11:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:11:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:11:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:11:05 INFO - 2016-10-06 16:11:05.762 screenresolution[2013:13371] starting screenresolution argv=screenresolution get 16:11:05 INFO - 2016-10-06 16:11:05.765 screenresolution[2013:13371] Display 0: 1600x1200x32@60 16:11:05 INFO - 2016-10-06 16:11:05.772 screenresolution[2014:13374] starting screenresolution argv=screenresolution list 16:11:05 INFO - Available Modes on Display 0 16:11:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:11:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:11:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:11:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:11:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:11:06 INFO - Intel Iris: 16:11:06 INFO - Chipset Model: Intel Iris 16:11:06 INFO - Type: GPU 16:11:06 INFO - Bus: Built-In 16:11:06 INFO - VRAM (Dynamic, Max): 1536 MB 16:11:06 INFO - Vendor: Intel (0x8086) 16:11:06 INFO - Device ID: 0x0a2e 16:11:06 INFO - Revision ID: 0x0009 16:11:06 INFO - Displays: 16:11:06 INFO - Display: 16:11:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:11:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:11:06 INFO - Display Serial Number: 1600x1200 60 16:11:06 INFO - Main Display: Yes 16:11:06 INFO - Mirror: Off 16:11:06 INFO - Online: Yes 16:11:06 INFO - Rotation: Supported 16:11:06 INFO - Return code: 0 16:11:06 INFO - Running post-action listener: _resource_record_post_action 16:11:06 INFO - [mozharness: 2016-10-06 23:11:06.012413Z] Finished run-tests step (success) 16:11:06 INFO - Running post-run listener: _resource_record_post_run 16:11:06 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 958464; Write bytes: 707140608; Read time: 8; Write time: 1943 16:11:06 INFO - TinderboxPrint: CPU usage
53.6% 16:11:06 INFO - TinderboxPrint: I/O read bytes / time
958,464 / 8 16:11:06 INFO - TinderboxPrint: I/O write bytes / time
707,140,608 / 1,943 16:11:06 INFO - TinderboxPrint: CPU idle
2,257.8 (46.4%) 16:11:06 INFO - TinderboxPrint: CPU system
977.0 (20.1%) 16:11:06 INFO - TinderboxPrint: CPU user
1,626.9 (33.5%) 16:11:06 INFO - TinderboxPrint: Swap in / out
408,657,920 / 0 16:11:06 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408453632; Write bytes: 410532864; Read time: 30697; Write time: 827 16:11:06 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 262144; Write bytes: 293255168; Read time: 5; Write time: 1097 16:11:06 INFO - Running post-run listener: _upload_blobber_files 16:11:06 INFO - Blob upload gear active. 16:11:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:06 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 16:11:06 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'] 16:11:06 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 16:11:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:07 INFO - (blobuploader) - INFO - Done attempting. 16:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:08 INFO - (blobuploader) - INFO - Done attempting. 16:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:10 INFO - (blobuploader) - INFO - Done attempting. 16:11:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:11 INFO - Return code: 0 16:11:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2181d39363e9dd958bd66721d92723eb1cf7839d05c7c134b000e9abb504c825656da9c9f2d9344b2e20d5f7c0a2ba40b747b0d48fc10cbbefe98e06b2866adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8afcaf45d4341df3f7f8d2c79e936342782df7409696d54f19e3e93023857f0a9e42840372784d2b2b0dedf6e4b4241653f26f3e88e69fae6d62fa83d4e48394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/404362691d0553c97add620f5371c7a2d24b2e605013e91ebca31046eb5774f37ce3ba4c38a6d8169fd8dc1a593488b8d97ccdc0ceba0f77b61c68a65ca2af0d"} 16:11:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:11 INFO - Contents: 16:11:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2181d39363e9dd958bd66721d92723eb1cf7839d05c7c134b000e9abb504c825656da9c9f2d9344b2e20d5f7c0a2ba40b747b0d48fc10cbbefe98e06b2866adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8afcaf45d4341df3f7f8d2c79e936342782df7409696d54f19e3e93023857f0a9e42840372784d2b2b0dedf6e4b4241653f26f3e88e69fae6d62fa83d4e48394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/404362691d0553c97add620f5371c7a2d24b2e605013e91ebca31046eb5774f37ce3ba4c38a6d8169fd8dc1a593488b8d97ccdc0ceba0f77b61c68a65ca2af0d"} 16:11:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:11 INFO - Copying logs to upload dir... 16:11:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.568527 ========= master_lag: 2.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-06 16:11:13.242750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 16:11:13.250399) ========= 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.44yqObOpU8/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.ie4eXlxV9b/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2181d39363e9dd958bd66721d92723eb1cf7839d05c7c134b000e9abb504c825656da9c9f2d9344b2e20d5f7c0a2ba40b747b0d48fc10cbbefe98e06b2866adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8afcaf45d4341df3f7f8d2c79e936342782df7409696d54f19e3e93023857f0a9e42840372784d2b2b0dedf6e4b4241653f26f3e88e69fae6d62fa83d4e48394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/404362691d0553c97add620f5371c7a2d24b2e605013e91ebca31046eb5774f37ce3ba4c38a6d8169fd8dc1a593488b8d97ccdc0ceba0f77b61c68a65ca2af0d"} build_url:https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/Z82gZ6SAQteOZqwEeO3k6g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2181d39363e9dd958bd66721d92723eb1cf7839d05c7c134b000e9abb504c825656da9c9f2d9344b2e20d5f7c0a2ba40b747b0d48fc10cbbefe98e06b2866adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8afcaf45d4341df3f7f8d2c79e936342782df7409696d54f19e3e93023857f0a9e42840372784d2b2b0dedf6e4b4241653f26f3e88e69fae6d62fa83d4e48394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/404362691d0553c97add620f5371c7a2d24b2e605013e91ebca31046eb5774f37ce3ba4c38a6d8169fd8dc1a593488b8d97ccdc0ceba0f77b61c68a65ca2af0d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 16:11:13.295104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 16:11:13.295472) ========= 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.44yqObOpU8/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.ie4eXlxV9b/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.005332 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 16:11:13.347352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 16:11:13.347703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 16:11:13.348056) ========= ========= Total master_lag: 2.37 =========