builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0320 starttime: 1475749573.03 results: success (0) buildid: 20161006014700 builduid: 9f2208d618e04c1ab6f2772db863358a revision: 43bc30457ad4b4d9507b0dce05ffe5a76e88229f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:13.033475) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:13.033871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-10-06 03:26:13.034159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2016-10-06 03:26:19.577860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:19.578231) ========= 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.obDSnmcxfk/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.9NxXZBMM3S/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-06 03:26:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2016-10-06 03:26:19 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136949 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:20.056604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:20.056948) ========= 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.obDSnmcxfk/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.9NxXZBMM3S/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.020488 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:20.101016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 03:26:20.101371) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 43bc30457ad4b4d9507b0dce05ffe5a76e88229f --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 43bc30457ad4b4d9507b0dce05ffe5a76e88229f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.obDSnmcxfk/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.9NxXZBMM3S/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-06 03:26:20,180 truncating revision to first 12 chars 2016-10-06 03:26:20,180 Setting DEBUG logging. 2016-10-06 03:26:20,180 attempt 1/10 2016-10-06 03:26:20,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/43bc30457ad4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 03:26:20,977 unpacking tar archive at: autoland-43bc30457ad4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.068769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 03:26:21.194842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:21.195162) ========= script_repo_revision: 43bc30457ad4b4d9507b0dce05ffe5a76e88229f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:21.195543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:21.195830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:26:21.218455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 03:26:21.218855) ========= /tools/buildbot/bin/python 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', '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:26:21 INFO - MultiFileLogger online at 20161006 03:26:21 in /builds/slave/test 03:26:21 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 03:26:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:21 INFO - {'append_to_log': False, 03:26:21 INFO - 'base_work_dir': '/builds/slave/test', 03:26:21 INFO - 'blob_upload_branch': 'Autoland', 03:26:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:21 INFO - 'branch': 'Autoland', 03:26:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:21 INFO - 'config_files': ('talos/mac_config.py',), 03:26:21 INFO - 'default_actions': ('clobber', 03:26:21 INFO - 'read-buildbot-config', 03:26:21 INFO - 'download-and-extract', 03:26:21 INFO - 'populate-webroot', 03:26:21 INFO - 'create-virtualenv', 03:26:21 INFO - 'install', 03:26:21 INFO - 'run-tests'), 03:26:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:21 INFO - 'download_minidump_stackwalk': True, 03:26:21 INFO - 'download_symbols': 'ondemand', 03:26:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:21 INFO - 'installer_path': 'installer.exe', 03:26:21 INFO - 'log_level': 'info', 03:26:21 INFO - 'log_name': 'talos', 03:26:21 INFO - 'log_to_console': True, 03:26:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:26:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:26:21 INFO - 'opt_config_files': (), 03:26:21 INFO - 'pip_index': False, 03:26:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:21 INFO - 'cmd': ('bash', 03:26:21 INFO - '-c', 03:26:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:21 INFO - 'enabled': True, 03:26:21 INFO - 'halt_on_failure': False, 03:26:21 INFO - 'name': 'check_screen_resolution'},), 03:26:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:21 INFO - 'cmd': ('bash', 03:26:21 INFO - '-c', 03:26:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:21 INFO - 'enabled': True, 03:26:21 INFO - 'halt_on_failure': False, 03:26:21 INFO - 'name': 'check_screen_resolution'},), 03:26:21 INFO - 'run_cmd_checks_enabled': True, 03:26:21 INFO - 'sps_profile': False, 03:26:21 INFO - 'sps_profile_interval': 0, 03:26:21 INFO - 'suite': 'dromaeojs', 03:26:21 INFO - 'system_bits': '32', 03:26:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:21 INFO - 'title': 't-yosemite-r7-0320', 03:26:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:21 INFO - 'use_talos_json': True, 03:26:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:21 INFO - 'work_dir': 'build'} 03:26:21 INFO - [mozharness: 2016-10-06 10:26:21.412884Z] Running clobber step. 03:26:21 INFO - Running pre-action listener: _resource_record_pre_action 03:26:21 INFO - Running main action method: clobber 03:26:21 INFO - rmtree: /builds/slave/test/build 03:26:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:22 INFO - Running post-action listener: _resource_record_post_action 03:26:22 INFO - [mozharness: 2016-10-06 10:26:22.916913Z] Finished clobber step (success) 03:26:22 INFO - [mozharness: 2016-10-06 10:26:22.917129Z] Running read-buildbot-config step. 03:26:22 INFO - Running pre-action listener: _resource_record_pre_action 03:26:22 INFO - Running main action method: read_buildbot_config 03:26:22 INFO - Using buildbot properties: 03:26:22 INFO - { 03:26:22 INFO - "project": "", 03:26:22 INFO - "product": "firefox", 03:26:22 INFO - "script_repo_revision": "production", 03:26:22 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 03:26:22 INFO - "repository": "", 03:26:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 03:26:22 INFO - "buildid": "20161006014700", 03:26:22 INFO - "pgo_build": "False", 03:26:22 INFO - "basedir": "/builds/slave/test", 03:26:22 INFO - "buildnumber": 347, 03:26:22 INFO - "slavename": "t-yosemite-r7-0320", 03:26:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:26:22 INFO - "platform": "yosemite_r7", 03:26:22 INFO - "scheduler": "tests-autoland-macosx64-talos", 03:26:22 INFO - "branch": "autoland", 03:26:22 INFO - "repo_path": "integration/autoland", 03:26:22 INFO - "revision": "43bc30457ad4b4d9507b0dce05ffe5a76e88229f", 03:26:22 INFO - "stage_platform": "macosx64", 03:26:22 INFO - "builduid": "9f2208d618e04c1ab6f2772db863358a", 03:26:22 INFO - "slavebuilddir": "test" 03:26:22 INFO - } 03:26:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:26:22 INFO - Running post-action listener: _resource_record_post_action 03:26:22 INFO - [mozharness: 2016-10-06 10:26:22.922533Z] Finished read-buildbot-config step (success) 03:26:22 INFO - [mozharness: 2016-10-06 10:26:22.922718Z] Running download-and-extract step. 03:26:22 INFO - Running pre-action listener: _resource_record_pre_action 03:26:22 INFO - Running main action method: download_and_extract 03:26:22 INFO - mkdir: /builds/slave/test/build/tests 03:26: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')]} 03:26:22 INFO - trying https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:26:22 INFO - Downloading https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/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 03:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/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 03:26:23 INFO - Downloaded 1199 bytes. 03:26:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:26:23 INFO - Using the following test package requirements: 03:26:23 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:26:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:26:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:26:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'jsshell-mac.zip'], 03:26:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:26:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:26:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:26:23 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:26:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:26:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:26:23 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:26:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:26:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:26:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:26:23 INFO - Fetch https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:26:24 INFO - Http code: 200 03:26:24 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 03:26:24 INFO - x-amz-cf-id: 1RRKgQxFLKcyIgE-OdM5WIe91wajZv-PhLyrAJ6BMN_Qwn3estabnw== 03:26:24 INFO - x-amz-version-id: z6VDxNi92YZsO3cvKL51I6sHqzr1tWck 03:26:24 INFO - Expected file size: 16477190 03:26:24 INFO - Obtained file size: 16477190 03:26:31 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 03:26:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:26:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:26:31 INFO - Fetch https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:26:31 INFO - Http code: 200 03:26:31 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 03:26:31 INFO - x-amz-cf-id: UlFTzsHAcMsqRqT_9OT60IGRPtLuG8ap1VgUmUAcoeSEVtEsjeEm6w== 03:26:31 INFO - x-amz-version-id: z6VDxNi92YZsO3cvKL51I6sHqzr1tWck 03:26:32 INFO - Expected file size: 16477190 03:26:32 INFO - Obtained file size: 16477190 03:26:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:26:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:26:38 INFO - Fetch https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:26:39 INFO - Http code: 200 03:26:39 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 03:26:39 INFO - x-amz-cf-id: Gn_T4nk1iWD-KbWcPf2z6lNohZShhrOHZueIzbIgGpZLxOMGyS_9-g== 03:26:39 INFO - x-amz-version-id: PUJOQpRF67EwpQinmvf7yjrj07D0NA4N 03:26:39 INFO - Expected file size: 14409006 03:26:39 INFO - Obtained file size: 14409006 03:26: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')]} 03:26:40 INFO - trying https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:26:40 INFO - Downloading https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/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 03:26:42 INFO - Downloaded 111632265 bytes. 03:26:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:26:42 INFO - mkdir: /builds/slave/test/properties 03:26:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:42 INFO - Contents: 03:26:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:26:43 INFO - Running post-action listener: _resource_record_post_action 03:26:43 INFO - Running post-action listener: set_extra_try_arguments 03:26:43 INFO - [mozharness: 2016-10-06 10:26:43.612787Z] Finished download-and-extract step (success) 03:26:43 INFO - [mozharness: 2016-10-06 10:26:43.612906Z] Running populate-webroot step. 03:26:43 INFO - Running pre-action listener: _resource_record_pre_action 03:26:43 INFO - Running main action method: populate_webroot 03:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:43 INFO - '--tppagecycles', 03:26:43 INFO - '7'], 03:26:43 INFO - 'tests': ['tsvgm']}}, 03:26:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['damp', 'tps']}, 03:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'tests': ['damp', 'tps']}, 03:26:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['dromaeo_dom']}, 03:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['basic_compositor_video']}, 03:26:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:26:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['a11yr', 03:26:43 INFO - 'ts_paint', 03:26:43 INFO - 'tpaint', 03:26:43 INFO - 'sessionrestore', 03:26:43 INFO - 'sessionrestore_no_auto_restore', 03:26:43 INFO - 'tabpaint']}, 03:26:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:43 INFO - 'ts_paint', 03:26:43 INFO - 'tpaint', 03:26:43 INFO - 'sessionrestore', 03:26:43 INFO - 'sessionrestore_no_auto_restore', 03:26:43 INFO - 'tabpaint']}, 03:26:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:43 INFO - 'ts_paint', 03:26:43 INFO - 'tpaint', 03:26:43 INFO - 'sessionrestore', 03:26:43 INFO - 'sessionrestore_no_auto_restore', 03:26:43 INFO - 'tabpaint']}, 03:26:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:43 INFO - 'ts_paint', 03:26:43 INFO - 'tpaint', 03:26:43 INFO - 'sessionrestore', 03:26:43 INFO - 'sessionrestore_no_auto_restore', 03:26:43 INFO - 'tabpaint']}, 03:26:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['a11yr', 03:26:43 INFO - 'ts_paint', 03:26:43 INFO - 'tpaint', 03:26:43 INFO - 'sessionrestore', 03:26:43 INFO - 'sessionrestore_no_auto_restore', 03:26:43 INFO - 'tabpaint']}, 03:26:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['a11yr', 03:26:43 INFO - 'ts_paint', 03:26:43 INFO - 'tpaint', 03:26:43 INFO - 'sessionrestore', 03:26:43 INFO - 'sessionrestore_no_auto_restore', 03:26:43 INFO - 'tabpaint']}, 03:26:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['tsvgx', 03:26:43 INFO - 'tsvgr_opacity', 03:26:43 INFO - 'tart', 03:26:43 INFO - 'tscrollx', 03:26:43 INFO - 'cart']}, 03:26:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:43 INFO - 'tsvgr_opacity', 03:26:43 INFO - 'tart', 03:26:43 INFO - 'tscrollx', 03:26:43 INFO - 'cart']}, 03:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'talos_options': ['--disable-e10s'], 03:26:43 INFO - 'tests': ['tp5o']}, 03:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'tests': ['tp5o']}, 03:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'talos_options': ['--disable-e10s', 03:26:43 INFO - '--xperf_path', 03:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:43 INFO - 'tests': ['tp5n']}, 03:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:43 INFO - 'talos_options': ['--xperf_path', 03:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:43 INFO - 'tests': ['tp5n']}}, 03:26:43 INFO - 'talos.zip': {'path': '', 03:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:43 INFO - Running post-action listener: _resource_record_post_action 03:26:43 INFO - [mozharness: 2016-10-06 10:26:43.631666Z] Finished populate-webroot step (success) 03:26:43 INFO - [mozharness: 2016-10-06 10:26:43.631804Z] Running create-virtualenv step. 03:26:43 INFO - Running pre-action listener: _resource_record_pre_action 03:26:43 INFO - Running main action method: create_virtualenv 03:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:43 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 03:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:43 INFO - Using real prefix '/tools/python27' 03:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:47 INFO - Installing pip.................done. 03:26:47 INFO - Return code: 0 03:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:26:47 INFO - Reading from file tmpfile_stdout 03:26:47 INFO - Output received: 03:26:47 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) 03:26:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:47 INFO - 'HOME': '/Users/cltbld', 03:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PAGER': '/bin/cat', 03:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:26:47 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - 'XPC_FLAGS': '0x0', 03:26:47 INFO - 'XPC_SERVICE_NAME': '0', 03:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 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 03:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:47 INFO - 'HOME': '/Users/cltbld', 03:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PAGER': '/bin/cat', 03:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:26:47 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - 'XPC_FLAGS': '0x0', 03:26:47 INFO - 'XPC_SERVICE_NAME': '0', 03:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:48 INFO - Downloading/unpacking psutil>=3.1.1 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:51 INFO - Installing collected packages: psutil 03:26:51 INFO - Running setup.py install for psutil 03:26:51 INFO - building 'psutil._psutil_osx' extension 03:26:51 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 INFO - building 'psutil._psutil_posix' extension 03:26:52 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 03:26:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:26:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:26:52 INFO - ^ 03:26:52 INFO - 1 warning generated. 03:26:52 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 03:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:52 INFO - Successfully installed psutil 03:26:52 INFO - Cleaning up... 03:26:52 INFO - Return code: 0 03:26:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:52 INFO - 'HOME': '/Users/cltbld', 03:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:52 INFO - 'LOGNAME': 'cltbld', 03:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:52 INFO - 'MOZ_NO_REMOTE': '1', 03:26:52 INFO - 'NO_EM_RESTART': '1', 03:26:52 INFO - 'PAGER': '/bin/cat', 03:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:52 INFO - 'PWD': '/builds/slave/test', 03:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:52 INFO - 'SHELL': '/bin/bash', 03:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:26:52 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:52 INFO - 'USER': 'cltbld', 03:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:52 INFO - 'XPC_FLAGS': '0x0', 03:26:52 INFO - 'XPC_SERVICE_NAME': '0', 03:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:53 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 03:26:53 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 03:26:53 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 03:26:53 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 03:26:53 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 03:26:53 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 03:26:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:55 INFO - Installing collected packages: mozsystemmonitor 03:26:55 INFO - Running setup.py install for mozsystemmonitor 03:26:55 INFO - Successfully installed mozsystemmonitor 03:26:55 INFO - Cleaning up... 03:26:56 INFO - Return code: 0 03:26:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:56 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')]} 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:56 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')]} 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:56 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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:26:56 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 03:26:56 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 03:26:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:26:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:56 INFO - 'HOME': '/Users/cltbld', 03:26:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:56 INFO - 'LOGNAME': 'cltbld', 03:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:56 INFO - 'MOZ_NO_REMOTE': '1', 03:26:56 INFO - 'NO_EM_RESTART': '1', 03:26:56 INFO - 'PAGER': '/bin/cat', 03:26:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:56 INFO - 'PWD': '/builds/slave/test', 03:26:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:56 INFO - 'SHELL': '/bin/bash', 03:26:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:26:56 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:26:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:56 INFO - 'USER': 'cltbld', 03:26:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:56 INFO - 'XPC_FLAGS': '0x0', 03:26:56 INFO - 'XPC_SERVICE_NAME': '0', 03:26:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:56 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:59 INFO - warning: no files found matching '*.txt' 03:26:59 INFO - no previously-included directories found matching 'build' 03:26:59 INFO - no previously-included directories found matching 'dist' 03:26:59 INFO - no previously-included directories found matching '.git*' 03:26:59 INFO - Installing collected packages: jsonschema, functools32 03:26:59 INFO - Running setup.py install for functools32 03:26:59 INFO - warning: no files found matching '*.txt' 03:26:59 INFO - no previously-included directories found matching 'build' 03:26:59 INFO - no previously-included directories found matching 'dist' 03:26:59 INFO - no previously-included directories found matching '.git*' 03:26:59 INFO - Successfully installed jsonschema functools32 03:26:59 INFO - Cleaning up... 03:26:59 INFO - Return code: 0 03:26:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26:59 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')]} 03:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:59 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')]} 03:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:59 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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:26:59 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 03:26:59 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 03:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:59 INFO - 'HOME': '/Users/cltbld', 03:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:59 INFO - 'LOGNAME': 'cltbld', 03:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:59 INFO - 'MOZ_NO_REMOTE': '1', 03:26:59 INFO - 'NO_EM_RESTART': '1', 03:26:59 INFO - 'PAGER': '/bin/cat', 03:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:59 INFO - 'PWD': '/builds/slave/test', 03:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:59 INFO - 'SHELL': '/bin/bash', 03:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:26:59 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:59 INFO - 'USER': 'cltbld', 03:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:59 INFO - 'XPC_FLAGS': '0x0', 03:26:59 INFO - 'XPC_SERVICE_NAME': '0', 03:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:59 INFO - Cleaning up... 03:26:59 INFO - Return code: 0 03:26:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:59 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')]} 03:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:59 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')]} 03:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:59 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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:26:59 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 03:26:59 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 03:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:59 INFO - 'HOME': '/Users/cltbld', 03:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:59 INFO - 'LOGNAME': 'cltbld', 03:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:59 INFO - 'MOZ_NO_REMOTE': '1', 03:26:59 INFO - 'NO_EM_RESTART': '1', 03:26:59 INFO - 'PAGER': '/bin/cat', 03:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:59 INFO - 'PWD': '/builds/slave/test', 03:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:59 INFO - 'SHELL': '/bin/bash', 03:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:26:59 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:59 INFO - 'USER': 'cltbld', 03:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:59 INFO - 'XPC_FLAGS': '0x0', 03:26:59 INFO - 'XPC_SERVICE_NAME': '0', 03:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:00 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 03:27:00 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 03:27:00 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 03:27:00 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 03:27:00 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 03:27:00 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 03:27:02 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:02 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 03:27:02 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 03:27:02 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 03:27:02 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 03:27:02 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 03:27:02 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 03:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:03 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 03:27:03 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 03:27:03 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 03:27:03 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 03:27:03 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 03:27:03 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 03:27:03 INFO - Downloading docopt-0.6.1.tar.gz 03:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:03 INFO - Running setup.py install for blobuploader 03:27:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:03 INFO - Running setup.py install for requests 03:27:04 INFO - Running setup.py install for docopt 03:27:04 INFO - Successfully installed blobuploader requests docopt 03:27:04 INFO - Cleaning up... 03:27:04 INFO - Return code: 0 03:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:04 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')]} 03:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 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')]} 03:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:27:04 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 03:27:04 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 03:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:04 INFO - 'HOME': '/Users/cltbld', 03:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:04 INFO - 'LOGNAME': 'cltbld', 03:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:04 INFO - 'MOZ_NO_REMOTE': '1', 03:27:04 INFO - 'NO_EM_RESTART': '1', 03:27:04 INFO - 'PAGER': '/bin/cat', 03:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:04 INFO - 'PWD': '/builds/slave/test', 03:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:04 INFO - 'SHELL': '/bin/bash', 03:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:27:04 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:04 INFO - 'USER': 'cltbld', 03:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:04 INFO - 'XPC_FLAGS': '0x0', 03:27:04 INFO - 'XPC_SERVICE_NAME': '0', 03:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:04 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Xx1kNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-WGkQHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-gp7UIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Ttiq9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-9b0spS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-LbUNSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-c_O0hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-LgD4K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Nd2jwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-rVePUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:05 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4SP1yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:06 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-LQN6Ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:06 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-b5NUKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:06 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4zdS26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:06 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-IZP3y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:06 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-3NCJSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:06 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-_eZLRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:06 INFO - Running setup.py install for manifestparser 03:27:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:06 INFO - Running setup.py install for mozcrash 03:27:07 INFO - Running setup.py install for mozdebug 03:27:07 INFO - Running setup.py install for mozdevice 03:27:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Running setup.py install for mozfile 03:27:07 INFO - Running setup.py install for mozhttpd 03:27:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Running setup.py install for mozinfo 03:27:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Running setup.py install for mozInstall 03:27:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:07 INFO - Running setup.py install for mozleak 03:27:08 INFO - Running setup.py install for mozlog 03:27:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:08 INFO - Running setup.py install for moznetwork 03:27:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:08 INFO - Running setup.py install for mozprocess 03:27:08 INFO - Running setup.py install for mozprofile 03:27:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:08 INFO - Running setup.py install for mozrunner 03:27:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:08 INFO - Running setup.py install for mozscreenshot 03:27:09 INFO - Running setup.py install for moztest 03:27:09 INFO - Running setup.py install for mozversion 03:27:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:09 INFO - Cleaning up... 03:27:09 INFO - Return code: 0 03:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:09 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')]} 03:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:09 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')]} 03:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:09 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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:27:09 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 03:27:09 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 03:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:09 INFO - 'HOME': '/Users/cltbld', 03:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:09 INFO - 'LOGNAME': 'cltbld', 03:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:09 INFO - 'MOZ_NO_REMOTE': '1', 03:27:09 INFO - 'NO_EM_RESTART': '1', 03:27:09 INFO - 'PAGER': '/bin/cat', 03:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:09 INFO - 'PWD': '/builds/slave/test', 03:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:09 INFO - 'SHELL': '/bin/bash', 03:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:27:09 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:09 INFO - 'USER': 'cltbld', 03:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:09 INFO - 'XPC_FLAGS': '0x0', 03:27:09 INFO - 'XPC_SERVICE_NAME': '0', 03:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:09 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-q3k44V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:09 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)) 03:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:09 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-KnQrM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:09 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)) 03:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:09 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-KA6nYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:09 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)) 03:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:09 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-V7bLPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Ae8jyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Wytrbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-m3YOFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-HPWs_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-jfzVjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-_yg8vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-kiFAjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-YiQq88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Z3cFBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:10 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)) 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:10 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-vf43Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:11 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)) 03:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-X09mbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:11 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)) 03:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-E7x_T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:11 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)) 03:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:11 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-5Wd9mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:11 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)) 03:27:11 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)) 03:27:11 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)) 03:27:11 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)) 03:27:11 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)) 03:27:11 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)) 03:27:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:11 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 03:27:11 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 03:27:11 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 03:27:11 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 03:27:11 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 03:27:11 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 03:27:13 INFO - Downloading blessings-1.6.tar.gz 03:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:13 INFO - Installing collected packages: blessings 03:27:13 INFO - Running setup.py install for blessings 03:27:14 INFO - Successfully installed blessings 03:27:14 INFO - Cleaning up... 03:27:14 INFO - Return code: 0 03:27:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:14 INFO - Reading from file tmpfile_stdout 03:27:14 INFO - Current package versions: 03:27:14 INFO - blessings == 1.6 03:27:14 INFO - blobuploader == 1.2.4 03:27:14 INFO - docopt == 0.6.1 03:27:14 INFO - functools32 == 3.2.3-2 03:27:14 INFO - jsonschema == 2.5.1 03:27:14 INFO - manifestparser == 1.1 03:27:14 INFO - mozInstall == 1.12 03:27:14 INFO - mozcrash == 0.17 03:27:14 INFO - mozdebug == 0.1 03:27:14 INFO - mozdevice == 0.48 03:27:14 INFO - mozfile == 1.2 03:27:14 INFO - mozhttpd == 0.7 03:27:14 INFO - mozinfo == 0.9 03:27:14 INFO - mozleak == 0.1 03:27:14 INFO - mozlog == 3.4 03:27:14 INFO - moznetwork == 0.27 03:27:14 INFO - mozprocess == 0.23 03:27:14 INFO - mozprofile == 0.28 03:27:14 INFO - mozrunner == 6.12 03:27:14 INFO - mozscreenshot == 0.1 03:27:14 INFO - mozsystemmonitor == 0.3 03:27:14 INFO - moztest == 0.7 03:27:14 INFO - mozversion == 1.4 03:27:14 INFO - psutil == 3.1.1 03:27:14 INFO - requests == 1.2.3 03:27:14 INFO - wsgiref == 0.1.2 03:27:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:14 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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:27:14 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 03:27:14 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 03:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:14 INFO - 'HOME': '/Users/cltbld', 03:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:14 INFO - 'LOGNAME': 'cltbld', 03:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:14 INFO - 'MOZ_NO_REMOTE': '1', 03:27:14 INFO - 'NO_EM_RESTART': '1', 03:27:14 INFO - 'PAGER': '/bin/cat', 03:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:14 INFO - 'PWD': '/builds/slave/test', 03:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:14 INFO - 'SHELL': '/bin/bash', 03:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:27:14 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:14 INFO - 'USER': 'cltbld', 03:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:14 INFO - 'XPC_FLAGS': '0x0', 03:27:14 INFO - 'XPC_SERVICE_NAME': '0', 03:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 INFO - Cleaning up... 03:27:14 INFO - Return code: 0 03:27:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:14 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 0x10db38490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10daae570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e04acc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, '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.obDSnmcxfk/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.9NxXZBMM3S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 03:27:14 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 03:27:14 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 03:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:14 INFO - 'HOME': '/Users/cltbld', 03:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:14 INFO - 'LOGNAME': 'cltbld', 03:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:14 INFO - 'MOZ_NO_REMOTE': '1', 03:27:14 INFO - 'NO_EM_RESTART': '1', 03:27:14 INFO - 'PAGER': '/bin/cat', 03:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:14 INFO - 'PWD': '/builds/slave/test', 03:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:14 INFO - 'SHELL': '/bin/bash', 03:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:27:14 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:14 INFO - 'USER': 'cltbld', 03:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:14 INFO - 'XPC_FLAGS': '0x0', 03:27:14 INFO - 'XPC_SERVICE_NAME': '0', 03:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:14 INFO - Cleaning up... 03:27:14 INFO - Return code: 0 03:27:14 INFO - Running post-action listener: _resource_record_post_action 03:27:14 INFO - Running post-action listener: _start_resource_monitoring 03:27:14 INFO - Starting resource monitoring. 03:27:14 INFO - [mozharness: 2016-10-06 10:27:14.995383Z] Finished create-virtualenv step (success) 03:27:14 INFO - [mozharness: 2016-10-06 10:27:14.996405Z] Running install step. 03:27:14 INFO - Running pre-action listener: _resource_record_pre_action 03:27:14 INFO - Running main action method: install 03:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:15 INFO - Reading from file tmpfile_stdout 03:27:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:15 INFO - Reading from file tmpfile_stdout 03:27:15 INFO - Output received: 03:27:15 INFO - Usage: mozinstall [options] installer 03:27:15 INFO - Options: 03:27:15 INFO - -h, --help show this help message and exit 03:27:15 INFO - -d DEST, --destination=DEST 03:27:15 INFO - Directory to install application into. [default: 03:27:15 INFO - "/builds/slave/test"] 03:27:15 INFO - --app=APP Application being installed. [default: firefox] 03:27:15 INFO - mkdir: /builds/slave/test/build/application 03:27:15 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'] 03:27:15 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 03:27:49 INFO - Reading from file tmpfile_stdout 03:27:49 INFO - Output received: 03:27:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:27:49 INFO - Running post-action listener: _resource_record_post_action 03:27:49 INFO - [mozharness: 2016-10-06 10:27:49.432793Z] Finished install step (success) 03:27:49 INFO - [mozharness: 2016-10-06 10:27:49.432974Z] Running run-tests step. 03:27:49 INFO - Running pre-action listener: _resource_record_pre_action 03:27:49 INFO - Running main action method: run_tests 03:27:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:49 INFO - 2016-10-06 03:27:49.447 screenresolution[1930:16699] starting screenresolution argv=screenresolution get 03:27:49 INFO - 2016-10-06 03:27:49.450 screenresolution[1930:16699] Display 0: 1600x1200x32@60 03:27:49 INFO - 2016-10-06 03:27:49.455 screenresolution[1931:16701] starting screenresolution argv=screenresolution list 03:27:49 INFO - Available Modes on Display 0 03:27:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:49 INFO - Intel Iris: 03:27:49 INFO - Chipset Model: Intel Iris 03:27:49 INFO - Type: GPU 03:27:49 INFO - Bus: Built-In 03:27:49 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:49 INFO - Vendor: Intel (0x8086) 03:27:49 INFO - Device ID: 0x0a2e 03:27:49 INFO - Revision ID: 0x0009 03:27:49 INFO - Displays: 03:27:49 INFO - Display: 03:27:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:49 INFO - Display Serial Number: 1600x1200 60 03:27:49 INFO - Main Display: Yes 03:27:49 INFO - Mirror: Off 03:27:49 INFO - Online: Yes 03:27:49 INFO - Rotation: Supported 03:27:49 INFO - Return code: 0 03:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:49 INFO - Python 2.7.3 03:27:49 INFO - Return code: 0 03:27:49 INFO - grabbing minidump binary from tooltool 03:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:49 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 0x10d94cd30>, '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 0x10d772db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d944b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:49 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 03:27:49 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 03:27:49 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 03:27:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:49 INFO - Return code: 0 03:27:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:27:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:27:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:49 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/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 03:27:49 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/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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 03:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obDSnmcxfk/Render', 03:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:49 INFO - 'HOME': '/Users/cltbld', 03:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:49 INFO - 'LOGNAME': 'cltbld', 03:27:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:49 INFO - 'MOZ_NO_REMOTE': '1', 03:27:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:49 INFO - 'NO_EM_RESTART': '1', 03:27:49 INFO - 'PAGER': '/bin/cat', 03:27:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:49 INFO - 'PWD': '/builds/slave/test', 03:27:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:49 INFO - 'SHELL': '/bin/bash', 03:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9NxXZBMM3S/Listeners', 03:27:49 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 03:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:49 INFO - 'USER': 'cltbld', 03:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:49 INFO - 'XPC_FLAGS': '0x0', 03:27:49 INFO - 'XPC_SERVICE_NAME': '0', 03:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:49 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/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 03:27:50 INFO - mozversion application_buildid: 20161006014700 03:27:50 INFO - mozversion application_changeset: 43bc30457ad4b4d9507b0dce05ffe5a76e88229f 03:27:50 INFO - mozversion application_display_name: Nightly 03:27:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:50 INFO - mozversion application_name: Firefox 03:27:50 INFO - mozversion application_remotingname: firefox 03:27:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:27:50 INFO - mozversion application_vendor: Mozilla 03:27:50 INFO - mozversion application_version: 52.0a1 03:27:50 INFO - mozversion platform_buildid: 20161006014700 03:27:50 INFO - mozversion platform_changeset: 43bc30457ad4b4d9507b0dce05ffe5a76e88229f 03:27:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:27:50 INFO - mozversion platform_version: 52.0a1 03:27:50 INFO - using testdate: 1475749670 03:27:50 INFO - actual date: 1475749670 03:27:50 INFO - starting webserver on 'localhost:52733' 03:27:50 INFO - SUITE-START | Running 2 tests 03:27:50 INFO - TEST-START | dromaeo_css 03:27:50 INFO - operating with platform_type : mac_ 03:27:50 INFO - Initialising browser for dromaeo_css test... 03:27:50 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpVsuY04/profile http://localhost:52733/getInfo.html) 03:27:52 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 03:27:52 INFO - PROCESS | 1941 | colorDepth:24 03:27:52 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 03:27:52 INFO - PROCESS | 1941 | __metrics 03:27:52 INFO - PROCESS | 1941 | 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" 03:27:52 INFO - PROCESS | 1941 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:27:53 INFO - TEST-INFO | 1941: exit 0 03:27:53 INFO - Browser initialized. 03:27:53 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:53 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpVsuY04/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:05 INFO - PROCESS | 1943 | RSS: Main: 235630592 03:28:05 INFO - PROCESS | 1943 | 03:28:56 INFO - PROCESS | 1943 | 1475749736088 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] 03:31:07 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52733/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52733/tests/dromaeo/cssquery-ext.html) 03:31:11 INFO - PROCESS | 1943 | RSS: Main: 571666432 03:31:11 INFO - PROCESS | 1943 | 03:34:14 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52733/tests/dromaeo/cssquery-ext.html (next: http://localhost:52733/tests/dromaeo/cssquery-jquery.html) 03:34:15 INFO - PROCESS | 1943 | RSS: Main: 371671040 03:34:15 INFO - PROCESS | 1943 | 03:37:17 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52733/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52733/tests/dromaeo/cssquery-mootools.html) 03:37:18 INFO - PROCESS | 1943 | RSS: Main: 349110272 03:37:18 INFO - PROCESS | 1943 | 03:40:20 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52733/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52733/tests/dromaeo/cssquery-prototype.html) 03:40:21 INFO - PROCESS | 1943 | RSS: Main: 343777280 03:40:21 INFO - PROCESS | 1943 | 03:43:24 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52733/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52733/tests/dromaeo/cssquery-yui.html) 03:43:25 INFO - PROCESS | 1943 | RSS: Main: 341610496 03:43:25 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:52733/tests/dromaeo/cssquery-yui.html (next: http://localhost:52733/tests/dromaeo/cssquery-dojo.html) 03:46:28 INFO - PROCESS | 1943 | RSS: Main: 623538176 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | __start_tp_report 03:46:28 INFO - PROCESS | 1943 | _x_x_mozilla_page_load 03:46:28 INFO - PROCESS | 1943 | _x_x_mozilla_page_load_details 03:46:28 INFO - PROCESS | 1943 | |i|pagename|runs| 03:46:28 INFO - PROCESS | 1943 | |0;dojo.html;3248.707616314532;3252.918677033074;3274.034159922824;3294.341131773646;3333.949990750139;5456.945430545693;5570.164475328703;5594.664320140784;5633.492985631297;5685.744141513632;4707.90584188316;5546.750396232169;5611.3546942101675;5676.063449530833;5707.828765137042;5022.799088036474;5022.874428139289;5038.5969122470115;5083.135866902617;5091.770870310845;5112.565431938289;5189.325387699612;5198.610104242178;5211.921821172686;5282.260483532308;5004.9749751251375;5141.331626888499;5160.8967820643375;5162.070827251093;5255.579553635719;5061.797528098871;5068.949310506885;5111.2333150027425;5111.565516931066;5115.104856650109;5033.622478314104;5089.491050894918;5108.795648174068;5110.437851836295;5173;5618.775248990036;5619.1009438490055;5645.717714114277;5663.49028587425;5677.318721753375;5963.224780778514;6025.758969641209;6042.244719410074;6047.485963693091;6083.908741368883;6118.8776224475705;6131.50343106675;6145.4161854623735;6151.661658608775;6176.81469555914;5701.458361455613;5701.629394089371;5701.771929122789;5707.258056452634;5717.456841600041;6113.908291375633;6148.1699970504305;6165.167702360213;6230.158928544589;6236;5892.646441213541;5980.401959803985;5983.940160598426;6027.969860150759;6046.153538504613;6129.478994285536;6149.7847575334645;6151.938480615226;6155.876882462326;6173.722182501798;6017.488513476316;6096.591473715663;6097.725602347905;6104.725287362079;6130.5204358993005;5769.769209231667;5806.709664516842;5835.241418615553;5850.590458667937;5912.231409916683;4740.7392593407;4745.525447455296;4784.425868895755;4872.342233798463;4883.975580122076;4352.651787856964;4367.67242456817;4403.3174857897075;4427.136708341843;4443.022535042285;5144.485551444825;5689.203511508392;5700.184455855244;5724.227229324071;5751.166080918243;6022.728977196037;6106;6161.353057928943;6166.167567378437;6180;5607.943920560824;5611.719414029282;5618.578606604439;5624.29696287964;5626.071698169756;5271.736413179326;5279.049771041249;5283.365996080495;5289.153735402318;5294.391145018295;6136.335271946702;6179.28938172116;6182.7217775201125;6196.659183744938;6232.844178895564;6185.84535386619;6186.81439556814;6191.4118158774845;6195.19462469876;6206.503479721701;6222;6223.937760622517;6227.657478838707;6233.0338797486465;6243.656598887105;5906.291245050449;5930.7924222652;5931.051031834886;6037.9094313584455;6077.665728384981;6106.5114790817515;6113.694315284307;6119.326874043941;6128.387161283836;6135.907961380493;5747.798827041033;5913;5916.3492015877355;5925.911111333419;5942.227510423617;5915.467607915309;5928.258967629046;5928.4960778334325;5929.555283353852;5933.821985340447;5015.498450154955;5746.9712651436475;5789.363170051375;5803.970980145073;5810.680412577349;5768.798092066758;5777.9133313001175;5792.333881603501;5837.591368604157;5910.940890591211;5625.409332020079;5625.803096891589;5636;5639.2668953035845;5659.066254068032 03:46:28 INFO - PROCESS | 1943 | |1;ext.html;467.31071669287786;482.35846324388547;509.4065413792931;532.1830989431223;548.9121740521516;40506.59493405065;41451.170976580484;41907.79046104773;42236.944076398104;44000;43054;43346.56653433465;43523.56476435235;43580;43598.34602480965;8771.868421973675;9796.314258001943;9986.750331241705;9999;10000.099991000809;11947.462364193632;12281.631551053482;12315;12410.689732756662;12458.439370228316;12259.816102758421;12345.012399008057;12351.444185011651;12390.93804530976;12419.379031048456;12058.155929084967;12206.145569810116;12281;12314.81527777084;12327.999999999955;12055.397230138458;12135.757284854342;12147.757044859141;12150.392480376035;12170.452329645099;40148;40347.59652403468;40451;40455.59544404548;40483;3001.7298443140003;3322.302316513535;3333.2000319923286;3638.21778317663;3800.7529510581726;31059.068227953197;31788.841055794805;31886.681133188835;31910.521342179887;32370.676293237;3162.7469802415753;3296.868125274986;3304.1739565108724;3312.685294897005;3449.896503104911;520644;522333.5533289351;524291;524926;531006;33627;34441;34552.13619659478;61872;62608.17397825272;34986.475202871974;35253.82373088118;35335.11662208466;35341.64658353384;35450.822745886624;14398.568042958728;14570.125792452487;14574.854251457562;14590;14596;11239.381833999045;11419.771604568028;12140.089493288038;12255.632331030083;12370.6288811334;7783.92216077832;7793.376529877596;7814.063721414266;7851.842963140705;7888.343447875895;3254.495553189259;3283.668595297318;3285.78642388244;3299.802011879295;3309.619393769699;877.9209871111631;911.7902882337099;952.852307892264;953.561361773578;1142.8457158283525;28801.99193028234;29520;29601.555976660366;30364.54453183204;30544.69455305463;1027.5992362978445;1037.0459177556666;1065.4938904020528;1112.9833052504218;1186.95845645402;15188.924055379874;15470.149141797308;15490.9225453872;15584.376624935103;15987.920060399856;680088;683756;685487;689073;691938;58533.122003169985;58896;58965.41034589685;59034.40965590289;59116.704416477645;1360.5034162530605;1366.5148872150442;1384.3286006286942;1393.428694235379;1394.3934388541018;28955.42089158247;29409.85295073511;29774.25564360908;30314.090577282717;30332;50614.49385506098;51076;51159.23261151011;51192.488075120265;51199.464016079575;577116;582990;582994;583197;584231;22664.206752763574;23037.769622303564;26134.170608057255;26408.735912641398;26817.463650727266;44867.55132448634;46461;47506.28740568825;47520;47984.040319192725;37168.492343058846;38929.61070389373;39213;40174.99562510961;40441.39337909875;38849.2230155401;38959.805200974944;40147.79926100351;40187;40359.79820100881;37929.62070379371;38071.238575227784;38381;38656;38961.805190973864;31823.204419888763;32427.675723242464;34013.82993085019;34683.82658086794;34903.30193396169;25166.874165629786;25417.872910635328;25509.489810203322;26056.478870422863;26370.73629263683 03:46:28 INFO - PROCESS | 1943 | |2;jquery.html;362.2519497238203;376.0429706397219;387.63949526939945;398.4740143011226;408.3079180788563;19035.524111897194;21117;21517.354479365604;21540.413881311382;21788.128474860987;20036.799632003676;20341;20745.273915412963;20938.476538086554;21004.474888127803;5755.251817263771;5762.769489220436;5967.522598192134;6012.729427175787;6019.067044608093;4163.979180104096;4390.97804510977;4392.12157568486;4835.588974937117;5957.642541447505;6259;6580.111684922546;6599.901001484982;6651.467882569407;6665.40011398974;6455.386738259858;6498.69296399776;6520.706568204442;6570.375814297634;6578;5625.296837895263;5671.943280567224;5682.232898558683;5686.1755045518585;5704.71476426177;24846.130385436605;25301.240962771146;25340.366490837692;25698.743012569823;26075.348116297053;2183.617866873307;2196.417949243452;2207.6357401028813;2324.732655744594;2616.6205900144373;14405.567832965027;15211.619709507351;15278.847211527853;15900.284487198103;15965.361385544564;1791.6595846789198;1857.8699491035634;1860.8139186081285;1878.8309052185232;1970.8324792392664;114826;121004.39497802543;121410;121582.37055626973;122379.3881030598;9377.874655041438;11186.664400068012;11541.884581154249;11611.071114310835;11718.531258749725;14466.493672721404;14507.347169377403;14514.201718905562;14515.782263266059;14536.63658408527;8088.9595552021865;8417.494950303002;8430.15698430152;8538.743837684879;8561.700340488178;8374.330053595697;8377.581120943929;8388.706395276136;8534.359923005675;8537.957310213533;3820.617938206213;4388.2320593896575;4480.708753930984;4489.910201796011;4547.977260113745;1759.5337235632567;1835.1925152932668;1860.2373027059111;1904.961900761977;1908.6469003234447;793.7896457438783;910.0899100899101;943.6084025129632;968.7481254873784;1002.4015871358399;15809.683806323808;19877.27372342756;20203.989800509917;21111.577768444546;21295.254666086923;906.4742449379344;913.1918252346721;923.1230331185267;928.7863791328033;935.8862953085807;10878.619248326271;11302.321860688386;11315.83026254607;11317.603883864025;11342.20604557673;502675;509031;510463;609888;612054;141997;149591.25204373908;149937.25031374773;150195.7274913399;150779;967.6419724701906;978.6134476881734;995.0845222395413;1015.5886865819207;1020.0564477857952;14679.926600367357;18300.816991830445;19281.710774338677;19303.4208973731;19356.90321548383;48427;49717.502824971285;51117.48882511127;52832.47167528275;53211.4678853222;66035.66982165059;69247.55933010469;70875;71456.28543714496;71546.28453715396;11372.658820235407;11493;11515.136364772508;11843.407829608657;12143.878561214275;12972.416241269355;13478.52825151115;13521.661958451117;14009.509667161601;14131.505397311044;11301.039411650101;11471.598494052669;11769.882301176878;11908.166428349932;11992.700182495508;11348.886511135113;11391.430428478709;11801.409929503663;11955.163138580216;12041.217320874115;11420.486078126338;11560.30638161713;12042.447477993837;12044.21712588679;12048.698782530157;11854.822177667169;11974.64076077719;12212.450439730412;12250.448729807002;12318.81521777192;9921.851172232567;11177.273477223955;11740.236884602473;11907.94046029799;11964.58123965657 03:46:28 INFO - PROCESS | 1943 | |3;mootools.html;1429.5925661186561;1556.8598826105651;1770.707833207521;1920.9807901920994;1955.4231501706995;8155.980502437181;8444.240018398343;8594.441361311518;9105.954470227656;9118.31612629053;8606.95696521518;8899.91100088999;8904.91095089049;8966.37235393521;8982.685606003775;2365.2194775724015;2393.700787401575;2395.73646898841;2399.688040554734;2401.9519609607796;2108.905099270529;2194.36363454598;2352.223766157164;2376.3821406434276;2400.759924007594;2306.746257911628;2374.715034195899;2382.154335211001;2383.4637206628545;2384.7138343398815;2353.8234632402637;2370.6562548430466;2375.7505461926507;2389.319044072431;2394.042383046778;2339.181286549711;2358.41039740065;2362.385779697274;2366;2368.4907744834773;8837.867431988525;8867.866981995276;8977;8980.595873185723;8986.14631609996;5239.187925871496;5423.05096608092;5427.019138014636;5428.267183930158;5430.348358197041;3325.9357005758166;3504.754667173299;3645.106948797535;3707.1102935295603;3711.0536813112485;992.1269283030958;1002.6490728245055;1030.7886883188928;1048.7063622185801;1055.9524821383056;11915.582954596548;11975.760484790342;11982.700432489257;12001.51993920242;12004.2197257178;4132.586741325843;4607.216773148572;4801.303810947393;4801.759912004386;4806.615470762331;10139.493025348704;10161.847572286422;10173.28786984904;10180.083792458714;10182.338148020355;4650.744209068466;5411.56707463402;5419.701916394557;5422.0511410503;5425.674459532441;4810.518948105161;4898.142825005681;4957.603391728653;4967.180415231519;4968.205087186033;3839.8080095995088;3865.8067096645054;3903.863364782219;3950.0322421006463;4036.3138266494766;1187.2045729361348;1227.1532642476664;1227.2636418149218;1264.930428826405;1273.7834568123442;768.8961990131261;854.3250831842898;872.9738107856774;897.3314880414002;969.1181025266973;5235.063026680153;5759;5765.88468230633;6062.120992456157;6116.633002019893;821.6549049399266;915.9084091590921;915.9404638698463;918.903515130915;957.712686194139;3881.922361552753;3905.3946638271113;3921.31377009028;4029.133736246721;4149.25313443577;10526.473676316153;10757.731056723487;10763.623273185402;10901.83647245292;10909.018188363085;10036.347637403545;10385.688429347132;10856.620018299322;10865.945670271756;10878.510467029002;8101.027876654722;8315.625796839156;8321.459105158145;8328.250457458858;8368.748937531884;5947.405259474018;5959.22530071088;6070.632453343288;6124.693765311806;6140.723667434887;9602.807943840944;9981.950090249502;10122.645707400206;10122.949385253027;10161.542730576994;10133.64532241368;10175.796484070424;10303.587856485656;10304.433256170983;10338.689839304832;8176.509409435453;8221.917780822354;8240.752777416687;8363.372747044117;8372.28835548985;8186.304164145876;8459.450135741157;8459.746207613782;8464.44981076228;8469.280111190617;7309.4152467803515;7447.590382529013;7575.280348366897;7575.431842611936;7708.537487750753;7309.195988441161;7358.374538164316;7471.17817040136;7490.625468726433;7569.47013709035;6010.308814486215;6997.615131167835;7074.29257074309;7079.752208672878;7081.504294699322;4905.975470122627;4991.600671946163;5034.899302014012;5080.339555857715;5136.152534831711;4905.509449055208;4993.675411098267;5047.697138171721;5194.714290714047;5209.479052094912 03:46:28 INFO - PROCESS | 1943 | |4;prototype.html;302.29715910508065;311.2498877704732;311.4596175635272;316.6848985259667;317.1769258773482;4350.521442641311;4691.272852707827;4800.543948324908;5199.714015729133;5216;5172.27588137661;5199.660152931177;5202.739863006854;5206.45332240115;5280.234366016925;3447.8103704296254;3505.930691139195;3541.610422853484;3884.261990221863;3930.6069393060607;3757.8684746033896;3980.3432433648413;3998.360262358023;4027.436158937751;4072.6989251073196;3929.2141571685634;3949.8222579983826;3954.1498577805764;3957.515931525678;3999.060220848098;3805.3530899746834;3946.2107578484274;3957.3668213086057;3983.780892050936;4007.318755811519;3411.812350320731;3451.3442445935443;3466.9945715742406;3475.7045651119683;3476.66971637694;4952.801887924478;4971.950280497221;4985.626078044125;4985.975070124662;4992.151334273182;4364.825406983717;4566.520515345874;4581.129585378767;4587.678862479628;4591.724496530219;4946.562139313179;5076.705440112748;5440.91838622421;5462.617616766828;5465.262189604392;3828.1960788234505;3838.596947320547;3843.865464708722;3853.5953724859046;3856.652901238902;5400.1899715043055;5727.198192253088;5739.0200380868955;5750.233596993976;5801.361850196475;3020.592220050309;3502.4571191465366;3668.413053911415;3867.7292589519025;3910.589388114207;3765.755225910307;3940.901477463029;3947.881563553098;3950.20995800841;3977.528314523645;4369.934450983238;4529.230030894756;4534.229181039232;4567.835202023462;4584.701994370355;5100.546344291859;5152.690838549699;5333.146696528537;5549.195366671891;5605.747741351649;1188.9643310700692;1225.7058306006495;1312.2979206124678;1334.3320848938827;1336.4253371050543;763.1147868472656;780.4614815777096;806.3871457692079;806.9152738962442;807.2290962131151;4885.3649025627155;4889.48660390661;4898.542326482883;5039.874003149951;5099.923501147486;4657.6273898088075;5095.617828662865;5154.819581314636;5300.469953004746;5455.108482838525;4548.931766023512;5150.965368679351;5167.560757335668;5171.225005745827;5257.526822585985;2261.027758064048;2602.843829370206;2809.8735556899987;2877.8488604558343;2901.8984335548153;5614.2701448811395;5805.8548536286935;5815.82552523425;5819.301683797971;5822.243108395966;5008.549230569266;5320.893582128413;5571.693556854331;5722.170285308607;5796.449337312949;5578.912112138094;5733.913991290134;5750.654960702372;5771.653700777967;5811.506021988093;4264.125854199943;4975.303457516023;5546.833594992157;5642.815008848188;5704.60067795267;5216.66091704038;5518.834434966958;5519.199716041232;5567.972160139173;5574.581906357121;5441.782328706808;5720.713964301685;5723.306888351512;5753.424657534213;5781.161731548817;3485.7734247273847;3737.5888652247686;3777.3578491657036;3794.279086973577;3818.19817838246;4989.376327959005;5225.634205605571;5621.971890140687;5686.9715651421475;5709.345154503176;4812.735299558558;4839.903201936012;5493.780248790164;5505.421930697219;5531.280933478622;4413.823447062082;4657.1371451418345;5524.088525393265;5568.359638641608;5576.745232322695;5321.414644389037;5324.73698678068;5325.893482130258;5367.463253674601;5384.6769193848495;4788.736619485822;5204.297419848272;5441;5456.072467680583;5468.808591699271;4082.95884549438;4739.218029025173;5394.004218439202;5421.3765416975975;5506.284183056177 03:46:28 INFO - PROCESS | 1943 | |5;yui.html;694.6457306773544;717.1895757793692;734.8860926556382;754.992450075499;822.436630907828;15348.30932608034;15966.76049859253;15987.120708361035;16009.19954002298;16014.759778603331;14207.218602976833;14344.784828227585;14348.641283967907;14360.138391696506;14440.638984025378;714.8427345983876;737.439545945083;739.116755477205;875.2560323724815;910.3218102513604;875.711015364928;895.6730793260479;905.2622112977934;916.812053529025;916.9633214671405;958.884933807944;960.5677445149676;961.538461538462;963.0417734354327;963.7735132243918;761.101899758285;956.2923436656894;958.9041095890425;961.7259081161906;965.8358079126565;576.1185386358877;695.6730336741723;712.8360477090247;726.2483329753733;727.7489266203152;15135.318910649048;15178.392864285415;15214.695706085817;15222.238888055554;15230.695386092217;13950.930245348809;14147.080439771486;14161.929190354085;14264.500742473963;14299.142051476842;11559.38845951087;12307.4461649226;12689.809652855214;12750.234985900875;12769.170003949714;4353.825846966118;4543.5002149763495;4626.236670949289;4716.622670186377;4755.2153894607345;112238;113313.40239171269;116390;116664.99999999916;118151;10953.945230273797;11104.192714430177;11115.333080015225;11161.832572511257;11520.308781473139;22220.666689999664;22369.88815055947;22418.88790556037;22427.663585046237;22457.55084898293;7823.960880195563;7825.3739700824935;7995.600219988977;8096.352291816641;8147.877781833277;4286.469924849527;4413.558644135625;4416.712913660602;4465.330200469891;4470.664700147502;3507.175813683782;3581.212133330663;3629.310431018098;3632.0556655269293;3640.581333146669;652.725855140842;662.4898827902584;665.3978149774462;669.8559809640853;678.521642242218;595.3867516458055;597.6055803169974;619.6831188403487;631.0376675569793;637.6659245412094;8456.957715211507;8886.155815197546;8886.24466920306;8986;9150.267978561698;505.70669011972967;531.9520544527275;545.3265217456438;577.7255803493307;593.24657684741;4182.958170418317;4446.5331140230455;4705.623550115983;4820.517948205222;5038.269450929594;93553;97479.51260243653;143428;151862.24068879805;164478;138019;138332.30833845766;138960.30519847336;141632;143199;111755.99999999837;111839;121169.39415303043;121919.3904030492;122787;9443.433393996382;9738;9739.984332197402;9741.707748767549;9844.9015509844;40409.797951010056;55748.44251557432;61875.38124618696;62306;67145.66427168029;57635.13547296878;58960.70519647374;70598.23504412225;70910.64544677244;96287.37126287316;12566.623001309976;13184.143030702973;13418.731625367633;13615;13880.958928080636;14196.716065678835;14472.638184045061;14473.131612103307;14488.420463181776;14839.92580037093;11633.449518872594;12045.457954392248;14093.365798538885;14100.153990760587;14181.432742690176;13462.528811491551;13489.123206991515;14206.502772402917;14374.425022999381;14426;13553.186808791505;13891.305434728425;14071.437142514595;14193.716125677221;14226.502072427415;8800.559972001247;11084;11356.886431135583;11589.942050289694;11625.59310424131;7546.886796698163;10265.743356415851;10531.315464494783;11166.944165279121;11515.827262591236 03:46:28 INFO - PROCESS | 1943 | __end_tp_report 03:46:28 INFO - PROCESS | 1943 | __start_cc_report 03:46:28 INFO - PROCESS | 1943 | _x_x_mozilla_cycle_collect,3844 03:46:28 INFO - PROCESS | 1943 | __end_cc_report 03:46:28 INFO - PROCESS | 1943 | __startTimestamp1475750788824__endTimestamp 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | ------- Summary: start ------- 03:46:28 INFO - PROCESS | 1943 | Number of tests: 6 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | [#0] dojo.html Cycles:165 Average:5609.88 Median:5751.17 stddev:622.04 (10.8%) stddev-sans-first:595.73 03:46:28 INFO - PROCESS | 1943 | Values: 3248.7 3252.9 3274.0 3294.3 3333.9 5456.9 5570.2 5594.7 5633.5 5685.7 4707.9 5546.8 5611.4 5676.1 5707.8 5022.8 5022.9 5038.6 5083.1 5091.8 5112.6 5189.3 5198.6 5211.9 5282.3 5005.0 5141.3 5160.9 5162.1 5255.6 5061.8 5068.9 5111.2 5111.6 5115.1 5033.6 5089.5 5108.8 5110.4 5173.0 5618.8 5619.1 5645.7 5663.5 5677.3 5963.2 6025.8 6042.2 6047.5 6083.9 6118.9 6131.5 6145.4 6151.7 6176.8 5701.5 5701.6 5701.8 5707.3 5717.5 6113.9 6148.2 6165.2 6230.2 6236.0 5892.6 5980.4 5983.9 6028.0 6046.2 6129.5 6149.8 6151.9 6155.9 6173.7 6017.5 6096.6 6097.7 6104.7 6130.5 5769.8 5806.7 5835.2 5850.6 5912.2 4740.7 4745.5 4784.4 4872.3 4884.0 4352.7 4367.7 4403.3 4427.1 4443.0 5144.5 5689.2 5700.2 5724.2 5751.2 6022.7 6106.0 6161.4 6166.2 6180.0 5607.9 5611.7 5618.6 5624.3 5626.1 5271.7 5279.0 5283.4 5289.2 5294.4 6136.3 6179.3 6182.7 6196.7 6232.8 6185.8 6186.8 6191.4 6195.2 6206.5 6222.0 6223.9 6227.7 6233.0 6243.7 5906.3 5930.8 5931.1 6037.9 6077.7 6106.5 6113.7 6119.3 6128.4 6135.9 5747.8 5913.0 5916.3 5925.9 5942.2 5915.5 5928.3 5928.5 5929.6 5933.8 5015.5 5747.0 5789.4 5804.0 5810.7 5768.8 5777.9 5792.3 5837.6 5910.9 5625.4 5625.8 5636.0 5639.3 5659.1 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | [#1] ext.html Cycles:180 Average:71431.17 Median:34617.98 stddev:161120.80 (465.4%) stddev-sans-first:161484.69 03:46:28 INFO - PROCESS | 1943 | Values: 467.3 482.4 509.4 532.2 548.9 40506.6 41451.2 41907.8 42236.9 44000.0 43054.0 43346.6 43523.6 43580.0 43598.3 8771.9 9796.3 9986.8 9999.0 10000.1 11947.5 12281.6 12315.0 12410.7 12458.4 12259.8 12345.0 12351.4 12390.9 12419.4 12058.2 12206.1 12281.0 12314.8 12328.0 12055.4 12135.8 12147.8 12150.4 12170.5 40148.0 40347.6 40451.0 40455.6 40483.0 3001.7 3322.3 3333.2 3638.2 3800.8 31059.1 31788.8 31886.7 31910.5 32370.7 3162.7 3296.9 3304.2 3312.7 3449.9 520644.0 522333.6 524291.0 524926.0 531006.0 33627.0 34441.0 34552.1 61872.0 62608.2 34986.5 35253.8 35335.1 35341.6 35450.8 14398.6 14570.1 14574.9 14590.0 14596.0 11239.4 11419.8 12140.1 12255.6 12370.6 7783.9 7793.4 7814.1 7851.8 7888.3 3254.5 3283.7 3285.8 3299.8 3309.6 877.9 911.8 952.9 953.6 1142.8 28802.0 29520.0 29601.6 30364.5 30544.7 1027.6 1037.0 1065.5 1113.0 1187.0 15188.9 15470.1 15490.9 15584.4 15987.9 680088.0 683756.0 685487.0 689073.0 691938.0 58533.1 58896.0 58965.4 59034.4 59116.7 1360.5 1366.5 1384.3 1393.4 1394.4 28955.4 29409.9 29774.3 30314.1 30332.0 50614.5 51076.0 51159.2 51192.5 51199.5 577116.0 582990.0 582994.0 583197.0 584231.0 22664.2 23037.8 26134.2 26408.7 26817.5 44867.6 46461.0 47506.3 47520.0 47984.0 37168.5 38929.6 39213.0 40175.0 40441.4 38849.2 38959.8 40147.8 40187.0 40359.8 37929.6 38071.2 38381.0 38656.0 38961.8 31823.2 32427.7 34013.8 34683.8 34903.3 25166.9 25417.9 25509.5 26056.5 26370.7 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | [#2] jquery.html Cycles:180 Average:34427.23 Median:21114.29 stddev:92970.64 (440.3%) stddev-sans-first:93196.27 03:46:28 INFO - PROCESS | 1943 | Values: 362.3 376.0 387.6 398.5 408.3 19035.5 21117.0 21517.4 21540.4 21788.1 20036.8 20341.0 20745.3 20938.5 21004.5 5755.3 5762.8 5967.5 6012.7 6019.1 4164.0 4391.0 4392.1 4835.6 5957.6 6259.0 6580.1 6599.9 6651.5 6665.4 6455.4 6498.7 6520.7 6570.4 6578.0 5625.3 5671.9 5682.2 5686.2 5704.7 24846.1 25301.2 25340.4 25698.7 26075.3 2183.6 2196.4 2207.6 2324.7 2616.6 14405.6 15211.6 15278.8 15900.3 15965.4 1791.7 1857.9 1860.8 1878.8 1970.8 114826.0 121004.4 121410.0 121582.4 122379.4 9377.9 11186.7 11541.9 11611.1 11718.5 14466.5 14507.3 14514.2 14515.8 14536.6 8089.0 8417.5 8430.2 8538.7 8561.7 8374.3 8377.6 8388.7 8534.4 8538.0 3820.6 4388.2 4480.7 4489.9 4548.0 1759.5 1835.2 1860.2 1905.0 1908.6 793.8 910.1 943.6 968.7 1002.4 15809.7 19877.3 20204.0 21111.6 21295.3 906.5 913.2 923.1 928.8 935.9 10878.6 11302.3 11315.8 11317.6 11342.2 502675.0 509031.0 510463.0 609888.0 612054.0 141997.0 149591.3 149937.3 150195.7 150779.0 967.6 978.6 995.1 1015.6 1020.1 14679.9 18300.8 19281.7 19303.4 19356.9 48427.0 49717.5 51117.5 52832.5 53211.5 66035.7 69247.6 70875.0 71456.3 71546.3 11372.7 11493.0 11515.1 11843.4 12143.9 12972.4 13478.5 13521.7 14009.5 14131.5 11301.0 11471.6 11769.9 11908.2 11992.7 11348.9 11391.4 11801.4 11955.2 12041.2 11420.5 11560.3 12042.4 12044.2 12048.7 11854.8 11974.6 12212.5 12250.4 12318.8 9921.9 11177.3 11740.2 11907.9 11964.6 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | [#3] mootools.html Cycles:180 Average:5783.37 Median:4905.74 stddev:3258.77 (66.4%) stddev-sans-first:3251.49 03:46:28 INFO - PROCESS | 1943 | Values: 1429.6 1556.9 1770.7 1921.0 1955.4 8156.0 8444.2 8594.4 9106.0 9118.3 8607.0 8899.9 8904.9 8966.4 8982.7 2365.2 2393.7 2395.7 2399.7 2402.0 2108.9 2194.4 2352.2 2376.4 2400.8 2306.7 2374.7 2382.2 2383.5 2384.7 2353.8 2370.7 2375.8 2389.3 2394.0 2339.2 2358.4 2362.4 2366.0 2368.5 8837.9 8867.9 8977.0 8980.6 8986.1 5239.2 5423.1 5427.0 5428.3 5430.3 3325.9 3504.8 3645.1 3707.1 3711.1 992.1 1002.6 1030.8 1048.7 1056.0 11915.6 11975.8 11982.7 12001.5 12004.2 4132.6 4607.2 4801.3 4801.8 4806.6 10139.5 10161.8 10173.3 10180.1 10182.3 4650.7 5411.6 5419.7 5422.1 5425.7 4810.5 4898.1 4957.6 4967.2 4968.2 3839.8 3865.8 3903.9 3950.0 4036.3 1187.2 1227.2 1227.3 1264.9 1273.8 768.9 854.3 873.0 897.3 969.1 5235.1 5759.0 5765.9 6062.1 6116.6 821.7 915.9 915.9 918.9 957.7 3881.9 3905.4 3921.3 4029.1 4149.3 10526.5 10757.7 10763.6 10901.8 10909.0 10036.3 10385.7 10856.6 10865.9 10878.5 8101.0 8315.6 8321.5 8328.3 8368.7 5947.4 5959.2 6070.6 6124.7 6140.7 9602.8 9982.0 10122.6 10122.9 10161.5 10133.6 10175.8 10303.6 10304.4 10338.7 8176.5 8221.9 8240.8 8363.4 8372.3 8186.3 8459.5 8459.7 8464.4 8469.3 7309.4 7447.6 7575.3 7575.4 7708.5 7309.2 7358.4 7471.2 7490.6 7569.5 6010.3 6997.6 7074.3 7079.8 7081.5 4906.0 4991.6 5034.9 5080.3 5136.2 4905.5 4993.7 5047.7 5194.7 5209.5 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | [#4] prototype.html Cycles:180 Average:4432.05 Median:4985.80 stddev:1362.61 (27.3%) stddev-sans-first:1330.71 03:46:28 INFO - PROCESS | 1943 | Values: 302.3 311.2 311.5 316.7 317.2 4350.5 4691.3 4800.5 5199.7 5216.0 5172.3 5199.7 5202.7 5206.5 5280.2 3447.8 3505.9 3541.6 3884.3 3930.6 3757.9 3980.3 3998.4 4027.4 4072.7 3929.2 3949.8 3954.1 3957.5 3999.1 3805.4 3946.2 3957.4 3983.8 4007.3 3411.8 3451.3 3467.0 3475.7 3476.7 4952.8 4972.0 4985.6 4986.0 4992.2 4364.8 4566.5 4581.1 4587.7 4591.7 4946.6 5076.7 5440.9 5462.6 5465.3 3828.2 3838.6 3843.9 3853.6 3856.7 5400.2 5727.2 5739.0 5750.2 5801.4 3020.6 3502.5 3668.4 3867.7 3910.6 3765.8 3940.9 3947.9 3950.2 3977.5 4369.9 4529.2 4534.2 4567.8 4584.7 5100.5 5152.7 5333.1 5549.2 5605.7 1189.0 1225.7 1312.3 1334.3 1336.4 763.1 780.5 806.4 806.9 807.2 4885.4 4889.5 4898.5 5039.9 5099.9 4657.6 5095.6 5154.8 5300.5 5455.1 4548.9 5151.0 5167.6 5171.2 5257.5 2261.0 2602.8 2809.9 2877.8 2901.9 5614.3 5805.9 5815.8 5819.3 5822.2 5008.5 5320.9 5571.7 5722.2 5796.4 5578.9 5733.9 5750.7 5771.7 5811.5 4264.1 4975.3 5546.8 5642.8 5704.6 5216.7 5518.8 5519.2 5568.0 5574.6 5441.8 5720.7 5723.3 5753.4 5781.2 3485.8 3737.6 3777.4 3794.3 3818.2 4989.4 5225.6 5622.0 5687.0 5709.3 4812.7 4839.9 5493.8 5505.4 5531.3 4413.8 4657.1 5524.1 5568.4 5576.7 5321.4 5324.7 5325.9 5367.5 5384.7 4788.7 5204.3 5441.0 5456.1 5468.8 4083.0 4739.2 5394.0 5421.4 5506.3 03:46:28 INFO - PROCESS | 1943 | 03:46:28 INFO - PROCESS | 1943 | [#5] yui.html Cycles:180 Average:24391.65 Median:22025.19 stddev:39193.31 (177.9%) stddev-sans-first:39262.87 03:46:28 INFO - PROCESS | 1943 | Values: 694.6 717.2 734.9 755.0 822.4 15348.3 15966.8 15987.1 16009.2 16014.8 14207.2 14344.8 14348.6 14360.1 14440.6 714.8 737.4 739.1 875.3 910.3 875.7 895.7 905.3 916.8 917.0 958.9 960.6 961.5 963.0 963.8 761.1 956.3 958.9 961.7 965.8 576.1 695.7 712.8 726.2 727.7 15135.3 15178.4 15214.7 15222.2 15230.7 13950.9 14147.1 14161.9 14264.5 14299.1 11559.4 12307.4 12689.8 12750.2 12769.2 4353.8 4543.5 4626.2 4716.6 4755.2 112238.0 113313.4 116390.0 116665.0 118151.0 10953.9 11104.2 11115.3 11161.8 11520.3 22220.7 22369.9 22418.9 22427.7 22457.6 7824.0 7825.4 7995.6 8096.4 8147.9 4286.5 4413.6 4416.7 4465.3 4470.7 3507.2 3581.2 3629.3 3632.1 3640.6 652.7 662.5 665.4 669.9 678.5 595.4 597.6 619.7 631.0 637.7 8457.0 8886.2 8886.2 8986.0 9150.3 505.7 532.0 545.3 577.7 593.2 4183.0 4446.5 4705.6 4820.5 5038.3 93553.0 97479.5 143428.0 151862.2 164478.0 138019.0 138332.3 138960.3 141632.0 143199.0 111756.0 111839.0 121169.4 121919.4 122787.0 9443.4 9738.0 9740.0 9741.7 9844.9 40409.8 55748.4 61875.4 62306.0 67145.7 57635.1 58960.7 70598.2 70910.6 96287.4 12566.6 13184.1 13418.7 13615.0 13881.0 14196.7 14472.6 14473.1 14488.4 14839.9 11633.4 12045.5 14093.4 14100.2 14181.4 13462.5 13489.1 14206.5 14374.4 14426.0 13553.2 13891.3 14071.4 14193.7 14226.5 8800.6 11084.0 11356.9 11589.9 11625.6 7546.9 10265.7 10531.3 11166.9 11515.8 03:46:28 INFO - PROCESS | 1943 | -------- Summary: end -------- 03:46:28 INFO - PROCESS | 1943 | 03:46:29 INFO - TEST-INFO | 1943: exit 0 03:46:29 INFO - TEST-OK | dromaeo_css | took 1119449ms 03:46:29 INFO - TEST-START | kraken 03:46:29 INFO - operating with platform_type : mac_ 03:46:29 INFO - Initialising browser for kraken test... 03:46:29 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmphRzXVC/profile http://localhost:52733/getInfo.html) 03:46:31 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 03:46:31 INFO - PROCESS | 1970 | colorDepth:24 03:46:31 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 03:46:31 INFO - PROCESS | 1970 | __metrics 03:46:31 INFO - PROCESS | 1970 | 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" 03:46:31 INFO - PROCESS | 1970 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:46:32 INFO - TEST-INFO | 1970: exit 0 03:46:32 INFO - Browser initialized. 03:46:32 INFO - Running cycle 1/1 for kraken test... 03:46:32 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmphRzXVC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:44 INFO - PROCESS | 1971 | RSS: Main: 235790336 03:46:44 INFO - PROCESS | 1971 | 03:46:47 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52733/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:48 INFO - PROCESS | 1971 | RSS: Main: 294600704 03:46:48 INFO - PROCESS | 1971 | 03:46:50 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52733/tests/kraken/driver.html?testName=audio-dft) 03:46:51 INFO - PROCESS | 1971 | RSS: Main: 293879808 03:46:51 INFO - PROCESS | 1971 | 03:46:55 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52733/tests/kraken/driver.html?testName=audio-fft) 03:46:55 INFO - PROCESS | 1971 | RSS: Main: 385241088 03:46:55 INFO - PROCESS | 1971 | 03:46:57 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52733/tests/kraken/driver.html?testName=audio-oscillator) 03:46:58 INFO - PROCESS | 1971 | RSS: Main: 285802496 03:46:58 INFO - PROCESS | 1971 | 03:47:00 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52733/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:01 INFO - PROCESS | 1971 | RSS: Main: 290713600 03:47:01 INFO - PROCESS | 1971 | 03:47:03 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52733/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:04 INFO - PROCESS | 1971 | RSS: Main: 328945664 03:47:04 INFO - PROCESS | 1971 | 03:47:07 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52733/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:07 INFO - PROCESS | 1971 | RSS: Main: 328323072 03:47:07 INFO - PROCESS | 1971 | 03:47:10 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52733/tests/kraken/driver.html?testName=json-parse-financial) 03:47:11 INFO - PROCESS | 1971 | RSS: Main: 326995968 03:47:11 INFO - PROCESS | 1971 | 03:47:12 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52733/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:13 INFO - PROCESS | 1971 | RSS: Main: 301920256 03:47:13 INFO - PROCESS | 1971 | 03:47:15 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:15 INFO - PROCESS | 1971 | RSS: Main: 305135616 03:47:15 INFO - PROCESS | 1971 | 03:47:17 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:18 INFO - PROCESS | 1971 | RSS: Main: 307957760 03:47:18 INFO - PROCESS | 1971 | 03:47:21 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:22 INFO - PROCESS | 1971 | RSS: Main: 320815104 03:47:22 INFO - PROCESS | 1971 | 03:47:25 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:25 INFO - PROCESS | 1971 | RSS: Main: 320217088 03:47:25 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:52733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52733/tests/kraken/driver.html?testName=ai-astar) 03:47:27 INFO - PROCESS | 1971 | RSS: Main: 364187648 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | __start_tp_report 03:47:27 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 03:47:27 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 03:47:27 INFO - PROCESS | 1971 | |i|pagename|runs| 03:47:27 INFO - PROCESS | 1971 | |0;ai-astar;112;114;112;112;113;113;113;117;162;160 03:47:27 INFO - PROCESS | 1971 | |1;audio-beat-detection;152;114;113;149;117;113;112;112;146;113 03:47:27 INFO - PROCESS | 1971 | |2;audio-dft;187;208;257;188;181;183;181;178;180;182 03:47:27 INFO - PROCESS | 1971 | |3;audio-fft;77;59;59;106;84;68;58;59;80;57 03:47:27 INFO - PROCESS | 1971 | |4;audio-oscillator;91;70;90;70;69;69;92;67;68;89 03:47:27 INFO - PROCESS | 1971 | |5;imaging-gaussian-blur;87;84;86;83;85;83;86;84;87;82 03:47:27 INFO - PROCESS | 1971 | |6;imaging-darkroom;91;91;93;92;92;92;92;92;92;92 03:47:27 INFO - PROCESS | 1971 | |7;imaging-desaturate;88;86;86;85;83;85;87;85;87;86 03:47:27 INFO - PROCESS | 1971 | |8;json-parse-financial;59;56;55;53;52;54;52;55;54;52 03:47:27 INFO - PROCESS | 1971 | |9;json-stringify-tinderbox;65;76;63;75;71;69;68;68;71;71 03:47:27 INFO - PROCESS | 1971 | |10;stanford-crypto-aes;87;85;86;86;86;85;89;87;87;87 03:47:27 INFO - PROCESS | 1971 | |11;stanford-crypto-ccm;152;155;154;143;145;146;146;145;202;147 03:47:27 INFO - PROCESS | 1971 | |12;stanford-crypto-pbkdf2;169;177;233;171;171;179;233;167;171;171 03:47:27 INFO - PROCESS | 1971 | |13;stanford-crypto-sha256-iterative;68;67;69;69;71;68;68;68;69;70 03:47:27 INFO - PROCESS | 1971 | __end_tp_report 03:47:27 INFO - PROCESS | 1971 | __start_cc_report 03:47:27 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,1930 03:47:27 INFO - PROCESS | 1971 | __end_cc_report 03:47:27 INFO - PROCESS | 1971 | __startTimestamp1475750847968__endTimestamp 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | ------- Summary: start ------- 03:47:27 INFO - PROCESS | 1971 | Number of tests: 14 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#0] ai-astar Cycles:10 Average:122.80 Median:113.50 stddev:20.19 (17.8%) stddev-sans-first:21.04 03:47:27 INFO - PROCESS | 1971 | Values: 112.0 114.0 112.0 112.0 113.0 113.0 113.0 117.0 162.0 160.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:115.50 stddev:17.30 (15.0%) stddev-sans-first:15.12 03:47:27 INFO - PROCESS | 1971 | Values: 152.0 114.0 113.0 149.0 117.0 113.0 112.0 112.0 146.0 113.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#2] audio-dft Cycles:10 Average:192.50 Median:185.00 stddev:24.23 (13.1%) stddev-sans-first:25.61 03:47:27 INFO - PROCESS | 1971 | Values: 187.0 208.0 257.0 188.0 181.0 183.0 181.0 178.0 180.0 182.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#3] audio-fft Cycles:10 Average:70.70 Median:63.50 stddev:16.04 (25.3%) stddev-sans-first:16.85 03:47:27 INFO - PROCESS | 1971 | Values: 77.0 59.0 59.0 106.0 84.0 68.0 58.0 59.0 80.0 57.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.50 stddev:11.25 (14.1%) stddev-sans-first:10.82 03:47:27 INFO - PROCESS | 1971 | Values: 91.0 70.0 90.0 70.0 69.0 69.0 92.0 67.0 68.0 89.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#5] imaging-gaussian-blur Cycles:10 Average:84.70 Median:85.50 stddev:1.77 (2.1%) stddev-sans-first:1.67 03:47:27 INFO - PROCESS | 1971 | Values: 87.0 84.0 86.0 83.0 85.0 83.0 86.0 84.0 87.0 82.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#6] imaging-darkroom Cycles:10 Average:91.90 Median:92.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 03:47:27 INFO - PROCESS | 1971 | Values: 91.0 91.0 93.0 92.0 92.0 92.0 92.0 92.0 92.0 92.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.24 03:47:27 INFO - PROCESS | 1971 | Values: 88.0 86.0 86.0 85.0 83.0 85.0 87.0 85.0 87.0 86.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:2.20 (4.0%) stddev-sans-first:1.50 03:47:27 INFO - PROCESS | 1971 | Values: 59.0 56.0 55.0 53.0 52.0 54.0 52.0 55.0 54.0 52.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:71.00 stddev:4.03 (5.7%) stddev-sans-first:3.90 03:47:27 INFO - PROCESS | 1971 | Values: 65.0 76.0 63.0 75.0 71.0 69.0 68.0 68.0 71.0 71.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 03:47:27 INFO - PROCESS | 1971 | Values: 87.0 85.0 86.0 86.0 86.0 85.0 89.0 87.0 87.0 87.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:149.50 stddev:17.53 (11.7%) stddev-sans-first:18.59 03:47:27 INFO - PROCESS | 1971 | Values: 152.0 155.0 154.0 143.0 145.0 146.0 146.0 145.0 202.0 147.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:174.00 stddev:25.96 (14.9%) stddev-sans-first:26.95 03:47:27 INFO - PROCESS | 1971 | Values: 169.0 177.0 233.0 171.0 171.0 179.0 233.0 167.0 171.0 171.0 03:47:27 INFO - PROCESS | 1971 | 03:47:27 INFO - PROCESS | 1971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 03:47:27 INFO - PROCESS | 1971 | Values: 68.0 67.0 69.0 69.0 71.0 68.0 68.0 68.0 69.0 70.0 03:47:27 INFO - PROCESS | 1971 | -------- Summary: end -------- 03:47:27 INFO - PROCESS | 1971 | 03:47:28 INFO - TEST-INFO | 1971: exit 0 03:47:28 INFO - TEST-OK | kraken | took 59377ms 03:47:28 INFO - SUITE-END | took 1178s 03:47:29 INFO - Completed test suite (00:19:39) 03:47:29 INFO - javascript benchmark 03:47:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.707616314532, 3252.918677033074, 3274.034159922824, 3294.341131773646, 3333.949990750139, 5456.945430545693, 5570.164475328703, 5594.664320140784, 5633.492985631297, 5685.744141513632, 4707.90584188316, 5546.750396232169, 5611.3546942101675, 5676.063449530833, 5707.828765137042, 5022.799088036474, 5022.874428139289, 5038.5969122470115, 5083.135866902617, 5091.770870310845, 5112.565431938289, 5189.325387699612, 5198.610104242178, 5211.921821172686, 5282.260483532308, 5004.9749751251375, 5141.331626888499, 5160.8967820643375, 5162.070827251093, 5255.579553635719, 5061.797528098871, 5068.949310506885, 5111.2333150027425, 5111.565516931066, 5115.104856650109, 5033.622478314104, 5089.491050894918, 5108.795648174068, 5110.437851836295, 5173.0, 5618.775248990036, 5619.1009438490055, 5645.717714114277, 5663.49028587425, 5677.318721753375, 5963.224780778514, 6025.758969641209, 6042.244719410074, 6047.485963693091, 6083.908741368883, 6118.8776224475705, 6131.50343106675, 6145.4161854623735, 6151.661658608775, 6176.81469555914, 5701.458361455613, 5701.629394089371, 5701.771929122789, 5707.258056452634, 5717.456841600041, 6113.908291375633, 6148.1699970504305, 6165.167702360213, 6230.158928544589, 6236.0, 5892.646441213541, 5980.401959803985, 5983.940160598426, 6027.969860150759, 6046.153538504613, 6129.478994285536, 6149.7847575334645, 6151.938480615226, 6155.876882462326, 6173.722182501798, 6017.488513476316, 6096.591473715663, 6097.725602347905, 6104.725287362079, 6130.5204358993005, 5769.769209231667, 5806.709664516842, 5835.241418615553, 5850.590458667937, 5912.231409916683, 4740.7392593407, 4745.525447455296, 4784.425868895755, 4872.342233798463, 4883.975580122076, 4352.651787856964, 4367.67242456817, 4403.3174857897075, 4427.136708341843, 4443.022535042285, 5144.485551444825, 5689.203511508392, 5700.184455855244, 5724.227229324071, 5751.166080918243, 6022.728977196037, 6106.0, 6161.353057928943, 6166.167567378437, 6180.0, 5607.943920560824, 5611.719414029282, 5618.578606604439, 5624.29696287964, 5626.071698169756, 5271.736413179326, 5279.049771041249, 5283.365996080495, 5289.153735402318, 5294.391145018295, 6136.335271946702, 6179.28938172116, 6182.7217775201125, 6196.659183744938, 6232.844178895564, 6185.84535386619, 6186.81439556814, 6191.4118158774845, 6195.19462469876, 6206.503479721701, 6222.0, 6223.937760622517, 6227.657478838707, 6233.0338797486465, 6243.656598887105, 5906.291245050449, 5930.7924222652, 5931.051031834886, 6037.9094313584455, 6077.665728384981, 6106.5114790817515, 6113.694315284307, 6119.326874043941, 6128.387161283836, 6135.907961380493, 5747.798827041033, 5913.0, 5916.3492015877355, 5925.911111333419, 5942.227510423617, 5915.467607915309, 5928.258967629046, 5928.4960778334325, 5929.555283353852, 5933.821985340447, 5015.498450154955, 5746.9712651436475, 5789.363170051375, 5803.970980145073, 5810.680412577349, 5768.798092066758, 5777.9133313001175, 5792.333881603501, 5837.591368604157, 5910.940890591211, 5625.409332020079, 5625.803096891589, 5636.0, 5639.2668953035845, 5659.066254068032], "value": 5570.147482932981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.31071669287786, 482.35846324388547, 509.4065413792931, 532.1830989431223, 548.9121740521516, 40506.59493405065, 41451.170976580484, 41907.79046104773, 42236.944076398104, 44000.0, 43054.0, 43346.56653433465, 43523.56476435235, 43580.0, 43598.34602480965, 8771.868421973675, 9796.314258001943, 9986.750331241705, 9999.0, 10000.099991000809, 11947.462364193632, 12281.631551053482, 12315.0, 12410.689732756662, 12458.439370228316, 12259.816102758421, 12345.012399008057, 12351.444185011651, 12390.93804530976, 12419.379031048456, 12058.155929084967, 12206.145569810116, 12281.0, 12314.81527777084, 12327.999999999955, 12055.397230138458, 12135.757284854342, 12147.757044859141, 12150.392480376035, 12170.452329645099, 40148.0, 40347.59652403468, 40451.0, 40455.59544404548, 40483.0, 3001.7298443140003, 3322.302316513535, 3333.2000319923286, 3638.21778317663, 3800.7529510581726, 31059.068227953197, 31788.841055794805, 31886.681133188835, 31910.521342179887, 32370.676293237, 3162.7469802415753, 3296.868125274986, 3304.1739565108724, 3312.685294897005, 3449.896503104911, 520644.0, 522333.5533289351, 524291.0, 524926.0, 531006.0, 33627.0, 34441.0, 34552.13619659478, 61872.0, 62608.17397825272, 34986.475202871974, 35253.82373088118, 35335.11662208466, 35341.64658353384, 35450.822745886624, 14398.568042958728, 14570.125792452487, 14574.854251457562, 14590.0, 14596.0, 11239.381833999045, 11419.771604568028, 12140.089493288038, 12255.632331030083, 12370.6288811334, 7783.92216077832, 7793.376529877596, 7814.063721414266, 7851.842963140705, 7888.343447875895, 3254.495553189259, 3283.668595297318, 3285.78642388244, 3299.802011879295, 3309.619393769699, 877.9209871111631, 911.7902882337099, 952.852307892264, 953.561361773578, 1142.8457158283525, 28801.99193028234, 29520.0, 29601.555976660366, 30364.54453183204, 30544.69455305463, 1027.5992362978445, 1037.0459177556666, 1065.4938904020528, 1112.9833052504218, 1186.95845645402, 15188.924055379874, 15470.149141797308, 15490.9225453872, 15584.376624935103, 15987.920060399856, 680088.0, 683756.0, 685487.0, 689073.0, 691938.0, 58533.122003169985, 58896.0, 58965.41034589685, 59034.40965590289, 59116.704416477645, 1360.5034162530605, 1366.5148872150442, 1384.3286006286942, 1393.428694235379, 1394.3934388541018, 28955.42089158247, 29409.85295073511, 29774.25564360908, 30314.090577282717, 30332.0, 50614.49385506098, 51076.0, 51159.23261151011, 51192.488075120265, 51199.464016079575, 577116.0, 582990.0, 582994.0, 583197.0, 584231.0, 22664.206752763574, 23037.769622303564, 26134.170608057255, 26408.735912641398, 26817.463650727266, 44867.55132448634, 46461.0, 47506.28740568825, 47520.0, 47984.040319192725, 37168.492343058846, 38929.61070389373, 39213.0, 40174.99562510961, 40441.39337909875, 38849.2230155401, 38959.805200974944, 40147.79926100351, 40187.0, 40359.79820100881, 37929.62070379371, 38071.238575227784, 38381.0, 38656.0, 38961.805190973864, 31823.204419888763, 32427.675723242464, 34013.82993085019, 34683.82658086794, 34903.30193396169, 25166.874165629786, 25417.872910635328, 25509.489810203322, 26056.478870422863, 26370.73629263683], "value": 19207.094755350743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2519497238203, 376.0429706397219, 387.63949526939945, 398.4740143011226, 408.3079180788563, 19035.524111897194, 21117.0, 21517.354479365604, 21540.413881311382, 21788.128474860987, 20036.799632003676, 20341.0, 20745.273915412963, 20938.476538086554, 21004.474888127803, 5755.251817263771, 5762.769489220436, 5967.522598192134, 6012.729427175787, 6019.067044608093, 4163.979180104096, 4390.97804510977, 4392.12157568486, 4835.588974937117, 5957.642541447505, 6259.0, 6580.111684922546, 6599.901001484982, 6651.467882569407, 6665.40011398974, 6455.386738259858, 6498.69296399776, 6520.706568204442, 6570.375814297634, 6578.0, 5625.296837895263, 5671.943280567224, 5682.232898558683, 5686.1755045518585, 5704.71476426177, 24846.130385436605, 25301.240962771146, 25340.366490837692, 25698.743012569823, 26075.348116297053, 2183.617866873307, 2196.417949243452, 2207.6357401028813, 2324.732655744594, 2616.6205900144373, 14405.567832965027, 15211.619709507351, 15278.847211527853, 15900.284487198103, 15965.361385544564, 1791.6595846789198, 1857.8699491035634, 1860.8139186081285, 1878.8309052185232, 1970.8324792392664, 114826.0, 121004.39497802543, 121410.0, 121582.37055626973, 122379.3881030598, 9377.874655041438, 11186.664400068012, 11541.884581154249, 11611.071114310835, 11718.531258749725, 14466.493672721404, 14507.347169377403, 14514.201718905562, 14515.782263266059, 14536.63658408527, 8088.9595552021865, 8417.494950303002, 8430.15698430152, 8538.743837684879, 8561.700340488178, 8374.330053595697, 8377.581120943929, 8388.706395276136, 8534.359923005675, 8537.957310213533, 3820.617938206213, 4388.2320593896575, 4480.708753930984, 4489.910201796011, 4547.977260113745, 1759.5337235632567, 1835.1925152932668, 1860.2373027059111, 1904.961900761977, 1908.6469003234447, 793.7896457438783, 910.0899100899101, 943.6084025129632, 968.7481254873784, 1002.4015871358399, 15809.683806323808, 19877.27372342756, 20203.989800509917, 21111.577768444546, 21295.254666086923, 906.4742449379344, 913.1918252346721, 923.1230331185267, 928.7863791328033, 935.8862953085807, 10878.619248326271, 11302.321860688386, 11315.83026254607, 11317.603883864025, 11342.20604557673, 502675.0, 509031.0, 510463.0, 609888.0, 612054.0, 141997.0, 149591.25204373908, 149937.25031374773, 150195.7274913399, 150779.0, 967.6419724701906, 978.6134476881734, 995.0845222395413, 1015.5886865819207, 1020.0564477857952, 14679.926600367357, 18300.816991830445, 19281.710774338677, 19303.4208973731, 19356.90321548383, 48427.0, 49717.502824971285, 51117.48882511127, 52832.47167528275, 53211.4678853222, 66035.66982165059, 69247.55933010469, 70875.0, 71456.28543714496, 71546.28453715396, 11372.658820235407, 11493.0, 11515.136364772508, 11843.407829608657, 12143.878561214275, 12972.416241269355, 13478.52825151115, 13521.661958451117, 14009.509667161601, 14131.505397311044, 11301.039411650101, 11471.598494052669, 11769.882301176878, 11908.166428349932, 11992.700182495508, 11348.886511135113, 11391.430428478709, 11801.409929503663, 11955.163138580216, 12041.217320874115, 11420.486078126338, 11560.30638161713, 12042.447477993837, 12044.21712588679, 12048.698782530157, 11854.822177667169, 11974.64076077719, 12212.450439730412, 12250.448729807002, 12318.81521777192, 9921.851172232567, 11177.273477223955, 11740.236884602473, 11907.94046029799, 11964.58123965657], "value": 9919.178758604789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.5925661186561, 1556.8598826105651, 1770.707833207521, 1920.9807901920994, 1955.4231501706995, 8155.980502437181, 8444.240018398343, 8594.441361311518, 9105.954470227656, 9118.31612629053, 8606.95696521518, 8899.91100088999, 8904.91095089049, 8966.37235393521, 8982.685606003775, 2365.2194775724015, 2393.700787401575, 2395.73646898841, 2399.688040554734, 2401.9519609607796, 2108.905099270529, 2194.36363454598, 2352.223766157164, 2376.3821406434276, 2400.759924007594, 2306.746257911628, 2374.715034195899, 2382.154335211001, 2383.4637206628545, 2384.7138343398815, 2353.8234632402637, 2370.6562548430466, 2375.7505461926507, 2389.319044072431, 2394.042383046778, 2339.181286549711, 2358.41039740065, 2362.385779697274, 2366.0, 2368.4907744834773, 8837.867431988525, 8867.866981995276, 8977.0, 8980.595873185723, 8986.14631609996, 5239.187925871496, 5423.05096608092, 5427.019138014636, 5428.267183930158, 5430.348358197041, 3325.9357005758166, 3504.754667173299, 3645.106948797535, 3707.1102935295603, 3711.0536813112485, 992.1269283030958, 1002.6490728245055, 1030.7886883188928, 1048.7063622185801, 1055.9524821383056, 11915.582954596548, 11975.760484790342, 11982.700432489257, 12001.51993920242, 12004.2197257178, 4132.586741325843, 4607.216773148572, 4801.303810947393, 4801.759912004386, 4806.615470762331, 10139.493025348704, 10161.847572286422, 10173.28786984904, 10180.083792458714, 10182.338148020355, 4650.744209068466, 5411.56707463402, 5419.701916394557, 5422.0511410503, 5425.674459532441, 4810.518948105161, 4898.142825005681, 4957.603391728653, 4967.180415231519, 4968.205087186033, 3839.8080095995088, 3865.8067096645054, 3903.863364782219, 3950.0322421006463, 4036.3138266494766, 1187.2045729361348, 1227.1532642476664, 1227.2636418149218, 1264.930428826405, 1273.7834568123442, 768.8961990131261, 854.3250831842898, 872.9738107856774, 897.3314880414002, 969.1181025266973, 5235.063026680153, 5759.0, 5765.88468230633, 6062.120992456157, 6116.633002019893, 821.6549049399266, 915.9084091590921, 915.9404638698463, 918.903515130915, 957.712686194139, 3881.922361552753, 3905.3946638271113, 3921.31377009028, 4029.133736246721, 4149.25313443577, 10526.473676316153, 10757.731056723487, 10763.623273185402, 10901.83647245292, 10909.018188363085, 10036.347637403545, 10385.688429347132, 10856.620018299322, 10865.945670271756, 10878.510467029002, 8101.027876654722, 8315.625796839156, 8321.459105158145, 8328.250457458858, 8368.748937531884, 5947.405259474018, 5959.22530071088, 6070.632453343288, 6124.693765311806, 6140.723667434887, 9602.807943840944, 9981.950090249502, 10122.645707400206, 10122.949385253027, 10161.542730576994, 10133.64532241368, 10175.796484070424, 10303.587856485656, 10304.433256170983, 10338.689839304832, 8176.509409435453, 8221.917780822354, 8240.752777416687, 8363.372747044117, 8372.28835548985, 8186.304164145876, 8459.450135741157, 8459.746207613782, 8464.44981076228, 8469.280111190617, 7309.4152467803515, 7447.590382529013, 7575.280348366897, 7575.431842611936, 7708.537487750753, 7309.195988441161, 7358.374538164316, 7471.17817040136, 7490.625468726433, 7569.47013709035, 6010.308814486215, 6997.615131167835, 7074.29257074309, 7079.752208672878, 7081.504294699322, 4905.975470122627, 4991.600671946163, 5034.899302014012, 5080.339555857715, 5136.152534831711, 4905.509449055208, 4993.675411098267, 5047.697138171721, 5194.714290714047, 5209.479052094912], "value": 4625.014991778713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.29715910508065, 311.2498877704732, 311.4596175635272, 316.6848985259667, 317.1769258773482, 4350.521442641311, 4691.272852707827, 4800.543948324908, 5199.714015729133, 5216.0, 5172.27588137661, 5199.660152931177, 5202.739863006854, 5206.45332240115, 5280.234366016925, 3447.8103704296254, 3505.930691139195, 3541.610422853484, 3884.261990221863, 3930.6069393060607, 3757.8684746033896, 3980.3432433648413, 3998.360262358023, 4027.436158937751, 4072.6989251073196, 3929.2141571685634, 3949.8222579983826, 3954.1498577805764, 3957.515931525678, 3999.060220848098, 3805.3530899746834, 3946.2107578484274, 3957.3668213086057, 3983.780892050936, 4007.318755811519, 3411.812350320731, 3451.3442445935443, 3466.9945715742406, 3475.7045651119683, 3476.66971637694, 4952.801887924478, 4971.950280497221, 4985.626078044125, 4985.975070124662, 4992.151334273182, 4364.825406983717, 4566.520515345874, 4581.129585378767, 4587.678862479628, 4591.724496530219, 4946.562139313179, 5076.705440112748, 5440.91838622421, 5462.617616766828, 5465.262189604392, 3828.1960788234505, 3838.596947320547, 3843.865464708722, 3853.5953724859046, 3856.652901238902, 5400.1899715043055, 5727.198192253088, 5739.0200380868955, 5750.233596993976, 5801.361850196475, 3020.592220050309, 3502.4571191465366, 3668.413053911415, 3867.7292589519025, 3910.589388114207, 3765.755225910307, 3940.901477463029, 3947.881563553098, 3950.20995800841, 3977.528314523645, 4369.934450983238, 4529.230030894756, 4534.229181039232, 4567.835202023462, 4584.701994370355, 5100.546344291859, 5152.690838549699, 5333.146696528537, 5549.195366671891, 5605.747741351649, 1188.9643310700692, 1225.7058306006495, 1312.2979206124678, 1334.3320848938827, 1336.4253371050543, 763.1147868472656, 780.4614815777096, 806.3871457692079, 806.9152738962442, 807.2290962131151, 4885.3649025627155, 4889.48660390661, 4898.542326482883, 5039.874003149951, 5099.923501147486, 4657.6273898088075, 5095.617828662865, 5154.819581314636, 5300.469953004746, 5455.108482838525, 4548.931766023512, 5150.965368679351, 5167.560757335668, 5171.225005745827, 5257.526822585985, 2261.027758064048, 2602.843829370206, 2809.8735556899987, 2877.8488604558343, 2901.8984335548153, 5614.2701448811395, 5805.8548536286935, 5815.82552523425, 5819.301683797971, 5822.243108395966, 5008.549230569266, 5320.893582128413, 5571.693556854331, 5722.170285308607, 5796.449337312949, 5578.912112138094, 5733.913991290134, 5750.654960702372, 5771.653700777967, 5811.506021988093, 4264.125854199943, 4975.303457516023, 5546.833594992157, 5642.815008848188, 5704.60067795267, 5216.66091704038, 5518.834434966958, 5519.199716041232, 5567.972160139173, 5574.581906357121, 5441.782328706808, 5720.713964301685, 5723.306888351512, 5753.424657534213, 5781.161731548817, 3485.7734247273847, 3737.5888652247686, 3777.3578491657036, 3794.279086973577, 3818.19817838246, 4989.376327959005, 5225.634205605571, 5621.971890140687, 5686.9715651421475, 5709.345154503176, 4812.735299558558, 4839.903201936012, 5493.780248790164, 5505.421930697219, 5531.280933478622, 4413.823447062082, 4657.1371451418345, 5524.088525393265, 5568.359638641608, 5576.745232322695, 5321.414644389037, 5324.73698678068, 5325.893482130258, 5367.463253674601, 5384.6769193848495, 4788.736619485822, 5204.297419848272, 5441.0, 5456.072467680583, 5468.808591699271, 4082.95884549438, 4739.218029025173, 5394.004218439202, 5421.3765416975975, 5506.284183056177], "value": 3992.5837798828, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6457306773544, 717.1895757793692, 734.8860926556382, 754.992450075499, 822.436630907828, 15348.30932608034, 15966.76049859253, 15987.120708361035, 16009.19954002298, 16014.759778603331, 14207.218602976833, 14344.784828227585, 14348.641283967907, 14360.138391696506, 14440.638984025378, 714.8427345983876, 737.439545945083, 739.116755477205, 875.2560323724815, 910.3218102513604, 875.711015364928, 895.6730793260479, 905.2622112977934, 916.812053529025, 916.9633214671405, 958.884933807944, 960.5677445149676, 961.538461538462, 963.0417734354327, 963.7735132243918, 761.101899758285, 956.2923436656894, 958.9041095890425, 961.7259081161906, 965.8358079126565, 576.1185386358877, 695.6730336741723, 712.8360477090247, 726.2483329753733, 727.7489266203152, 15135.318910649048, 15178.392864285415, 15214.695706085817, 15222.238888055554, 15230.695386092217, 13950.930245348809, 14147.080439771486, 14161.929190354085, 14264.500742473963, 14299.142051476842, 11559.38845951087, 12307.4461649226, 12689.809652855214, 12750.234985900875, 12769.170003949714, 4353.825846966118, 4543.5002149763495, 4626.236670949289, 4716.622670186377, 4755.2153894607345, 112238.0, 113313.40239171269, 116390.0, 116664.99999999916, 118151.0, 10953.945230273797, 11104.192714430177, 11115.333080015225, 11161.832572511257, 11520.308781473139, 22220.666689999664, 22369.88815055947, 22418.88790556037, 22427.663585046237, 22457.55084898293, 7823.960880195563, 7825.3739700824935, 7995.600219988977, 8096.352291816641, 8147.877781833277, 4286.469924849527, 4413.558644135625, 4416.712913660602, 4465.330200469891, 4470.664700147502, 3507.175813683782, 3581.212133330663, 3629.310431018098, 3632.0556655269293, 3640.581333146669, 652.725855140842, 662.4898827902584, 665.3978149774462, 669.8559809640853, 678.521642242218, 595.3867516458055, 597.6055803169974, 619.6831188403487, 631.0376675569793, 637.6659245412094, 8456.957715211507, 8886.155815197546, 8886.24466920306, 8986.0, 9150.267978561698, 505.70669011972967, 531.9520544527275, 545.3265217456438, 577.7255803493307, 593.24657684741, 4182.958170418317, 4446.5331140230455, 4705.623550115983, 4820.517948205222, 5038.269450929594, 93553.0, 97479.51260243653, 143428.0, 151862.24068879805, 164478.0, 138019.0, 138332.30833845766, 138960.30519847336, 141632.0, 143199.0, 111755.99999999837, 111839.0, 121169.39415303043, 121919.3904030492, 122787.0, 9443.433393996382, 9738.0, 9739.984332197402, 9741.707748767549, 9844.9015509844, 40409.797951010056, 55748.44251557432, 61875.38124618696, 62306.0, 67145.66427168029, 57635.13547296878, 58960.70519647374, 70598.23504412225, 70910.64544677244, 96287.37126287316, 12566.623001309976, 13184.143030702973, 13418.731625367633, 13615.0, 13880.958928080636, 14196.716065678835, 14472.638184045061, 14473.131612103307, 14488.420463181776, 14839.92580037093, 11633.449518872594, 12045.457954392248, 14093.365798538885, 14100.153990760587, 14181.432742690176, 13462.528811491551, 13489.123206991515, 14206.502772402917, 14374.425022999381, 14426.0, 13553.186808791505, 13891.305434728425, 14071.437142514595, 14193.716125677221, 14226.502072427415, 8800.559972001247, 11084.0, 11356.886431135583, 11589.942050289694, 11625.59310424131, 7546.886796698163, 10265.743356415851, 10531.315464494783, 11166.944165279121, 11515.827262591236], "value": 7826.33092297633, "unit": "score"}], "name": "dromaeo_css", "value": 7316.375281693524, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 112.0, 112.0, 113.0, 113.0, 113.0, 117.0, 162.0, 160.0], "value": 122.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 113.0, 149.0, 117.0, 113.0, 112.0, 112.0, 146.0, 113.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 208.0, 257.0, 188.0, 181.0, 183.0, 181.0, 178.0, 180.0, 182.0], "value": 192.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 59.0, 106.0, 84.0, 68.0, 58.0, 59.0, 80.0, 57.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 90.0, 70.0, 69.0, 69.0, 92.0, 67.0, 68.0, 89.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 83.0, 85.0, 83.0, 86.0, 84.0, 87.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 93.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0], "value": 91.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 85.0, 83.0, 85.0, 87.0, 85.0, 87.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 55.0, 53.0, 52.0, 54.0, 52.0, 55.0, 54.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 63.0, 75.0, 71.0, 69.0, 68.0, 68.0, 71.0, 71.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 86.0, 86.0, 85.0, 89.0, 87.0, 87.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 154.0, 143.0, 145.0, 146.0, 146.0, 145.0, 202.0, 147.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 177.0, 233.0, 171.0, 171.0, 179.0, 233.0, 167.0, 171.0, 171.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 69.0, 71.0, 68.0, 68.0, 68.0, 69.0, 70.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1466.8000000000002, "alertThreshold": 2.0}]} 03:47:29 INFO - Return code: 0 03:47:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:29 INFO - # TBPL SUCCESS # 03:47:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:47:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:47:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:47:29 INFO - 2016-10-06 03:47:29.292 screenresolution[1975:18903] starting screenresolution argv=screenresolution get 03:47:29 INFO - 2016-10-06 03:47:29.296 screenresolution[1975:18903] Display 0: 1600x1200x32@60 03:47:29 INFO - 2016-10-06 03:47:29.302 screenresolution[1976:18906] starting screenresolution argv=screenresolution list 03:47:29 INFO - Available Modes on Display 0 03:47:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:47:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:47:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:47:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:47:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:47:29 INFO - Intel Iris: 03:47:29 INFO - Chipset Model: Intel Iris 03:47:29 INFO - Type: GPU 03:47:29 INFO - Bus: Built-In 03:47:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:47:29 INFO - Vendor: Intel (0x8086) 03:47:29 INFO - Device ID: 0x0a2e 03:47:29 INFO - Revision ID: 0x0009 03:47:29 INFO - Displays: 03:47:29 INFO - Display: 03:47:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:47:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:47:29 INFO - Display Serial Number: 1600x1200 60 03:47:29 INFO - Main Display: Yes 03:47:29 INFO - Mirror: Off 03:47:29 INFO - Online: Yes 03:47:29 INFO - Rotation: Supported 03:47:29 INFO - Return code: 0 03:47:29 INFO - Running post-action listener: _resource_record_post_action 03:47:29 INFO - [mozharness: 2016-10-06 10:47:29.537444Z] Finished run-tests step (success) 03:47:29 INFO - Running post-run listener: _resource_record_post_run 03:47:29 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 741376; Write bytes: 707362816; Read time: 7; Write time: 1953 03:47:29 INFO - TinderboxPrint: CPU usage
53.7% 03:47:29 INFO - TinderboxPrint: I/O read bytes / time
741,376 / 7 03:47:29 INFO - TinderboxPrint: I/O write bytes / time
707,362,816 / 1,953 03:47:29 INFO - TinderboxPrint: CPU idle
2,247.2 (46.3%) 03:47:29 INFO - TinderboxPrint: CPU system
971.5 (20.0%) 03:47:29 INFO - TinderboxPrint: CPU user
1,639.1 (33.7%) 03:47:29 INFO - TinderboxPrint: Swap in / out
408,358,912 / 0 03:47:29 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399968768; Write bytes: 393910272; Read time: 30008; Write time: 788 03:47:29 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 741376; Write bytes: 296495104; Read time: 7; Write time: 1114 03:47:30 INFO - Running post-run listener: _upload_blobber_files 03:47:30 INFO - Blob upload gear active. 03:47:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:30 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 03:47:30 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'] 03:47:30 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 03:47:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:47:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:47:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:31 INFO - (blobuploader) - INFO - Done attempting. 03:47:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:47:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:47:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:31 INFO - (blobuploader) - INFO - Done attempting. 03:47:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:34 INFO - (blobuploader) - INFO - Done attempting. 03:47:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:34 INFO - Return code: 0 03:47:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/caf110da57a56735357b7436ae26f4b1f0ec3c9488bcdcc56efa390f2457a6c64a8cf5d5b30c4bb11aa7b7e0a28d708cdf9623b8b2d08b6c72551045f784a84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e4c496b3fb52bccb05fa2fb3c8a0eabdb156a9fe66ef2be4eeccae3aaa2cebe3fe4a0f6a6458d668eeaee4948d10bd14a473787177aff98541c0c509bc5661a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8a22d33e8700062234545ccc42fd56a691466597832e27f795c9379102a9daf56d290b5f07ac261ba833ead34decd6f60e52a68a58f21883fec1de36734acad9"} 03:47:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:34 INFO - Contents: 03:47:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/caf110da57a56735357b7436ae26f4b1f0ec3c9488bcdcc56efa390f2457a6c64a8cf5d5b30c4bb11aa7b7e0a28d708cdf9623b8b2d08b6c72551045f784a84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e4c496b3fb52bccb05fa2fb3c8a0eabdb156a9fe66ef2be4eeccae3aaa2cebe3fe4a0f6a6458d668eeaee4948d10bd14a473787177aff98541c0c509bc5661a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8a22d33e8700062234545ccc42fd56a691466597832e27f795c9379102a9daf56d290b5f07ac261ba833ead34decd6f60e52a68a58f21883fec1de36734acad9"} 03:47:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:34 INFO - Copying logs to upload dir... 03:47:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.848625 ========= master_lag: 1.96 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 03:47:36.024365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-10-06 03:47:36.032295) ========= 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.obDSnmcxfk/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.9NxXZBMM3S/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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/caf110da57a56735357b7436ae26f4b1f0ec3c9488bcdcc56efa390f2457a6c64a8cf5d5b30c4bb11aa7b7e0a28d708cdf9623b8b2d08b6c72551045f784a84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e4c496b3fb52bccb05fa2fb3c8a0eabdb156a9fe66ef2be4eeccae3aaa2cebe3fe4a0f6a6458d668eeaee4948d10bd14a473787177aff98541c0c509bc5661a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8a22d33e8700062234545ccc42fd56a691466597832e27f795c9379102a9daf56d290b5f07ac261ba833ead34decd6f60e52a68a58f21883fec1de36734acad9"} build_url:https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/JzU8gn62QdKAD67S-mX5rg/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/caf110da57a56735357b7436ae26f4b1f0ec3c9488bcdcc56efa390f2457a6c64a8cf5d5b30c4bb11aa7b7e0a28d708cdf9623b8b2d08b6c72551045f784a84a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e4c496b3fb52bccb05fa2fb3c8a0eabdb156a9fe66ef2be4eeccae3aaa2cebe3fe4a0f6a6458d668eeaee4948d10bd14a473787177aff98541c0c509bc5661a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8a22d33e8700062234545ccc42fd56a691466597832e27f795c9379102a9daf56d290b5f07ac261ba833ead34decd6f60e52a68a58f21883fec1de36734acad9"}' ========= master_lag: 1.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-10-06 03:47:37.164395) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:47:37.164779) ========= 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.obDSnmcxfk/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.9NxXZBMM3S/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.004636 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:47:37.374867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 03:47:37.375206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 03:47:37.375592) ========= ========= Total master_lag: 3.67 =========