builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1476726651.71 results: success (0) buildid: 20161017084149 builduid: 26b4c0181b374403a111333dc2ece11b revision: 8168208334e580f36ab91072cf8faa72690bc9a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:51.713060) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:51.713753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:51.714091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:51.767077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:51.767458) ========= 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.wFZLgoSqOg/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.hBWdXigMyh/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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-17 10:50:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-10-17 10:50:52 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.494620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:52.285688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:52.286023) ========= 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.wFZLgoSqOg/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.hBWdXigMyh/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.019569 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:52.337308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 10:50:52.337769) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8168208334e580f36ab91072cf8faa72690bc9a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8168208334e580f36ab91072cf8faa72690bc9a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wFZLgoSqOg/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.hBWdXigMyh/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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-17 10:50:52,420 truncating revision to first 12 chars 2016-10-17 10:50:52,420 Setting DEBUG logging. 2016-10-17 10:50:52,421 attempt 1/10 2016-10-17 10:50:52,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8168208334e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 10:50:53,469 unpacking tar archive at: autoland-8168208334e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 10:50:53.691841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:53.692264) ========= script_repo_revision: 8168208334e580f36ab91072cf8faa72690bc9a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:53.692692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:53.693025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 10:50:53.712474) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-10-17 10:50:53.712902) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wFZLgoSqOg/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.hBWdXigMyh/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:50:53 INFO - MultiFileLogger online at 20161017 10:50:53 in /builds/slave/test 10:50:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:50:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:53 INFO - {'append_to_log': False, 10:50:53 INFO - 'base_work_dir': '/builds/slave/test', 10:50:53 INFO - 'blob_upload_branch': 'Autoland', 10:50:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:53 INFO - 'branch': 'Autoland', 10:50:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:53 INFO - 'config_files': ('talos/mac_config.py',), 10:50:53 INFO - 'default_actions': ('clobber', 10:50:53 INFO - 'read-buildbot-config', 10:50:53 INFO - 'download-and-extract', 10:50:53 INFO - 'populate-webroot', 10:50:53 INFO - 'create-virtualenv', 10:50:53 INFO - 'install', 10:50:53 INFO - 'run-tests'), 10:50:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:53 INFO - 'download_minidump_stackwalk': True, 10:50:53 INFO - 'download_symbols': 'ondemand', 10:50:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:53 INFO - 'installer_path': 'installer.exe', 10:50:53 INFO - 'log_level': 'info', 10:50:53 INFO - 'log_name': 'talos', 10:50:53 INFO - 'log_to_console': True, 10:50:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:50:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:50:53 INFO - 'opt_config_files': (), 10:50:53 INFO - 'pip_index': False, 10:50:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:53 INFO - 'cmd': ('bash', 10:50:53 INFO - '-c', 10:50:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:53 INFO - 'enabled': True, 10:50:53 INFO - 'halt_on_failure': False, 10:50:53 INFO - 'name': 'check_screen_resolution'},), 10:50:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:53 INFO - 'cmd': ('bash', 10:50:53 INFO - '-c', 10:50:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:53 INFO - 'enabled': True, 10:50:53 INFO - 'halt_on_failure': False, 10:50:53 INFO - 'name': 'check_screen_resolution'},), 10:50:53 INFO - 'run_cmd_checks_enabled': True, 10:50:53 INFO - 'sps_profile': False, 10:50:53 INFO - 'sps_profile_interval': 0, 10:50:53 INFO - 'suite': 'dromaeojs', 10:50:53 INFO - 'system_bits': '32', 10:50:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:53 INFO - 'title': 't-yosemite-r7-0060', 10:50:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:53 INFO - 'use_talos_json': True, 10:50:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:53 INFO - 'work_dir': 'build'} 10:50:53 INFO - [mozharness: 2016-10-17 17:50:53.912446Z] Running clobber step. 10:50:53 INFO - Running pre-action listener: _resource_record_pre_action 10:50:53 INFO - Running main action method: clobber 10:50:53 INFO - rmtree: /builds/slave/test/build 10:50:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - [mozharness: 2016-10-17 17:50:55.602933Z] Finished clobber step (success) 10:50:55 INFO - [mozharness: 2016-10-17 17:50:55.603055Z] Running read-buildbot-config step. 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: read_buildbot_config 10:50:55 INFO - Using buildbot properties: 10:50:55 INFO - { 10:50:55 INFO - "project": "", 10:50:55 INFO - "product": "firefox", 10:50:55 INFO - "script_repo_revision": "production", 10:50:55 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 10:50:55 INFO - "repository": "", 10:50:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 10:50:55 INFO - "buildid": "20161017084149", 10:50:55 INFO - "pgo_build": "False", 10:50:55 INFO - "basedir": "/builds/slave/test", 10:50:55 INFO - "buildnumber": 261, 10:50:55 INFO - "slavename": "t-yosemite-r7-0060", 10:50:55 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:50:55 INFO - "platform": "yosemite_r7", 10:50:55 INFO - "scheduler": "tests-autoland-macosx64-talos", 10:50:55 INFO - "branch": "autoland", 10:50:55 INFO - "repo_path": "integration/autoland", 10:50:55 INFO - "revision": "8168208334e580f36ab91072cf8faa72690bc9a0", 10:50:55 INFO - "stage_platform": "macosx64", 10:50:55 INFO - "builduid": "26b4c0181b374403a111333dc2ece11b", 10:50:55 INFO - "slavebuilddir": "test" 10:50:55 INFO - } 10:50:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - [mozharness: 2016-10-17 17:50:55.606353Z] Finished read-buildbot-config step (success) 10:50:55 INFO - [mozharness: 2016-10-17 17:50:55.606469Z] Running download-and-extract step. 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: download_and_extract 10:50:55 INFO - mkdir: /builds/slave/test/build/tests 10:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:55 INFO - trying https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:50:55 INFO - Downloading https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/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 10:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/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 10:50:56 INFO - Downloaded 1199 bytes. 10:50:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:50:56 INFO - Using the following test package requirements: 10:50:56 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:50:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:50:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:50:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'jsshell-mac.zip'], 10:50:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:50:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:50:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:50:56 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:50:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:50:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:50:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:50:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:50:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:50:56 INFO - Fetch https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:50:57 INFO - Http code: 200 10:50:57 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:50:57 INFO - x-amz-cf-id: yyNEVQvyPfMQsxgqO1PH-sA9YoaSXkRWwyj5f1gH53k_XO8g3VmbPg== 10:50:57 INFO - x-amz-version-id: .hPsfcsv637ywSEUfGeinLB4bVRD89EU 10:50:57 INFO - Expected file size: 16483385 10:50:57 INFO - Obtained file size: 16483385 10:51:04 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 10:51:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:51:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:51:04 INFO - Fetch https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:51:04 INFO - Http code: 200 10:51:04 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 10:51:04 INFO - x-amz-cf-id: fXwSAJSvqUYbMvttyC0jnQLfcQUTlQqkZgaG-kTt9fgPB1brauhv4A== 10:51:04 INFO - x-amz-version-id: .hPsfcsv637ywSEUfGeinLB4bVRD89EU 10:51:05 INFO - Expected file size: 16483385 10:51:05 INFO - Obtained file size: 16483385 10:51:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:51:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:51:11 INFO - Fetch https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:51:12 INFO - Http code: 200 10:51:12 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 10:51:12 INFO - x-amz-cf-id: tLBew-lqDiGDiAVYZ1EaFZa0PGDe_wew5udDEUlQptemaOXyP6L3dg== 10:51:12 INFO - x-amz-version-id: LAC3IgAfJukDgo.4PMYl2treCo1NICpO 10:51:13 INFO - Expected file size: 14409028 10:51:13 INFO - Obtained file size: 14409028 10:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:14 INFO - trying https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:51:14 INFO - Downloading https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/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 10:51:17 INFO - Downloaded 111678250 bytes. 10:51:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:51:17 INFO - mkdir: /builds/slave/test/properties 10:51:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:17 INFO - Contents: 10:51:17 INFO - build_url:https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:51:18 INFO - Running post-action listener: _resource_record_post_action 10:51:18 INFO - Running post-action listener: set_extra_try_arguments 10:51:18 INFO - [mozharness: 2016-10-17 17:51:18.839559Z] Finished download-and-extract step (success) 10:51:18 INFO - [mozharness: 2016-10-17 17:51:18.839697Z] Running populate-webroot step. 10:51:18 INFO - Running pre-action listener: _resource_record_pre_action 10:51:18 INFO - Running main action method: populate_webroot 10:51:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:18 INFO - '--tppagecycles', 10:51:18 INFO - '7'], 10:51:18 INFO - 'tests': ['tsvgm']}}, 10:51:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['damp', 'tps']}, 10:51:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'tests': ['damp', 'tps']}, 10:51:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['dromaeo_dom']}, 10:51:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['basic_compositor_video']}, 10:51:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['a11yr', 10:51:18 INFO - 'ts_paint', 10:51:18 INFO - 'tpaint', 10:51:18 INFO - 'sessionrestore', 10:51:18 INFO - 'sessionrestore_no_auto_restore', 10:51:18 INFO - 'tabpaint']}, 10:51:18 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:18 INFO - 'ts_paint', 10:51:18 INFO - 'tpaint', 10:51:18 INFO - 'sessionrestore', 10:51:18 INFO - 'sessionrestore_no_auto_restore', 10:51:18 INFO - 'tabpaint']}, 10:51:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:18 INFO - 'ts_paint', 10:51:18 INFO - 'tpaint', 10:51:18 INFO - 'sessionrestore', 10:51:18 INFO - 'sessionrestore_no_auto_restore', 10:51:18 INFO - 'tabpaint']}, 10:51:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:18 INFO - 'ts_paint', 10:51:18 INFO - 'tpaint', 10:51:18 INFO - 'sessionrestore', 10:51:18 INFO - 'sessionrestore_no_auto_restore', 10:51:18 INFO - 'tabpaint']}, 10:51:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['a11yr', 10:51:18 INFO - 'ts_paint', 10:51:18 INFO - 'tpaint', 10:51:18 INFO - 'sessionrestore', 10:51:18 INFO - 'sessionrestore_no_auto_restore', 10:51:18 INFO - 'tabpaint']}, 10:51:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['a11yr', 10:51:18 INFO - 'ts_paint', 10:51:18 INFO - 'tpaint', 10:51:18 INFO - 'sessionrestore', 10:51:18 INFO - 'sessionrestore_no_auto_restore', 10:51:18 INFO - 'tabpaint']}, 10:51:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['tsvgx', 10:51:18 INFO - 'tsvgr_opacity', 10:51:18 INFO - 'tart', 10:51:18 INFO - 'tscrollx', 10:51:18 INFO - 'cart']}, 10:51:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:18 INFO - 'tsvgr_opacity', 10:51:18 INFO - 'tart', 10:51:18 INFO - 'tscrollx', 10:51:18 INFO - 'cart']}, 10:51:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'talos_options': ['--disable-e10s'], 10:51:18 INFO - 'tests': ['tp5o']}, 10:51:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'tests': ['tp5o']}, 10:51:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'talos_options': ['--disable-e10s', 10:51:18 INFO - '--xperf_path', 10:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:18 INFO - 'tests': ['tp5n']}, 10:51:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:18 INFO - 'talos_options': ['--xperf_path', 10:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:18 INFO - 'tests': ['tp5n']}}, 10:51:18 INFO - 'talos.zip': {'path': '', 10:51:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:18 INFO - Running post-action listener: _resource_record_post_action 10:51:18 INFO - [mozharness: 2016-10-17 17:51:18.858466Z] Finished populate-webroot step (success) 10:51:18 INFO - [mozharness: 2016-10-17 17:51:18.858599Z] Running create-virtualenv step. 10:51:18 INFO - Running pre-action listener: _resource_record_pre_action 10:51:18 INFO - Running main action method: create_virtualenv 10:51:18 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:18 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 10:51:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:18 INFO - Using real prefix '/tools/python27' 10:51:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:19 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:22 INFO - Installing pip.................done. 10:51:22 INFO - Return code: 0 10:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:51:22 INFO - Reading from file tmpfile_stdout 10:51:22 INFO - Output received: 10:51: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) 10:51:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51: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 10:51: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 10:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:22 INFO - 'HOME': '/Users/cltbld', 10:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:22 INFO - 'LOGNAME': 'cltbld', 10:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:22 INFO - 'MOZ_NO_REMOTE': '1', 10:51:22 INFO - 'NO_EM_RESTART': '1', 10:51:22 INFO - 'PAGER': '/bin/cat', 10:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:22 INFO - 'PWD': '/builds/slave/test', 10:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:22 INFO - 'SHELL': '/bin/bash', 10:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:22 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:22 INFO - 'USER': 'cltbld', 10:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:22 INFO - 'XPC_FLAGS': '0x0', 10:51:22 INFO - 'XPC_SERVICE_NAME': '0', 10:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51: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 10:51:23 INFO - Cleaning up... 10:51:23 INFO - Return code: 0 10:51:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51: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 10:51: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 10:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:23 INFO - 'HOME': '/Users/cltbld', 10:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:23 INFO - 'LOGNAME': 'cltbld', 10:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:23 INFO - 'MOZ_NO_REMOTE': '1', 10:51:23 INFO - 'NO_EM_RESTART': '1', 10:51:23 INFO - 'PAGER': '/bin/cat', 10:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:23 INFO - 'PWD': '/builds/slave/test', 10:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:23 INFO - 'SHELL': '/bin/bash', 10:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:23 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:23 INFO - 'USER': 'cltbld', 10:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:23 INFO - 'XPC_FLAGS': '0x0', 10:51:23 INFO - 'XPC_SERVICE_NAME': '0', 10:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:23 INFO - Downloading/unpacking psutil>=3.1.1 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:27 INFO - Installing collected packages: psutil 10:51:27 INFO - Running setup.py install for psutil 10:51:28 INFO - building 'psutil._psutil_osx' extension 10:51:28 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 10:51:28 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 10:51:28 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 10:51:28 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 10:51:28 INFO - building 'psutil._psutil_posix' extension 10:51:28 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 10:51:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:51:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:51:28 INFO - ^ 10:51:28 INFO - 1 warning generated. 10:51:28 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 10:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:28 INFO - Successfully installed psutil 10:51:28 INFO - Cleaning up... 10:51:28 INFO - Return code: 0 10:51:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:28 INFO - 'HOME': '/Users/cltbld', 10:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:28 INFO - 'LOGNAME': 'cltbld', 10:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:28 INFO - 'MOZ_NO_REMOTE': '1', 10:51:28 INFO - 'NO_EM_RESTART': '1', 10:51:28 INFO - 'PAGER': '/bin/cat', 10:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:28 INFO - 'PWD': '/builds/slave/test', 10:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:28 INFO - 'SHELL': '/bin/bash', 10:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:28 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:28 INFO - 'USER': 'cltbld', 10:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:28 INFO - 'XPC_FLAGS': '0x0', 10:51:28 INFO - 'XPC_SERVICE_NAME': '0', 10:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51:29 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 10:51:29 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 10:51:29 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 10:51:29 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 10:51:29 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 10:51:29 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 10:51:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:31 INFO - Installing collected packages: mozsystemmonitor 10:51:31 INFO - Running setup.py install for mozsystemmonitor 10:51:31 INFO - Successfully installed mozsystemmonitor 10:51:31 INFO - Cleaning up... 10:51:31 INFO - Return code: 0 10:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:32 INFO - 'HOME': '/Users/cltbld', 10:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:32 INFO - 'LOGNAME': 'cltbld', 10:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:32 INFO - 'MOZ_NO_REMOTE': '1', 10:51:32 INFO - 'NO_EM_RESTART': '1', 10:51:32 INFO - 'PAGER': '/bin/cat', 10:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:32 INFO - 'PWD': '/builds/slave/test', 10:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:32 INFO - 'SHELL': '/bin/bash', 10:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:32 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:32 INFO - 'USER': 'cltbld', 10:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:32 INFO - 'XPC_FLAGS': '0x0', 10:51:32 INFO - 'XPC_SERVICE_NAME': '0', 10:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:32 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:35 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:35 INFO - warning: no files found matching '*.txt' 10:51:35 INFO - no previously-included directories found matching 'build' 10:51:35 INFO - no previously-included directories found matching 'dist' 10:51:35 INFO - no previously-included directories found matching '.git*' 10:51:35 INFO - Installing collected packages: jsonschema, functools32 10:51:35 INFO - Running setup.py install for functools32 10:51:35 INFO - warning: no files found matching '*.txt' 10:51:35 INFO - no previously-included directories found matching 'build' 10:51:35 INFO - no previously-included directories found matching 'dist' 10:51:35 INFO - no previously-included directories found matching '.git*' 10:51:35 INFO - Successfully installed jsonschema functools32 10:51:35 INFO - Cleaning up... 10:51:35 INFO - Return code: 0 10:51:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:35 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 10:51:35 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 10:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:35 INFO - 'HOME': '/Users/cltbld', 10:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:35 INFO - 'LOGNAME': 'cltbld', 10:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:35 INFO - 'MOZ_NO_REMOTE': '1', 10:51:35 INFO - 'NO_EM_RESTART': '1', 10:51:35 INFO - 'PAGER': '/bin/cat', 10:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:35 INFO - 'PWD': '/builds/slave/test', 10:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:35 INFO - 'SHELL': '/bin/bash', 10:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:35 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:35 INFO - 'USER': 'cltbld', 10:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:35 INFO - 'XPC_FLAGS': '0x0', 10:51:35 INFO - 'XPC_SERVICE_NAME': '0', 10:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:51:35 INFO - Cleaning up... 10:51:35 INFO - Return code: 0 10:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:35 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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:35 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 10:51:35 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 10:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:35 INFO - 'HOME': '/Users/cltbld', 10:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:35 INFO - 'LOGNAME': 'cltbld', 10:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:35 INFO - 'MOZ_NO_REMOTE': '1', 10:51:35 INFO - 'NO_EM_RESTART': '1', 10:51:35 INFO - 'PAGER': '/bin/cat', 10:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:35 INFO - 'PWD': '/builds/slave/test', 10:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:35 INFO - 'SHELL': '/bin/bash', 10:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:35 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:35 INFO - 'USER': 'cltbld', 10:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:35 INFO - 'XPC_FLAGS': '0x0', 10:51:35 INFO - 'XPC_SERVICE_NAME': '0', 10:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:36 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:36 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 10:51:36 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 10:51:36 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 10:51:36 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 10:51:36 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 10:51:36 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 10:51:38 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:39 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 10:51:39 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 10:51:39 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 10:51:39 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 10:51:39 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 10:51:39 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 10:51:39 INFO - Downloading docopt-0.6.1.tar.gz 10:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:39 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:39 INFO - Running setup.py install for blobuploader 10:51:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:40 INFO - Running setup.py install for requests 10:51:40 INFO - Running setup.py install for docopt 10:51:40 INFO - Successfully installed blobuploader requests docopt 10:51:40 INFO - Cleaning up... 10:51:40 INFO - Return code: 0 10:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:40 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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:40 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 10:51:40 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 10:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:40 INFO - 'HOME': '/Users/cltbld', 10:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:40 INFO - 'LOGNAME': 'cltbld', 10:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:40 INFO - 'MOZ_NO_REMOTE': '1', 10:51:40 INFO - 'NO_EM_RESTART': '1', 10:51:40 INFO - 'PAGER': '/bin/cat', 10:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:40 INFO - 'PWD': '/builds/slave/test', 10:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:40 INFO - 'SHELL': '/bin/bash', 10:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:40 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:40 INFO - 'USER': 'cltbld', 10:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:40 INFO - 'XPC_FLAGS': '0x0', 10:51:40 INFO - 'XPC_SERVICE_NAME': '0', 10:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-76p1zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-UYH58l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ZUZy1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Zk7LaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ad2paf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-L1NZxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Ovthvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-a8ZJHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-beZv_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:41 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-HpfZck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:42 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-y2EjKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:42 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-rkbwA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:42 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-F9_bHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:42 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-WvN1zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:42 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-quCAsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:42 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-oHQh0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:42 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-VpmWXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:42 INFO - Running setup.py install for manifestparser 10:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Running setup.py install for mozcrash 10:51:43 INFO - Running setup.py install for mozdebug 10:51:43 INFO - Running setup.py install for mozdevice 10:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Running setup.py install for mozfile 10:51:43 INFO - Running setup.py install for mozhttpd 10:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Running setup.py install for mozinfo 10:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Running setup.py install for mozInstall 10:51:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozleak 10:51:44 INFO - Running setup.py install for mozlog 10:51:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for moznetwork 10:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozprocess 10:51:44 INFO - Running setup.py install for mozprofile 10:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozrunner 10:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:45 INFO - Running setup.py install for mozscreenshot 10:51:45 INFO - Running setup.py install for moztest 10:51:45 INFO - Running setup.py install for mozversion 10:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:45 INFO - Cleaning up... 10:51:45 INFO - Return code: 0 10:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:45 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')]} 10:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:45 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')]} 10:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:45 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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:45 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 10:51:45 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 10:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:45 INFO - 'HOME': '/Users/cltbld', 10:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:45 INFO - 'LOGNAME': 'cltbld', 10:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:45 INFO - 'MOZ_NO_REMOTE': '1', 10:51:45 INFO - 'NO_EM_RESTART': '1', 10:51:45 INFO - 'PAGER': '/bin/cat', 10:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:45 INFO - 'PWD': '/builds/slave/test', 10:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:45 INFO - 'SHELL': '/bin/bash', 10:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:45 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:45 INFO - 'USER': 'cltbld', 10:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:45 INFO - 'XPC_FLAGS': '0x0', 10:51:45 INFO - 'XPC_SERVICE_NAME': '0', 10:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:45 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Ychd7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:45 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ZhJ8zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:45 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-DTyA_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-1BMmKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ZhadYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-5jmiO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-vEDklS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-PCrjub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-awmjsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-ZEQkNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-SwKi6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:46 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-eVeZf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:47 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)) 10:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-6JEtNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:47 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)) 10:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-tiYlAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:47 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)) 10:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-uQiY5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:47 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)) 10:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-Qp8YIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:47 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)) 10:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:47 INFO - Running setup.py (path:/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/pip-4a5vfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:47 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)) 10:51:47 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)) 10:51:47 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)) 10:51:47 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)) 10:51:47 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)) 10:51:47 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)) 10:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:50 INFO - Downloading blessings-1.6.tar.gz 10:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:50 INFO - Installing collected packages: blessings 10:51:50 INFO - Running setup.py install for blessings 10:51:50 INFO - Successfully installed blessings 10:51:50 INFO - Cleaning up... 10:51:50 INFO - Return code: 0 10:51:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:50 INFO - Reading from file tmpfile_stdout 10:51:50 INFO - Current package versions: 10:51:50 INFO - blessings == 1.6 10:51:50 INFO - blobuploader == 1.2.4 10:51:50 INFO - docopt == 0.6.1 10:51:50 INFO - functools32 == 3.2.3-2 10:51:50 INFO - jsonschema == 2.5.1 10:51:50 INFO - manifestparser == 1.1 10:51:50 INFO - mozInstall == 1.12 10:51:50 INFO - mozcrash == 0.17 10:51:50 INFO - mozdebug == 0.1 10:51:50 INFO - mozdevice == 0.48 10:51:50 INFO - mozfile == 1.2 10:51:50 INFO - mozhttpd == 0.7 10:51:50 INFO - mozinfo == 0.9 10:51:50 INFO - mozleak == 0.1 10:51:50 INFO - mozlog == 3.4 10:51:50 INFO - moznetwork == 0.27 10:51:50 INFO - mozprocess == 0.23 10:51:50 INFO - mozprofile == 0.28 10:51:50 INFO - mozrunner == 6.12 10:51:50 INFO - mozscreenshot == 0.1 10:51:50 INFO - mozsystemmonitor == 0.3 10:51:50 INFO - moztest == 0.7 10:51:50 INFO - mozversion == 1.4 10:51:50 INFO - psutil == 3.1.1 10:51:50 INFO - requests == 1.2.3 10:51:50 INFO - wsgiref == 0.1.2 10:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:50 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')]} 10:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:50 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')]} 10:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:50 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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:50 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 10:51:50 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 10:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:50 INFO - 'HOME': '/Users/cltbld', 10:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:50 INFO - 'LOGNAME': 'cltbld', 10:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:50 INFO - 'MOZ_NO_REMOTE': '1', 10:51:50 INFO - 'NO_EM_RESTART': '1', 10:51:50 INFO - 'PAGER': '/bin/cat', 10:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:50 INFO - 'PWD': '/builds/slave/test', 10:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:50 INFO - 'SHELL': '/bin/bash', 10:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:50 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:50 INFO - 'USER': 'cltbld', 10:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:50 INFO - 'XPC_FLAGS': '0x0', 10:51:50 INFO - 'XPC_SERVICE_NAME': '0', 10:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 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)) 10:51:51 INFO - Cleaning up... 10:51:51 INFO - Return code: 0 10:51:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:51 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')]} 10:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 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')]} 10:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:51 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 0x106028490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9452cf49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, '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.wFZLgoSqOg/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.hBWdXigMyh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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 10:51:51 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 10:51:51 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 10:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:51 INFO - 'HOME': '/Users/cltbld', 10:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:51 INFO - 'LOGNAME': 'cltbld', 10:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:51 INFO - 'MOZ_NO_REMOTE': '1', 10:51:51 INFO - 'NO_EM_RESTART': '1', 10:51:51 INFO - 'PAGER': '/bin/cat', 10:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:51 INFO - 'PWD': '/builds/slave/test', 10:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:51 INFO - 'SHELL': '/bin/bash', 10:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:51:51 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:51 INFO - 'USER': 'cltbld', 10:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:51 INFO - 'XPC_FLAGS': '0x0', 10:51:51 INFO - 'XPC_SERVICE_NAME': '0', 10:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:51 INFO - Cleaning up... 10:51:51 INFO - Return code: 0 10:51:51 INFO - Running post-action listener: _resource_record_post_action 10:51:51 INFO - Running post-action listener: _start_resource_monitoring 10:51:51 INFO - Starting resource monitoring. 10:51:51 INFO - [mozharness: 2016-10-17 17:51:51.351656Z] Finished create-virtualenv step (success) 10:51:51 INFO - [mozharness: 2016-10-17 17:51:51.352651Z] Running install step. 10:51:51 INFO - Running pre-action listener: _resource_record_pre_action 10:51:51 INFO - Running main action method: install 10:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:51 INFO - Reading from file tmpfile_stdout 10:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:51 INFO - Reading from file tmpfile_stdout 10:51:51 INFO - Output received: 10:51:51 INFO - Usage: mozinstall [options] installer 10:51:51 INFO - Options: 10:51:51 INFO - -h, --help show this help message and exit 10:51:51 INFO - -d DEST, --destination=DEST 10:51:51 INFO - Directory to install application into. [default: 10:51:51 INFO - "/builds/slave/test"] 10:51:51 INFO - --app=APP Application being installed. [default: firefox] 10:51:51 INFO - mkdir: /builds/slave/test/build/application 10:51:51 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'] 10:51:51 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 10:52:27 INFO - Reading from file tmpfile_stdout 10:52:27 INFO - Output received: 10:52:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:52:27 INFO - Running post-action listener: _resource_record_post_action 10:52:27 INFO - [mozharness: 2016-10-17 17:52:27.039820Z] Finished install step (success) 10:52:27 INFO - [mozharness: 2016-10-17 17:52:27.040000Z] Running run-tests step. 10:52:27 INFO - Running pre-action listener: _resource_record_pre_action 10:52:27 INFO - Running main action method: run_tests 10:52:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:52:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:52:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:52:27 INFO - 2016-10-17 10:52:27.054 screenresolution[1931:18862] starting screenresolution argv=screenresolution get 10:52:27 INFO - 2016-10-17 10:52:27.057 screenresolution[1931:18862] Display 0: 1600x1200x32@60 10:52:27 INFO - 2016-10-17 10:52:27.063 screenresolution[1932:18865] starting screenresolution argv=screenresolution list 10:52:27 INFO - Available Modes on Display 0 10:52:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:52:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:52:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:52:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:52:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:52:27 INFO - Intel Iris: 10:52:27 INFO - Chipset Model: Intel Iris 10:52:27 INFO - Type: GPU 10:52:27 INFO - Bus: Built-In 10:52:27 INFO - VRAM (Dynamic, Max): 1536 MB 10:52:27 INFO - Vendor: Intel (0x8086) 10:52:27 INFO - Device ID: 0x0a2e 10:52:27 INFO - Revision ID: 0x0009 10:52:27 INFO - Displays: 10:52:27 INFO - Display: 10:52:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:52:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:52:27 INFO - Display Serial Number: 1600x1200 60 10:52:27 INFO - Main Display: Yes 10:52:27 INFO - Mirror: Off 10:52:27 INFO - Online: Yes 10:52:27 INFO - Rotation: Supported 10:52:27 INFO - Return code: 0 10:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:27 INFO - Python 2.7.3 10:52:27 INFO - Return code: 0 10:52:27 INFO - grabbing minidump binary from tooltool 10:52: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')]} 10:52:27 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 0x105e3cd30>, '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 0x105c62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:27 INFO - Return code: 0 10:52:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:52:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:52:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 10:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --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 10:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFZLgoSqOg/Render', 10:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:27 INFO - 'HOME': '/Users/cltbld', 10:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:27 INFO - 'LOGNAME': 'cltbld', 10:52:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:27 INFO - 'MOZ_NO_REMOTE': '1', 10:52:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:27 INFO - 'NO_EM_RESTART': '1', 10:52:27 INFO - 'PAGER': '/bin/cat', 10:52:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:27 INFO - 'PWD': '/builds/slave/test', 10:52:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:27 INFO - 'SHELL': '/bin/bash', 10:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBWdXigMyh/Listeners', 10:52:27 INFO - 'TMPDIR': '/var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/', 10:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:27 INFO - 'USER': 'cltbld', 10:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:27 INFO - 'XPC_FLAGS': '0x0', 10:52:27 INFO - 'XPC_SERVICE_NAME': '0', 10:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 10:52:27 INFO - mozversion application_buildid: 20161017084149 10:52:27 INFO - mozversion application_changeset: 8168208334e580f36ab91072cf8faa72690bc9a0 10:52:27 INFO - mozversion application_display_name: Nightly 10:52:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:27 INFO - mozversion application_name: Firefox 10:52:27 INFO - mozversion application_remotingname: firefox 10:52:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:52:27 INFO - mozversion application_vendor: Mozilla 10:52:27 INFO - mozversion application_version: 52.0a1 10:52:27 INFO - mozversion platform_buildid: 20161017084149 10:52:27 INFO - mozversion platform_changeset: 8168208334e580f36ab91072cf8faa72690bc9a0 10:52:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:52:27 INFO - mozversion platform_version: 52.0a1 10:52:27 INFO - using testdate: 1476726747 10:52:27 INFO - actual date: 1476726747 10:52:27 INFO - starting webserver on 'localhost:53656' 10:52:27 INFO - SUITE-START | Running 2 tests 10:52:27 INFO - TEST-START | dromaeo_css 10:52:27 INFO - operating with platform_type : mac_ 10:52:27 INFO - Initialising browser for dromaeo_css test... 10:52:27 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpVcdlzA/profile http://localhost:53656/getInfo.html) 10:52:30 INFO - PROCESS | 1942 | __metrics Screen width/height:1600/1200 10:52:30 INFO - PROCESS | 1942 | colorDepth:24 10:52:30 INFO - PROCESS | 1942 | Browser inner width/height: 1024/689 10:52:30 INFO - PROCESS | 1942 | __metrics 10:52:30 INFO - PROCESS | 1942 | 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" 10:52:30 INFO - PROCESS | 1942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:30 INFO - TEST-INFO | 1942: exit 0 10:52:30 INFO - Browser initialized. 10:52:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:30 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmpVcdlzA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:42 INFO - PROCESS | 1944 | RSS: Main: 230522880 10:52:42 INFO - PROCESS | 1944 | 10:53:33 INFO - PROCESS | 1944 | 1476726813693 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] 10:55:47 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53656/tests/dromaeo/cssquery-ext.html) 10:55:50 INFO - PROCESS | 1944 | RSS: Main: 450080768 10:55:50 INFO - PROCESS | 1944 | 10:58:53 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-ext.html (next: http://localhost:53656/tests/dromaeo/cssquery-jquery.html) 10:58:54 INFO - PROCESS | 1944 | RSS: Main: 370204672 10:58:54 INFO - PROCESS | 1944 | 11:01:56 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53656/tests/dromaeo/cssquery-mootools.html) 11:01:57 INFO - PROCESS | 1944 | RSS: Main: 362364928 11:01:57 INFO - PROCESS | 1944 | 11:04:59 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53656/tests/dromaeo/cssquery-prototype.html) 11:05:00 INFO - PROCESS | 1944 | RSS: Main: 358154240 11:05:00 INFO - PROCESS | 1944 | 11:08:03 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53656/tests/dromaeo/cssquery-yui.html) 11:08:03 INFO - PROCESS | 1944 | RSS: Main: 337747968 11:08:03 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:53656/tests/dromaeo/cssquery-yui.html (next: http://localhost:53656/tests/dromaeo/cssquery-dojo.html) 11:11:07 INFO - PROCESS | 1944 | RSS: Main: 475279360 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | __start_tp_report 11:11:07 INFO - PROCESS | 1944 | _x_x_mozilla_page_load 11:11:07 INFO - PROCESS | 1944 | _x_x_mozilla_page_load_details 11:11:07 INFO - PROCESS | 1944 | |i|pagename|runs| 11:11:07 INFO - PROCESS | 1944 | |0;dojo.html;3296.8186749728757;3300.2244472548955;3316.5025246213063;3347.3138006708627;3369.7135743461804;5598.216249725042;5690.886182276357;5701.458361455665;5764.106563482662;5817.389174136718;5662.235598194243;5694.715264236782;5706.058500347448;5722.313322401307;5727.169560413738;5134.460881607433;5174;5175.223716442526;5188.481151884819;5214.348206474191;5224.425313215544;5272.578193744491;5286.762095705683;5296.417394086667;5301.019311427379;5202.453742357055;5205.60957928155;5219.478052194788;5231.398389185235;5300.204969254604;5256.710880901549;5270.920936185979;5284.260203571464;5317.096093664087;5360.437154098841;5081.872953176163;5106;5168.302279192299;5199.896002079975;5218.8695282617855;5604.607677462579;5614.29821272341;5695.686737229451;5707.686077265748;5728.3126024876865;6231.158793562857;6248.4376406123665;6250.843728906813;6257.18656574647;6284.214473190851;6124.441964285734;6164.167837341946;6168.537359698041;6250.562460627758;6266.530010249249;5797.710114494258;5822.039363505059;5837.299524057055;5860.619059761102;5925.259342582177;6221.9377806221355;6224.128621992924;6234.501239900797;6245.9694150465575;6246.93802053652;6005.399460054047;6101.481374083164;6158.969205153946;6163.445289923839;6175.475084617858;6146.754129834846;6152.953997820381;6153.2000839890525;6238.781642642486;6289.182406287245;6240.31356550779;6245.687715614201;6246.219222597176;6247.843803904848;6250.874982500324;6176.722047507873;6228.065790131516;6233.844153896189;6246.15676883624;6247.625142491465;4841.055994081191;4874.293227482066;4888.560029597354;4893.314935908976;4935.481774413706;4401.801918913657;4405.735655860659;4431.047324825178;4474.753888536162;4489.9551004490195;5708.40061793514;5788.710564471759;5790.768369265266;5803.622764520293;5854.619449735754;6099.146119543268;6202.658853762996;6279.843003924939;6282.811515654537;6299.275583307886;5714.79998200061;5728.1407788831175;5730.426957304237;5733.598648094593;5736.483716465455;5373.7581808818695;5374.596905232123;5386.48828361305;5387.380451248078;5391.191321301758;6163.445289923929;6164.321924588202;6214.912390331674;6227.50179985591;6244.500439964882;6258.092576576462;6265.248170219421;6271.3728627136925;6273.247210334606;6287.276963149114;6220.844478888064;6236.781712640217;6253.437190652863;6262.2172228471445;6276.6547839869245;6077.665728384981;6101.610781564156;6141.508679305734;6172.351903050115;6184.474319682698;6178.62928224308;6221.875562488634;6242.313345531897;6272.466840318624;6285.842853928689;5922.644641321534;6130.141780150693;6152.169457123231;6160.691965401802;6177.382261773787;6118.877622447615;6139.723712432862;6144.56988010835;6150.7847225346895;6154.046122850965;5786.479216870502;5836.387179346108;5858.7070646468355;5916.26046744157;5924.940750592611;6067.787627433018;6101.664408457577;6102.755889764538;6104.572679912363;6108.992016317258;5672.064109422065;5883.117532370179;5895.764169433346;5899.321578018583;5927.4665280125 11:11:07 INFO - PROCESS | 1944 | |1;ext.html;468.45659035518804;471.4507598647576;487.83407655702865;510.6348960493249;513.4531723714247;28930.566041509366;30937;37532.81233593828;38117;38345.424818627675;34049;40569.78290651278;40617.907313902855;40662;40739.79630101853;8160.428769986103;9183.678571250024;9480.146786789188;9489.620415183419;9490.857637135448;8497.660093596249;8715;9282.211012063948;11152.944235278812;11413.600523981662;11330.886691133106;11338.943305283463;11352.262102963323;11366.772664546705;11376.601818936339;8487.40588158829;11314.547418103308;11389.54441822326;11403.771924561463;11406.315621062762;8422.494650321001;11052.834207486894;11344.829827552594;11364.715882102932;11504;38480.422793658116;38710;38785.224295514214;38787;38817.80591097055;3314.254292784128;3349.330133973215;3372.881949131793;3376;3455.9459364893696;26937.86531067352;27142.235754675883;29697.109086727432;29951.850240748874;30755.69244307573;2748.560230363132;3093.427715872571;3094.845257737104;3190.96809031909;3230.370077834823;467385;467834;471683;472067.6396618029;478334;55623.16565251524;55792.721036394556;55800;55841.44158558363;55934;33033.339333213204;33549.66450335514;33670.663293367244;34917;58102;16049.438269660739;16166.524197297638;16174;16199;16200.108994005443;11290.491927863266;12377.938110309391;12460.81308780369;12481.625551233477;12516.249025058525;15577.922110389602;16027.519174424786;18049.368272110674;18373.908130459262;18603;7580;7707.714207227253;7708.498947568502;7785.493942893694;7792.999695117421;834.2950207075012;864.6411739128191;972.8346181149221;990.8605104130307;1022.243539780572;24040.75959240385;28523.42953140967;28828.99098531583;29322.706772932423;29353.266168345963;1050.6217761605815;1059.3114475590928;1060.8620879285797;1062.675883855416;1109.0573012938937;14964.925175374054;15085.47200847965;15107;15345.232738363036;15488.993215441185;638965;645417;645976;647266;647713;55101.44898550963;55734;55836.64980101207;55845;55890;1225.6874497003384;1270.5680068776476;1335.4124185358412;1377.3801789194902;1396.5461225101678;29143.271418214714;29978;30254.84872575623;30547.2363190922;30768.924401962053;45765.08469830651;46341;46358.30462543132;46599.76700116478;46604;456203;543008;544056;544082;544894;24280.1501947431;25523.6171457432;25839.354016149748;26084.73915260899;26332.73667263303;45268.320975186056;45284.773576131905;45709;45833.77083114563;46502.76748616235;33017.51421186004;36777.81611091927;37156.07109822276;38710.2257954845;38834;33510;37092.443613345284;37298.6270137306;38262.80868595639;38272.42591361188;36266.456003159445;36804.631953680124;37302.44046339253;37340.43989340217;37479.625203747615;28662.14013579596;31340.05979820609;32674.673253267163;33468.66531334655;34887.47668785021;19639.70540441923;23395.436883530663;24691.506169876862;25125.623115652914;25138.49723005493 11:11:07 INFO - PROCESS | 1944 | |2;jquery.html;340.40599154475444;356.6184182924272;364.8358238792543;371.37608817187123;391.1160776644782;14800.6299842504;15018.77471837922;15693.607659808526;19787.208511659515;20452.89773551134;17498.475045748615;19520;20907.477313067142;21235.027096206504;21352.25267115651;5565.359983601887;5969.552283578727;5972.283326000886;5972.6715030673295;5996.670183139926;4653.302004699289;5885.264341957255;5943.64338139713;5951.88096238075;5966.642001479903;5579.581531385163;5876.588638795286;5891.175235467017;5901.350851406363;5902.6458412495385;5653.1520271959125;5824.155497452888;5839.591228613998;5846.327672317695;5850.619709718854;5045.369328833895;5106.64253502255;5108.489151084899;5117.1556693145585;5344.43883392246;12844.871551284554;12980.935095324463;13123.212607243597;13126.343682815821;13133.474661013644;2231.787980141884;2275.0444813178506;2290.530441259538;2390.7329115568605;2822.32264256579;10170.59317627294;10661.840072398843;12586.622401327882;14662.607052330011;14897.478588249467;1758.261530157337;1832.3403574713093;1834.5230240137528;1845.952302974364;1859.1355019915804;106954.46522767414;117825.41087294594;118582.40708796486;119163.14644937188;122230;11220.102391808636;11252.099832013419;11438.370889600985;11439.88560114405;11620.360880151673;14482.855171448362;14509.709805803825;14519.491817786327;14524.419023239163;14529.636759081108;8314.293285070717;8471.449355791854;8524.914750852537;8533.402661813738;8605.612747426381;8383.11977242393;8403;8560.272376847914;8563;8613.855942580913;4418.33724941255;4496.4487251898045;4538.750368729686;4572.74849883253;4616.399868017136;1868.1313189366738;1879.257693211174;1884.547708549938;1887.3582981786258;1895.469268604793;674.1068084787578;709.620511600706;793.4049462902823;920.5627327019746;931.6366617019368;20391.082401291977;21877.781222187576;21930;22102.336929892128;22108;738.512581696078;906.9138431848963;937.1986951156799;945.3807755919884;1017.8829434615114;11014.669559913216;11341.546338146547;11434.142439317084;11463.942680286546;11600.941995290139;579224;583461;587317.3804785863;593339;594516;96273;121838.3908080454;125704;127110.45779084366;128812.06781898279;896.914793094668;981.5239608789731;1013.7566983923805;1056.4136904018344;1059.9311044782064;18922.959237242085;19270.71093933564;19329.710054349478;19335.51661208481;19350;52568;52695;54054.189187163014;54597.454025459236;55166.72416637891;75998.86001709868;77445;77845.22154778606;78446;79418.60290698509;6965;7945.960270198612;8009.359251260002;8059.4209852846525;8271.296939760188;9090.13643703847;12099.81850272229;12472.5010999559;12958.870411296144;13011.284379359226;9273.76815579589;11321.377324247245;11377;11397.772044558897;11777.116716246144;9399.859002114837;10338.276320657482;11156.442177891235;11629.88370116288;11689.707757305796;11186.32882027081;11627.720950695586;11688.94155529217;11852.881471185523;11873.584424545099;8013.198680132174;8114.797130071795;8243.464174828618;8250.886130372322;8386;10640.308379955588;11379.905217029262;11535.711607209887;11653.242539234923;11708.004819590431 11:11:07 INFO - PROCESS | 1944 | |3;mootools.html;1519.1340935666672;1574.4017273436095;1771.2029586685987;1835.1925152932718;1919.7600299962505;8523.914760852389;8977.281817454605;8979.775505612362;8980.057094005133;8994.595243214055;7920.80197995049;8169.754907352774;8490.150984901507;8743.606537705802;8744.519051452167;2308.9884550577267;2336.754640762721;2338.9298321050396;2342.6954495915506;2347.8239132065078;2303.216906251874;2320.3039088273536;2353.8469999450067;2356.3873392917794;2358.3278765551822;1955.8728682635654;2325.860448373103;2354.411397150712;2354.5761762882676;2366.680498132756;2312.583734927712;2314.560233555619;2318.5710643530915;2320.44309365751;2325.848819826706;2317.895694693743;2319.3621754017613;2322.291701031185;2324.5118525109747;2325.8720770357622;8858.424202426886;8884.11158884113;8995.055519170459;9009.594568244445;9017.729468115967;5163.096458119814;5329.173978033372;5335.0930341841595;5350.892982140335;5352.892942141136;3242.96757032429;3384.560007199073;3456.2914602506426;3556.0754203906913;3593.0298819318637;1013.5033833421644;1052.2844465763278;1054.393723608928;1076.364944682641;1077.3535878472853;11600.30398176112;11739.47172377245;11798.764024719543;11804;11811.704707382298;4505.324201369821;4576.496585375606;4760.571548560577;4763.880902977453;4785.784639691153;9884.752881178028;9896.059874312074;9896.307258491981;9900.455474948947;9910.306278560576;5339.41266460689;5347.1979203119845;5353.785848566014;5354.544863686552;5355.7054362009685;4305.991809470824;4375.7155784873885;4551.362809206714;4752.097101550694;4866.367372241657;3843.5964223756105;3864.671502922227;3995.700322475826;3998.1803730235233;4000.4199391088127;1251.5431867368345;1255.5919326219016;1267.702090008847;1269.5429645327674;1288.8066789981578;801.3469022746443;902.9683961061331;908.3686837647772;909.6679711905107;919.7654598077581;5813.883722325614;5936.584439089309;6006.849828754316;6062.727177277033;6219.19643303446;908.182635627927;932.7994481186578;937.315759495572;939.487979051405;973.124188230584;3862.9806850965565;3922.7842468663926;3926.234384295035;4010.8970033241094;4089.0595163112057;10566.31318964265;10837.078848297826;10924.96212859777;10963.013328800445;11012.229143960007;10924.726881828017;10926.617568385069;10928.890711092947;10931.125509959184;10941.945290273497;8206.958965205136;8329.66681332752;8331;8333.916660833314;8357.540335281496;5533.612647114664;5783.884322313615;5873.911891321719;5948.762049517971;5967.46292833647;10149.34029288094;10183.898161018295;10199.949000254952;10215.182785377301;10271.589136434757;9890.406575605486;10242.692719218436;10269.486525673537;10281.948590257001;10296.485175741333;6977.1976222733;7169.318914703095;7433.516821406592;7603.2776886195725;7604.733834315773;6480.611163330215;7933.325667318342;8017.238362355567;8238.09380968105;8466.068732439304;6274.937250627435;7502.512336698315;7513.436492262993;7574.356179724785;7684.923150768421;7292.34368906801;7347.044884165024;7394.593297368481;7410.147832999274;7526.548407095592;6733.966330168318;6909.861802764017;7004.509684322048;7062.929370706227;7066.328698773608;5002.17464118431;5017.297578338962;5057.31726216956;5061.114304996685;5156.9742151289;4937.1113199624415;5049.141645920276;5049.2426136079885;5173.1464308388695;5229.686218826882 11:11:07 INFO - PROCESS | 1944 | |4;prototype.html;284.6996418778189;292.71167899618877;302.58092541829564;308.23250107232997;310.2940809658026;5271.364317841079;5272.4727527247305;5336.466353364662;5340.465953404658;5416.945830541694;5083.035232518641;5225.126180600664;5285.286486324345;5309.893802123965;5322.403279016299;3395;4056.472658554384;4069.6540794032544;4081.469408976829;4089.3048181809163;3399.881004164855;4089.5073298246075;4094.4677191965;4103.712740108193;4145.212409642173;3917.6278253565865;3988.985562291039;4017.7388469749517;4037.8182981765744;4124.896877578055;3305.4545999909988;4028.3756017817286;4029.657479114279;4041.5756345583586;4048.797560121997;2846.889713011927;2990.596269503633;3079.6757394320434;3475.721942244614;3496.4405695088917;4278.2940814765525;4949.975250123763;4970.329005584272;5176.870578235536;5208.7916483341;3722.3858063419775;4005.559388467266;4517.390152329426;4533.705309154927;4610.446746390455;5071.771770270347;5327.706976116312;5512.448755124496;5557.833265002016;5566.159350048453;3862.382018876994;3866.709996750255;3907.179492306619;3913.6086391360923;3931.9973406781087;4477.3731677565165;5665.383906924407;5782.681952492653;5807.912881306784;5817.952768501668;3088.44408006561;3457.792532448061;3814.408766641175;3909.9218015639526;3914.373700207953;3931.567527571965;3959.425883246913;3960.3069462843887;4012.6789856811383;4030.3349947258375;4088.4889388826396;4286.935695964563;4637.86086417408;4650.95349046512;4651.744154071558;4823.541763532458;5418.997485465202;5565.41563135873;5642.915356269659;5734.5125664319;1110.8889111088827;1342.4160490186605;1368.3921392363932;1368.8288963879515;1376.0460146591863;797.0992778160642;846.5439444156042;854.8418542569644;861.9224269815621;862.4307956748642;3915.295246855593;4168.499780026355;4175.617749622816;4307.652329480441;4320.546342634041;4049.919001619951;4058.6144316290497;4417.845375411845;4683.555062269079;4844.304493427272;4128.566500517462;4314;4328.978355108267;4338.349247612883;4374.62815660666;2297.7936583293904;2356.7525409832065;2359.1480687660105;2386.0217310902794;2577.832440891336;4765.475797662254;4924.606031517542;5009.423916249605;5019.84940451787;5026.768441731799;4067.3085575452246;4265.675207012124;4335.9187589957;4779;4875.2454863002995;4094.3244364679495;4383.890402739957;4929.2254788276905;5019.82430614934;5061.431690658077;3978.5822488638278;4275.6365708913845;4848.781804818721;4877.5366340197625;4878.780454879468;4291.592298731615;4371.688493452015;4453.55464453552;4613.907721845477;4713.67004309695;4252.745440095241;4753.168195565693;4937.456879743154;5636.549076073986;6077.84236596002;3412.5904891412197;3657.6708096271464;3876.476675648751;3891.9221615568094;3909.6481316681634;4915.926261106015;5284.260203571426;5722.484976352148;5866.6186697864505;5924.674142922181;5350.859656137421;5364.64783618574;5604.8038318658655;5681.318241810844;5748.798792042258;4519.728816271035;4664.510226426177;5273.44628813969;5565.30433695788;5565.6104072714525;5480.629412911111;5492.47821456961;5525.889482210253;5537.224788529528;5602.187682786055;5198.6880787152895;5312.681239125664;5539.556835453073;5582.804601838916;5608.38307786135;4710.317004034464;5360.195970604441;5456.727163641723;5458.4814442627885;5593.412691667317 11:11:07 INFO - PROCESS | 1944 | |5;yui.html;661.6228749612717;710.4352040128099;742.8625704244719;765.6439755513685;819.5328662662283;15044.323005464754;15734.606634834106;15737.370505179808;15757.60605984851;16135.273912673929;14103;14213.218272994982;14224.573262802107;14227.573172804832;14248.14511129333;596.6449962272462;687.4363022321699;720.6324774365086;856.5075081827943;862.8446879561676;874.9387542872001;878.1745159550003;896.5427631907709;896.8251191017754;897.7037577599376;942.4486675294927;943.3302355327726;944.3767113704956;945.7588314979671;947.313197931501;725.3906718356606;751.1887161865227;937.9531023448834;938.816930698514;939.5161491831747;669.3306693306694;688.8518968421813;692.4495026453981;692.504859025799;692.6432887063166;14907.403703851833;14979.400823967027;14982.400703971827;14992;14999.700005999819;13351.198928064347;13533.458661653522;13805.17168969865;13824.930875345659;13946.673311736855;12361.690957726129;12364.629061128091;12392.690182745413;12422.130450868352;12787.424565894464;4404.11917616478;4422.513523512411;4478.1043791241555;4530.592246697813;4539.387182730322;108029;108157.13292901759;113935.29097063468;115915.51056117985;119978;10599.682009539727;10848.511816968256;10928.961748633867;10997.285176463503;11018.173636977259;21675.458113547287;21702.023408946636;21707.674384884238;21744.238951636617;21755.564888702138;6367.395097465734;6584.473242140617;7777.533347999138;7856.84286314282;7871.763847084597;4268.253055715238;4298.8280468780895;4339.696221264544;4381.474223093249;4518.073794872043;3400.8639654413546;3574.0171452850673;3577.7853328800356;3578;3578.5526809148855;643.4852118305431;656.0520048529828;661.2792056658266;661.2825084782968;665.5308007854451;511.68717397364446;516.8707823044239;554.0553356527112;556.9622762116664;631.8167731357855;8960.507172105597;9554.856677149848;9608.519574021271;9719.708408747749;9759.951200243953;540.6918056707717;552.4751486088232;643.3052303512289;651.9380658837403;671.4561205423622;4639.582437580634;4700.576948074689;4738.4787673356595;4744.95610965587;4775.2359622460235;86528.70206946901;123565.08306295537;144076.5592344063;150415;163466;82357;83816.68474755951;110757;139184.6081539192;141604;117282.41358793151;118152;118591;120607.39696301462;122306.77693223133;7051.224365319708;8731;8754.387192896436;8798.560071996502;8911.777205569653;61738;62038.689806550676;63434.365656342845;64158;66020;84367.5781621088;94596.05403945873;97303.02696973222;98533.50733246288;98566.01433985568;11460.598879039193;11883.287002779862;11988;11999.580014699444;12190.512379505075;12966.740665186831;13340.733185336045;13431;13520;13537.255450950292;11587.652370428901;12240.892311830932;12577.119601627799;12638.936805316282;14017;13103;13340.382764141968;13600.727985440433;13750.862491374959;14260.42958281657;13359;13424.731505370033;13427.932860336026;13733.244671543162;13866.930665346608;10686.57253709874;11193.832092518456;11569.041943398988;11583.362915039754;11610.593629222936;10280.691579252634;11329.660110196708;11425.771484570096;11578.884211157781;11624.825627615422 11:11:07 INFO - PROCESS | 1944 | __end_tp_report 11:11:07 INFO - PROCESS | 1944 | __start_cc_report 11:11:07 INFO - PROCESS | 1944 | _x_x_mozilla_cycle_collect,2748 11:11:07 INFO - PROCESS | 1944 | __end_cc_report 11:11:07 INFO - PROCESS | 1944 | __startTimestamp1476727867382__endTimestamp 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | ------- Summary: start ------- 11:11:07 INFO - PROCESS | 1944 | Number of tests: 6 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | [#0] dojo.html Cycles:165 Average:5742.47 Median:5922.64 stddev:634.54 (10.7%) stddev-sans-first:606.79 11:11:07 INFO - PROCESS | 1944 | Values: 3296.8 3300.2 3316.5 3347.3 3369.7 5598.2 5690.9 5701.5 5764.1 5817.4 5662.2 5694.7 5706.1 5722.3 5727.2 5134.5 5174.0 5175.2 5188.5 5214.3 5224.4 5272.6 5286.8 5296.4 5301.0 5202.5 5205.6 5219.5 5231.4 5300.2 5256.7 5270.9 5284.3 5317.1 5360.4 5081.9 5106.0 5168.3 5199.9 5218.9 5604.6 5614.3 5695.7 5707.7 5728.3 6231.2 6248.4 6250.8 6257.2 6284.2 6124.4 6164.2 6168.5 6250.6 6266.5 5797.7 5822.0 5837.3 5860.6 5925.3 6221.9 6224.1 6234.5 6246.0 6246.9 6005.4 6101.5 6159.0 6163.4 6175.5 6146.8 6153.0 6153.2 6238.8 6289.2 6240.3 6245.7 6246.2 6247.8 6250.9 6176.7 6228.1 6233.8 6246.2 6247.6 4841.1 4874.3 4888.6 4893.3 4935.5 4401.8 4405.7 4431.0 4474.8 4490.0 5708.4 5788.7 5790.8 5803.6 5854.6 6099.1 6202.7 6279.8 6282.8 6299.3 5714.8 5728.1 5730.4 5733.6 5736.5 5373.8 5374.6 5386.5 5387.4 5391.2 6163.4 6164.3 6214.9 6227.5 6244.5 6258.1 6265.2 6271.4 6273.2 6287.3 6220.8 6236.8 6253.4 6262.2 6276.7 6077.7 6101.6 6141.5 6172.4 6184.5 6178.6 6221.9 6242.3 6272.5 6285.8 5922.6 6130.1 6152.2 6160.7 6177.4 6118.9 6139.7 6144.6 6150.8 6154.0 5786.5 5836.4 5858.7 5916.3 5924.9 6067.8 6101.7 6102.8 6104.6 6109.0 5672.1 5883.1 5895.8 5899.3 5927.5 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | [#1] ext.html Cycles:180 Average:66889.48 Median:18712.50 stddev:147844.04 (790.1%) stddev-sans-first:148174.67 11:11:07 INFO - PROCESS | 1944 | Values: 468.5 471.5 487.8 510.6 513.5 28930.6 30937.0 37532.8 38117.0 38345.4 34049.0 40569.8 40617.9 40662.0 40739.8 8160.4 9183.7 9480.1 9489.6 9490.9 8497.7 8715.0 9282.2 11152.9 11413.6 11330.9 11338.9 11352.3 11366.8 11376.6 8487.4 11314.5 11389.5 11403.8 11406.3 8422.5 11052.8 11344.8 11364.7 11504.0 38480.4 38710.0 38785.2 38787.0 38817.8 3314.3 3349.3 3372.9 3376.0 3455.9 26937.9 27142.2 29697.1 29951.9 30755.7 2748.6 3093.4 3094.8 3191.0 3230.4 467385.0 467834.0 471683.0 472067.6 478334.0 55623.2 55792.7 55800.0 55841.4 55934.0 33033.3 33549.7 33670.7 34917.0 58102.0 16049.4 16166.5 16174.0 16199.0 16200.1 11290.5 12377.9 12460.8 12481.6 12516.2 15577.9 16027.5 18049.4 18373.9 18603.0 7580.0 7707.7 7708.5 7785.5 7793.0 834.3 864.6 972.8 990.9 1022.2 24040.8 28523.4 28829.0 29322.7 29353.3 1050.6 1059.3 1060.9 1062.7 1109.1 14964.9 15085.5 15107.0 15345.2 15489.0 638965.0 645417.0 645976.0 647266.0 647713.0 55101.4 55734.0 55836.6 55845.0 55890.0 1225.7 1270.6 1335.4 1377.4 1396.5 29143.3 29978.0 30254.8 30547.2 30768.9 45765.1 46341.0 46358.3 46599.8 46604.0 456203.0 543008.0 544056.0 544082.0 544894.0 24280.2 25523.6 25839.4 26084.7 26332.7 45268.3 45284.8 45709.0 45833.8 46502.8 33017.5 36777.8 37156.1 38710.2 38834.0 33510.0 37092.4 37298.6 38262.8 38272.4 36266.5 36804.6 37302.4 37340.4 37479.6 28662.1 31340.1 32674.7 33468.7 34887.5 19639.7 23395.4 24691.5 25125.6 25138.5 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | [#2] jquery.html Cycles:180 Average:34143.30 Median:2253.42 stddev:98021.08 (4349.9%) stddev-sans-first:98263.19 11:11:07 INFO - PROCESS | 1944 | Values: 340.4 356.6 364.8 371.4 391.1 14800.6 15018.8 15693.6 19787.2 20452.9 17498.5 19520.0 20907.5 21235.0 21352.3 5565.4 5969.6 5972.3 5972.7 5996.7 4653.3 5885.3 5943.6 5951.9 5966.6 5579.6 5876.6 5891.2 5901.4 5902.6 5653.2 5824.2 5839.6 5846.3 5850.6 5045.4 5106.6 5108.5 5117.2 5344.4 12844.9 12980.9 13123.2 13126.3 13133.5 2231.8 2275.0 2290.5 2390.7 2822.3 10170.6 10661.8 12586.6 14662.6 14897.5 1758.3 1832.3 1834.5 1846.0 1859.1 106954.5 117825.4 118582.4 119163.1 122230.0 11220.1 11252.1 11438.4 11439.9 11620.4 14482.9 14509.7 14519.5 14524.4 14529.6 8314.3 8471.4 8524.9 8533.4 8605.6 8383.1 8403.0 8560.3 8563.0 8613.9 4418.3 4496.4 4538.8 4572.7 4616.4 1868.1 1879.3 1884.5 1887.4 1895.5 674.1 709.6 793.4 920.6 931.6 20391.1 21877.8 21930.0 22102.3 22108.0 738.5 906.9 937.2 945.4 1017.9 11014.7 11341.5 11434.1 11463.9 11600.9 579224.0 583461.0 587317.4 593339.0 594516.0 96273.0 121838.4 125704.0 127110.5 128812.1 896.9 981.5 1013.8 1056.4 1059.9 18923.0 19270.7 19329.7 19335.5 19350.0 52568.0 52695.0 54054.2 54597.5 55166.7 75998.9 77445.0 77845.2 78446.0 79418.6 6965.0 7946.0 8009.4 8059.4 8271.3 9090.1 12099.8 12472.5 12958.9 13011.3 9273.8 11321.4 11377.0 11397.8 11777.1 9399.9 10338.3 11156.4 11629.9 11689.7 11186.3 11627.7 11688.9 11852.9 11873.6 8013.2 8114.8 8243.5 8250.9 8386.0 10640.3 11379.9 11535.7 11653.2 11708.0 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | [#3] mootools.html Cycles:180 Average:5720.61 Median:5009.74 stddev:3232.16 (64.5%) stddev-sans-first:3225.81 11:11:07 INFO - PROCESS | 1944 | Values: 1519.1 1574.4 1771.2 1835.2 1919.8 8523.9 8977.3 8979.8 8980.1 8994.6 7920.8 8169.8 8490.2 8743.6 8744.5 2309.0 2336.8 2338.9 2342.7 2347.8 2303.2 2320.3 2353.8 2356.4 2358.3 1955.9 2325.9 2354.4 2354.6 2366.7 2312.6 2314.6 2318.6 2320.4 2325.8 2317.9 2319.4 2322.3 2324.5 2325.9 8858.4 8884.1 8995.1 9009.6 9017.7 5163.1 5329.2 5335.1 5350.9 5352.9 3243.0 3384.6 3456.3 3556.1 3593.0 1013.5 1052.3 1054.4 1076.4 1077.4 11600.3 11739.5 11798.8 11804.0 11811.7 4505.3 4576.5 4760.6 4763.9 4785.8 9884.8 9896.1 9896.3 9900.5 9910.3 5339.4 5347.2 5353.8 5354.5 5355.7 4306.0 4375.7 4551.4 4752.1 4866.4 3843.6 3864.7 3995.7 3998.2 4000.4 1251.5 1255.6 1267.7 1269.5 1288.8 801.3 903.0 908.4 909.7 919.8 5813.9 5936.6 6006.8 6062.7 6219.2 908.2 932.8 937.3 939.5 973.1 3863.0 3922.8 3926.2 4010.9 4089.1 10566.3 10837.1 10925.0 10963.0 11012.2 10924.7 10926.6 10928.9 10931.1 10941.9 8207.0 8329.7 8331.0 8333.9 8357.5 5533.6 5783.9 5873.9 5948.8 5967.5 10149.3 10183.9 10199.9 10215.2 10271.6 9890.4 10242.7 10269.5 10281.9 10296.5 6977.2 7169.3 7433.5 7603.3 7604.7 6480.6 7933.3 8017.2 8238.1 8466.1 6274.9 7502.5 7513.4 7574.4 7684.9 7292.3 7347.0 7394.6 7410.1 7526.5 6734.0 6909.9 7004.5 7062.9 7066.3 5002.2 5017.3 5057.3 5061.1 5157.0 4937.1 5049.1 5049.2 5173.1 5229.7 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | [#4] prototype.html Cycles:180 Average:4260.63 Median:4518.56 stddev:1308.12 (28.9%) stddev-sans-first:1277.30 11:11:07 INFO - PROCESS | 1944 | Values: 284.7 292.7 302.6 308.2 310.3 5271.4 5272.5 5336.5 5340.5 5416.9 5083.0 5225.1 5285.3 5309.9 5322.4 3395.0 4056.5 4069.7 4081.5 4089.3 3399.9 4089.5 4094.5 4103.7 4145.2 3917.6 3989.0 4017.7 4037.8 4124.9 3305.5 4028.4 4029.7 4041.6 4048.8 2846.9 2990.6 3079.7 3475.7 3496.4 4278.3 4950.0 4970.3 5176.9 5208.8 3722.4 4005.6 4517.4 4533.7 4610.4 5071.8 5327.7 5512.4 5557.8 5566.2 3862.4 3866.7 3907.2 3913.6 3932.0 4477.4 5665.4 5782.7 5807.9 5818.0 3088.4 3457.8 3814.4 3909.9 3914.4 3931.6 3959.4 3960.3 4012.7 4030.3 4088.5 4286.9 4637.9 4651.0 4651.7 4823.5 5419.0 5565.4 5642.9 5734.5 1110.9 1342.4 1368.4 1368.8 1376.0 797.1 846.5 854.8 861.9 862.4 3915.3 4168.5 4175.6 4307.7 4320.5 4049.9 4058.6 4417.8 4683.6 4844.3 4128.6 4314.0 4329.0 4338.3 4374.6 2297.8 2356.8 2359.1 2386.0 2577.8 4765.5 4924.6 5009.4 5019.8 5026.8 4067.3 4265.7 4335.9 4779.0 4875.2 4094.3 4383.9 4929.2 5019.8 5061.4 3978.6 4275.6 4848.8 4877.5 4878.8 4291.6 4371.7 4453.6 4613.9 4713.7 4252.7 4753.2 4937.5 5636.5 6077.8 3412.6 3657.7 3876.5 3891.9 3909.6 4915.9 5284.3 5722.5 5866.6 5924.7 5350.9 5364.6 5604.8 5681.3 5748.8 4519.7 4664.5 5273.4 5565.3 5565.6 5480.6 5492.5 5525.9 5537.2 5602.2 5198.7 5312.7 5539.6 5582.8 5608.4 4710.3 5360.2 5456.7 5458.5 5593.4 11:11:07 INFO - PROCESS | 1944 | 11:11:07 INFO - PROCESS | 1944 | [#5] yui.html Cycles:180 Average:24338.34 Median:3578.28 stddev:38646.11 (1080.0%) stddev-sans-first:38713.63 11:11:07 INFO - PROCESS | 1944 | Values: 661.6 710.4 742.9 765.6 819.5 15044.3 15734.6 15737.4 15757.6 16135.3 14103.0 14213.2 14224.6 14227.6 14248.1 596.6 687.4 720.6 856.5 862.8 874.9 878.2 896.5 896.8 897.7 942.4 943.3 944.4 945.8 947.3 725.4 751.2 938.0 938.8 939.5 669.3 688.9 692.4 692.5 692.6 14907.4 14979.4 14982.4 14992.0 14999.7 13351.2 13533.5 13805.2 13824.9 13946.7 12361.7 12364.6 12392.7 12422.1 12787.4 4404.1 4422.5 4478.1 4530.6 4539.4 108029.0 108157.1 113935.3 115915.5 119978.0 10599.7 10848.5 10929.0 10997.3 11018.2 21675.5 21702.0 21707.7 21744.2 21755.6 6367.4 6584.5 7777.5 7856.8 7871.8 4268.3 4298.8 4339.7 4381.5 4518.1 3400.9 3574.0 3577.8 3578.0 3578.6 643.5 656.1 661.3 661.3 665.5 511.7 516.9 554.1 557.0 631.8 8960.5 9554.9 9608.5 9719.7 9760.0 540.7 552.5 643.3 651.9 671.5 4639.6 4700.6 4738.5 4745.0 4775.2 86528.7 123565.1 144076.6 150415.0 163466.0 82357.0 83816.7 110757.0 139184.6 141604.0 117282.4 118152.0 118591.0 120607.4 122306.8 7051.2 8731.0 8754.4 8798.6 8911.8 61738.0 62038.7 63434.4 64158.0 66020.0 84367.6 94596.1 97303.0 98533.5 98566.0 11460.6 11883.3 11988.0 11999.6 12190.5 12966.7 13340.7 13431.0 13520.0 13537.3 11587.7 12240.9 12577.1 12638.9 14017.0 13103.0 13340.4 13600.7 13750.9 14260.4 13359.0 13424.7 13427.9 13733.2 13866.9 10686.6 11193.8 11569.0 11583.4 11610.6 10280.7 11329.7 11425.8 11578.9 11624.8 11:11:07 INFO - PROCESS | 1944 | -------- Summary: end -------- 11:11:07 INFO - PROCESS | 1944 | 11:11:08 INFO - TEST-INFO | 1944: exit 0 11:11:08 INFO - TEST-OK | dromaeo_css | took 1120425ms 11:11:08 INFO - TEST-START | kraken 11:11:08 INFO - operating with platform_type : mac_ 11:11:08 INFO - Initialising browser for kraken test... 11:11:08 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmp858esr/profile http://localhost:53656/getInfo.html) 11:11:10 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 11:11:10 INFO - PROCESS | 1948 | colorDepth:24 11:11:10 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 11:11:10 INFO - PROCESS | 1948 | __metrics 11:11:10 INFO - PROCESS | 1948 | 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" 11:11:10 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:11:11 INFO - TEST-INFO | 1948: exit 0 11:11:11 INFO - Browser initialized. 11:11:11 INFO - Running cycle 1/1 for kraken test... 11:11:11 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9c/2dh985pd15l19fywb0pq404000000w/T/tmp858esr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:23 INFO - PROCESS | 1949 | RSS: Main: 230559744 11:11:23 INFO - PROCESS | 1949 | 11:11:26 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:26 INFO - PROCESS | 1949 | RSS: Main: 290963456 11:11:26 INFO - PROCESS | 1949 | 11:11:29 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-dft) 11:11:30 INFO - PROCESS | 1949 | RSS: Main: 292163584 11:11:30 INFO - PROCESS | 1949 | 11:11:33 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-fft) 11:11:34 INFO - PROCESS | 1949 | RSS: Main: 387088384 11:11:34 INFO - PROCESS | 1949 | 11:11:36 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53656/tests/kraken/driver.html?testName=audio-oscillator) 11:11:37 INFO - PROCESS | 1949 | RSS: Main: 290971648 11:11:37 INFO - PROCESS | 1949 | 11:11:39 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:39 INFO - PROCESS | 1949 | RSS: Main: 292802560 11:11:39 INFO - PROCESS | 1949 | 11:11:42 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53656/tests/kraken/driver.html?testName=imaging-darkroom) 11:11:43 INFO - PROCESS | 1949 | RSS: Main: 329699328 11:11:43 INFO - PROCESS | 1949 | 11:11:46 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53656/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:46 INFO - PROCESS | 1949 | RSS: Main: 330416128 11:11:46 INFO - PROCESS | 1949 | 11:11:49 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53656/tests/kraken/driver.html?testName=json-parse-financial) 11:11:50 INFO - PROCESS | 1949 | RSS: Main: 327712768 11:11:50 INFO - PROCESS | 1949 | 11:11:51 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:52 INFO - PROCESS | 1949 | RSS: Main: 303411200 11:11:52 INFO - PROCESS | 1949 | 11:11:54 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:55 INFO - PROCESS | 1949 | RSS: Main: 306950144 11:11:55 INFO - PROCESS | 1949 | 11:11:57 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:58 INFO - PROCESS | 1949 | RSS: Main: 309239808 11:11:58 INFO - PROCESS | 1949 | 11:12:01 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:01 INFO - PROCESS | 1949 | RSS: Main: 317595648 11:12:01 INFO - PROCESS | 1949 | 11:12:04 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:05 INFO - PROCESS | 1949 | RSS: Main: 317874176 11:12:05 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53656/tests/kraken/driver.html?testName=ai-astar) 11:12:07 INFO - PROCESS | 1949 | RSS: Main: 361820160 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | __start_tp_report 11:12:07 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 11:12:07 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 11:12:07 INFO - PROCESS | 1949 | |i|pagename|runs| 11:12:07 INFO - PROCESS | 1949 | |0;ai-astar;113;113;113;112;113;114;113;113;113;113 11:12:07 INFO - PROCESS | 1949 | |1;audio-beat-detection;156;113;116;151;118;113;118;114;145;114 11:12:07 INFO - PROCESS | 1949 | |2;audio-dft;186;183;186;186;185;184;182;185;186;184 11:12:07 INFO - PROCESS | 1949 | |3;audio-fft;80;61;83;121;86;59;60;59;85;58 11:12:07 INFO - PROCESS | 1949 | |4;audio-oscillator;89;75;120;101;79;69;93;70;69;92 11:12:07 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;90;90;93;89;92;88;96;89;92;89 11:12:07 INFO - PROCESS | 1949 | |6;imaging-darkroom;96;108;147;148;97;99;97;102;150;128 11:12:07 INFO - PROCESS | 1949 | |7;imaging-desaturate;82;82;79;78;84;82;85;83;81;82 11:12:07 INFO - PROCESS | 1949 | |8;json-parse-financial;55;52;53;76;80;80;80;53;55;53 11:12:07 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;71;67;67;80;76;72;72;69;71;71 11:12:07 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;87;96;99;105;102;89;85;88;87;88 11:12:07 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;148;146;148;145;145;148;146;145;238;148 11:12:07 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;174;173;180;171;223;231;184;173;171;166 11:12:07 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;70;70;69;70;69;69;68;69;69;68 11:12:07 INFO - PROCESS | 1949 | __end_tp_report 11:12:07 INFO - PROCESS | 1949 | __start_cc_report 11:12:07 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,2019 11:12:07 INFO - PROCESS | 1949 | __end_cc_report 11:12:07 INFO - PROCESS | 1949 | __startTimestamp1476727927544__endTimestamp 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | ------- Summary: start ------- 11:12:07 INFO - PROCESS | 1949 | Number of tests: 14 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:12:07 INFO - PROCESS | 1949 | Values: 113.0 113.0 113.0 112.0 113.0 114.0 113.0 113.0 113.0 113.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:118.00 stddev:17.45 (14.8%) stddev-sans-first:14.69 11:12:07 INFO - PROCESS | 1949 | Values: 156.0 113.0 116.0 151.0 118.0 113.0 118.0 114.0 145.0 114.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:1.42 (0.8%) stddev-sans-first:1.42 11:12:07 INFO - PROCESS | 1949 | Values: 186.0 183.0 186.0 186.0 185.0 184.0 182.0 185.0 186.0 184.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:75.20 Median:70.50 stddev:20.13 (28.6%) stddev-sans-first:21.28 11:12:07 INFO - PROCESS | 1949 | Values: 80.0 61.0 83.0 121.0 86.0 59.0 60.0 59.0 85.0 58.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:77.00 stddev:16.59 (21.6%) stddev-sans-first:17.56 11:12:07 INFO - PROCESS | 1949 | Values: 89.0 75.0 120.0 101.0 79.0 69.0 93.0 70.0 69.0 92.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:91.00 stddev:2.44 (2.7%) stddev-sans-first:2.57 11:12:07 INFO - PROCESS | 1949 | Values: 90.0 90.0 93.0 89.0 92.0 88.0 96.0 89.0 92.0 89.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:117.20 Median:123.00 stddev:23.43 (19.1%) stddev-sans-first:23.56 11:12:07 INFO - PROCESS | 1949 | Values: 96.0 108.0 147.0 148.0 97.0 99.0 97.0 102.0 150.0 128.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:81.80 Median:82.00 stddev:2.10 (2.6%) stddev-sans-first:2.22 11:12:07 INFO - PROCESS | 1949 | Values: 82.0 82.0 79.0 78.0 84.0 82.0 85.0 83.0 81.0 82.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:65.50 stddev:13.25 (20.2%) stddev-sans-first:13.67 11:12:07 INFO - PROCESS | 1949 | Values: 55.0 52.0 53.0 76.0 80.0 80.0 80.0 53.0 55.0 53.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:3.95 (5.5%) stddev-sans-first:4.18 11:12:07 INFO - PROCESS | 1949 | Values: 71.0 67.0 67.0 80.0 76.0 72.0 72.0 69.0 71.0 71.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:88.00 stddev:7.23 (8.2%) stddev-sans-first:7.38 11:12:07 INFO - PROCESS | 1949 | Values: 87.0 96.0 99.0 105.0 102.0 89.0 85.0 88.0 87.0 88.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:148.00 stddev:28.95 (19.6%) stddev-sans-first:30.57 11:12:07 INFO - PROCESS | 1949 | Values: 148.0 146.0 148.0 145.0 145.0 148.0 146.0 145.0 238.0 148.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:177.00 stddev:22.96 (13.0%) stddev-sans-first:24.04 11:12:07 INFO - PROCESS | 1949 | Values: 174.0 173.0 180.0 171.0 223.0 231.0 184.0 173.0 171.0 166.0 11:12:07 INFO - PROCESS | 1949 | 11:12:07 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 11:12:07 INFO - PROCESS | 1949 | Values: 70.0 70.0 69.0 70.0 69.0 69.0 68.0 69.0 69.0 68.0 11:12:07 INFO - PROCESS | 1949 | -------- Summary: end -------- 11:12:07 INFO - PROCESS | 1949 | 11:12:08 INFO - TEST-INFO | 1949: exit 0 11:12:08 INFO - TEST-OK | kraken | took 60350ms 11:12:08 INFO - SUITE-END | took 1180s 11:12:08 INFO - Completed test suite (00:19:41) 11:12:08 INFO - javascript benchmark 11:12:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.8186749728757, 3300.2244472548955, 3316.5025246213063, 3347.3138006708627, 3369.7135743461804, 5598.216249725042, 5690.886182276357, 5701.458361455665, 5764.106563482662, 5817.389174136718, 5662.235598194243, 5694.715264236782, 5706.058500347448, 5722.313322401307, 5727.169560413738, 5134.460881607433, 5174.0, 5175.223716442526, 5188.481151884819, 5214.348206474191, 5224.425313215544, 5272.578193744491, 5286.762095705683, 5296.417394086667, 5301.019311427379, 5202.453742357055, 5205.60957928155, 5219.478052194788, 5231.398389185235, 5300.204969254604, 5256.710880901549, 5270.920936185979, 5284.260203571464, 5317.096093664087, 5360.437154098841, 5081.872953176163, 5106.0, 5168.302279192299, 5199.896002079975, 5218.8695282617855, 5604.607677462579, 5614.29821272341, 5695.686737229451, 5707.686077265748, 5728.3126024876865, 6231.158793562857, 6248.4376406123665, 6250.843728906813, 6257.18656574647, 6284.214473190851, 6124.441964285734, 6164.167837341946, 6168.537359698041, 6250.562460627758, 6266.530010249249, 5797.710114494258, 5822.039363505059, 5837.299524057055, 5860.619059761102, 5925.259342582177, 6221.9377806221355, 6224.128621992924, 6234.501239900797, 6245.9694150465575, 6246.93802053652, 6005.399460054047, 6101.481374083164, 6158.969205153946, 6163.445289923839, 6175.475084617858, 6146.754129834846, 6152.953997820381, 6153.2000839890525, 6238.781642642486, 6289.182406287245, 6240.31356550779, 6245.687715614201, 6246.219222597176, 6247.843803904848, 6250.874982500324, 6176.722047507873, 6228.065790131516, 6233.844153896189, 6246.15676883624, 6247.625142491465, 4841.055994081191, 4874.293227482066, 4888.560029597354, 4893.314935908976, 4935.481774413706, 4401.801918913657, 4405.735655860659, 4431.047324825178, 4474.753888536162, 4489.9551004490195, 5708.40061793514, 5788.710564471759, 5790.768369265266, 5803.622764520293, 5854.619449735754, 6099.146119543268, 6202.658853762996, 6279.843003924939, 6282.811515654537, 6299.275583307886, 5714.79998200061, 5728.1407788831175, 5730.426957304237, 5733.598648094593, 5736.483716465455, 5373.7581808818695, 5374.596905232123, 5386.48828361305, 5387.380451248078, 5391.191321301758, 6163.445289923929, 6164.321924588202, 6214.912390331674, 6227.50179985591, 6244.500439964882, 6258.092576576462, 6265.248170219421, 6271.3728627136925, 6273.247210334606, 6287.276963149114, 6220.844478888064, 6236.781712640217, 6253.437190652863, 6262.2172228471445, 6276.6547839869245, 6077.665728384981, 6101.610781564156, 6141.508679305734, 6172.351903050115, 6184.474319682698, 6178.62928224308, 6221.875562488634, 6242.313345531897, 6272.466840318624, 6285.842853928689, 5922.644641321534, 6130.141780150693, 6152.169457123231, 6160.691965401802, 6177.382261773787, 6118.877622447615, 6139.723712432862, 6144.56988010835, 6150.7847225346895, 6154.046122850965, 5786.479216870502, 5836.387179346108, 5858.7070646468355, 5916.26046744157, 5924.940750592611, 6067.787627433018, 6101.664408457577, 6102.755889764538, 6104.572679912363, 6108.992016317258, 5672.064109422065, 5883.117532370179, 5895.764169433346, 5899.321578018583, 5927.4665280125], "value": 5700.730216043073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.45659035518804, 471.4507598647576, 487.83407655702865, 510.6348960493249, 513.4531723714247, 28930.566041509366, 30937.0, 37532.81233593828, 38117.0, 38345.424818627675, 34049.0, 40569.78290651278, 40617.907313902855, 40662.0, 40739.79630101853, 8160.428769986103, 9183.678571250024, 9480.146786789188, 9489.620415183419, 9490.857637135448, 8497.660093596249, 8715.0, 9282.211012063948, 11152.944235278812, 11413.600523981662, 11330.886691133106, 11338.943305283463, 11352.262102963323, 11366.772664546705, 11376.601818936339, 8487.40588158829, 11314.547418103308, 11389.54441822326, 11403.771924561463, 11406.315621062762, 8422.494650321001, 11052.834207486894, 11344.829827552594, 11364.715882102932, 11504.0, 38480.422793658116, 38710.0, 38785.224295514214, 38787.0, 38817.80591097055, 3314.254292784128, 3349.330133973215, 3372.881949131793, 3376.0, 3455.9459364893696, 26937.86531067352, 27142.235754675883, 29697.109086727432, 29951.850240748874, 30755.69244307573, 2748.560230363132, 3093.427715872571, 3094.845257737104, 3190.96809031909, 3230.370077834823, 467385.0, 467834.0, 471683.0, 472067.6396618029, 478334.0, 55623.16565251524, 55792.721036394556, 55800.0, 55841.44158558363, 55934.0, 33033.339333213204, 33549.66450335514, 33670.663293367244, 34917.0, 58102.0, 16049.438269660739, 16166.524197297638, 16174.0, 16199.0, 16200.108994005443, 11290.491927863266, 12377.938110309391, 12460.81308780369, 12481.625551233477, 12516.249025058525, 15577.922110389602, 16027.519174424786, 18049.368272110674, 18373.908130459262, 18603.0, 7580.0, 7707.714207227253, 7708.498947568502, 7785.493942893694, 7792.999695117421, 834.2950207075012, 864.6411739128191, 972.8346181149221, 990.8605104130307, 1022.243539780572, 24040.75959240385, 28523.42953140967, 28828.99098531583, 29322.706772932423, 29353.266168345963, 1050.6217761605815, 1059.3114475590928, 1060.8620879285797, 1062.675883855416, 1109.0573012938937, 14964.925175374054, 15085.47200847965, 15107.0, 15345.232738363036, 15488.993215441185, 638965.0, 645417.0, 645976.0, 647266.0, 647713.0, 55101.44898550963, 55734.0, 55836.64980101207, 55845.0, 55890.0, 1225.6874497003384, 1270.5680068776476, 1335.4124185358412, 1377.3801789194902, 1396.5461225101678, 29143.271418214714, 29978.0, 30254.84872575623, 30547.2363190922, 30768.924401962053, 45765.08469830651, 46341.0, 46358.30462543132, 46599.76700116478, 46604.0, 456203.0, 543008.0, 544056.0, 544082.0, 544894.0, 24280.1501947431, 25523.6171457432, 25839.354016149748, 26084.73915260899, 26332.73667263303, 45268.320975186056, 45284.773576131905, 45709.0, 45833.77083114563, 46502.76748616235, 33017.51421186004, 36777.81611091927, 37156.07109822276, 38710.2257954845, 38834.0, 33510.0, 37092.443613345284, 37298.6270137306, 38262.80868595639, 38272.42591361188, 36266.456003159445, 36804.631953680124, 37302.44046339253, 37340.43989340217, 37479.625203747615, 28662.14013579596, 31340.05979820609, 32674.673253267163, 33468.66531334655, 34887.47668785021, 19639.70540441923, 23395.436883530663, 24691.506169876862, 25125.623115652914, 25138.49723005493], "value": 19224.96433883578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.40599154475444, 356.6184182924272, 364.8358238792543, 371.37608817187123, 391.1160776644782, 14800.6299842504, 15018.77471837922, 15693.607659808526, 19787.208511659515, 20452.89773551134, 17498.475045748615, 19520.0, 20907.477313067142, 21235.027096206504, 21352.25267115651, 5565.359983601887, 5969.552283578727, 5972.283326000886, 5972.6715030673295, 5996.670183139926, 4653.302004699289, 5885.264341957255, 5943.64338139713, 5951.88096238075, 5966.642001479903, 5579.581531385163, 5876.588638795286, 5891.175235467017, 5901.350851406363, 5902.6458412495385, 5653.1520271959125, 5824.155497452888, 5839.591228613998, 5846.327672317695, 5850.619709718854, 5045.369328833895, 5106.64253502255, 5108.489151084899, 5117.1556693145585, 5344.43883392246, 12844.871551284554, 12980.935095324463, 13123.212607243597, 13126.343682815821, 13133.474661013644, 2231.787980141884, 2275.0444813178506, 2290.530441259538, 2390.7329115568605, 2822.32264256579, 10170.59317627294, 10661.840072398843, 12586.622401327882, 14662.607052330011, 14897.478588249467, 1758.261530157337, 1832.3403574713093, 1834.5230240137528, 1845.952302974364, 1859.1355019915804, 106954.46522767414, 117825.41087294594, 118582.40708796486, 119163.14644937188, 122230.0, 11220.102391808636, 11252.099832013419, 11438.370889600985, 11439.88560114405, 11620.360880151673, 14482.855171448362, 14509.709805803825, 14519.491817786327, 14524.419023239163, 14529.636759081108, 8314.293285070717, 8471.449355791854, 8524.914750852537, 8533.402661813738, 8605.612747426381, 8383.11977242393, 8403.0, 8560.272376847914, 8563.0, 8613.855942580913, 4418.33724941255, 4496.4487251898045, 4538.750368729686, 4572.74849883253, 4616.399868017136, 1868.1313189366738, 1879.257693211174, 1884.547708549938, 1887.3582981786258, 1895.469268604793, 674.1068084787578, 709.620511600706, 793.4049462902823, 920.5627327019746, 931.6366617019368, 20391.082401291977, 21877.781222187576, 21930.0, 22102.336929892128, 22108.0, 738.512581696078, 906.9138431848963, 937.1986951156799, 945.3807755919884, 1017.8829434615114, 11014.669559913216, 11341.546338146547, 11434.142439317084, 11463.942680286546, 11600.941995290139, 579224.0, 583461.0, 587317.3804785863, 593339.0, 594516.0, 96273.0, 121838.3908080454, 125704.0, 127110.45779084366, 128812.06781898279, 896.914793094668, 981.5239608789731, 1013.7566983923805, 1056.4136904018344, 1059.9311044782064, 18922.959237242085, 19270.71093933564, 19329.710054349478, 19335.51661208481, 19350.0, 52568.0, 52695.0, 54054.189187163014, 54597.454025459236, 55166.72416637891, 75998.86001709868, 77445.0, 77845.22154778606, 78446.0, 79418.60290698509, 6965.0, 7945.960270198612, 8009.359251260002, 8059.4209852846525, 8271.296939760188, 9090.13643703847, 12099.81850272229, 12472.5010999559, 12958.870411296144, 13011.284379359226, 9273.76815579589, 11321.377324247245, 11377.0, 11397.772044558897, 11777.116716246144, 9399.859002114837, 10338.276320657482, 11156.442177891235, 11629.88370116288, 11689.707757305796, 11186.32882027081, 11627.720950695586, 11688.94155529217, 11852.881471185523, 11873.584424545099, 8013.198680132174, 8114.797130071795, 8243.464174828618, 8250.886130372322, 8386.0, 10640.308379955588, 11379.905217029262, 11535.711607209887, 11653.242539234923, 11708.004819590431], "value": 9319.894235239883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.1340935666672, 1574.4017273436095, 1771.2029586685987, 1835.1925152932718, 1919.7600299962505, 8523.914760852389, 8977.281817454605, 8979.775505612362, 8980.057094005133, 8994.595243214055, 7920.80197995049, 8169.754907352774, 8490.150984901507, 8743.606537705802, 8744.519051452167, 2308.9884550577267, 2336.754640762721, 2338.9298321050396, 2342.6954495915506, 2347.8239132065078, 2303.216906251874, 2320.3039088273536, 2353.8469999450067, 2356.3873392917794, 2358.3278765551822, 1955.8728682635654, 2325.860448373103, 2354.411397150712, 2354.5761762882676, 2366.680498132756, 2312.583734927712, 2314.560233555619, 2318.5710643530915, 2320.44309365751, 2325.848819826706, 2317.895694693743, 2319.3621754017613, 2322.291701031185, 2324.5118525109747, 2325.8720770357622, 8858.424202426886, 8884.11158884113, 8995.055519170459, 9009.594568244445, 9017.729468115967, 5163.096458119814, 5329.173978033372, 5335.0930341841595, 5350.892982140335, 5352.892942141136, 3242.96757032429, 3384.560007199073, 3456.2914602506426, 3556.0754203906913, 3593.0298819318637, 1013.5033833421644, 1052.2844465763278, 1054.393723608928, 1076.364944682641, 1077.3535878472853, 11600.30398176112, 11739.47172377245, 11798.764024719543, 11804.0, 11811.704707382298, 4505.324201369821, 4576.496585375606, 4760.571548560577, 4763.880902977453, 4785.784639691153, 9884.752881178028, 9896.059874312074, 9896.307258491981, 9900.455474948947, 9910.306278560576, 5339.41266460689, 5347.1979203119845, 5353.785848566014, 5354.544863686552, 5355.7054362009685, 4305.991809470824, 4375.7155784873885, 4551.362809206714, 4752.097101550694, 4866.367372241657, 3843.5964223756105, 3864.671502922227, 3995.700322475826, 3998.1803730235233, 4000.4199391088127, 1251.5431867368345, 1255.5919326219016, 1267.702090008847, 1269.5429645327674, 1288.8066789981578, 801.3469022746443, 902.9683961061331, 908.3686837647772, 909.6679711905107, 919.7654598077581, 5813.883722325614, 5936.584439089309, 6006.849828754316, 6062.727177277033, 6219.19643303446, 908.182635627927, 932.7994481186578, 937.315759495572, 939.487979051405, 973.124188230584, 3862.9806850965565, 3922.7842468663926, 3926.234384295035, 4010.8970033241094, 4089.0595163112057, 10566.31318964265, 10837.078848297826, 10924.96212859777, 10963.013328800445, 11012.229143960007, 10924.726881828017, 10926.617568385069, 10928.890711092947, 10931.125509959184, 10941.945290273497, 8206.958965205136, 8329.66681332752, 8331.0, 8333.916660833314, 8357.540335281496, 5533.612647114664, 5783.884322313615, 5873.911891321719, 5948.762049517971, 5967.46292833647, 10149.34029288094, 10183.898161018295, 10199.949000254952, 10215.182785377301, 10271.589136434757, 9890.406575605486, 10242.692719218436, 10269.486525673537, 10281.948590257001, 10296.485175741333, 6977.1976222733, 7169.318914703095, 7433.516821406592, 7603.2776886195725, 7604.733834315773, 6480.611163330215, 7933.325667318342, 8017.238362355567, 8238.09380968105, 8466.068732439304, 6274.937250627435, 7502.512336698315, 7513.436492262993, 7574.356179724785, 7684.923150768421, 7292.34368906801, 7347.044884165024, 7394.593297368481, 7410.147832999274, 7526.548407095592, 6733.966330168318, 6909.861802764017, 7004.509684322048, 7062.929370706227, 7066.328698773608, 5002.17464118431, 5017.297578338962, 5057.31726216956, 5061.114304996685, 5156.9742151289, 4937.1113199624415, 5049.141645920276, 5049.2426136079885, 5173.1464308388695, 5229.686218826882], "value": 4587.24934349696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.6996418778189, 292.71167899618877, 302.58092541829564, 308.23250107232997, 310.2940809658026, 5271.364317841079, 5272.4727527247305, 5336.466353364662, 5340.465953404658, 5416.945830541694, 5083.035232518641, 5225.126180600664, 5285.286486324345, 5309.893802123965, 5322.403279016299, 3395.0, 4056.472658554384, 4069.6540794032544, 4081.469408976829, 4089.3048181809163, 3399.881004164855, 4089.5073298246075, 4094.4677191965, 4103.712740108193, 4145.212409642173, 3917.6278253565865, 3988.985562291039, 4017.7388469749517, 4037.8182981765744, 4124.896877578055, 3305.4545999909988, 4028.3756017817286, 4029.657479114279, 4041.5756345583586, 4048.797560121997, 2846.889713011927, 2990.596269503633, 3079.6757394320434, 3475.721942244614, 3496.4405695088917, 4278.2940814765525, 4949.975250123763, 4970.329005584272, 5176.870578235536, 5208.7916483341, 3722.3858063419775, 4005.559388467266, 4517.390152329426, 4533.705309154927, 4610.446746390455, 5071.771770270347, 5327.706976116312, 5512.448755124496, 5557.833265002016, 5566.159350048453, 3862.382018876994, 3866.709996750255, 3907.179492306619, 3913.6086391360923, 3931.9973406781087, 4477.3731677565165, 5665.383906924407, 5782.681952492653, 5807.912881306784, 5817.952768501668, 3088.44408006561, 3457.792532448061, 3814.408766641175, 3909.9218015639526, 3914.373700207953, 3931.567527571965, 3959.425883246913, 3960.3069462843887, 4012.6789856811383, 4030.3349947258375, 4088.4889388826396, 4286.935695964563, 4637.86086417408, 4650.95349046512, 4651.744154071558, 4823.541763532458, 5418.997485465202, 5565.41563135873, 5642.915356269659, 5734.5125664319, 1110.8889111088827, 1342.4160490186605, 1368.3921392363932, 1368.8288963879515, 1376.0460146591863, 797.0992778160642, 846.5439444156042, 854.8418542569644, 861.9224269815621, 862.4307956748642, 3915.295246855593, 4168.499780026355, 4175.617749622816, 4307.652329480441, 4320.546342634041, 4049.919001619951, 4058.6144316290497, 4417.845375411845, 4683.555062269079, 4844.304493427272, 4128.566500517462, 4314.0, 4328.978355108267, 4338.349247612883, 4374.62815660666, 2297.7936583293904, 2356.7525409832065, 2359.1480687660105, 2386.0217310902794, 2577.832440891336, 4765.475797662254, 4924.606031517542, 5009.423916249605, 5019.84940451787, 5026.768441731799, 4067.3085575452246, 4265.675207012124, 4335.9187589957, 4779.0, 4875.2454863002995, 4094.3244364679495, 4383.890402739957, 4929.2254788276905, 5019.82430614934, 5061.431690658077, 3978.5822488638278, 4275.6365708913845, 4848.781804818721, 4877.5366340197625, 4878.780454879468, 4291.592298731615, 4371.688493452015, 4453.55464453552, 4613.907721845477, 4713.67004309695, 4252.745440095241, 4753.168195565693, 4937.456879743154, 5636.549076073986, 6077.84236596002, 3412.5904891412197, 3657.6708096271464, 3876.476675648751, 3891.9221615568094, 3909.6481316681634, 4915.926261106015, 5284.260203571426, 5722.484976352148, 5866.6186697864505, 5924.674142922181, 5350.859656137421, 5364.64783618574, 5604.8038318658655, 5681.318241810844, 5748.798792042258, 4519.728816271035, 4664.510226426177, 5273.44628813969, 5565.30433695788, 5565.6104072714525, 5480.629412911111, 5492.47821456961, 5525.889482210253, 5537.224788529528, 5602.187682786055, 5198.6880787152895, 5312.681239125664, 5539.556835453073, 5582.804601838916, 5608.38307786135, 4710.317004034464, 5360.195970604441, 5456.727163641723, 5458.4814442627885, 5593.412691667317], "value": 3851.999995157533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.6228749612717, 710.4352040128099, 742.8625704244719, 765.6439755513685, 819.5328662662283, 15044.323005464754, 15734.606634834106, 15737.370505179808, 15757.60605984851, 16135.273912673929, 14103.0, 14213.218272994982, 14224.573262802107, 14227.573172804832, 14248.14511129333, 596.6449962272462, 687.4363022321699, 720.6324774365086, 856.5075081827943, 862.8446879561676, 874.9387542872001, 878.1745159550003, 896.5427631907709, 896.8251191017754, 897.7037577599376, 942.4486675294927, 943.3302355327726, 944.3767113704956, 945.7588314979671, 947.313197931501, 725.3906718356606, 751.1887161865227, 937.9531023448834, 938.816930698514, 939.5161491831747, 669.3306693306694, 688.8518968421813, 692.4495026453981, 692.504859025799, 692.6432887063166, 14907.403703851833, 14979.400823967027, 14982.400703971827, 14992.0, 14999.700005999819, 13351.198928064347, 13533.458661653522, 13805.17168969865, 13824.930875345659, 13946.673311736855, 12361.690957726129, 12364.629061128091, 12392.690182745413, 12422.130450868352, 12787.424565894464, 4404.11917616478, 4422.513523512411, 4478.1043791241555, 4530.592246697813, 4539.387182730322, 108029.0, 108157.13292901759, 113935.29097063468, 115915.51056117985, 119978.0, 10599.682009539727, 10848.511816968256, 10928.961748633867, 10997.285176463503, 11018.173636977259, 21675.458113547287, 21702.023408946636, 21707.674384884238, 21744.238951636617, 21755.564888702138, 6367.395097465734, 6584.473242140617, 7777.533347999138, 7856.84286314282, 7871.763847084597, 4268.253055715238, 4298.8280468780895, 4339.696221264544, 4381.474223093249, 4518.073794872043, 3400.8639654413546, 3574.0171452850673, 3577.7853328800356, 3578.0, 3578.5526809148855, 643.4852118305431, 656.0520048529828, 661.2792056658266, 661.2825084782968, 665.5308007854451, 511.68717397364446, 516.8707823044239, 554.0553356527112, 556.9622762116664, 631.8167731357855, 8960.507172105597, 9554.856677149848, 9608.519574021271, 9719.708408747749, 9759.951200243953, 540.6918056707717, 552.4751486088232, 643.3052303512289, 651.9380658837403, 671.4561205423622, 4639.582437580634, 4700.576948074689, 4738.4787673356595, 4744.95610965587, 4775.2359622460235, 86528.70206946901, 123565.08306295537, 144076.5592344063, 150415.0, 163466.0, 82357.0, 83816.68474755951, 110757.0, 139184.6081539192, 141604.0, 117282.41358793151, 118152.0, 118591.0, 120607.39696301462, 122306.77693223133, 7051.224365319708, 8731.0, 8754.387192896436, 8798.560071996502, 8911.777205569653, 61738.0, 62038.689806550676, 63434.365656342845, 64158.0, 66020.0, 84367.5781621088, 94596.05403945873, 97303.02696973222, 98533.50733246288, 98566.01433985568, 11460.598879039193, 11883.287002779862, 11988.0, 11999.580014699444, 12190.512379505075, 12966.740665186831, 13340.733185336045, 13431.0, 13520.0, 13537.255450950292, 11587.652370428901, 12240.892311830932, 12577.119601627799, 12638.936805316282, 14017.0, 13103.0, 13340.382764141968, 13600.727985440433, 13750.862491374959, 14260.42958281657, 13359.0, 13424.731505370033, 13427.932860336026, 13733.244671543162, 13866.930665346608, 10686.57253709874, 11193.832092518456, 11569.041943398988, 11583.362915039754, 11610.593629222936, 10280.691579252634, 11329.660110196708, 11425.771484570096, 11578.884211157781, 11624.825627615422], "value": 7720.994866014033, "unit": "score"}], "name": "dromaeo_css", "value": 7200.472680495791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 113.0, 116.0, 151.0, 118.0, 113.0, 118.0, 114.0, 145.0, 114.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 186.0, 186.0, 185.0, 184.0, 182.0, 185.0, 186.0, 184.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 83.0, 121.0, 86.0, 59.0, 60.0, 59.0, 85.0, 58.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 75.0, 120.0, 101.0, 79.0, 69.0, 93.0, 70.0, 69.0, 92.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 93.0, 89.0, 92.0, 88.0, 96.0, 89.0, 92.0, 89.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 108.0, 147.0, 148.0, 97.0, 99.0, 97.0, 102.0, 150.0, 128.0], "value": 117.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 79.0, 78.0, 84.0, 82.0, 85.0, 83.0, 81.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 76.0, 80.0, 80.0, 80.0, 53.0, 55.0, 53.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 80.0, 76.0, 72.0, 72.0, 69.0, 71.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 96.0, 99.0, 105.0, 102.0, 89.0, 85.0, 88.0, 87.0, 88.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 148.0, 145.0, 145.0, 148.0, 146.0, 145.0, 238.0, 148.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 180.0, 171.0, 223.0, 231.0, 184.0, 173.0, 171.0, 166.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1511.4999999999998, "alertThreshold": 2.0}]} 11:12:08 INFO - Return code: 0 11:12:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:12:08 INFO - # TBPL SUCCESS # 11:12:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:08 INFO - 2016-10-17 11:12:08.890 screenresolution[1953:21003] starting screenresolution argv=screenresolution get 11:12:08 INFO - 2016-10-17 11:12:08.892 screenresolution[1953:21003] Display 0: 1600x1200x32@60 11:12:08 INFO - 2016-10-17 11:12:08.898 screenresolution[1954:21006] starting screenresolution argv=screenresolution list 11:12:08 INFO - Available Modes on Display 0 11:12:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:09 INFO - Intel Iris: 11:12:09 INFO - Chipset Model: Intel Iris 11:12:09 INFO - Type: GPU 11:12:09 INFO - Bus: Built-In 11:12:09 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:09 INFO - Vendor: Intel (0x8086) 11:12:09 INFO - Device ID: 0x0a2e 11:12:09 INFO - Revision ID: 0x0009 11:12:09 INFO - Displays: 11:12:09 INFO - Display: 11:12:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:09 INFO - Display Serial Number: 1600x1200 60 11:12:09 INFO - Main Display: Yes 11:12:09 INFO - Mirror: Off 11:12:09 INFO - Online: Yes 11:12:09 INFO - Rotation: Supported 11:12:09 INFO - Return code: 0 11:12:09 INFO - Running post-action listener: _resource_record_post_action 11:12:09 INFO - [mozharness: 2016-10-17 18:12:09.132952Z] Finished run-tests step (success) 11:12:09 INFO - Running post-run listener: _resource_record_post_run 11:12:09 INFO - Total resource usage - Wall time: 1217s; CPU: 54.0%; Read bytes: 933888; Write bytes: 707606528; Read time: 13; Write time: 1989 11:12:09 INFO - TinderboxPrint: CPU usage
53.8% 11:12:09 INFO - TinderboxPrint: I/O read bytes / time
933,888 / 13 11:12:09 INFO - TinderboxPrint: I/O write bytes / time
707,606,528 / 1,989 11:12:09 INFO - TinderboxPrint: CPU idle
2,249.0 (46.2%) 11:12:09 INFO - TinderboxPrint: CPU system
978.6 (20.1%) 11:12:09 INFO - TinderboxPrint: CPU user
1,642.1 (33.7%) 11:12:09 INFO - TinderboxPrint: Swap in / out
406,757,376 / 0 11:12:09 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 393292288; Write bytes: 387278848; Read time: 30091; Write time: 658 11:12:09 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 933888; Write bytes: 298807296; Read time: 13; Write time: 1284 11:12:09 INFO - Running post-run listener: _upload_blobber_files 11:12:09 INFO - Blob upload gear active. 11:12:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:09 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 11:12:09 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:09 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:10 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:12:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:12:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:11 INFO - (blobuploader) - INFO - Done attempting. 11:12:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:12:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:12:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:12 INFO - (blobuploader) - INFO - Done attempting. 11:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:16 INFO - (blobuploader) - INFO - Done attempting. 11:12:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:16 INFO - Return code: 0 11:12:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/23ee4ee8ae76fa1e1468b31f85665003e45d0443c23d201b5177fcaf2c6e16c8ee1423208ce26dd395ac0474a85ed4b1e423b680d0222a4036aaba2bfb93e59a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fb93c23d964e0b38a3a5467eb081b1b1ef67cd339b56d68068b34853308afa54d9821feee13ebf8b005548f18e8e8a035a4c6e5def3fe7c29350430c0a84778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f41fadd50cbcc8aa17acd14c5cee94d18f1e4da0f072952a234102104c5b589a8fddb0bfd14132dd318144308269cc6fada0a295e7dcce38bb4a0c3c55dbc719"} 11:12:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:16 INFO - Contents: 11:12:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/23ee4ee8ae76fa1e1468b31f85665003e45d0443c23d201b5177fcaf2c6e16c8ee1423208ce26dd395ac0474a85ed4b1e423b680d0222a4036aaba2bfb93e59a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fb93c23d964e0b38a3a5467eb081b1b1ef67cd339b56d68068b34853308afa54d9821feee13ebf8b005548f18e8e8a035a4c6e5def3fe7c29350430c0a84778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f41fadd50cbcc8aa17acd14c5cee94d18f1e4da0f072952a234102104c5b589a8fddb0bfd14132dd318144308269cc6fada0a295e7dcce38bb4a0c3c55dbc719"} 11:12:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:16 INFO - Copying logs to upload dir... 11:12:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.669390 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-10-17 11:12:16.420369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:16.424302) ========= 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.wFZLgoSqOg/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.hBWdXigMyh/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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/Autoland/sha512/23ee4ee8ae76fa1e1468b31f85665003e45d0443c23d201b5177fcaf2c6e16c8ee1423208ce26dd395ac0474a85ed4b1e423b680d0222a4036aaba2bfb93e59a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fb93c23d964e0b38a3a5467eb081b1b1ef67cd339b56d68068b34853308afa54d9821feee13ebf8b005548f18e8e8a035a4c6e5def3fe7c29350430c0a84778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f41fadd50cbcc8aa17acd14c5cee94d18f1e4da0f072952a234102104c5b589a8fddb0bfd14132dd318144308269cc6fada0a295e7dcce38bb4a0c3c55dbc719"} build_url:https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/DXkYqvzNRo6tTMI2dti9ig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/23ee4ee8ae76fa1e1468b31f85665003e45d0443c23d201b5177fcaf2c6e16c8ee1423208ce26dd395ac0474a85ed4b1e423b680d0222a4036aaba2bfb93e59a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fb93c23d964e0b38a3a5467eb081b1b1ef67cd339b56d68068b34853308afa54d9821feee13ebf8b005548f18e8e8a035a4c6e5def3fe7c29350430c0a84778", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f41fadd50cbcc8aa17acd14c5cee94d18f1e4da0f072952a234102104c5b589a8fddb0bfd14132dd318144308269cc6fada0a295e7dcce38bb4a0c3c55dbc719"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:16.457641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:16.458029) ========= 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.wFZLgoSqOg/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.hBWdXigMyh/Listeners TMPDIR=/var/folders/9c/2dh985pd15l19fywb0pq404000000w/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.005043 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:16.507288) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 11:12:16.507624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 11:12:16.508068) ========= ========= Total master_lag: 0.18 =========