builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0179 starttime: 1475760730.39 results: success (0) buildid: 20161006041003 builduid: fcd1b113dbab46e1b7790fa553d58144 revision: 993bd0c52f8addd18cdf4163acd645e51090c679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.388596) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.389138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.389467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.414333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.414789) ========= 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.fiDwjf7UWN/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.0H4VukkdXs/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 54.4M=0s 2016-10-06 06:32:10 (54.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096814 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.586502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.586824) ========= 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.fiDwjf7UWN/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.0H4VukkdXs/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.033726 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:10.641692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 06:32:10.642060) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 993bd0c52f8addd18cdf4163acd645e51090c679 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 993bd0c52f8addd18cdf4163acd645e51090c679 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fiDwjf7UWN/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.0H4VukkdXs/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:10,713 truncating revision to first 12 chars 2016-10-06 06:32:10,713 Setting DEBUG logging. 2016-10-06 06:32:10,713 attempt 1/10 2016-10-06 06:32:10,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/993bd0c52f8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 06:32:12,011 unpacking tar archive at: fx-team-993bd0c52f8a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.560320 ========= master_lag: 1.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 06:32:13.398356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:13.398678) ========= script_repo_revision: 993bd0c52f8addd18cdf4163acd645e51090c679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:13.399081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:13.399355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 06:32:13.419507) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-06 06:32:13.419913) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fiDwjf7UWN/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.0H4VukkdXs/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:13 INFO - MultiFileLogger online at 20161006 06:32:13 in /builds/slave/test 06:32:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:32:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:32:13 INFO - {'append_to_log': False, 06:32:13 INFO - 'base_work_dir': '/builds/slave/test', 06:32:13 INFO - 'blob_upload_branch': 'Fx-Team', 06:32:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:32:13 INFO - 'branch': 'Fx-Team', 06:32:13 INFO - 'buildbot_json_path': 'buildprops.json', 06:32:13 INFO - 'config_files': ('talos/mac_config.py',), 06:32:13 INFO - 'default_actions': ('clobber', 06:32:13 INFO - 'read-buildbot-config', 06:32:13 INFO - 'download-and-extract', 06:32:13 INFO - 'populate-webroot', 06:32:13 INFO - 'create-virtualenv', 06:32:13 INFO - 'install', 06:32:13 INFO - 'run-tests'), 06:32:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:32:13 INFO - 'download_minidump_stackwalk': True, 06:32:13 INFO - 'download_symbols': 'ondemand', 06:32:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:32:13 INFO - 'tooltool.py': '/tools/tooltool.py', 06:32:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:32:13 INFO - '/tools/misc-python/virtualenv.py')}, 06:32:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:32:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:32:13 INFO - 'installer_path': 'installer.exe', 06:32:13 INFO - 'log_level': 'info', 06:32:13 INFO - 'log_name': 'talos', 06:32:13 INFO - 'log_to_console': True, 06:32:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:32:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:32:13 INFO - 'opt_config_files': (), 06:32:13 INFO - 'pip_index': False, 06:32:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:13 INFO - 'cmd': ('bash', 06:32:13 INFO - '-c', 06:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:13 INFO - 'enabled': True, 06:32:13 INFO - 'halt_on_failure': False, 06:32:13 INFO - 'name': 'check_screen_resolution'},), 06:32:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:32:13 INFO - 'cmd': ('bash', 06:32:13 INFO - '-c', 06:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:32:13 INFO - 'enabled': True, 06:32:13 INFO - 'halt_on_failure': False, 06:32:13 INFO - 'name': 'check_screen_resolution'},), 06:32:13 INFO - 'run_cmd_checks_enabled': True, 06:32:13 INFO - 'sps_profile': False, 06:32:13 INFO - 'sps_profile_interval': 0, 06:32:13 INFO - 'suite': 'dromaeojs', 06:32:13 INFO - 'system_bits': '32', 06:32:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:32:13 INFO - 'title': 't-yosemite-r7-0179', 06:32:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:32:13 INFO - 'use_talos_json': True, 06:32:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:32:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:32:13 INFO - 'work_dir': 'build'} 06:32:13 INFO - [mozharness: 2016-10-06 13:32:13.616584Z] Running clobber step. 06:32:13 INFO - Running pre-action listener: _resource_record_pre_action 06:32:13 INFO - Running main action method: clobber 06:32:13 INFO - rmtree: /builds/slave/test/build 06:32:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:32:16 INFO - Running post-action listener: _resource_record_post_action 06:32:16 INFO - [mozharness: 2016-10-06 13:32:16.100255Z] Finished clobber step (success) 06:32:16 INFO - [mozharness: 2016-10-06 13:32:16.100472Z] Running read-buildbot-config step. 06:32:16 INFO - Running pre-action listener: _resource_record_pre_action 06:32:16 INFO - Running main action method: read_buildbot_config 06:32:16 INFO - Using buildbot properties: 06:32:16 INFO - { 06:32:16 INFO - "project": "", 06:32:16 INFO - "product": "firefox", 06:32:16 INFO - "script_repo_revision": "production", 06:32:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:32:16 INFO - "repository": "", 06:32:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:32:16 INFO - "buildid": "20161006041003", 06:32:16 INFO - "pgo_build": "False", 06:32:16 INFO - "basedir": "/builds/slave/test", 06:32:16 INFO - "buildnumber": 854, 06:32:16 INFO - "slavename": "t-yosemite-r7-0179", 06:32:16 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:32:16 INFO - "platform": "yosemite_r7", 06:32:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:32:16 INFO - "branch": "fx-team", 06:32:16 INFO - "repo_path": "integration/fx-team", 06:32:16 INFO - "revision": "993bd0c52f8addd18cdf4163acd645e51090c679", 06:32:16 INFO - "stage_platform": "macosx64", 06:32:16 INFO - "builduid": "fcd1b113dbab46e1b7790fa553d58144", 06:32:16 INFO - "slavebuilddir": "test" 06:32:16 INFO - } 06:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:32:16 INFO - Running post-action listener: _resource_record_post_action 06:32:16 INFO - [mozharness: 2016-10-06 13:32:16.103694Z] Finished read-buildbot-config step (success) 06:32:16 INFO - [mozharness: 2016-10-06 13:32:16.103804Z] Running download-and-extract step. 06:32:16 INFO - Running pre-action listener: _resource_record_pre_action 06:32:16 INFO - Running main action method: download_and_extract 06:32:16 INFO - mkdir: /builds/slave/test/build/tests 06:32:16 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')]} 06:32:16 INFO - trying https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:32:16 INFO - Downloading https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/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 06:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/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 06:32:17 INFO - Downloaded 1199 bytes. 06:32:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:32:17 INFO - Using the following test package requirements: 06:32:17 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:32:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:32:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:32:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'jsshell-mac.zip'], 06:32:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:32:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:32:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:32:17 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:32:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:32:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:32:17 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:32:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:32:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:32:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:32:17 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:32:18 INFO - Http code: 200 06:32:18 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 06:32:18 INFO - x-amz-cf-id: aTS2fk2P5yiwNn0OXz0VZFEB5qc812DZTLF77C94DMQuLLLnt8lcOw== 06:32:18 INFO - x-amz-version-id: ECAvNlXJTfqPU_McJ5joWXkjY7vPWt0m 06:32:18 INFO - Expected file size: 16478308 06:32:18 INFO - Obtained file size: 16478308 06:32:25 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 06:32:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:32:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:32:25 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:32:25 INFO - Http code: 200 06:32:25 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 06:32:25 INFO - x-amz-cf-id: cy2Bt7bsqR8W9ez_hlgVqKycl5veoBspRUhrhGUu7SWEIYcwdjqsrg== 06:32:25 INFO - x-amz-version-id: ECAvNlXJTfqPU_McJ5joWXkjY7vPWt0m 06:32:26 INFO - Expected file size: 16478308 06:32:26 INFO - Obtained file size: 16478308 06:32:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:32:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:32:32 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:32:33 INFO - Http code: 200 06:32:33 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 06:32:33 INFO - x-amz-cf-id: cl4OSGNPFb60wYRxgQhD6B5EcaG4kDpF1lZTAg4oF_K0whlMinHvoQ== 06:32:33 INFO - x-amz-version-id: v9Ymh0OKDxR5UJMNqnwnPNpb0V3WxK5T 06:32:34 INFO - Expected file size: 14409006 06:32:34 INFO - Obtained file size: 14409006 06:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:34 INFO - trying https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:32:34 INFO - Downloading https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/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 06:32:38 INFO - Downloaded 111659133 bytes. 06:32:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:32:38 INFO - mkdir: /builds/slave/test/properties 06:32:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:32:38 INFO - Writing to file /builds/slave/test/properties/build_url 06:32:38 INFO - Contents: 06:32:38 INFO - build_url:https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:32:39 INFO - Running post-action listener: _resource_record_post_action 06:32:39 INFO - Running post-action listener: set_extra_try_arguments 06:32:39 INFO - [mozharness: 2016-10-06 13:32:39.246167Z] Finished download-and-extract step (success) 06:32:39 INFO - [mozharness: 2016-10-06 13:32:39.246295Z] Running populate-webroot step. 06:32:39 INFO - Running pre-action listener: _resource_record_pre_action 06:32:39 INFO - Running main action method: populate_webroot 06:32:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:32:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:32:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:32:39 INFO - '--tppagecycles', 06:32:39 INFO - '7'], 06:32:39 INFO - 'tests': ['tsvgm']}}, 06:32:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:32:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:32:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:32:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['damp', 'tps']}, 06:32:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'tests': ['damp', 'tps']}, 06:32:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['dromaeo_dom']}, 06:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:32:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['basic_compositor_video']}, 06:32:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:32:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['a11yr', 06:32:39 INFO - 'ts_paint', 06:32:39 INFO - 'tpaint', 06:32:39 INFO - 'sessionrestore', 06:32:39 INFO - 'sessionrestore_no_auto_restore', 06:32:39 INFO - 'tabpaint']}, 06:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 06:32:39 INFO - 'ts_paint', 06:32:39 INFO - 'tpaint', 06:32:39 INFO - 'sessionrestore', 06:32:39 INFO - 'sessionrestore_no_auto_restore', 06:32:39 INFO - 'tabpaint']}, 06:32:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:32:39 INFO - 'ts_paint', 06:32:39 INFO - 'tpaint', 06:32:39 INFO - 'sessionrestore', 06:32:39 INFO - 'sessionrestore_no_auto_restore', 06:32:39 INFO - 'tabpaint']}, 06:32:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:32:39 INFO - 'ts_paint', 06:32:39 INFO - 'tpaint', 06:32:39 INFO - 'sessionrestore', 06:32:39 INFO - 'sessionrestore_no_auto_restore', 06:32:39 INFO - 'tabpaint']}, 06:32:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['a11yr', 06:32:39 INFO - 'ts_paint', 06:32:39 INFO - 'tpaint', 06:32:39 INFO - 'sessionrestore', 06:32:39 INFO - 'sessionrestore_no_auto_restore', 06:32:39 INFO - 'tabpaint']}, 06:32:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['a11yr', 06:32:39 INFO - 'ts_paint', 06:32:39 INFO - 'tpaint', 06:32:39 INFO - 'sessionrestore', 06:32:39 INFO - 'sessionrestore_no_auto_restore', 06:32:39 INFO - 'tabpaint']}, 06:32:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['tsvgx', 06:32:39 INFO - 'tsvgr_opacity', 06:32:39 INFO - 'tart', 06:32:39 INFO - 'tscrollx', 06:32:39 INFO - 'cart']}, 06:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:32:39 INFO - 'tsvgr_opacity', 06:32:39 INFO - 'tart', 06:32:39 INFO - 'tscrollx', 06:32:39 INFO - 'cart']}, 06:32:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'talos_options': ['--disable-e10s'], 06:32:39 INFO - 'tests': ['tp5o']}, 06:32:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'tests': ['tp5o']}, 06:32:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'talos_options': ['--disable-e10s', 06:32:39 INFO - '--xperf_path', 06:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:39 INFO - 'tests': ['tp5n']}, 06:32:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:32:39 INFO - 'talos_options': ['--xperf_path', 06:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:39 INFO - 'tests': ['tp5n']}}, 06:32:39 INFO - 'talos.zip': {'path': '', 06:32:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:32:39 INFO - Running post-action listener: _resource_record_post_action 06:32:39 INFO - [mozharness: 2016-10-06 13:32:39.265314Z] Finished populate-webroot step (success) 06:32:39 INFO - [mozharness: 2016-10-06 13:32:39.265424Z] Running create-virtualenv step. 06:32:39 INFO - Running pre-action listener: _resource_record_pre_action 06:32:39 INFO - Running main action method: create_virtualenv 06:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 06:32:39 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 06:32:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:32:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:32:39 INFO - Using real prefix '/tools/python27' 06:32:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:32:43 INFO - Installing pip.................done. 06:32:43 INFO - Return code: 0 06:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:32:43 INFO - Reading from file tmpfile_stdout 06:32:43 INFO - Output received: 06:32:43 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) 06:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:32:43 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')]} 06:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:43 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')]} 06:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:43 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:43 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 06:32:43 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 06:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:43 INFO - 'HOME': '/Users/cltbld', 06:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:43 INFO - 'LOGNAME': 'cltbld', 06:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:43 INFO - 'MOZ_NO_REMOTE': '1', 06:32:43 INFO - 'NO_EM_RESTART': '1', 06:32:43 INFO - 'PAGER': '/bin/cat', 06:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:43 INFO - 'PWD': '/builds/slave/test', 06:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:43 INFO - 'SHELL': '/bin/bash', 06:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:32:43 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:43 INFO - 'USER': 'cltbld', 06:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:43 INFO - 'XPC_FLAGS': '0x0', 06:32:43 INFO - 'XPC_SERVICE_NAME': '0', 06:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:43 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 06:32:43 INFO - Cleaning up... 06:32:43 INFO - Return code: 0 06:32:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:32:43 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')]} 06:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:43 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')]} 06:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:43 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:43 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 06:32:43 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 06:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:43 INFO - 'HOME': '/Users/cltbld', 06:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:43 INFO - 'LOGNAME': 'cltbld', 06:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:43 INFO - 'MOZ_NO_REMOTE': '1', 06:32:43 INFO - 'NO_EM_RESTART': '1', 06:32:43 INFO - 'PAGER': '/bin/cat', 06:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:43 INFO - 'PWD': '/builds/slave/test', 06:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:43 INFO - 'SHELL': '/bin/bash', 06:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:32:43 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:43 INFO - 'USER': 'cltbld', 06:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:43 INFO - 'XPC_FLAGS': '0x0', 06:32:43 INFO - 'XPC_SERVICE_NAME': '0', 06:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:43 INFO - Downloading/unpacking psutil>=3.1.1 06:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:32:47 INFO - Installing collected packages: psutil 06:32:47 INFO - Running setup.py install for psutil 06:32:47 INFO - building 'psutil._psutil_osx' extension 06:32:47 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 06:32:47 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 06:32:47 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 06:32:47 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 06:32:48 INFO - building 'psutil._psutil_posix' extension 06:32:48 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 06:32:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:32:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:32:48 INFO - ^ 06:32:48 INFO - 1 warning generated. 06:32:48 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 06:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:32:48 INFO - Successfully installed psutil 06:32:48 INFO - Cleaning up... 06:32:48 INFO - Return code: 0 06:32:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:32:48 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')]} 06:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:48 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')]} 06:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:48 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:48 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 06:32:48 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 06:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:48 INFO - 'HOME': '/Users/cltbld', 06:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:48 INFO - 'LOGNAME': 'cltbld', 06:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:48 INFO - 'MOZ_NO_REMOTE': '1', 06:32:48 INFO - 'NO_EM_RESTART': '1', 06:32:48 INFO - 'PAGER': '/bin/cat', 06:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:48 INFO - 'PWD': '/builds/slave/test', 06:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:48 INFO - 'SHELL': '/bin/bash', 06:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:32:48 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:48 INFO - 'USER': 'cltbld', 06:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:48 INFO - 'XPC_FLAGS': '0x0', 06:32:48 INFO - 'XPC_SERVICE_NAME': '0', 06:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:32: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 06:32: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 06:32: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 06:32: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 06:32: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 06:32: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 06:32:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:32:51 INFO - Installing collected packages: mozsystemmonitor 06:32:51 INFO - Running setup.py install for mozsystemmonitor 06:32:51 INFO - Successfully installed mozsystemmonitor 06:32:51 INFO - Cleaning up... 06:32:51 INFO - Return code: 0 06:32:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:51 INFO - 'HOME': '/Users/cltbld', 06:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:51 INFO - 'LOGNAME': 'cltbld', 06:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:51 INFO - 'MOZ_NO_REMOTE': '1', 06:32:51 INFO - 'NO_EM_RESTART': '1', 06:32:51 INFO - 'PAGER': '/bin/cat', 06:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:51 INFO - 'PWD': '/builds/slave/test', 06:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:51 INFO - 'SHELL': '/bin/bash', 06:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:32:51 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:51 INFO - 'USER': 'cltbld', 06:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:51 INFO - 'XPC_FLAGS': '0x0', 06:32:51 INFO - 'XPC_SERVICE_NAME': '0', 06:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:51 INFO - Downloading/unpacking jsonschema==2.5.1 06:32:51 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 06:32:51 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 06:32:51 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 06:32:51 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 06:32:51 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 06:32:51 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 06:32:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:32:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:32:54 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 06:32:54 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 06:32:54 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 06:32:54 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 06:32:54 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 06:32:54 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 06:32:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:32:54 INFO - warning: no files found matching '*.txt' 06:32:54 INFO - no previously-included directories found matching 'build' 06:32:54 INFO - no previously-included directories found matching 'dist' 06:32:54 INFO - no previously-included directories found matching '.git*' 06:32:54 INFO - Installing collected packages: jsonschema, functools32 06:32:54 INFO - Running setup.py install for functools32 06:32:54 INFO - warning: no files found matching '*.txt' 06:32:54 INFO - no previously-included directories found matching 'build' 06:32:54 INFO - no previously-included directories found matching 'dist' 06:32:54 INFO - no previously-included directories found matching '.git*' 06:32:54 INFO - Successfully installed jsonschema functools32 06:32:54 INFO - Cleaning up... 06:32:54 INFO - Return code: 0 06:32:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:54 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:54 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 06:32:54 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 06:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:54 INFO - 'HOME': '/Users/cltbld', 06:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:54 INFO - 'LOGNAME': 'cltbld', 06:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:54 INFO - 'MOZ_NO_REMOTE': '1', 06:32:54 INFO - 'NO_EM_RESTART': '1', 06:32:54 INFO - 'PAGER': '/bin/cat', 06:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:54 INFO - 'PWD': '/builds/slave/test', 06:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:54 INFO - 'SHELL': '/bin/bash', 06:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:32:54 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:54 INFO - 'USER': 'cltbld', 06:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:54 INFO - 'XPC_FLAGS': '0x0', 06:32:54 INFO - 'XPC_SERVICE_NAME': '0', 06:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:32:55 INFO - Cleaning up... 06:32:55 INFO - Return code: 0 06:32:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:32:55 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:32:55 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 06:32:55 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 06:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:32:55 INFO - 'HOME': '/Users/cltbld', 06:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:32:55 INFO - 'LOGNAME': 'cltbld', 06:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:55 INFO - 'MOZ_NO_REMOTE': '1', 06:32:55 INFO - 'NO_EM_RESTART': '1', 06:32:55 INFO - 'PAGER': '/bin/cat', 06:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:55 INFO - 'PWD': '/builds/slave/test', 06:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:32:55 INFO - 'SHELL': '/bin/bash', 06:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:32:55 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:32:55 INFO - 'USER': 'cltbld', 06:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:55 INFO - 'XPC_FLAGS': '0x0', 06:32:55 INFO - 'XPC_SERVICE_NAME': '0', 06:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:32:55 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 06:32:55 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 06:32:55 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 06:32:55 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 06:32:55 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 06:32:55 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 06:32:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:32:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:32:57 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 06:32:57 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 06:32:57 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 06:32:57 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 06:32:57 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 06:32:57 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 06:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:32: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 06:32: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 06:32: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 06:32: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 06:32: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 06:32: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 06:32:59 INFO - Downloading docopt-0.6.1.tar.gz 06:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:32:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:32:59 INFO - Running setup.py install for blobuploader 06:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:32:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:32:59 INFO - Running setup.py install for requests 06:32:59 INFO - Running setup.py install for docopt 06:32:59 INFO - Successfully installed blobuploader requests docopt 06:32:59 INFO - Cleaning up... 06:33:00 INFO - Return code: 0 06:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:00 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:33:00 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 06:33:00 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 06:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:00 INFO - 'HOME': '/Users/cltbld', 06:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:00 INFO - 'LOGNAME': 'cltbld', 06:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:00 INFO - 'MOZ_NO_REMOTE': '1', 06:33:00 INFO - 'NO_EM_RESTART': '1', 06:33:00 INFO - 'PAGER': '/bin/cat', 06:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:00 INFO - 'PWD': '/builds/slave/test', 06:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:00 INFO - 'SHELL': '/bin/bash', 06:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:33:00 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:00 INFO - 'USER': 'cltbld', 06:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:00 INFO - 'XPC_FLAGS': '0x0', 06:33:00 INFO - 'XPC_SERVICE_NAME': '0', 06:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-oYewmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-rcCr8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-MTQLuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-yqEQh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-PrFgC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-p8jdlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-SjPw8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-YrJd5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ket4dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ZEe3Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-bbbpnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-nVETlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-UWWYiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-GTMZZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-mdQUI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-nkodmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-jVvQaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:33:02 INFO - Running setup.py install for manifestparser 06:33:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:33:02 INFO - Running setup.py install for mozcrash 06:33:02 INFO - Running setup.py install for mozdebug 06:33:02 INFO - Running setup.py install for mozdevice 06:33:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:33:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:33:02 INFO - Running setup.py install for mozfile 06:33:02 INFO - Running setup.py install for mozhttpd 06:33:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:33:02 INFO - Running setup.py install for mozinfo 06:33:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Running setup.py install for mozInstall 06:33:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Running setup.py install for mozleak 06:33:03 INFO - Running setup.py install for mozlog 06:33:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Running setup.py install for moznetwork 06:33:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Running setup.py install for mozprocess 06:33:03 INFO - Running setup.py install for mozprofile 06:33:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:33:03 INFO - Running setup.py install for mozrunner 06:33:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:33:04 INFO - Running setup.py install for mozscreenshot 06:33:04 INFO - Running setup.py install for moztest 06:33:04 INFO - Running setup.py install for mozversion 06:33:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:33:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:33:04 INFO - Cleaning up... 06:33:04 INFO - Return code: 0 06:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33: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')]} 06:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:04 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:33:04 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 06:33:04 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 06:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:04 INFO - 'HOME': '/Users/cltbld', 06:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:04 INFO - 'LOGNAME': 'cltbld', 06:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:04 INFO - 'MOZ_NO_REMOTE': '1', 06:33:04 INFO - 'NO_EM_RESTART': '1', 06:33:04 INFO - 'PAGER': '/bin/cat', 06:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:04 INFO - 'PWD': '/builds/slave/test', 06:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:04 INFO - 'SHELL': '/bin/bash', 06:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:33:04 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:04 INFO - 'USER': 'cltbld', 06:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:04 INFO - 'XPC_FLAGS': '0x0', 06:33:04 INFO - 'XPC_SERVICE_NAME': '0', 06:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:33:04 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-nBlfsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:33:04 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)) 06:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:33:04 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-rwStVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-slvG2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-JPDvXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-rJgIGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-TQU38N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-QKfiEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-EY2vih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-qscjKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-7AqJJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:33:05 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)) 06:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:33:05 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-jSCttb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:33:06 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)) 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:33:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-hwq1bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:33:06 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)) 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:33:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-HehQph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:33:06 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)) 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:33:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-RTVyyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:33:06 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)) 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Plc2q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:33:06 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)) 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:33:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-YhsuOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:33:06 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)) 06:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:33:06 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-XQh0pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:33:06 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)) 06:33:06 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)) 06:33:06 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)) 06:33:06 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)) 06:33:06 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)) 06:33:06 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)) 06:33:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:33:06 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 06:33:06 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 06:33:06 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 06:33:06 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 06:33:06 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 06:33:06 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 06:33:09 INFO - Downloading blessings-1.6.tar.gz 06:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:33:09 INFO - Installing collected packages: blessings 06:33:09 INFO - Running setup.py install for blessings 06:33:09 INFO - Successfully installed blessings 06:33:09 INFO - Cleaning up... 06:33:09 INFO - Return code: 0 06:33:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:09 INFO - Reading from file tmpfile_stdout 06:33:09 INFO - Current package versions: 06:33:09 INFO - blessings == 1.6 06:33:09 INFO - blobuploader == 1.2.4 06:33:09 INFO - docopt == 0.6.1 06:33:09 INFO - functools32 == 3.2.3-2 06:33:09 INFO - jsonschema == 2.5.1 06:33:09 INFO - manifestparser == 1.1 06:33:09 INFO - mozInstall == 1.12 06:33:09 INFO - mozcrash == 0.17 06:33:09 INFO - mozdebug == 0.1 06:33:09 INFO - mozdevice == 0.48 06:33:09 INFO - mozfile == 1.2 06:33:09 INFO - mozhttpd == 0.7 06:33:09 INFO - mozinfo == 0.9 06:33:09 INFO - mozleak == 0.1 06:33:09 INFO - mozlog == 3.4 06:33:09 INFO - moznetwork == 0.27 06:33:09 INFO - mozprocess == 0.23 06:33:09 INFO - mozprofile == 0.28 06:33:09 INFO - mozrunner == 6.12 06:33:09 INFO - mozscreenshot == 0.1 06:33:09 INFO - mozsystemmonitor == 0.3 06:33:09 INFO - moztest == 0.7 06:33:09 INFO - mozversion == 1.4 06:33:09 INFO - psutil == 3.1.1 06:33:09 INFO - requests == 1.2.3 06:33:09 INFO - wsgiref == 0.1.2 06:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:33: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')]} 06:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:10 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')]} 06:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:10 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:33:10 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 06:33:10 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 06:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:10 INFO - 'HOME': '/Users/cltbld', 06:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:10 INFO - 'LOGNAME': 'cltbld', 06:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:10 INFO - 'MOZ_NO_REMOTE': '1', 06:33:10 INFO - 'NO_EM_RESTART': '1', 06:33:10 INFO - 'PAGER': '/bin/cat', 06:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:10 INFO - 'PWD': '/builds/slave/test', 06:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:10 INFO - 'SHELL': '/bin/bash', 06:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:33:10 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:10 INFO - 'USER': 'cltbld', 06:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:10 INFO - 'XPC_FLAGS': '0x0', 06:33:10 INFO - 'XPC_SERVICE_NAME': '0', 06:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 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)) 06:33:10 INFO - Cleaning up... 06:33:10 INFO - Return code: 0 06:33:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:33:10 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')]} 06:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:10 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')]} 06:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:33:11 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 0x107a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0425dbd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, '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.fiDwjf7UWN/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.0H4VukkdXs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 06:33:11 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 06:33:11 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 06:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:11 INFO - 'HOME': '/Users/cltbld', 06:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:11 INFO - 'LOGNAME': 'cltbld', 06:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:11 INFO - 'MOZ_NO_REMOTE': '1', 06:33:11 INFO - 'NO_EM_RESTART': '1', 06:33:11 INFO - 'PAGER': '/bin/cat', 06:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:11 INFO - 'PWD': '/builds/slave/test', 06:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:11 INFO - 'SHELL': '/bin/bash', 06:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:33:11 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:11 INFO - 'USER': 'cltbld', 06:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:11 INFO - 'XPC_FLAGS': '0x0', 06:33:11 INFO - 'XPC_SERVICE_NAME': '0', 06:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:33:11 INFO - Cleaning up... 06:33:11 INFO - Return code: 0 06:33:11 INFO - Running post-action listener: _resource_record_post_action 06:33:11 INFO - Running post-action listener: _start_resource_monitoring 06:33:11 INFO - Starting resource monitoring. 06:33:11 INFO - [mozharness: 2016-10-06 13:33:11.408987Z] Finished create-virtualenv step (success) 06:33:11 INFO - [mozharness: 2016-10-06 13:33:11.409953Z] Running install step. 06:33:11 INFO - Running pre-action listener: _resource_record_pre_action 06:33:11 INFO - Running main action method: install 06:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:33:11 INFO - Reading from file tmpfile_stdout 06:33:11 INFO - Detecting whether we're running mozinstall >=1.0... 06:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:33:11 INFO - Reading from file tmpfile_stdout 06:33:11 INFO - Output received: 06:33:11 INFO - Usage: mozinstall [options] installer 06:33:11 INFO - Options: 06:33:11 INFO - -h, --help show this help message and exit 06:33:11 INFO - -d DEST, --destination=DEST 06:33:11 INFO - Directory to install application into. [default: 06:33:11 INFO - "/builds/slave/test"] 06:33:11 INFO - --app=APP Application being installed. [default: firefox] 06:33:11 INFO - mkdir: /builds/slave/test/build/application 06:33:11 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'] 06:33:11 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 06:33:46 INFO - Reading from file tmpfile_stdout 06:33:46 INFO - Output received: 06:33:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:33:46 INFO - Running post-action listener: _resource_record_post_action 06:33:46 INFO - [mozharness: 2016-10-06 13:33:46.025380Z] Finished install step (success) 06:33:46 INFO - [mozharness: 2016-10-06 13:33:46.025511Z] Running run-tests step. 06:33:46 INFO - Running pre-action listener: _resource_record_pre_action 06:33:46 INFO - Running main action method: run_tests 06:33:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:33:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:33:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:33:46 INFO - 2016-10-06 06:33:46.040 screenresolution[1642:7395] starting screenresolution argv=screenresolution get 06:33:46 INFO - 2016-10-06 06:33:46.042 screenresolution[1642:7395] Display 0: 1600x1200x32@60 06:33:46 INFO - 2016-10-06 06:33:46.049 screenresolution[1643:7397] starting screenresolution argv=screenresolution list 06:33:46 INFO - Available Modes on Display 0 06:33:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:33:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:33:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:33:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:33:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:33:46 INFO - Intel Iris: 06:33:46 INFO - Chipset Model: Intel Iris 06:33:46 INFO - Type: GPU 06:33:46 INFO - Bus: Built-In 06:33:46 INFO - VRAM (Dynamic, Max): 1536 MB 06:33:46 INFO - Vendor: Intel (0x8086) 06:33:46 INFO - Device ID: 0x0a2e 06:33:46 INFO - Revision ID: 0x0009 06:33:46 INFO - Displays: 06:33:46 INFO - Display: 06:33:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:33:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:33:46 INFO - Display Serial Number: 1600x1200 60 06:33:46 INFO - Main Display: Yes 06:33:46 INFO - Mirror: Off 06:33:46 INFO - Online: Yes 06:33:46 INFO - Rotation: Supported 06:33:46 INFO - Return code: 0 06:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:33:46 INFO - Python 2.7.3 06:33:46 INFO - Return code: 0 06:33:46 INFO - grabbing minidump binary from tooltool 06:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:33:46 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 0x107891d30>, '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 0x1076b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107889b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:33:46 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 06:33:46 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 06:33:46 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 06:33:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:33:46 INFO - Return code: 0 06:33:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:33:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:33:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:33:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:33:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 06:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0179 --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 06:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fiDwjf7UWN/Render', 06:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:33:46 INFO - 'HOME': '/Users/cltbld', 06:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:33:46 INFO - 'LOGNAME': 'cltbld', 06:33:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:33:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:33:46 INFO - 'MOZ_NO_REMOTE': '1', 06:33:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:33:46 INFO - 'NO_EM_RESTART': '1', 06:33:46 INFO - 'PAGER': '/bin/cat', 06:33:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:33:46 INFO - 'PWD': '/builds/slave/test', 06:33:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:33:46 INFO - 'SHELL': '/bin/bash', 06:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0H4VukkdXs/Listeners', 06:33:46 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 06:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:33:46 INFO - 'USER': 'cltbld', 06:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:33:46 INFO - 'XPC_FLAGS': '0x0', 06:33:46 INFO - 'XPC_SERVICE_NAME': '0', 06:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:33:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 06:33:46 INFO - mozversion application_buildid: 20161006041003 06:33:46 INFO - mozversion application_changeset: 993bd0c52f8addd18cdf4163acd645e51090c679 06:33:46 INFO - mozversion application_display_name: Nightly 06:33:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:33:46 INFO - mozversion application_name: Firefox 06:33:46 INFO - mozversion application_remotingname: firefox 06:33:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:33:46 INFO - mozversion application_vendor: Mozilla 06:33:46 INFO - mozversion application_version: 52.0a1 06:33:46 INFO - mozversion platform_buildid: 20161006041003 06:33:46 INFO - mozversion platform_changeset: 993bd0c52f8addd18cdf4163acd645e51090c679 06:33:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:33:46 INFO - mozversion platform_version: 52.0a1 06:33:46 INFO - using testdate: 1475760826 06:33:46 INFO - actual date: 1475760826 06:33:46 INFO - starting webserver on 'localhost:49267' 06:33:46 INFO - SUITE-START | Running 2 tests 06:33:46 INFO - TEST-START | dromaeo_css 06:33:46 INFO - operating with platform_type : mac_ 06:33:46 INFO - Initialising browser for dromaeo_css test... 06:33:46 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmp3ySqnH/profile http://localhost:49267/getInfo.html) 06:33:48 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 06:33:48 INFO - PROCESS | 1653 | colorDepth:24 06:33:48 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 06:33:48 INFO - PROCESS | 1653 | __metrics 06:33:49 INFO - PROCESS | 1653 | 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" 06:33:49 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:33:49 INFO - TEST-INFO | 1653: exit 0 06:33:49 INFO - Browser initialized. 06:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 06:33:49 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmp3ySqnH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:01 INFO - PROCESS | 1655 | RSS: Main: 244449280 06:34:01 INFO - PROCESS | 1655 | 06:34:52 INFO - PROCESS | 1655 | 1475760892922 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] 06:37:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 06:37:08 INFO - PROCESS | 1655 | RSS: Main: 472150016 06:37:08 INFO - PROCESS | 1655 | 06:40:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 06:40:11 INFO - PROCESS | 1655 | RSS: Main: 372002816 06:40:11 INFO - PROCESS | 1655 | 06:43:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 06:43:14 INFO - PROCESS | 1655 | RSS: Main: 364359680 06:43:14 INFO - PROCESS | 1655 | 06:46:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 06:46:17 INFO - PROCESS | 1655 | RSS: Main: 345485312 06:46:17 INFO - PROCESS | 1655 | 06:49:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 06:49:22 INFO - PROCESS | 1655 | RSS: Main: 334950400 06:49:22 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 06:52:25 INFO - PROCESS | 1655 | RSS: Main: 440766464 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | __start_tp_report 06:52:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 06:52:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 06:52:25 INFO - PROCESS | 1655 | |i|pagename|runs| 06:52:25 INFO - PROCESS | 1655 | |0;dojo.html;3250.4311745444547;3256.6092068951716;3258.2017405735596;3270.2151483643925;3311.8840840570583;4915.090708218978;5511.53151982082;5544.750486228119;5558.360788509312;5596.9160462593045;5528.474794894489;5584.692841893704;5626.803061892834;5636.915446268309;5728.083506638928;5058.974705126469;5062.190049592066;5087.135187018216;5114.744262786864;5126.897462050757;4471.971446567291;5201.0898092833795;5204.791808327663;5220.477952204768;5273.920891186635;4492.865214043584;5162.251473536354;5174.2238664200295;5222.7649755760895;5250.7112108834;5041.59667226621;5041.6722913010535;5099.184130539096;5105.438401775802;5107.514786095315;5027.145385284511;5031.119554078022;5145.974270128663;5155.742212889378;5172.094883395391;5189.506996835295;5470.835874923759;5558.972205138948;5575.247341608912;5596.076647353182;5953.910691339634;6143.447089761943;6154;6162;6177.1969643945995;6100.762843515328;6111.816645500642;6189.597676151036;6193.225846769154;6200.472959798422;5702.287214098238;5702.45826646468;5703.800366987136;5709.543236541067;5744.138379243063;6136.693165341715;6238.469730072995;6244.875102497925;6255.937440625627;6271.404216599416;5896.6756828374855;5958.910616340671;5979.850503737442;5982.282126144891;6107.328193898667;6112.541559383064;6176.197094377702;6192.969035154795;6194.442500175006;6198.504119670506;6104.599274111988;6132.448079672851;6132.754689812357;6133.6319820810895;6135.846603834851;5988.3113441953865;6016.217891674054;6045.758169673164;6130.754769809247;6140.574473083197;4822.879428014257;4842.273658951115;4847.200211964986;4852.320675105488;4862.562369386772;4295.183915056192;4303.720258183208;4305.16049370376;4385.144896745104;4399.142167277414;5580.553555715533;5630.690312032795;5650.576206784508;5669.489745922887;5672.971635141798;5865.706714664249;5878.059510478303;5893.6463812171405;5978.073398623221;6202.131701561785;5433.809816656398;5472.753726082336;5483.533899618577;5493.313335833021;5497.862553436196;5194.428612852583;5208.609354298367;5293.550048245942;5334.546563542065;5353;6203.503719702503;6221.222347206599;6245.469135123565;6261.217347831612;6261.624302541862;6172.4136207060255;6191.938080619317;6200.348963358782;6210.347913469021;6217.4715149211015;6160;6178.598391104564;6185.257769067741;6221.906671399842;6225.190725205694;6108.205933228652;6142.877142457215;6147.893379191788;6151.477124444473;6157.168782214344;6168.228971378578;6175.228096487939;6179.598326108789;6185.8144255672405;6205.81382558524;5778.422157784188;5787.768489260382;5853.560982926212;6000.309964354155;6040.298440780859;5813.709314534171;5901.527877769682;5917.763289468373;5923.911141332969;5926.674032928058;5777.133429985536;5780.364159942319;5782.855428614318;5788.21859049023;5794.62334948227;5849.502792262705;5887.264091988502;5916.615419997686;5918.260217472816;5925.792597259076;5656.518207529538;5774.0761478163295;5788;5795.130730390307;5796.82609521715 06:52:25 INFO - PROCESS | 1655 | |1;ext.html;480.42589106018323;490.54624472363065;495.9801607935681;523.916173412254;542.5659472422067;40762.98092547688;42002.789986050106;42210.577894221125;42534.361984570256;42694.78652606733;41444.58555414445;41774;41850;41905.37141942866;41921.37117943226;9805.852912206323;9951.253655975795;9968.6510972116;9981.75045623858;9983.40099594023;9650.420974741503;9752.36609620376;9753.707388778348;9754.512274386288;9759.804803903917;9691.370060946052;9762.658306959258;9816.6073357066;9828.803423931517;9986.300958932878;9710.36882602632;9739.172170365491;9744.805103897954;9761.609535618567;9766.827980642298;8267.677171652507;9606.039396060409;9704;9710.271729620306;9717.271204659679;40486.59513404887;40728.981775455555;40824.59175408238;40824.79587602043;40880.182396352204;3233.708966193054;3325.6341802401716;3333.633300336961;3453.188500702333;3694.8706795262037;26189.607155892678;30984.22539436532;31438.842805786055;31807.20481987946;32021.559029843713;3192.6807319267887;3240.675932406764;3253.7397008239286;3280.2455435249785;3283.3597448497553;481698;487263;489751;490465;505463;59139.40860591425;59585.40414595798;59598.70200649056;59666;59772;35033.124171895906;35462;35588.822055889555;36242.27515449676;36267.637323626426;16135.435259765853;16260.18699065042;16262.18689065542;16284;16320.836791631931;12454.564090256797;12575.811362829565;12589.24464532131;12592.559260425842;12593.181443206162;14829.851701483063;18258.991510933785;18283.98314278156;18358.357457488924;18359.05280364728;7351.632418379059;7442.702291908263;7488.925110748823;7631.1605723370385;7651.885221721679;730.9853802924018;832.7376876284072;900.4012331799411;903.4895284164426;923.9676611318572;28505.287367815556;28659.57010644842;29576.852115739282;29674.25814354615;29794.255143621584;958.7028021313415;1069.753956589973;1107.1143085531703;1142.5204360353362;1187.5190547828142;11984.760304793856;12958.80561791574;13820.792688109485;15408;15734.763978540332;643837;753371;767650;768619;948804;57662;58279;58330.708346458;58376;58533.70733146307;1219.0917766264013;1261.356708078868;1261.6215135459327;1301.362332457108;1342.3489607540334;24612.876935615208;27873.58189627198;30024.69975300219;30575.541366879068;30739.385212295183;47614.28578571393;48876.999999998574;48907.75546122246;48913.266301006224;49013.754931225114;544748;549088;550318;550352;550921;24035.399115022265;24510.264692059267;26595.93616255328;26821.19536413911;27148;45239.547604523534;45444.31833522566;45497.09005819931;45754.25474471542;45863.77068114638;28883.844646213915;38280.42579361368;38408.615913840506;39783.030684092635;40202.798986004884;36879.26241475209;38261.04347391338;38715.225695485366;39729.00677483086;40010.59989400069;37021.81489092537;37032;37094.25811483809;37853.43219851759;38410.42384364181;31991.84004079965;32593.837030814695;33434.366521907985;33995.66004340024;34176;25034.874825625757;25102.748972510773;25319.493610127327;25400.872995634905;25881.482370352864 06:52:25 INFO - PROCESS | 1655 | |2;jquery.html;364.8814135405992;370.6904734546654;378.39645765004826;381.3250546532636;393.05666400638484;18851.340203092896;20768.96155192238;21453.249136280254;21610.027548760303;21618.35144945652;20176.69734953977;20460.28389006385;20718.5497015209;20977.74133551988;21011.47471313218;5879.529637629001;6014.548908831834;6185;6229.2836323822885;6238.1266622672865;4265.146970605876;4461.24158892989;6086.300075491331;6240.469560087398;6603.108580341641;6871.175458944934;6878;6945.58326500409;6956.234814170437;6968.895466568006;6627.768028119017;6867.004284378787;6923.099997000408;6923.792286231421;6936.306369363074;5947.6431414115295;5949.077892926603;6027.276726792769;6028.367021462771;6045.516358691294;22438.663420048713;22663.433414164778;24326.756732432805;25338.239852804447;25713.97144114233;2190.769969153248;2502.749725027501;2802.3274414140665;3090.3510262844607;3201.551782750417;12566.81149782754;15288.694226115527;15447.845521544754;16012.879098463112;16061.277242524115;1885.9717104243448;1914.9617007659908;1927.421773467954;1928.2479832865195;1945.873518221311;104647.0191899786;112324;112449.43775281153;112466;113300;10667.413292268844;11032.745340124522;11306.265092768943;11340.716482087848;11390;13989;13994.650133746738;13995.090319129224;14006.71986560263;14019.369128389248;8270.917290827136;8556.486610803371;8592.398532102818;8734.781630459162;8765.342599305077;7896.684132634745;8465.153484651486;8469.703560375481;8609.913900861036;8693.652253909899;5857;6596.703148358335;6635.4359879410795;6643.40209381158;6753.696083676246;1654.338264694108;1754.9649007019789;1783.7146056630877;1786.63374008328;1802.8107048759953;803.6664784114644;852.859278219087;889.8531742262454;937.7889974755761;1018.923580731448;19638.607227855362;20950.790492094882;21983.450413739785;22020.669689954662;22158.667619985714;905.7328088213861;932.7901222224945;944.3955868244329;946.7301818981557;972.2076507646245;9895.901040989642;11354.602588909349;11605.88394116065;11778;12042.939785301018;472183;581874;614300;629013;630958;133914;135194;135747;139176;140341.2982935079;975.6292608808608;990.9058639429243;994.472929347447;1017.2828156149897;1020.2246292817364;19614.509637259183;20088.096035678136;20209.79790202138;20210.78735275888;20239.19043238313;54771.72614137063;54853.45146548643;55018;55436.445635543125;55979;62131;80328;80673.19326806656;81030.5948470254;81250;7881.763547093597;8007.4366906725945;8044.798880028046;8115.79710507242;8208.753737387888;11130.16523760705;11321.81120982318;12573.308468034345;12687.555935542212;12749.55376561853;9538.666146684833;10167.67820183401;10813.729656758644;11093.722656933318;11146.944265278946;9844.655437059668;10783.299085559414;10840.457977100956;11055.447227638746;11110.555577776799;10901.672949811518;11055.72360690989;11089.445527723421;11421.885781142082;11690.941545292219;7872.448928574945;8031.237032481905;8184.749193971706;8204.948762809297;8377.246047855722;8164.550949697824;9106.856380346793;9501.33490655675;10665.093467055387;10770.838437423288 06:52:25 INFO - PROCESS | 1655 | |3;mootools.html;1382.2190462388746;1526.3970731561033;1672.389577804102;1829.8719089663712;1873.3536929759237;8601.526916019617;9074;9083.636654533819;9095.636174553027;9111.407758495694;7977.401694872879;8249.257566818986;8541.615627296771;8838.248748856355;8852.3360747944;2240.305505293356;2275.7155355580553;2277.9658305125436;2278.8860556972168;2285.0745448093467;2208.017432242653;2212.3031245157804;2222.811061059812;2332.265336419031;2342.02805835578;2296.115995341797;2316.652502124686;2317.339558225906;2317.9884100579475;2355.1168311883043;2323.9767602324014;2326.0579465316573;2327.627579587275;2329.650552417134;2335.6146235871147;2307.4231442139467;2332.5334933013464;2335.3344296875307;2336.7429582745885;2339.5905716499547;8809.64761409543;9025.774355641095;9030.322725795591;9031.096890310917;9033.187013168781;5188.558972487343;5346.518813306821;5350.705711185883;5357.785688572452;5359.062164121263;3410.931781364384;3507.1232191952013;3650.324689932371;3654.3604869148057;3654.3787556115526;1077.450500244873;1081.2755453845941;1084.5336505302716;1102.7077824376547;1104.8232282834708;11352.09183265345;11650.359230242333;11787.469563869647;11787.705307367385;11794;3742.7754334740002;4499.932501012488;4722.5513576210205;4749.26386410107;4763.857084287477;9944.453055081894;9969.30214884951;9987.0012998701;10003.649872254437;10012.148967337713;5312.442193569696;5314.946850531523;5316.601254905898;5321.521063104339;5325.573954083664;4368.453943257093;4405.229084910128;4588.38056862326;4776.665633405628;4844.75776211188;3803.600621934657;3841.7118716096406;3936.4095385692376;3962.2471730371135;3985.740926839746;1223.6818427208989;1245.483124503339;1247.376311844078;1255.2029461291963;1259.250745806244;835.8035861572525;848.7029539661193;887.9156480134377;896.6458248991612;935.3546053223254;5590.832275031756;5687.345955215121;5946.672932988728;5959.1941995060315;5970.611910225822;915.1763412928418;921.8386782313069;934.7943452440452;940.8870935487786;976.5947131940165;3913.412988051815;3953.1573822067735;4022.416749571296;4055.9657287392115;4073.714839961174;8821.470711757314;11081.224314298082;11192.04867586248;11192.496337664825;11235.269707468988;9279.350445468888;10704.625338113285;11144.442777861075;11154.442277886235;11180.496877640526;8180.222878826502;8403.495790252604;8407.369447291478;8415.621297041647;8440.746777596682;5792.681402522901;5806.158107074535;5880.647161170344;5932.762689492544;5971.671558064349;10271.383716976707;10324.535395907353;10324.587016519255;10355.948220259152;10381.53283102247;9710.660126895526;10142.746431339276;10179.643712470028;10258.948705256425;10267.640632577824;6971;7198.352148306678;7496.700131994878;7657;7673.462857600138;7853.725119620786;7898.091719452107;7994.000749906262;8338.124496927736;8431.662733490592;7516.586587737727;7592.962035189788;7622.809429764078;7642.426817988562;7820.687172513036;7175.964120179366;7340.339369456775;7376.0411146550605;7448.776536703907;7492.962535187289;6972.058772065706;6996.300369962963;7076.25699301566;7076.433885289268;7077.221505634273;4911.189653707098;4956.95903860179;5014.423341315795;5054.898902022012;5083.415407228216;4475.686701930834;4867.926981095357;4941.950580494149;4992.676940610813;5094.337736094284 06:52:25 INFO - PROCESS | 1655 | |4;prototype.html;298.80876239206907;299.2264994987955;308.2079056823962;312.3799258471934;315.17581524313897;4047.7856643007053;4252.851150209739;4716.740579268139;4811.13399588074;5112.872178195542;3542.7697199682;4221.902305400595;4584.129015487055;4996.600271978242;5028.245763135532;3949.5852935441794;3956.3669812829953;3967.3138915960744;4010.679145668354;4029.294873397151;3609.693176080036;3651.087228192952;3948.2165073623028;3949.4202319072315;3968.226195891802;2839.7930879376286;3143.512755522886;3751.8686845960397;3928.2732694451474;3935.291647503448;3215.4051500472488;3633.963660363389;3886.8833934981994;3929.4105884117466;3948.8420463181437;3200.8719651213923;3375.4599264117624;3386.407378708741;3395.1681837949614;3411.164264755126;4381.824727010916;4836.082772953919;4887.266909963499;4992.352523667181;5066.873328166788;4345.934810977807;4410.206162890679;4444.8444304449185;4455.77721113943;4484.551544845522;5387.299651045379;5412.295127034971;5415.80275286656;5450.645708028966;5482.616216864821;3699.72252081095;3727.7390582659223;3755.5916531300763;3758.9436158457647;3760.8119594020463;5226.425093239741;5604.411536788619;5608.4391560844;5676.744546495335;5708.9466478800105;3154.722337453335;3222.693844084808;3693.298273328059;3752.45589389537;3777.301199278142;3186.745060395163;3817.1220619257724;3824.330742120118;3828.942565861514;3836.654701076861;3719.776813391205;3782.0544863784053;4207.915841683149;4393.626541743987;4435.334699795057;4468.597826195658;4469.932951005738;5103.234514822732;5446;5513.9448605514235;1063.4948399510172;1221.1451983611507;1256.265084925329;1283.685497053228;1312.0225432053182;866.6273502393905;886.7851044069666;887.7514295997131;896.4307664633005;900.3967341880956;4599.482170883601;4676.392069031072;4865.105262368885;5037.571806396498;5044.924326135111;5148.845534633967;5519.337679478408;5547.445255474501;5548.278723765885;5579.954532963569;4203.516595591546;4301.247281725686;4334.50153232376;4844.4186697596515;4947.678400903929;2765.681946576129;2873.9425211495654;2884.3510210202535;2893.6833740647953;2933.7066293370917;4928;5280.947190528045;5718.571107166979;5722.828315150469;5727.398623144593;5570.303712035996;5595.888082238333;5612.1581762735095;5639.898056069145;5651.66090034591;4732;5698.296107530138;5738.598298119092;5751.993401154781;5753.252077229933;4248.511421186603;4558.8632341029825;5439.150688765839;5619.016672082287;5649.265595472562;4885.438174609965;5543.36251331086;5563.944360556343;5596.468335508121;5598.1602759586385;4442.800073996743;5438.945610543844;5766.913496297643;5889.38161493037;5896.292444906639;3710.2950439416422;3866;3901.668358189472;3919.7844118573753;3934.7835869027476;5464.617476776588;5476.808311709071;5571.3871474137;5575.968445837533;5609;5251.083354575476;5471.316085489314;5473.932583146248;5492.450754924475;5499.755144464785;4436.578525040116;5330.706811125426;5391.784328626811;5415.323084614423;5422.376426710979;5103.821366252163;5252;5284;5288.7258478854465;5298.54962328191;4490.777065352671;4852.078105160008;5438.728063596884;5510.311211098613;5523.558115350843;5127;5347.6791392515015;5358.517733404013;5360.812371566976;5388.9013817054565 06:52:25 INFO - PROCESS | 1655 | |5;yui.html;655.5902560899438;737.9114506259247;742.5804420502412;766.658836817616;800.9759707208785;15350.46273380432;15605.453809116654;15609.453669121584;15634.84365156348;16338.264778084986;14400.783988240184;14465.92767036166;14478.927605361985;14492.492762753305;14503.98472106953;683.7572661705098;705.3123204875232;705.8729428702832;821.9342452603793;842.7345386203357;807.5679511461369;852.26705033671;859.9054104048549;866.1944391715701;866.9219770220678;923.5151545438631;924.8381533231691;925.1488630459959;925.4354843545466;925.7176561148847;725.1407082607127;913.6756451459703;914.3096961793804;916.7295647783886;917.0783362720457;552.5993654600383;654.2606854254709;675.3752778679701;679.3783687925542;680.5100327764002;15039.624009399853;15085.924570377189;15104.697906041818;15112.773308400383;15117.924410377878;11516.827247591293;12112.81830772539;13512.459501619924;13789.655258618515;13874.93062534691;12303.876961230451;12613.369331533386;12787.232766033974;12868;12916.612501624966;4530.0939812037395;4542.931856022163;4565.680402371835;4743.715377077352;4765.046990601859;114760;116304;117612.41193794062;117792;119785.40107299408;10839;10844.837327440095;10961.177911656658;11212;11234.10127189823;21597.892010539847;21654.675179872316;21681.45796355072;21682.34952951414;21684.78315216859;7609.961950190213;7787.5716835574585;7788.727394541163;7915.16890726477;8045.356371490267;4252.593317211509;4265.680073994463;4283.271843786564;4367.410399596078;4460.219461594208;3409.4885767134633;3518.82405879705;3523.524324216249;3524.718022558189;3526.2947410518;491.33424210195386;655.4854439265154;664.8138521214067;666.0608541955819;666.9633170175687;520.9739513024409;602.3073465514693;603.6076550242377;604.8911195984765;629.9968500157562;8724.65101395937;8812.427192232484;8875.378723489423;8952.955235223912;8957;578.3609111931339;588.9322727886348;598.7486153938203;612.1888497740512;638.9840253993688;3434.347473979936;4253.170631726845;4346.913061738747;4438.267685831866;4467.195904737114;104723;158146;161391;162781;171225;96062;100861.49569252254;111865.89810375658;126383;132664;98817.01182988222;113067;117014;118202.40898795796;120215.39892300483;7646.808829779077;7716.112647045437;8205.261526462407;8275.710350137717;8625.611847466753;67135.32864671486;67589.3241067583;68043.65978170077;68626.65686671535;68698.31301686919;75469;98794;101254;102394.48802755939;106914.46542767236;11387.316760994367;11425.942870285595;11494.827577586175;11707.239029463057;11904.583339583072;11993.460294286604;12110.878891210976;12166.087543434101;12190.695232619255;12626.494940202288;11120.721981950515;11162.609308674157;11244.987921201275;11261.774764504828;11281.984621384116;11439.828402573801;11449.255798373079;11527.135464840338;11538.48076836561;11978.281303121841;10864.402457864893;10867.836982445111;10944.562217511211;11361.147913906325;11456.968872801488;9556.569954351931;9580.856287155559;9669.129778319984;9948.900510994798;10244.078032977068;9237.348112558762;9447.574859131219;9530.857037144588;9589.760255993657;9758.316917815684 06:52:25 INFO - PROCESS | 1655 | __end_tp_report 06:52:25 INFO - PROCESS | 1655 | __start_cc_report 06:52:25 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2741 06:52:25 INFO - PROCESS | 1655 | __end_cc_report 06:52:25 INFO - PROCESS | 1655 | __startTimestamp1475761945467__endTimestamp 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | ------- Summary: start ------- 06:52:25 INFO - PROCESS | 1655 | Number of tests: 6 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5621.43 Median:5788.00 stddev:643.81 (11.1%) stddev-sans-first:618.33 06:52:25 INFO - PROCESS | 1655 | Values: 3250.4 3256.6 3258.2 3270.2 3311.9 4915.1 5511.5 5544.8 5558.4 5596.9 5528.5 5584.7 5626.8 5636.9 5728.1 5059.0 5062.2 5087.1 5114.7 5126.9 4472.0 5201.1 5204.8 5220.5 5273.9 4492.9 5162.3 5174.2 5222.8 5250.7 5041.6 5041.7 5099.2 5105.4 5107.5 5027.1 5031.1 5146.0 5155.7 5172.1 5189.5 5470.8 5559.0 5575.2 5596.1 5953.9 6143.4 6154.0 6162.0 6177.2 6100.8 6111.8 6189.6 6193.2 6200.5 5702.3 5702.5 5703.8 5709.5 5744.1 6136.7 6238.5 6244.9 6255.9 6271.4 5896.7 5958.9 5979.9 5982.3 6107.3 6112.5 6176.2 6193.0 6194.4 6198.5 6104.6 6132.4 6132.8 6133.6 6135.8 5988.3 6016.2 6045.8 6130.8 6140.6 4822.9 4842.3 4847.2 4852.3 4862.6 4295.2 4303.7 4305.2 4385.1 4399.1 5580.6 5630.7 5650.6 5669.5 5673.0 5865.7 5878.1 5893.6 5978.1 6202.1 5433.8 5472.8 5483.5 5493.3 5497.9 5194.4 5208.6 5293.6 5334.5 5353.0 6203.5 6221.2 6245.5 6261.2 6261.6 6172.4 6191.9 6200.3 6210.3 6217.5 6160.0 6178.6 6185.3 6221.9 6225.2 6108.2 6142.9 6147.9 6151.5 6157.2 6168.2 6175.2 6179.6 6185.8 6205.8 5778.4 5787.8 5853.6 6000.3 6040.3 5813.7 5901.5 5917.8 5923.9 5926.7 5777.1 5780.4 5782.9 5788.2 5794.6 5849.5 5887.3 5916.6 5918.3 5925.8 5656.5 5774.1 5788.0 5795.1 5796.8 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:72276.20 Median:40745.98 stddev:166767.70 (409.3%) stddev-sans-first:167148.41 06:52:25 INFO - PROCESS | 1655 | Values: 480.4 490.5 496.0 523.9 542.6 40763.0 42002.8 42210.6 42534.4 42694.8 41444.6 41774.0 41850.0 41905.4 41921.4 9805.9 9951.3 9968.7 9981.8 9983.4 9650.4 9752.4 9753.7 9754.5 9759.8 9691.4 9762.7 9816.6 9828.8 9986.3 9710.4 9739.2 9744.8 9761.6 9766.8 8267.7 9606.0 9704.0 9710.3 9717.3 40486.6 40729.0 40824.6 40824.8 40880.2 3233.7 3325.6 3333.6 3453.2 3694.9 26189.6 30984.2 31438.8 31807.2 32021.6 3192.7 3240.7 3253.7 3280.2 3283.4 481698.0 487263.0 489751.0 490465.0 505463.0 59139.4 59585.4 59598.7 59666.0 59772.0 35033.1 35462.0 35588.8 36242.3 36267.6 16135.4 16260.2 16262.2 16284.0 16320.8 12454.6 12575.8 12589.2 12592.6 12593.2 14829.9 18259.0 18284.0 18358.4 18359.1 7351.6 7442.7 7488.9 7631.2 7651.9 731.0 832.7 900.4 903.5 924.0 28505.3 28659.6 29576.9 29674.3 29794.3 958.7 1069.8 1107.1 1142.5 1187.5 11984.8 12958.8 13820.8 15408.0 15734.8 643837.0 753371.0 767650.0 768619.0 948804.0 57662.0 58279.0 58330.7 58376.0 58533.7 1219.1 1261.4 1261.6 1301.4 1342.3 24612.9 27873.6 30024.7 30575.5 30739.4 47614.3 48877.0 48907.8 48913.3 49013.8 544748.0 549088.0 550318.0 550352.0 550921.0 24035.4 24510.3 26595.9 26821.2 27148.0 45239.5 45444.3 45497.1 45754.3 45863.8 28883.8 38280.4 38408.6 39783.0 40202.8 36879.3 38261.0 38715.2 39729.0 40010.6 37021.8 37032.0 37094.3 37853.4 38410.4 31991.8 32593.8 33434.4 33995.7 34176.0 25034.9 25102.7 25319.5 25400.9 25881.5 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34985.87 Median:3145.95 stddev:98410.30 (3128.2%) stddev-sans-first:98652.04 06:52:25 INFO - PROCESS | 1655 | Values: 364.9 370.7 378.4 381.3 393.1 18851.3 20769.0 21453.2 21610.0 21618.4 20176.7 20460.3 20718.5 20977.7 21011.5 5879.5 6014.5 6185.0 6229.3 6238.1 4265.1 4461.2 6086.3 6240.5 6603.1 6871.2 6878.0 6945.6 6956.2 6968.9 6627.8 6867.0 6923.1 6923.8 6936.3 5947.6 5949.1 6027.3 6028.4 6045.5 22438.7 22663.4 24326.8 25338.2 25714.0 2190.8 2502.7 2802.3 3090.4 3201.6 12566.8 15288.7 15447.8 16012.9 16061.3 1886.0 1915.0 1927.4 1928.2 1945.9 104647.0 112324.0 112449.4 112466.0 113300.0 10667.4 11032.7 11306.3 11340.7 11390.0 13989.0 13994.7 13995.1 14006.7 14019.4 8270.9 8556.5 8592.4 8734.8 8765.3 7896.7 8465.2 8469.7 8609.9 8693.7 5857.0 6596.7 6635.4 6643.4 6753.7 1654.3 1755.0 1783.7 1786.6 1802.8 803.7 852.9 889.9 937.8 1018.9 19638.6 20950.8 21983.5 22020.7 22158.7 905.7 932.8 944.4 946.7 972.2 9895.9 11354.6 11605.9 11778.0 12042.9 472183.0 581874.0 614300.0 629013.0 630958.0 133914.0 135194.0 135747.0 139176.0 140341.3 975.6 990.9 994.5 1017.3 1020.2 19614.5 20088.1 20209.8 20210.8 20239.2 54771.7 54853.5 55018.0 55436.4 55979.0 62131.0 80328.0 80673.2 81030.6 81250.0 7881.8 8007.4 8044.8 8115.8 8208.8 11130.2 11321.8 12573.3 12687.6 12749.6 9538.7 10167.7 10813.7 11093.7 11146.9 9844.7 10783.3 10840.5 11055.4 11110.6 10901.7 11055.7 11089.4 11421.9 11690.9 7872.4 8031.2 8184.7 8204.9 8377.2 8164.6 9106.9 9501.3 10665.1 10770.8 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5722.67 Median:4889.56 stddev:3242.69 (66.3%) stddev-sans-first:3235.38 06:52:25 INFO - PROCESS | 1655 | Values: 1382.2 1526.4 1672.4 1829.9 1873.4 8601.5 9074.0 9083.6 9095.6 9111.4 7977.4 8249.3 8541.6 8838.2 8852.3 2240.3 2275.7 2278.0 2278.9 2285.1 2208.0 2212.3 2222.8 2332.3 2342.0 2296.1 2316.7 2317.3 2318.0 2355.1 2324.0 2326.1 2327.6 2329.7 2335.6 2307.4 2332.5 2335.3 2336.7 2339.6 8809.6 9025.8 9030.3 9031.1 9033.2 5188.6 5346.5 5350.7 5357.8 5359.1 3410.9 3507.1 3650.3 3654.4 3654.4 1077.5 1081.3 1084.5 1102.7 1104.8 11352.1 11650.4 11787.5 11787.7 11794.0 3742.8 4499.9 4722.6 4749.3 4763.9 9944.5 9969.3 9987.0 10003.6 10012.1 5312.4 5314.9 5316.6 5321.5 5325.6 4368.5 4405.2 4588.4 4776.7 4844.8 3803.6 3841.7 3936.4 3962.2 3985.7 1223.7 1245.5 1247.4 1255.2 1259.3 835.8 848.7 887.9 896.6 935.4 5590.8 5687.3 5946.7 5959.2 5970.6 915.2 921.8 934.8 940.9 976.6 3913.4 3953.2 4022.4 4056.0 4073.7 8821.5 11081.2 11192.0 11192.5 11235.3 9279.4 10704.6 11144.4 11154.4 11180.5 8180.2 8403.5 8407.4 8415.6 8440.7 5792.7 5806.2 5880.6 5932.8 5971.7 10271.4 10324.5 10324.6 10355.9 10381.5 9710.7 10142.7 10179.6 10258.9 10267.6 6971.0 7198.4 7496.7 7657.0 7673.5 7853.7 7898.1 7994.0 8338.1 8431.7 7516.6 7593.0 7622.8 7642.4 7820.7 7176.0 7340.3 7376.0 7448.8 7493.0 6972.1 6996.3 7076.3 7076.4 7077.2 4911.2 4957.0 5014.4 5054.9 5083.4 4475.7 4867.9 4942.0 4992.7 5094.3 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4342.84 Median:4823.61 stddev:1350.19 (28.0%) stddev-sans-first:1319.42 06:52:25 INFO - PROCESS | 1655 | Values: 298.8 299.2 308.2 312.4 315.2 4047.8 4252.9 4716.7 4811.1 5112.9 3542.8 4221.9 4584.1 4996.6 5028.2 3949.6 3956.4 3967.3 4010.7 4029.3 3609.7 3651.1 3948.2 3949.4 3968.2 2839.8 3143.5 3751.9 3928.3 3935.3 3215.4 3634.0 3886.9 3929.4 3948.8 3200.9 3375.5 3386.4 3395.2 3411.2 4381.8 4836.1 4887.3 4992.4 5066.9 4345.9 4410.2 4444.8 4455.8 4484.6 5387.3 5412.3 5415.8 5450.6 5482.6 3699.7 3727.7 3755.6 3758.9 3760.8 5226.4 5604.4 5608.4 5676.7 5708.9 3154.7 3222.7 3693.3 3752.5 3777.3 3186.7 3817.1 3824.3 3828.9 3836.7 3719.8 3782.1 4207.9 4393.6 4435.3 4468.6 4469.9 5103.2 5446.0 5513.9 1063.5 1221.1 1256.3 1283.7 1312.0 866.6 886.8 887.8 896.4 900.4 4599.5 4676.4 4865.1 5037.6 5044.9 5148.8 5519.3 5547.4 5548.3 5580.0 4203.5 4301.2 4334.5 4844.4 4947.7 2765.7 2873.9 2884.4 2893.7 2933.7 4928.0 5280.9 5718.6 5722.8 5727.4 5570.3 5595.9 5612.2 5639.9 5651.7 4732.0 5698.3 5738.6 5752.0 5753.3 4248.5 4558.9 5439.2 5619.0 5649.3 4885.4 5543.4 5563.9 5596.5 5598.2 4442.8 5438.9 5766.9 5889.4 5896.3 3710.3 3866.0 3901.7 3919.8 3934.8 5464.6 5476.8 5571.4 5576.0 5609.0 5251.1 5471.3 5473.9 5492.5 5499.8 4436.6 5330.7 5391.8 5415.3 5422.4 5103.8 5252.0 5284.0 5288.7 5298.5 4490.8 4852.1 5438.7 5510.3 5523.6 5127.0 5347.7 5358.5 5360.8 5388.9 06:52:25 INFO - PROCESS | 1655 | 06:52:25 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24710.80 Median:4274.48 stddev:40339.68 (943.7%) stddev-sans-first:40412.41 06:52:25 INFO - PROCESS | 1655 | Values: 655.6 737.9 742.6 766.7 801.0 15350.5 15605.5 15609.5 15634.8 16338.3 14400.8 14465.9 14478.9 14492.5 14504.0 683.8 705.3 705.9 821.9 842.7 807.6 852.3 859.9 866.2 866.9 923.5 924.8 925.1 925.4 925.7 725.1 913.7 914.3 916.7 917.1 552.6 654.3 675.4 679.4 680.5 15039.6 15085.9 15104.7 15112.8 15117.9 11516.8 12112.8 13512.5 13789.7 13874.9 12303.9 12613.4 12787.2 12868.0 12916.6 4530.1 4542.9 4565.7 4743.7 4765.0 114760.0 116304.0 117612.4 117792.0 119785.4 10839.0 10844.8 10961.2 11212.0 11234.1 21597.9 21654.7 21681.5 21682.3 21684.8 7610.0 7787.6 7788.7 7915.2 8045.4 4252.6 4265.7 4283.3 4367.4 4460.2 3409.5 3518.8 3523.5 3524.7 3526.3 491.3 655.5 664.8 666.1 667.0 521.0 602.3 603.6 604.9 630.0 8724.7 8812.4 8875.4 8953.0 8957.0 578.4 588.9 598.7 612.2 639.0 3434.3 4253.2 4346.9 4438.3 4467.2 104723.0 158146.0 161391.0 162781.0 171225.0 96062.0 100861.5 111865.9 126383.0 132664.0 98817.0 113067.0 117014.0 118202.4 120215.4 7646.8 7716.1 8205.3 8275.7 8625.6 67135.3 67589.3 68043.7 68626.7 68698.3 75469.0 98794.0 101254.0 102394.5 106914.5 11387.3 11425.9 11494.8 11707.2 11904.6 11993.5 12110.9 12166.1 12190.7 12626.5 11120.7 11162.6 11245.0 11261.8 11282.0 11439.8 11449.3 11527.1 11538.5 11978.3 10864.4 10867.8 10944.6 11361.1 11457.0 9556.6 9580.9 9669.1 9948.9 10244.1 9237.3 9447.6 9530.9 9589.8 9758.3 06:52:25 INFO - PROCESS | 1655 | -------- Summary: end -------- 06:52:25 INFO - PROCESS | 1655 | 06:52:26 INFO - TEST-INFO | 1655: exit 0 06:52:26 INFO - TEST-OK | dromaeo_css | took 1119635ms 06:52:26 INFO - TEST-START | kraken 06:52:26 INFO - operating with platform_type : mac_ 06:52:26 INFO - Initialising browser for kraken test... 06:52:26 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpfF7z1o/profile http://localhost:49267/getInfo.html) 06:52:28 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 06:52:28 INFO - PROCESS | 1665 | colorDepth:24 06:52:28 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 06:52:28 INFO - PROCESS | 1665 | __metrics 06:52:28 INFO - PROCESS | 1665 | 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" 06:52:28 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:52:29 INFO - TEST-INFO | 1665: exit 0 06:52:29 INFO - Browser initialized. 06:52:29 INFO - Running cycle 1/1 for kraken test... 06:52:29 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpfF7z1o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:41 INFO - PROCESS | 1666 | RSS: Main: 236310528 06:52:41 INFO - PROCESS | 1666 | 06:52:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 06:52:45 INFO - PROCESS | 1666 | RSS: Main: 295014400 06:52:45 INFO - PROCESS | 1666 | 06:52:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 06:52:48 INFO - PROCESS | 1666 | RSS: Main: 295800832 06:52:48 INFO - PROCESS | 1666 | 06:52:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 06:52:53 INFO - PROCESS | 1666 | RSS: Main: 387117056 06:52:53 INFO - PROCESS | 1666 | 06:52:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 06:52:55 INFO - PROCESS | 1666 | RSS: Main: 285982720 06:52:55 INFO - PROCESS | 1666 | 06:52:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:52:58 INFO - PROCESS | 1666 | RSS: Main: 290086912 06:52:58 INFO - PROCESS | 1666 | 06:53:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 06:53:01 INFO - PROCESS | 1666 | RSS: Main: 328609792 06:53:01 INFO - PROCESS | 1666 | 06:53:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 06:53:05 INFO - PROCESS | 1666 | RSS: Main: 329719808 06:53:05 INFO - PROCESS | 1666 | 06:53:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 06:53:08 INFO - PROCESS | 1666 | RSS: Main: 329297920 06:53:08 INFO - PROCESS | 1666 | 06:53:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:53:10 INFO - PROCESS | 1666 | RSS: Main: 304226304 06:53:10 INFO - PROCESS | 1666 | 06:53:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:53:13 INFO - PROCESS | 1666 | RSS: Main: 304574464 06:53:13 INFO - PROCESS | 1666 | 06:53:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:53:16 INFO - PROCESS | 1666 | RSS: Main: 315228160 06:53:16 INFO - PROCESS | 1666 | 06:53:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:53:20 INFO - PROCESS | 1666 | RSS: Main: 322101248 06:53:20 INFO - PROCESS | 1666 | 06:53:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:53:23 INFO - PROCESS | 1666 | RSS: Main: 321499136 06:53:23 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 06:53:25 INFO - PROCESS | 1666 | RSS: Main: 365338624 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | __start_tp_report 06:53:25 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 06:53:25 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 06:53:25 INFO - PROCESS | 1666 | |i|pagename|runs| 06:53:25 INFO - PROCESS | 1666 | |0;ai-astar;114;113;116;113;114;115;114;114;115;164 06:53:25 INFO - PROCESS | 1666 | |1;audio-beat-detection;157;115;117;149;116;140;139;115;185;137 06:53:25 INFO - PROCESS | 1666 | |2;audio-dft;183;184;183;185;183;171;255;181;184;185 06:53:25 INFO - PROCESS | 1666 | |3;audio-fft;81;58;61;87;61;59;60;62;81;59 06:53:25 INFO - PROCESS | 1666 | |4;audio-oscillator;90;70;91;70;68;70;92;66;68;90 06:53:25 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;88;84;89;86;85;87;89;86;88;88 06:53:25 INFO - PROCESS | 1666 | |6;imaging-darkroom;108;145;150;94;93;93;92;92;97;92 06:53:25 INFO - PROCESS | 1666 | |7;imaging-desaturate;87;84;86;91;104;87;85;86;84;86 06:53:25 INFO - PROCESS | 1666 | |8;json-parse-financial;53;54;54;54;54;54;53;55;52;52 06:53:25 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;64;75;67;76;70;69;70;71;71;70 06:53:25 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;87;87;86;89;89;85;90;85;91;86 06:53:25 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;146;145;147;146;142;146;146;144;180;162 06:53:25 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;171;177;172;173;173;171;174;173;173;173 06:53:25 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;69;72;64;60;70;82;86;86;86 06:53:25 INFO - PROCESS | 1666 | __end_tp_report 06:53:25 INFO - PROCESS | 1666 | __start_cc_report 06:53:25 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2072 06:53:25 INFO - PROCESS | 1666 | __end_cc_report 06:53:25 INFO - PROCESS | 1666 | __startTimestamp1475762005646__endTimestamp 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | ------- Summary: start ------- 06:53:25 INFO - PROCESS | 1666 | Number of tests: 14 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:119.20 Median:114.50 stddev:15.77 (13.8%) stddev-sans-first:16.61 06:53:25 INFO - PROCESS | 1666 | Values: 114.0 113.0 116.0 113.0 114.0 115.0 114.0 114.0 115.0 164.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:139.50 stddev:22.78 (16.3%) stddev-sans-first:22.98 06:53:25 INFO - PROCESS | 1666 | Values: 157.0 115.0 117.0 149.0 116.0 140.0 139.0 115.0 185.0 137.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:189.40 Median:184.00 stddev:23.41 (12.7%) stddev-sans-first:24.72 06:53:25 INFO - PROCESS | 1666 | Values: 183.0 184.0 183.0 185.0 183.0 171.0 255.0 181.0 184.0 185.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.90 Median:61.50 stddev:11.29 (18.4%) stddev-sans-first:10.76 06:53:25 INFO - PROCESS | 1666 | Values: 81.0 58.0 61.0 87.0 61.0 59.0 60.0 62.0 81.0 59.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:80.00 stddev:11.48 (14.4%) stddev-sans-first:11.25 06:53:25 INFO - PROCESS | 1666 | Values: 90.0 70.0 91.0 70.0 68.0 70.0 92.0 66.0 68.0 90.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.76 06:53:25 INFO - PROCESS | 1666 | Values: 88.0 84.0 89.0 86.0 85.0 87.0 89.0 86.0 88.0 88.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:92.50 stddev:22.63 (24.5%) stddev-sans-first:23.99 06:53:25 INFO - PROCESS | 1666 | Values: 108.0 145.0 150.0 94.0 93.0 93.0 92.0 92.0 97.0 92.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:88.00 Median:86.00 stddev:5.96 (6.9%) stddev-sans-first:6.31 06:53:25 INFO - PROCESS | 1666 | Values: 87.0 84.0 86.0 91.0 104.0 87.0 85.0 86.0 84.0 86.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 06:53:25 INFO - PROCESS | 1666 | Values: 53.0 54.0 54.0 54.0 54.0 54.0 53.0 55.0 52.0 52.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:3.47 (4.9%) stddev-sans-first:2.83 06:53:25 INFO - PROCESS | 1666 | Values: 64.0 75.0 67.0 76.0 70.0 69.0 70.0 71.0 71.0 70.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:2.12 (2.4%) stddev-sans-first:2.24 06:53:25 INFO - PROCESS | 1666 | Values: 87.0 87.0 86.0 89.0 89.0 85.0 90.0 85.0 91.0 86.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:146.00 stddev:11.74 (8.0%) stddev-sans-first:12.34 06:53:25 INFO - PROCESS | 1666 | Values: 146.0 145.0 147.0 146.0 142.0 146.0 146.0 144.0 180.0 162.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.00 stddev:1.70 (1.0%) stddev-sans-first:1.64 06:53:25 INFO - PROCESS | 1666 | Values: 171.0 177.0 172.0 173.0 173.0 171.0 174.0 173.0 173.0 173.0 06:53:25 INFO - PROCESS | 1666 | 06:53:25 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:77.00 stddev:9.78 (12.7%) stddev-sans-first:10.17 06:53:25 INFO - PROCESS | 1666 | Values: 69.0 69.0 72.0 64.0 60.0 70.0 82.0 86.0 86.0 86.0 06:53:25 INFO - PROCESS | 1666 | -------- Summary: end -------- 06:53:25 INFO - PROCESS | 1666 | 06:53:26 INFO - TEST-INFO | 1666: exit 0 06:53:26 INFO - TEST-OK | kraken | took 60246ms 06:53:26 INFO - SUITE-END | took 1179s 06:53:26 INFO - Completed test suite (00:19:40) 06:53:26 INFO - javascript benchmark 06:53:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.4311745444547, 3256.6092068951716, 3258.2017405735596, 3270.2151483643925, 3311.8840840570583, 4915.090708218978, 5511.53151982082, 5544.750486228119, 5558.360788509312, 5596.9160462593045, 5528.474794894489, 5584.692841893704, 5626.803061892834, 5636.915446268309, 5728.083506638928, 5058.974705126469, 5062.190049592066, 5087.135187018216, 5114.744262786864, 5126.897462050757, 4471.971446567291, 5201.0898092833795, 5204.791808327663, 5220.477952204768, 5273.920891186635, 4492.865214043584, 5162.251473536354, 5174.2238664200295, 5222.7649755760895, 5250.7112108834, 5041.59667226621, 5041.6722913010535, 5099.184130539096, 5105.438401775802, 5107.514786095315, 5027.145385284511, 5031.119554078022, 5145.974270128663, 5155.742212889378, 5172.094883395391, 5189.506996835295, 5470.835874923759, 5558.972205138948, 5575.247341608912, 5596.076647353182, 5953.910691339634, 6143.447089761943, 6154.0, 6162.0, 6177.1969643945995, 6100.762843515328, 6111.816645500642, 6189.597676151036, 6193.225846769154, 6200.472959798422, 5702.287214098238, 5702.45826646468, 5703.800366987136, 5709.543236541067, 5744.138379243063, 6136.693165341715, 6238.469730072995, 6244.875102497925, 6255.937440625627, 6271.404216599416, 5896.6756828374855, 5958.910616340671, 5979.850503737442, 5982.282126144891, 6107.328193898667, 6112.541559383064, 6176.197094377702, 6192.969035154795, 6194.442500175006, 6198.504119670506, 6104.599274111988, 6132.448079672851, 6132.754689812357, 6133.6319820810895, 6135.846603834851, 5988.3113441953865, 6016.217891674054, 6045.758169673164, 6130.754769809247, 6140.574473083197, 4822.879428014257, 4842.273658951115, 4847.200211964986, 4852.320675105488, 4862.562369386772, 4295.183915056192, 4303.720258183208, 4305.16049370376, 4385.144896745104, 4399.142167277414, 5580.553555715533, 5630.690312032795, 5650.576206784508, 5669.489745922887, 5672.971635141798, 5865.706714664249, 5878.059510478303, 5893.6463812171405, 5978.073398623221, 6202.131701561785, 5433.809816656398, 5472.753726082336, 5483.533899618577, 5493.313335833021, 5497.862553436196, 5194.428612852583, 5208.609354298367, 5293.550048245942, 5334.546563542065, 5353.0, 6203.503719702503, 6221.222347206599, 6245.469135123565, 6261.217347831612, 6261.624302541862, 6172.4136207060255, 6191.938080619317, 6200.348963358782, 6210.347913469021, 6217.4715149211015, 6160.0, 6178.598391104564, 6185.257769067741, 6221.906671399842, 6225.190725205694, 6108.205933228652, 6142.877142457215, 6147.893379191788, 6151.477124444473, 6157.168782214344, 6168.228971378578, 6175.228096487939, 6179.598326108789, 6185.8144255672405, 6205.81382558524, 5778.422157784188, 5787.768489260382, 5853.560982926212, 6000.309964354155, 6040.298440780859, 5813.709314534171, 5901.527877769682, 5917.763289468373, 5923.911141332969, 5926.674032928058, 5777.133429985536, 5780.364159942319, 5782.855428614318, 5788.21859049023, 5794.62334948227, 5849.502792262705, 5887.264091988502, 5916.615419997686, 5918.260217472816, 5925.792597259076, 5656.518207529538, 5774.0761478163295, 5788.0, 5795.130730390307, 5796.82609521715], "value": 5579.037027024574, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.42589106018323, 490.54624472363065, 495.9801607935681, 523.916173412254, 542.5659472422067, 40762.98092547688, 42002.789986050106, 42210.577894221125, 42534.361984570256, 42694.78652606733, 41444.58555414445, 41774.0, 41850.0, 41905.37141942866, 41921.37117943226, 9805.852912206323, 9951.253655975795, 9968.6510972116, 9981.75045623858, 9983.40099594023, 9650.420974741503, 9752.36609620376, 9753.707388778348, 9754.512274386288, 9759.804803903917, 9691.370060946052, 9762.658306959258, 9816.6073357066, 9828.803423931517, 9986.300958932878, 9710.36882602632, 9739.172170365491, 9744.805103897954, 9761.609535618567, 9766.827980642298, 8267.677171652507, 9606.039396060409, 9704.0, 9710.271729620306, 9717.271204659679, 40486.59513404887, 40728.981775455555, 40824.59175408238, 40824.79587602043, 40880.182396352204, 3233.708966193054, 3325.6341802401716, 3333.633300336961, 3453.188500702333, 3694.8706795262037, 26189.607155892678, 30984.22539436532, 31438.842805786055, 31807.20481987946, 32021.559029843713, 3192.6807319267887, 3240.675932406764, 3253.7397008239286, 3280.2455435249785, 3283.3597448497553, 481698.0, 487263.0, 489751.0, 490465.0, 505463.0, 59139.40860591425, 59585.40414595798, 59598.70200649056, 59666.0, 59772.0, 35033.124171895906, 35462.0, 35588.822055889555, 36242.27515449676, 36267.637323626426, 16135.435259765853, 16260.18699065042, 16262.18689065542, 16284.0, 16320.836791631931, 12454.564090256797, 12575.811362829565, 12589.24464532131, 12592.559260425842, 12593.181443206162, 14829.851701483063, 18258.991510933785, 18283.98314278156, 18358.357457488924, 18359.05280364728, 7351.632418379059, 7442.702291908263, 7488.925110748823, 7631.1605723370385, 7651.885221721679, 730.9853802924018, 832.7376876284072, 900.4012331799411, 903.4895284164426, 923.9676611318572, 28505.287367815556, 28659.57010644842, 29576.852115739282, 29674.25814354615, 29794.255143621584, 958.7028021313415, 1069.753956589973, 1107.1143085531703, 1142.5204360353362, 1187.5190547828142, 11984.760304793856, 12958.80561791574, 13820.792688109485, 15408.0, 15734.763978540332, 643837.0, 753371.0, 767650.0, 768619.0, 948804.0, 57662.0, 58279.0, 58330.708346458, 58376.0, 58533.70733146307, 1219.0917766264013, 1261.356708078868, 1261.6215135459327, 1301.362332457108, 1342.3489607540334, 24612.876935615208, 27873.58189627198, 30024.69975300219, 30575.541366879068, 30739.385212295183, 47614.28578571393, 48876.999999998574, 48907.75546122246, 48913.266301006224, 49013.754931225114, 544748.0, 549088.0, 550318.0, 550352.0, 550921.0, 24035.399115022265, 24510.264692059267, 26595.93616255328, 26821.19536413911, 27148.0, 45239.547604523534, 45444.31833522566, 45497.09005819931, 45754.25474471542, 45863.77068114638, 28883.844646213915, 38280.42579361368, 38408.615913840506, 39783.030684092635, 40202.798986004884, 36879.26241475209, 38261.04347391338, 38715.225695485366, 39729.00677483086, 40010.59989400069, 37021.81489092537, 37032.0, 37094.25811483809, 37853.43219851759, 38410.42384364181, 31991.84004079965, 32593.837030814695, 33434.366521907985, 33995.66004340024, 34176.0, 25034.874825625757, 25102.748972510773, 25319.493610127327, 25400.872995634905, 25881.482370352864], "value": 19497.027541118983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.8814135405992, 370.6904734546654, 378.39645765004826, 381.3250546532636, 393.05666400638484, 18851.340203092896, 20768.96155192238, 21453.249136280254, 21610.027548760303, 21618.35144945652, 20176.69734953977, 20460.28389006385, 20718.5497015209, 20977.74133551988, 21011.47471313218, 5879.529637629001, 6014.548908831834, 6185.0, 6229.2836323822885, 6238.1266622672865, 4265.146970605876, 4461.24158892989, 6086.300075491331, 6240.469560087398, 6603.108580341641, 6871.175458944934, 6878.0, 6945.58326500409, 6956.234814170437, 6968.895466568006, 6627.768028119017, 6867.004284378787, 6923.099997000408, 6923.792286231421, 6936.306369363074, 5947.6431414115295, 5949.077892926603, 6027.276726792769, 6028.367021462771, 6045.516358691294, 22438.663420048713, 22663.433414164778, 24326.756732432805, 25338.239852804447, 25713.97144114233, 2190.769969153248, 2502.749725027501, 2802.3274414140665, 3090.3510262844607, 3201.551782750417, 12566.81149782754, 15288.694226115527, 15447.845521544754, 16012.879098463112, 16061.277242524115, 1885.9717104243448, 1914.9617007659908, 1927.421773467954, 1928.2479832865195, 1945.873518221311, 104647.0191899786, 112324.0, 112449.43775281153, 112466.0, 113300.0, 10667.413292268844, 11032.745340124522, 11306.265092768943, 11340.716482087848, 11390.0, 13989.0, 13994.650133746738, 13995.090319129224, 14006.71986560263, 14019.369128389248, 8270.917290827136, 8556.486610803371, 8592.398532102818, 8734.781630459162, 8765.342599305077, 7896.684132634745, 8465.153484651486, 8469.703560375481, 8609.913900861036, 8693.652253909899, 5857.0, 6596.703148358335, 6635.4359879410795, 6643.40209381158, 6753.696083676246, 1654.338264694108, 1754.9649007019789, 1783.7146056630877, 1786.63374008328, 1802.8107048759953, 803.6664784114644, 852.859278219087, 889.8531742262454, 937.7889974755761, 1018.923580731448, 19638.607227855362, 20950.790492094882, 21983.450413739785, 22020.669689954662, 22158.667619985714, 905.7328088213861, 932.7901222224945, 944.3955868244329, 946.7301818981557, 972.2076507646245, 9895.901040989642, 11354.602588909349, 11605.88394116065, 11778.0, 12042.939785301018, 472183.0, 581874.0, 614300.0, 629013.0, 630958.0, 133914.0, 135194.0, 135747.0, 139176.0, 140341.2982935079, 975.6292608808608, 990.9058639429243, 994.472929347447, 1017.2828156149897, 1020.2246292817364, 19614.509637259183, 20088.096035678136, 20209.79790202138, 20210.78735275888, 20239.19043238313, 54771.72614137063, 54853.45146548643, 55018.0, 55436.445635543125, 55979.0, 62131.0, 80328.0, 80673.19326806656, 81030.5948470254, 81250.0, 7881.763547093597, 8007.4366906725945, 8044.798880028046, 8115.79710507242, 8208.753737387888, 11130.16523760705, 11321.81120982318, 12573.308468034345, 12687.555935542212, 12749.55376561853, 9538.666146684833, 10167.67820183401, 10813.729656758644, 11093.722656933318, 11146.944265278946, 9844.655437059668, 10783.299085559414, 10840.457977100956, 11055.447227638746, 11110.555577776799, 10901.672949811518, 11055.72360690989, 11089.445527723421, 11421.885781142082, 11690.941545292219, 7872.448928574945, 8031.237032481905, 8184.749193971706, 8204.948762809297, 8377.246047855722, 8164.550949697824, 9106.856380346793, 9501.33490655675, 10665.093467055387, 10770.838437423288], "value": 9855.038419952134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.2190462388746, 1526.3970731561033, 1672.389577804102, 1829.8719089663712, 1873.3536929759237, 8601.526916019617, 9074.0, 9083.636654533819, 9095.636174553027, 9111.407758495694, 7977.401694872879, 8249.257566818986, 8541.615627296771, 8838.248748856355, 8852.3360747944, 2240.305505293356, 2275.7155355580553, 2277.9658305125436, 2278.8860556972168, 2285.0745448093467, 2208.017432242653, 2212.3031245157804, 2222.811061059812, 2332.265336419031, 2342.02805835578, 2296.115995341797, 2316.652502124686, 2317.339558225906, 2317.9884100579475, 2355.1168311883043, 2323.9767602324014, 2326.0579465316573, 2327.627579587275, 2329.650552417134, 2335.6146235871147, 2307.4231442139467, 2332.5334933013464, 2335.3344296875307, 2336.7429582745885, 2339.5905716499547, 8809.64761409543, 9025.774355641095, 9030.322725795591, 9031.096890310917, 9033.187013168781, 5188.558972487343, 5346.518813306821, 5350.705711185883, 5357.785688572452, 5359.062164121263, 3410.931781364384, 3507.1232191952013, 3650.324689932371, 3654.3604869148057, 3654.3787556115526, 1077.450500244873, 1081.2755453845941, 1084.5336505302716, 1102.7077824376547, 1104.8232282834708, 11352.09183265345, 11650.359230242333, 11787.469563869647, 11787.705307367385, 11794.0, 3742.7754334740002, 4499.932501012488, 4722.5513576210205, 4749.26386410107, 4763.857084287477, 9944.453055081894, 9969.30214884951, 9987.0012998701, 10003.649872254437, 10012.148967337713, 5312.442193569696, 5314.946850531523, 5316.601254905898, 5321.521063104339, 5325.573954083664, 4368.453943257093, 4405.229084910128, 4588.38056862326, 4776.665633405628, 4844.75776211188, 3803.600621934657, 3841.7118716096406, 3936.4095385692376, 3962.2471730371135, 3985.740926839746, 1223.6818427208989, 1245.483124503339, 1247.376311844078, 1255.2029461291963, 1259.250745806244, 835.8035861572525, 848.7029539661193, 887.9156480134377, 896.6458248991612, 935.3546053223254, 5590.832275031756, 5687.345955215121, 5946.672932988728, 5959.1941995060315, 5970.611910225822, 915.1763412928418, 921.8386782313069, 934.7943452440452, 940.8870935487786, 976.5947131940165, 3913.412988051815, 3953.1573822067735, 4022.416749571296, 4055.9657287392115, 4073.714839961174, 8821.470711757314, 11081.224314298082, 11192.04867586248, 11192.496337664825, 11235.269707468988, 9279.350445468888, 10704.625338113285, 11144.442777861075, 11154.442277886235, 11180.496877640526, 8180.222878826502, 8403.495790252604, 8407.369447291478, 8415.621297041647, 8440.746777596682, 5792.681402522901, 5806.158107074535, 5880.647161170344, 5932.762689492544, 5971.671558064349, 10271.383716976707, 10324.535395907353, 10324.587016519255, 10355.948220259152, 10381.53283102247, 9710.660126895526, 10142.746431339276, 10179.643712470028, 10258.948705256425, 10267.640632577824, 6971.0, 7198.352148306678, 7496.700131994878, 7657.0, 7673.462857600138, 7853.725119620786, 7898.091719452107, 7994.000749906262, 8338.124496927736, 8431.662733490592, 7516.586587737727, 7592.962035189788, 7622.809429764078, 7642.426817988562, 7820.687172513036, 7175.964120179366, 7340.339369456775, 7376.0411146550605, 7448.776536703907, 7492.962535187289, 6972.058772065706, 6996.300369962963, 7076.25699301566, 7076.433885289268, 7077.221505634273, 4911.189653707098, 4956.95903860179, 5014.423341315795, 5054.898902022012, 5083.415407228216, 4475.686701930834, 4867.926981095357, 4941.950580494149, 4992.676940610813, 5094.337736094284], "value": 4581.878864649726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.80876239206907, 299.2264994987955, 308.2079056823962, 312.3799258471934, 315.17581524313897, 4047.7856643007053, 4252.851150209739, 4716.740579268139, 4811.13399588074, 5112.872178195542, 3542.7697199682, 4221.902305400595, 4584.129015487055, 4996.600271978242, 5028.245763135532, 3949.5852935441794, 3956.3669812829953, 3967.3138915960744, 4010.679145668354, 4029.294873397151, 3609.693176080036, 3651.087228192952, 3948.2165073623028, 3949.4202319072315, 3968.226195891802, 2839.7930879376286, 3143.512755522886, 3751.8686845960397, 3928.2732694451474, 3935.291647503448, 3215.4051500472488, 3633.963660363389, 3886.8833934981994, 3929.4105884117466, 3948.8420463181437, 3200.8719651213923, 3375.4599264117624, 3386.407378708741, 3395.1681837949614, 3411.164264755126, 4381.824727010916, 4836.082772953919, 4887.266909963499, 4992.352523667181, 5066.873328166788, 4345.934810977807, 4410.206162890679, 4444.8444304449185, 4455.77721113943, 4484.551544845522, 5387.299651045379, 5412.295127034971, 5415.80275286656, 5450.645708028966, 5482.616216864821, 3699.72252081095, 3727.7390582659223, 3755.5916531300763, 3758.9436158457647, 3760.8119594020463, 5226.425093239741, 5604.411536788619, 5608.4391560844, 5676.744546495335, 5708.9466478800105, 3154.722337453335, 3222.693844084808, 3693.298273328059, 3752.45589389537, 3777.301199278142, 3186.745060395163, 3817.1220619257724, 3824.330742120118, 3828.942565861514, 3836.654701076861, 3719.776813391205, 3782.0544863784053, 4207.915841683149, 4393.626541743987, 4435.334699795057, 4468.597826195658, 4469.932951005738, 5103.234514822732, 5446.0, 5513.9448605514235, 1063.4948399510172, 1221.1451983611507, 1256.265084925329, 1283.685497053228, 1312.0225432053182, 866.6273502393905, 886.7851044069666, 887.7514295997131, 896.4307664633005, 900.3967341880956, 4599.482170883601, 4676.392069031072, 4865.105262368885, 5037.571806396498, 5044.924326135111, 5148.845534633967, 5519.337679478408, 5547.445255474501, 5548.278723765885, 5579.954532963569, 4203.516595591546, 4301.247281725686, 4334.50153232376, 4844.4186697596515, 4947.678400903929, 2765.681946576129, 2873.9425211495654, 2884.3510210202535, 2893.6833740647953, 2933.7066293370917, 4928.0, 5280.947190528045, 5718.571107166979, 5722.828315150469, 5727.398623144593, 5570.303712035996, 5595.888082238333, 5612.1581762735095, 5639.898056069145, 5651.66090034591, 4732.0, 5698.296107530138, 5738.598298119092, 5751.993401154781, 5753.252077229933, 4248.511421186603, 4558.8632341029825, 5439.150688765839, 5619.016672082287, 5649.265595472562, 4885.438174609965, 5543.36251331086, 5563.944360556343, 5596.468335508121, 5598.1602759586385, 4442.800073996743, 5438.945610543844, 5766.913496297643, 5889.38161493037, 5896.292444906639, 3710.2950439416422, 3866.0, 3901.668358189472, 3919.7844118573753, 3934.7835869027476, 5464.617476776588, 5476.808311709071, 5571.3871474137, 5575.968445837533, 5609.0, 5251.083354575476, 5471.316085489314, 5473.932583146248, 5492.450754924475, 5499.755144464785, 4436.578525040116, 5330.706811125426, 5391.784328626811, 5415.323084614423, 5422.376426710979, 5103.821366252163, 5252.0, 5284.0, 5288.7258478854465, 5298.54962328191, 4490.777065352671, 4852.078105160008, 5438.728063596884, 5510.311211098613, 5523.558115350843, 5127.0, 5347.6791392515015, 5358.517733404013, 5360.812371566976, 5388.9013817054565], "value": 3921.703381319284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.5902560899438, 737.9114506259247, 742.5804420502412, 766.658836817616, 800.9759707208785, 15350.46273380432, 15605.453809116654, 15609.453669121584, 15634.84365156348, 16338.264778084986, 14400.783988240184, 14465.92767036166, 14478.927605361985, 14492.492762753305, 14503.98472106953, 683.7572661705098, 705.3123204875232, 705.8729428702832, 821.9342452603793, 842.7345386203357, 807.5679511461369, 852.26705033671, 859.9054104048549, 866.1944391715701, 866.9219770220678, 923.5151545438631, 924.8381533231691, 925.1488630459959, 925.4354843545466, 925.7176561148847, 725.1407082607127, 913.6756451459703, 914.3096961793804, 916.7295647783886, 917.0783362720457, 552.5993654600383, 654.2606854254709, 675.3752778679701, 679.3783687925542, 680.5100327764002, 15039.624009399853, 15085.924570377189, 15104.697906041818, 15112.773308400383, 15117.924410377878, 11516.827247591293, 12112.81830772539, 13512.459501619924, 13789.655258618515, 13874.93062534691, 12303.876961230451, 12613.369331533386, 12787.232766033974, 12868.0, 12916.612501624966, 4530.0939812037395, 4542.931856022163, 4565.680402371835, 4743.715377077352, 4765.046990601859, 114760.0, 116304.0, 117612.41193794062, 117792.0, 119785.40107299408, 10839.0, 10844.837327440095, 10961.177911656658, 11212.0, 11234.10127189823, 21597.892010539847, 21654.675179872316, 21681.45796355072, 21682.34952951414, 21684.78315216859, 7609.961950190213, 7787.5716835574585, 7788.727394541163, 7915.16890726477, 8045.356371490267, 4252.593317211509, 4265.680073994463, 4283.271843786564, 4367.410399596078, 4460.219461594208, 3409.4885767134633, 3518.82405879705, 3523.524324216249, 3524.718022558189, 3526.2947410518, 491.33424210195386, 655.4854439265154, 664.8138521214067, 666.0608541955819, 666.9633170175687, 520.9739513024409, 602.3073465514693, 603.6076550242377, 604.8911195984765, 629.9968500157562, 8724.65101395937, 8812.427192232484, 8875.378723489423, 8952.955235223912, 8957.0, 578.3609111931339, 588.9322727886348, 598.7486153938203, 612.1888497740512, 638.9840253993688, 3434.347473979936, 4253.170631726845, 4346.913061738747, 4438.267685831866, 4467.195904737114, 104723.0, 158146.0, 161391.0, 162781.0, 171225.0, 96062.0, 100861.49569252254, 111865.89810375658, 126383.0, 132664.0, 98817.01182988222, 113067.0, 117014.0, 118202.40898795796, 120215.39892300483, 7646.808829779077, 7716.112647045437, 8205.261526462407, 8275.710350137717, 8625.611847466753, 67135.32864671486, 67589.3241067583, 68043.65978170077, 68626.65686671535, 68698.31301686919, 75469.0, 98794.0, 101254.0, 102394.48802755939, 106914.46542767236, 11387.316760994367, 11425.942870285595, 11494.827577586175, 11707.239029463057, 11904.583339583072, 11993.460294286604, 12110.878891210976, 12166.087543434101, 12190.695232619255, 12626.494940202288, 11120.721981950515, 11162.609308674157, 11244.987921201275, 11261.774764504828, 11281.984621384116, 11439.828402573801, 11449.255798373079, 11527.135464840338, 11538.48076836561, 11978.281303121841, 10864.402457864893, 10867.836982445111, 10944.562217511211, 11361.147913906325, 11456.968872801488, 9556.569954351931, 9580.856287155559, 9669.129778319984, 9948.900510994798, 10244.078032977068, 9237.348112558762, 9447.574859131219, 9530.857037144588, 9589.760255993657, 9758.316917815684], "value": 7527.019971510502, "unit": "score"}], "name": "dromaeo_css", "value": 7248.184053147395, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 116.0, 113.0, 114.0, 115.0, 114.0, 114.0, 115.0, 164.0], "value": 119.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 115.0, 117.0, 149.0, 116.0, 140.0, 139.0, 115.0, 185.0, 137.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 185.0, 183.0, 171.0, 255.0, 181.0, 184.0, 185.0], "value": 189.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 61.0, 87.0, 61.0, 59.0, 60.0, 62.0, 81.0, 59.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 91.0, 70.0, 68.0, 70.0, 92.0, 66.0, 68.0, 90.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 86.0, 85.0, 87.0, 89.0, 86.0, 88.0, 88.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 145.0, 150.0, 94.0, 93.0, 93.0, 92.0, 92.0, 97.0, 92.0], "value": 105.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 91.0, 104.0, 87.0, 85.0, 86.0, 84.0, 86.0], "value": 88.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 52.0, 52.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 67.0, 76.0, 70.0, 69.0, 70.0, 71.0, 71.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 89.0, 89.0, 85.0, 90.0, 85.0, 91.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 142.0, 146.0, 146.0, 144.0, 180.0, 162.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 177.0, 172.0, 173.0, 173.0, 171.0, 174.0, 173.0, 173.0, 173.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 64.0, 60.0, 70.0, 82.0, 86.0, 86.0, 86.0], "value": 74.4, "unit": "score"}], "name": "kraken", "value": 1479.7000000000003, "alertThreshold": 2.0}]} 06:53:26 INFO - Return code: 0 06:53:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:53:26 INFO - # TBPL SUCCESS # 06:53:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:53:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:53:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:53:26 INFO - 2016-10-06 06:53:26.933 screenresolution[1670:9775] starting screenresolution argv=screenresolution get 06:53:26 INFO - 2016-10-06 06:53:26.935 screenresolution[1670:9775] Display 0: 1600x1200x32@60 06:53:26 INFO - 2016-10-06 06:53:26.941 screenresolution[1671:9779] starting screenresolution argv=screenresolution list 06:53:26 INFO - Available Modes on Display 0 06:53:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:53:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:53:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:53:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:53:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:53:27 INFO - Intel Iris: 06:53:27 INFO - Chipset Model: Intel Iris 06:53:27 INFO - Type: GPU 06:53:27 INFO - Bus: Built-In 06:53:27 INFO - VRAM (Dynamic, Max): 1536 MB 06:53:27 INFO - Vendor: Intel (0x8086) 06:53:27 INFO - Device ID: 0x0a2e 06:53:27 INFO - Revision ID: 0x0009 06:53:27 INFO - Displays: 06:53:27 INFO - Display: 06:53:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:53:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:53:27 INFO - Display Serial Number: 1600x1200 60 06:53:27 INFO - Main Display: Yes 06:53:27 INFO - Mirror: Off 06:53:27 INFO - Online: Yes 06:53:27 INFO - Rotation: Supported 06:53:27 INFO - Return code: 0 06:53:27 INFO - Running post-action listener: _resource_record_post_action 06:53:27 INFO - [mozharness: 2016-10-06 13:53:27.184176Z] Finished run-tests step (success) 06:53:27 INFO - Running post-run listener: _resource_record_post_run 06:53:27 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 38380544; Write bytes: 709174784; Read time: 390; Write time: 1950 06:53:27 INFO - TinderboxPrint: CPU usage
53.4% 06:53:27 INFO - TinderboxPrint: I/O read bytes / time
38,380,544 / 390 06:53:27 INFO - TinderboxPrint: I/O write bytes / time
709,174,784 / 1,950 06:53:27 INFO - TinderboxPrint: CPU idle
2,266.2 (46.6%) 06:53:27 INFO - TinderboxPrint: CPU system
969.7 (19.9%) 06:53:27 INFO - TinderboxPrint: CPU user
1,625.8 (33.4%) 06:53:27 INFO - TinderboxPrint: Swap in / out
445,939,712 / 0 06:53:27 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396024320; Write bytes: 390682624; Read time: 29466; Write time: 731 06:53:27 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 36549632; Write bytes: 297479680; Read time: 370; Write time: 1171 06:53:27 INFO - Running post-run listener: _upload_blobber_files 06:53:27 INFO - Blob upload gear active. 06:53:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:53:27 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 06:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:53:28 INFO - (blobuploader) - INFO - Open directory for files ... 06:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:29 INFO - (blobuploader) - INFO - Done attempting. 06:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:31 INFO - (blobuploader) - INFO - Done attempting. 06:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:53:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:53:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:53:33 INFO - (blobuploader) - INFO - Done attempting. 06:53:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:53:33 INFO - Return code: 0 06:53:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:53:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:53:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac02139b4f01dc1676d6a20c6948835bcc8667ac3ebb85a5c96acfc6e699173115ea80be5da7c3fe363ee81a0214bb2b81bbb2ebcfa405925ea5ceabb1bb1788", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf89243517bab16cb27eddf1bb2551950e35b1ea20834e46e5b8298740aa03951b829b818a49fff6096b88a6381674fbcaac47e36bf5d96e4eb76a5cb33737d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3042804bed5407a0028d9435c08ec8ff332ce8d328bf5871ee8ff4bd1ea3d4e10a536384b2e581d465930da2f258c69429df9391c6b33962ed6011aa67bb8848"} 06:53:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:53:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:53:33 INFO - Contents: 06:53:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac02139b4f01dc1676d6a20c6948835bcc8667ac3ebb85a5c96acfc6e699173115ea80be5da7c3fe363ee81a0214bb2b81bbb2ebcfa405925ea5ceabb1bb1788", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf89243517bab16cb27eddf1bb2551950e35b1ea20834e46e5b8298740aa03951b829b818a49fff6096b88a6381674fbcaac47e36bf5d96e4eb76a5cb33737d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3042804bed5407a0028d9435c08ec8ff332ce8d328bf5871ee8ff4bd1ea3d4e10a536384b2e581d465930da2f258c69429df9391c6b33962ed6011aa67bb8848"} 06:53:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:53:33 INFO - Copying logs to upload dir... 06:53:33 INFO - mkdir: /builds/slave/test/build/upload/logs 06:53:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.066811 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-06 06:53:33.522401) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 06:53:33.525610) ========= 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.fiDwjf7UWN/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.0H4VukkdXs/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac02139b4f01dc1676d6a20c6948835bcc8667ac3ebb85a5c96acfc6e699173115ea80be5da7c3fe363ee81a0214bb2b81bbb2ebcfa405925ea5ceabb1bb1788", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf89243517bab16cb27eddf1bb2551950e35b1ea20834e46e5b8298740aa03951b829b818a49fff6096b88a6381674fbcaac47e36bf5d96e4eb76a5cb33737d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3042804bed5407a0028d9435c08ec8ff332ce8d328bf5871ee8ff4bd1ea3d4e10a536384b2e581d465930da2f258c69429df9391c6b33962ed6011aa67bb8848"} build_url:https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac02139b4f01dc1676d6a20c6948835bcc8667ac3ebb85a5c96acfc6e699173115ea80be5da7c3fe363ee81a0214bb2b81bbb2ebcfa405925ea5ceabb1bb1788", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcf89243517bab16cb27eddf1bb2551950e35b1ea20834e46e5b8298740aa03951b829b818a49fff6096b88a6381674fbcaac47e36bf5d96e4eb76a5cb33737d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3042804bed5407a0028d9435c08ec8ff332ce8d328bf5871ee8ff4bd1ea3d4e10a536384b2e581d465930da2f258c69429df9391c6b33962ed6011aa67bb8848"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 06:53:33.557869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:53:33.558191) ========= 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.fiDwjf7UWN/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.0H4VukkdXs/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005276 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:53:33.607147) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 06:53:33.607490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 06:53:33.607820) ========= ========= Total master_lag: 1.39 =========