builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0212 starttime: 1477487454.01 results: success (0) buildid: 20161026030210 builduid: 785a41cfee634b3dbf2331ade81eedfc revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.014570) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.015098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.015469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.109242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.109550) ========= 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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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-26 06:10:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.4M=0.001s 2016-10-26 06:10:54 (12.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.505076 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.638767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.639238) ========= 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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.020012 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:54.702441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 06:10:54.702860) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EyrTwU7RYO/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.fMUeXAjbV6/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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-26 06:10:54,784 truncating revision to first 12 chars 2016-10-26 06:10:54,784 Setting DEBUG logging. 2016-10-26 06:10:54,784 attempt 1/10 2016-10-26 06:10:54,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 06:10:55,996 unpacking tar archive at: mozilla-central-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=2.525401 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 06:10:57.256275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:57.257129) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:57.258386) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:57.259107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 06:10:57.279655) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 06:10:57.280090) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EyrTwU7RYO/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.fMUeXAjbV6/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:10:57 INFO - MultiFileLogger online at 20161026 06:10:57 in /builds/slave/test 06:10:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:10:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:10:57 INFO - {'append_to_log': False, 06:10:57 INFO - 'base_work_dir': '/builds/slave/test', 06:10:57 INFO - 'blob_upload_branch': 'Firefox', 06:10:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:10:57 INFO - 'branch': 'Firefox', 06:10:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:10:57 INFO - 'config_files': ('talos/mac_config.py',), 06:10:57 INFO - 'default_actions': ('clobber', 06:10:57 INFO - 'read-buildbot-config', 06:10:57 INFO - 'download-and-extract', 06:10:57 INFO - 'populate-webroot', 06:10:57 INFO - 'create-virtualenv', 06:10:57 INFO - 'install', 06:10:57 INFO - 'run-tests'), 06:10:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:10:57 INFO - 'download_minidump_stackwalk': True, 06:10:57 INFO - 'download_symbols': 'ondemand', 06:10:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:10:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:10:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:10:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:10:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:10:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:10:57 INFO - 'installer_path': 'installer.exe', 06:10:57 INFO - 'log_level': 'info', 06:10:57 INFO - 'log_name': 'talos', 06:10:57 INFO - 'log_to_console': True, 06:10:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:10:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:10:57 INFO - 'opt_config_files': (), 06:10:57 INFO - 'pip_index': False, 06:10:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:10:57 INFO - 'cmd': ('bash', 06:10:57 INFO - '-c', 06:10:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:10:57 INFO - 'enabled': True, 06:10:57 INFO - 'halt_on_failure': False, 06:10:57 INFO - 'name': 'check_screen_resolution'},), 06:10:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:10:57 INFO - 'cmd': ('bash', 06:10:57 INFO - '-c', 06:10:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:10:57 INFO - 'enabled': True, 06:10:57 INFO - 'halt_on_failure': False, 06:10:57 INFO - 'name': 'check_screen_resolution'},), 06:10:57 INFO - 'run_cmd_checks_enabled': True, 06:10:57 INFO - 'sps_profile': False, 06:10:57 INFO - 'sps_profile_interval': 0, 06:10:57 INFO - 'suite': 'dromaeojs', 06:10:57 INFO - 'system_bits': '32', 06:10:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:10:57 INFO - 'title': 't-yosemite-r7-0212', 06:10:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:10:57 INFO - 'use_talos_json': True, 06:10:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:10:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:10:57 INFO - 'work_dir': 'build'} 06:10:57 INFO - [mozharness: 2016-10-26 13:10:57.481394Z] Running clobber step. 06:10:57 INFO - Running pre-action listener: _resource_record_pre_action 06:10:57 INFO - Running main action method: clobber 06:10:57 INFO - rmtree: /builds/slave/test/build 06:10:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:10:59 INFO - Running post-action listener: _resource_record_post_action 06:10:59 INFO - [mozharness: 2016-10-26 13:10:59.211981Z] Finished clobber step (success) 06:10:59 INFO - [mozharness: 2016-10-26 13:10:59.212115Z] Running read-buildbot-config step. 06:10:59 INFO - Running pre-action listener: _resource_record_pre_action 06:10:59 INFO - Running main action method: read_buildbot_config 06:10:59 INFO - Using buildbot properties: 06:10:59 INFO - { 06:10:59 INFO - "project": "", 06:10:59 INFO - "product": "firefox", 06:10:59 INFO - "script_repo_revision": "production", 06:10:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:10:59 INFO - "repository": "", 06:10:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:10:59 INFO - "buildid": "20161026030210", 06:10:59 INFO - "stage_platform": "macosx64", 06:10:59 INFO - "basedir": "/builds/slave/test", 06:10:59 INFO - "nightly_build": "True", 06:10:59 INFO - "buildnumber": 17, 06:10:59 INFO - "slavename": "t-yosemite-r7-0212", 06:10:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:10:59 INFO - "platform": "yosemite_r7", 06:10:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:10:59 INFO - "branch": "mozilla-central", 06:10:59 INFO - "repo_path": "mozilla-central", 06:10:59 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 06:10:59 INFO - "pgo_build": "False", 06:10:59 INFO - "builduid": "785a41cfee634b3dbf2331ade81eedfc", 06:10:59 INFO - "slavebuilddir": "test" 06:10:59 INFO - } 06:10:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:10:59 INFO - Running post-action listener: _resource_record_post_action 06:10:59 INFO - [mozharness: 2016-10-26 13:10:59.215334Z] Finished read-buildbot-config step (success) 06:10:59 INFO - [mozharness: 2016-10-26 13:10:59.215442Z] Running download-and-extract step. 06:10:59 INFO - Running pre-action listener: _resource_record_pre_action 06:10:59 INFO - Running main action method: download_and_extract 06:10:59 INFO - mkdir: /builds/slave/test/build/tests 06:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:59 INFO - trying https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:10:59 INFO - Downloading https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/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:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/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:10:59 INFO - Downloaded 1199 bytes. 06:10:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:10:59 INFO - Using the following test package requirements: 06:10:59 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:10:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:10:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:10:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'jsshell-mac.zip'], 06:10:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:10:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:10:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:10:59 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:10:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:10:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:10:59 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:10:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:10:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:10:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:10:59 INFO - Fetch https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:11:00 INFO - Http code: 200 06:11:00 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 06:11:00 INFO - x-amz-cf-id: btg6kyaREI6J3Wj8a6vXMWOfs3CHl5sAiaZh_EXnCjOHDpWLZG8VkQ== 06:11:00 INFO - x-amz-version-id: akuMyXms1vGwVGgsjD5muG2U8GKEKD2Y 06:11:00 INFO - Expected file size: 16438467 06:11:00 INFO - Obtained file size: 16438467 06:11:07 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:11:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:11:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:11:07 INFO - Fetch https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:11:07 INFO - Http code: 200 06:11:07 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 06:11:07 INFO - x-amz-cf-id: DXb3uVyixOFbP_Or4CuvcnbFbvtFV2u51arJCB4UlAuu6h0Ak2FI8Q== 06:11:07 INFO - x-amz-version-id: akuMyXms1vGwVGgsjD5muG2U8GKEKD2Y 06:11:08 INFO - Expected file size: 16438467 06:11:08 INFO - Obtained file size: 16438467 06:11:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:11:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:11:14 INFO - Fetch https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:11:14 INFO - Http code: 200 06:11:14 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 06:11:14 INFO - x-amz-cf-id: fNk27nCVG4DlqwxGT5LupXHh0KN1sLkIuMHqGaXgJNBqdaJnBz8Qaw== 06:11:14 INFO - x-amz-version-id: zKsmnXrd04FYZQAhDfVSHxqYCIRMxKeq 06:11:15 INFO - Expected file size: 14409028 06:11:15 INFO - Obtained file size: 14409028 06:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:15 INFO - trying https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:11:15 INFO - Downloading https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/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:11:18 INFO - Downloaded 111805174 bytes. 06:11:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:11:18 INFO - mkdir: /builds/slave/test/properties 06:11:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:11:18 INFO - Writing to file /builds/slave/test/properties/build_url 06:11:18 INFO - Contents: 06:11:18 INFO - build_url:https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:11:19 INFO - Running post-action listener: _resource_record_post_action 06:11:19 INFO - Running post-action listener: set_extra_try_arguments 06:11:19 INFO - [mozharness: 2016-10-26 13:11:19.088571Z] Finished download-and-extract step (success) 06:11:19 INFO - [mozharness: 2016-10-26 13:11:19.088687Z] Running populate-webroot step. 06:11:19 INFO - Running pre-action listener: _resource_record_pre_action 06:11:19 INFO - Running main action method: populate_webroot 06:11:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:11:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:11:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:11:19 INFO - '--tppagecycles', 06:11:19 INFO - '7'], 06:11:19 INFO - 'tests': ['tsvgm']}}, 06:11:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:11:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:11:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:11:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:11:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:11:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['damp', 'tps']}, 06:11:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'tests': ['damp', 'tps']}, 06:11:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['dromaeo_dom']}, 06:11:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:11:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['basic_compositor_video']}, 06:11:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:11:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['a11yr', 06:11:19 INFO - 'ts_paint', 06:11:19 INFO - 'tpaint', 06:11:19 INFO - 'sessionrestore', 06:11:19 INFO - 'sessionrestore_no_auto_restore', 06:11:19 INFO - 'tabpaint']}, 06:11:19 INFO - 'other-e10s': {'tests': ['a11yr', 06:11:19 INFO - 'ts_paint', 06:11:19 INFO - 'tpaint', 06:11:19 INFO - 'sessionrestore', 06:11:19 INFO - 'sessionrestore_no_auto_restore', 06:11:19 INFO - 'tabpaint']}, 06:11:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:11:19 INFO - 'ts_paint', 06:11:19 INFO - 'tpaint', 06:11:19 INFO - 'sessionrestore', 06:11:19 INFO - 'sessionrestore_no_auto_restore', 06:11:19 INFO - 'tabpaint']}, 06:11:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:11:19 INFO - 'ts_paint', 06:11:19 INFO - 'tpaint', 06:11:19 INFO - 'sessionrestore', 06:11:19 INFO - 'sessionrestore_no_auto_restore', 06:11:19 INFO - 'tabpaint']}, 06:11:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['a11yr', 06:11:19 INFO - 'ts_paint', 06:11:19 INFO - 'tpaint', 06:11:19 INFO - 'sessionrestore', 06:11:19 INFO - 'sessionrestore_no_auto_restore', 06:11:19 INFO - 'tabpaint']}, 06:11:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['a11yr', 06:11:19 INFO - 'ts_paint', 06:11:19 INFO - 'tpaint', 06:11:19 INFO - 'sessionrestore', 06:11:19 INFO - 'sessionrestore_no_auto_restore', 06:11:19 INFO - 'tabpaint']}, 06:11:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['tsvgx', 06:11:19 INFO - 'tsvgr_opacity', 06:11:19 INFO - 'tart', 06:11:19 INFO - 'tscrollx', 06:11:19 INFO - 'cart']}, 06:11:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:11:19 INFO - 'tsvgr_opacity', 06:11:19 INFO - 'tart', 06:11:19 INFO - 'tscrollx', 06:11:19 INFO - 'cart']}, 06:11:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'talos_options': ['--disable-e10s'], 06:11:19 INFO - 'tests': ['tp5o']}, 06:11:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'tests': ['tp5o']}, 06:11:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'talos_options': ['--disable-e10s', 06:11:19 INFO - '--xperf_path', 06:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:19 INFO - 'tests': ['tp5n']}, 06:11:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:11:19 INFO - 'talos_options': ['--xperf_path', 06:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:11:19 INFO - 'tests': ['tp5n']}}, 06:11:19 INFO - 'talos.zip': {'path': '', 06:11:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:11:19 INFO - Running post-action listener: _resource_record_post_action 06:11:19 INFO - [mozharness: 2016-10-26 13:11:19.107636Z] Finished populate-webroot step (success) 06:11:19 INFO - [mozharness: 2016-10-26 13:11:19.107764Z] Running create-virtualenv step. 06:11:19 INFO - Running pre-action listener: _resource_record_pre_action 06:11:19 INFO - Running main action method: create_virtualenv 06:11:19 INFO - Creating virtualenv /builds/slave/test/build/venv 06:11:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:11:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:11:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:11:19 INFO - Using real prefix '/tools/python27' 06:11:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:11:19 INFO - Installing distribute.............................................................................................................................................................................................done. 06:11:22 INFO - Installing pip.................done. 06:11:22 INFO - Return code: 0 06:11:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:11:23 INFO - Reading from file tmpfile_stdout 06:11:23 INFO - Output received: 06:11:23 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:11:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:23 INFO - 'HOME': '/Users/cltbld', 06:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:23 INFO - 'LOGNAME': 'cltbld', 06:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:23 INFO - 'MOZ_NO_REMOTE': '1', 06:11:23 INFO - 'NO_EM_RESTART': '1', 06:11:23 INFO - 'PAGER': '/bin/cat', 06:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:23 INFO - 'PWD': '/builds/slave/test', 06:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:23 INFO - 'SHELL': '/bin/bash', 06:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:23 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:23 INFO - 'USER': 'cltbld', 06:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:23 INFO - 'XPC_FLAGS': '0x0', 06:11:23 INFO - 'XPC_SERVICE_NAME': '0', 06:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:11:23 INFO - Cleaning up... 06:11:23 INFO - Return code: 0 06:11:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:23 INFO - 'HOME': '/Users/cltbld', 06:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:23 INFO - 'LOGNAME': 'cltbld', 06:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:23 INFO - 'MOZ_NO_REMOTE': '1', 06:11:23 INFO - 'NO_EM_RESTART': '1', 06:11:23 INFO - 'PAGER': '/bin/cat', 06:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:23 INFO - 'PWD': '/builds/slave/test', 06:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:23 INFO - 'SHELL': '/bin/bash', 06:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:23 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:23 INFO - 'USER': 'cltbld', 06:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:23 INFO - 'XPC_FLAGS': '0x0', 06:11:23 INFO - 'XPC_SERVICE_NAME': '0', 06:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:23 INFO - Downloading/unpacking psutil>=3.1.1 06:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:11:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:27 INFO - Installing collected packages: psutil 06:11:27 INFO - Running setup.py install for psutil 06:11:27 INFO - building 'psutil._psutil_osx' extension 06:11:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:11:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:11:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:11:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:11:27 INFO - building 'psutil._psutil_posix' extension 06:11:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:11:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:11:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:11:28 INFO - ^ 06:11:28 INFO - 1 warning generated. 06:11:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:11:28 INFO - Successfully installed psutil 06:11:28 INFO - Cleaning up... 06:11:28 INFO - Return code: 0 06:11:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:28 INFO - 'HOME': '/Users/cltbld', 06:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:28 INFO - 'LOGNAME': 'cltbld', 06:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:28 INFO - 'MOZ_NO_REMOTE': '1', 06:11:28 INFO - 'NO_EM_RESTART': '1', 06:11:28 INFO - 'PAGER': '/bin/cat', 06:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:28 INFO - 'PWD': '/builds/slave/test', 06:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:28 INFO - 'SHELL': '/bin/bash', 06:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:28 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:28 INFO - 'USER': 'cltbld', 06:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:28 INFO - 'XPC_FLAGS': '0x0', 06:11:28 INFO - 'XPC_SERVICE_NAME': '0', 06:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:11:31 INFO - Installing collected packages: mozsystemmonitor 06:11:31 INFO - Running setup.py install for mozsystemmonitor 06:11:31 INFO - Successfully installed mozsystemmonitor 06:11:31 INFO - Cleaning up... 06:11:31 INFO - Return code: 0 06:11:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:31 INFO - 'HOME': '/Users/cltbld', 06:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:31 INFO - 'LOGNAME': 'cltbld', 06:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:31 INFO - 'MOZ_NO_REMOTE': '1', 06:11:31 INFO - 'NO_EM_RESTART': '1', 06:11:31 INFO - 'PAGER': '/bin/cat', 06:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:31 INFO - 'PWD': '/builds/slave/test', 06:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:31 INFO - 'SHELL': '/bin/bash', 06:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:31 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:31 INFO - 'USER': 'cltbld', 06:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:31 INFO - 'XPC_FLAGS': '0x0', 06:11:31 INFO - 'XPC_SERVICE_NAME': '0', 06:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:31 INFO - Downloading/unpacking jsonschema==2.5.1 06:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:11:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:34 INFO - Downloading functools32-3.2.3-2.tar.gz 06:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:11:34 INFO - warning: no files found matching '*.txt' 06:11:34 INFO - no previously-included directories found matching 'build' 06:11:34 INFO - no previously-included directories found matching 'dist' 06:11:34 INFO - no previously-included directories found matching '.git*' 06:11:34 INFO - Installing collected packages: jsonschema, functools32 06:11:34 INFO - Running setup.py install for functools32 06:11:34 INFO - warning: no files found matching '*.txt' 06:11:34 INFO - no previously-included directories found matching 'build' 06:11:34 INFO - no previously-included directories found matching 'dist' 06:11:34 INFO - no previously-included directories found matching '.git*' 06:11:34 INFO - Successfully installed jsonschema functools32 06:11:34 INFO - Cleaning up... 06:11:34 INFO - Return code: 0 06:11:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:11: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:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11: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:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:11:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:34 INFO - 'HOME': '/Users/cltbld', 06:11:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:34 INFO - 'LOGNAME': 'cltbld', 06:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:34 INFO - 'MOZ_NO_REMOTE': '1', 06:11:34 INFO - 'NO_EM_RESTART': '1', 06:11:34 INFO - 'PAGER': '/bin/cat', 06:11:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:34 INFO - 'PWD': '/builds/slave/test', 06:11:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:34 INFO - 'SHELL': '/bin/bash', 06:11:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:34 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:34 INFO - 'USER': 'cltbld', 06:11:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:34 INFO - 'XPC_FLAGS': '0x0', 06:11:34 INFO - 'XPC_SERVICE_NAME': '0', 06:11:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:11:35 INFO - Cleaning up... 06:11:35 INFO - Return code: 0 06:11:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:35 INFO - 'HOME': '/Users/cltbld', 06:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:35 INFO - 'LOGNAME': 'cltbld', 06:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:35 INFO - 'MOZ_NO_REMOTE': '1', 06:11:35 INFO - 'NO_EM_RESTART': '1', 06:11:35 INFO - 'PAGER': '/bin/cat', 06:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:35 INFO - 'PWD': '/builds/slave/test', 06:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:35 INFO - 'SHELL': '/bin/bash', 06:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:35 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:35 INFO - 'USER': 'cltbld', 06:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:35 INFO - 'XPC_FLAGS': '0x0', 06:11:35 INFO - 'XPC_SERVICE_NAME': '0', 06:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:11:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:11:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:39 INFO - Downloading docopt-0.6.1.tar.gz 06:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:11:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:11:39 INFO - Running setup.py install for blobuploader 06:11:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:11:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:11:39 INFO - Running setup.py install for requests 06:11:39 INFO - Running setup.py install for docopt 06:11:39 INFO - Successfully installed blobuploader requests docopt 06:11:39 INFO - Cleaning up... 06:11:40 INFO - Return code: 0 06:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:40 INFO - 'HOME': '/Users/cltbld', 06:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:40 INFO - 'LOGNAME': 'cltbld', 06:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:40 INFO - 'MOZ_NO_REMOTE': '1', 06:11:40 INFO - 'NO_EM_RESTART': '1', 06:11:40 INFO - 'PAGER': '/bin/cat', 06:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:40 INFO - 'PWD': '/builds/slave/test', 06:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:40 INFO - 'SHELL': '/bin/bash', 06:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:40 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:40 INFO - 'USER': 'cltbld', 06:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:40 INFO - 'XPC_FLAGS': '0x0', 06:11:40 INFO - 'XPC_SERVICE_NAME': '0', 06:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:40 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Axovx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:40 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-QB_Qgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:40 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-IBxZWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:40 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-pXxb5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:40 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-P4dOZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:40 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-0DrKPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:40 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-eTXOHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-sFfDwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-kdXktp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-LrsrSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-lHYzhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-yJotGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-rRHeDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-xkSIuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-cqIZ4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-81lSp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:41 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-BWRqSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:11:42 INFO - Running setup.py install for manifestparser 06:11:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozcrash 06:11:42 INFO - Running setup.py install for mozdebug 06:11:42 INFO - Running setup.py install for mozdevice 06:11:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozfile 06:11:42 INFO - Running setup.py install for mozhttpd 06:11:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:11:42 INFO - Running setup.py install for mozinfo 06:11:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Running setup.py install for mozInstall 06:11:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Running setup.py install for mozleak 06:11:43 INFO - Running setup.py install for mozlog 06:11:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Running setup.py install for moznetwork 06:11:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:11:43 INFO - Running setup.py install for mozprocess 06:11:43 INFO - Running setup.py install for mozprofile 06:11:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:11:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:11:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:11:44 INFO - Running setup.py install for mozrunner 06:11:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:11:44 INFO - Running setup.py install for mozscreenshot 06:11:44 INFO - Running setup.py install for moztest 06:11:44 INFO - Running setup.py install for mozversion 06:11:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:11:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:11:44 INFO - Cleaning up... 06:11:44 INFO - Return code: 0 06:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:44 INFO - 'HOME': '/Users/cltbld', 06:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:44 INFO - 'LOGNAME': 'cltbld', 06:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:44 INFO - 'MOZ_NO_REMOTE': '1', 06:11:44 INFO - 'NO_EM_RESTART': '1', 06:11:44 INFO - 'PAGER': '/bin/cat', 06:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:44 INFO - 'PWD': '/builds/slave/test', 06:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:44 INFO - 'SHELL': '/bin/bash', 06:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:44 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:44 INFO - 'USER': 'cltbld', 06:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:44 INFO - 'XPC_FLAGS': '0x0', 06:11:44 INFO - 'XPC_SERVICE_NAME': '0', 06:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:11:44 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-vllCDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-C9UhYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-4lKlwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:11:45 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:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-heanUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:11:45 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:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-0M0Ae_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:11:45 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:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-bXgxKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-FN6RcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-EnZqEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-UdX9W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:11:45 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-HZUXCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:11:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-F65JA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:11:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-1iE5Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:11:46 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:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:11:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Lr4MAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:11:46 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:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:11:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-9gCEOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:11:46 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:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-762fKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:11:46 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:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:11:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-TGDPC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:11:46 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-0BldEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:11:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:11:49 INFO - Downloading blessings-1.6.tar.gz 06:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:11:49 INFO - Installing collected packages: blessings 06:11:49 INFO - Running setup.py install for blessings 06:11:49 INFO - Successfully installed blessings 06:11:49 INFO - Cleaning up... 06:11:49 INFO - Return code: 0 06:11:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:11:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:49 INFO - Reading from file tmpfile_stdout 06:11:49 INFO - Current package versions: 06:11:49 INFO - blessings == 1.6 06:11:49 INFO - blobuploader == 1.2.4 06:11:49 INFO - docopt == 0.6.1 06:11:49 INFO - functools32 == 3.2.3-2 06:11:49 INFO - jsonschema == 2.5.1 06:11:49 INFO - manifestparser == 1.1 06:11:49 INFO - mozInstall == 1.12 06:11:49 INFO - mozcrash == 0.17 06:11:49 INFO - mozdebug == 0.1 06:11:49 INFO - mozdevice == 0.48 06:11:49 INFO - mozfile == 1.2 06:11:49 INFO - mozhttpd == 0.7 06:11:49 INFO - mozinfo == 0.9 06:11:49 INFO - mozleak == 0.1 06:11:49 INFO - mozlog == 3.4 06:11:49 INFO - moznetwork == 0.27 06:11:49 INFO - mozprocess == 0.23 06:11:49 INFO - mozprofile == 0.28 06:11:49 INFO - mozrunner == 6.12 06:11:49 INFO - mozscreenshot == 0.1 06:11:49 INFO - mozsystemmonitor == 0.3 06:11:49 INFO - moztest == 0.7 06:11:49 INFO - mozversion == 1.4 06:11:49 INFO - psutil == 3.1.1 06:11:49 INFO - requests == 1.2.3 06:11:49 INFO - wsgiref == 0.1.2 06:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:49 INFO - 'HOME': '/Users/cltbld', 06:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:49 INFO - 'LOGNAME': 'cltbld', 06:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:49 INFO - 'MOZ_NO_REMOTE': '1', 06:11:49 INFO - 'NO_EM_RESTART': '1', 06:11:49 INFO - 'PAGER': '/bin/cat', 06:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:49 INFO - 'PWD': '/builds/slave/test', 06:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:49 INFO - 'SHELL': '/bin/bash', 06:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:49 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:49 INFO - 'USER': 'cltbld', 06:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:49 INFO - 'XPC_FLAGS': '0x0', 06:11:49 INFO - 'XPC_SERVICE_NAME': '0', 06:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 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:11:50 INFO - Cleaning up... 06:11:50 INFO - Return code: 0 06:11:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:11:50 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 0x10d56f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4e5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36bc646f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, '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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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:11:50 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:11:50 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:11:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:11:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:11:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:11:50 INFO - 'HOME': '/Users/cltbld', 06:11:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:11:50 INFO - 'LOGNAME': 'cltbld', 06:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:50 INFO - 'MOZ_NO_REMOTE': '1', 06:11:50 INFO - 'NO_EM_RESTART': '1', 06:11:50 INFO - 'PAGER': '/bin/cat', 06:11:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:50 INFO - 'PWD': '/builds/slave/test', 06:11:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:11:50 INFO - 'SHELL': '/bin/bash', 06:11:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:11:50 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:11:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:11:50 INFO - 'USER': 'cltbld', 06:11:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:11:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:50 INFO - 'XPC_FLAGS': '0x0', 06:11:50 INFO - 'XPC_SERVICE_NAME': '0', 06:11:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:11:50 INFO - Cleaning up... 06:11:50 INFO - Return code: 0 06:11:50 INFO - Running post-action listener: _resource_record_post_action 06:11:50 INFO - Running post-action listener: _start_resource_monitoring 06:11:50 INFO - Starting resource monitoring. 06:11:50 INFO - [mozharness: 2016-10-26 13:11:50.470827Z] Finished create-virtualenv step (success) 06:11:50 INFO - [mozharness: 2016-10-26 13:11:50.471857Z] Running install step. 06:11:50 INFO - Running pre-action listener: _resource_record_pre_action 06:11:50 INFO - Running main action method: install 06:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:11:50 INFO - Reading from file tmpfile_stdout 06:11:50 INFO - Detecting whether we're running mozinstall >=1.0... 06:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:11:50 INFO - Reading from file tmpfile_stdout 06:11:50 INFO - Output received: 06:11:50 INFO - Usage: mozinstall [options] installer 06:11:50 INFO - Options: 06:11:50 INFO - -h, --help show this help message and exit 06:11:50 INFO - -d DEST, --destination=DEST 06:11:50 INFO - Directory to install application into. [default: 06:11:50 INFO - "/builds/slave/test"] 06:11:50 INFO - --app=APP Application being installed. [default: firefox] 06:11:50 INFO - mkdir: /builds/slave/test/build/application 06:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:12:24 INFO - Reading from file tmpfile_stdout 06:12:24 INFO - Output received: 06:12:24 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:12:24 INFO - Running post-action listener: _resource_record_post_action 06:12:24 INFO - [mozharness: 2016-10-26 13:12:24.905119Z] Finished install step (success) 06:12:24 INFO - [mozharness: 2016-10-26 13:12:24.905259Z] Running run-tests step. 06:12:24 INFO - Running pre-action listener: _resource_record_pre_action 06:12:24 INFO - Running main action method: run_tests 06:12:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:24 INFO - 2016-10-26 06:12:24.919 screenresolution[1936:16557] starting screenresolution argv=screenresolution get 06:12:24 INFO - 2016-10-26 06:12:24.922 screenresolution[1936:16557] Display 0: 1600x1200x32@60 06:12:24 INFO - 2016-10-26 06:12:24.928 screenresolution[1937:16559] starting screenresolution argv=screenresolution list 06:12:24 INFO - Available Modes on Display 0 06:12:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:25 INFO - Intel Iris: 06:12:25 INFO - Chipset Model: Intel Iris 06:12:25 INFO - Type: GPU 06:12:25 INFO - Bus: Built-In 06:12:25 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:25 INFO - Vendor: Intel (0x8086) 06:12:25 INFO - Device ID: 0x0a2e 06:12:25 INFO - Revision ID: 0x0009 06:12:25 INFO - Displays: 06:12:25 INFO - Display: 06:12:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:25 INFO - Display Serial Number: 1600x1200 60 06:12:25 INFO - Main Display: Yes 06:12:25 INFO - Mirror: Off 06:12:25 INFO - Online: Yes 06:12:25 INFO - Rotation: Supported 06:12:25 INFO - Return code: 0 06:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:12:25 INFO - Python 2.7.3 06:12:25 INFO - Return code: 0 06:12:25 INFO - grabbing minidump binary from tooltool 06:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d383d30>, '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 0x10d1a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d37bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:12:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:12:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:12:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:12:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:12:25 INFO - Return code: 0 06:12:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:12:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:12:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:12:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:12:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--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:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0212 --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:12:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EyrTwU7RYO/Render', 06:12:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:25 INFO - 'HOME': '/Users/cltbld', 06:12:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:25 INFO - 'LOGNAME': 'cltbld', 06:12:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:12:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:25 INFO - 'MOZ_NO_REMOTE': '1', 06:12:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:12:25 INFO - 'NO_EM_RESTART': '1', 06:12:25 INFO - 'PAGER': '/bin/cat', 06:12:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:25 INFO - 'PWD': '/builds/slave/test', 06:12:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:12:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:25 INFO - 'SHELL': '/bin/bash', 06:12:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fMUeXAjbV6/Listeners', 06:12:25 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 06:12:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:25 INFO - 'USER': 'cltbld', 06:12:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:25 INFO - 'XPC_FLAGS': '0x0', 06:12:25 INFO - 'XPC_SERVICE_NAME': '0', 06:12:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--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:12:25 INFO - mozversion application_buildid: 20161026030210 06:12:25 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 06:12:25 INFO - mozversion application_display_name: Nightly 06:12:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:12:25 INFO - mozversion application_name: Firefox 06:12:25 INFO - mozversion application_remotingname: firefox 06:12:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:12:25 INFO - mozversion application_vendor: Mozilla 06:12:25 INFO - mozversion application_version: 52.0a1 06:12:25 INFO - mozversion platform_buildid: 20161026030210 06:12:25 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 06:12:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:12:25 INFO - mozversion platform_version: 52.0a1 06:12:25 INFO - using testdate: 1477487545 06:12:25 INFO - actual date: 1477487545 06:12:25 INFO - starting webserver on 'localhost:51916' 06:12:25 INFO - SUITE-START | Running 2 tests 06:12:25 INFO - TEST-START | dromaeo_css 06:12:25 INFO - operating with platform_type : mac_ 06:12:25 INFO - Initialising browser for dromaeo_css test... 06:12:25 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp97UkYf/profile http://localhost:51916/getInfo.html) 06:12:27 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 06:12:27 INFO - PROCESS | 1947 | colorDepth:24 06:12:27 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 06:12:27 INFO - PROCESS | 1947 | __metrics 06:12:28 INFO - PROCESS | 1947 | 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:12:28 INFO - PROCESS | 1947 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:28 INFO - TEST-INFO | 1947: exit 0 06:12:28 INFO - Browser initialized. 06:12:28 INFO - Running cycle 1/1 for dromaeo_css test... 06:12:28 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp97UkYf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:40 INFO - PROCESS | 1950 | RSS: Main: 230248448 06:12:40 INFO - PROCESS | 1950 | 06:13:31 INFO - PROCESS | 1950 | 1477487611843 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:15:44 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51916/tests/dromaeo/cssquery-ext.html) 06:15:46 INFO - PROCESS | 1950 | RSS: Main: 401461248 06:15:46 INFO - PROCESS | 1950 | 06:18:49 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51916/tests/dromaeo/cssquery-ext.html (next: http://localhost:51916/tests/dromaeo/cssquery-jquery.html) 06:18:50 INFO - PROCESS | 1950 | RSS: Main: 368066560 06:18:50 INFO - PROCESS | 1950 | 06:21:52 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51916/tests/dromaeo/cssquery-mootools.html) 06:21:53 INFO - PROCESS | 1950 | RSS: Main: 348577792 06:21:53 INFO - PROCESS | 1950 | 06:24:55 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51916/tests/dromaeo/cssquery-prototype.html) 06:24:56 INFO - PROCESS | 1950 | RSS: Main: 332337152 06:24:56 INFO - PROCESS | 1950 | 06:27:59 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51916/tests/dromaeo/cssquery-yui.html) 06:28:00 INFO - PROCESS | 1950 | RSS: Main: 327892992 06:28:00 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51916/tests/dromaeo/cssquery-yui.html (next: http://localhost:51916/tests/dromaeo/cssquery-dojo.html) 06:31:03 INFO - PROCESS | 1950 | RSS: Main: 379478016 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | __start_tp_report 06:31:03 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 06:31:03 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 06:31:03 INFO - PROCESS | 1950 | |i|pagename|runs| 06:31:03 INFO - PROCESS | 1950 | |0;dojo.html;3292.2098696312883;3301.092199645099;3311.8178500182494;3315.1214928044064;3370.2248482848945;5539.972300138504;5613.83158505245;5638.520725738317;5681.119426488891;5718.056520674089;5633.577481688869;5664.886702265952;5671.602987790856;5674;5780.219670344502;4208.579142085782;5153.871153221181;5214.869628259305;5228.372595288571;5246.5802735781235;5101.38783345999;5170.974145129269;5203.947960520384;5224.582033437316;5236.895262094756;5230.6600070995455;5261.289725886994;5264.835996971028;5266.683998960056;5270.604704647148;5094.7197904115255;5133.332666753336;5169.767360468751;5200.245964335188;5208.8437346879655;5138.922916156223;5175.896482070375;5179.326687530597;5184.8963020739375;5279.208118782175;5610.635308704921;5651.32184137902;5656.745446454878;5664.660120392789;5670.177824215466;5998.25021872266;6211.161493198406;6253.562250642457;6265.8120256392385;6275.2783429905685;6089.817305480843;6140.688304616519;6173.81478555644;6191.721372538246;6201.410865967726;5734.283214598176;5735.512481439125;5738.569607279429;5741.684207368551;5786.103154011135;5228.529432351031;6218.409251121137;6332.968335158387;6344.080108384258;6353.205849268841;5878.323992740804;5938.287405511366;5951.732172052181;6042.788502402483;6054.939450605526;6136.7948077883175;6255.093011513305;6269.153664255267;6269.874602508015;6287.2769631492965;6202.658853763086;6206.782762603287;6212.409821066992;6212.782552610727;6214.906776398358;6059.878802423927;6123.693815309217;6154.569180157346;6208.658523781235;6241.157443745127;4846.055019271208;4853.126437241331;4886.486918873538;4889.3888263967;4943.307936888838;3944.901377465529;4263.936040959388;4391.012022294958;4394.560543945644;4395.318725597537;5631.1271752878365;5730.19777231188;5740.282464691913;5744.195812586241;5774.711264436762;5995.280566332068;6111.622125543816;6113.841195312599;6119.289302195972;6176.536759743038;5705.885882282331;5718.142278658234;5718.942810571841;5733.140028995684;5745.913811292834;5327.067763141435;5342.6260161788305;5348.03735327637;5357.732113394392;5358.8660283492445;6133.426475724657;6244.718987645476;6293.402126797947;6299.464545513682;6305.054241863757;6124.014786914819;6133.1510485532735;6142.498775697809;6192.256929168529;6243.125962365181;6285.371462853678;6286.685665716787;6295.150154729053;6299;6305.527085468517;6078.756849725962;6142.723577439116;6165.136880836776;6181.783637572664;6202.379762023762;6104.664243466652;6125.723854043132;6140.718981675666;6157.199564056644;6249.312575616587;4918.729469879191;6091.847703807441;6098.46248493007;6105.236845394325;6111.236095488064;6024.337322894566;6075.2405949256345;6075.605085669417;6099.4815440688035;6102.4507794298725;5729.9713501432225;5793.739281732248;5840.182374467663;5842.7662893485485;5922.763089476372;5941.584089113893;6069.150318955438;6085.1480792689945;6112.755489780359;6130.754769809158;5737.8565535861935;5808.983427900016;5874.559408044499;5883.441073098049;5899.67551784656 06:31:03 INFO - PROCESS | 1950 | |1;ext.html;491.6926920674578;513.9922901156482;520.4873199898102;520.606941758972;546.6228302471293;30516.69483305169;32593.185170370754;32628.836855815716;41369.58630413695;42565;43728.56271437293;44014.339784903175;44175.89560260987;44218.894527636825;44270.89322766924;9473.763155921106;9628.422294662343;9646.807063858754;9656;9672.081152290557;8288.792780180484;9619.759506012371;9724.319297649168;9735.41587504752;9760.707178784647;9651.227901767877;9712.174465170468;9721.270904682176;9728.416295022322;9728.708138755814;9653.662121825737;9691.27315451344;9692.22462203022;9699.03009699028;9708.98055704148;9451.52742362886;9528.666496672584;9538.332316737831;9548.952255238679;9558.378705384128;40941.79529102365;41340.793296033626;41356.79321603403;41402.37896431556;41407;3382.6109997350372;3467.878624248164;3821.197548514815;3983.063979964706;4162.105147393295;27154.45691086167;30476;31718;31762.841185793925;32125;3164.493681011027;3202.231464448539;3217.099212220582;3344.7324214062814;3355.312161007012;466302;469408;471721;471956;472593;33358;34529;61914.76170476565;62369.37630623727;62409.68795156086;35442.8227858859;35498.64501355005;35538.644613554054;35550.28899421997;35578.11054723601;14187.64530886736;14311;14346.426142954166;14357.78463323051;14372;12087.9725223357;12164.635060948185;12166.209196402382;12179;12203.328816914978;7708.306252437307;7738.012301200271;7757.8448431031065;7822.726204582926;7829.882551761728;3189.4259033374215;3216.903492895217;3238.6437491875877;3240.513922911582;3250;906.7098528470826;931.7204838548408;960.9135177834029;979.9020097990144;1134.3647557367901;29996.55005174924;30000.799968001473;30626.54060189099;30716.69283307138;30752.53871191934;989.9307048506536;1039.5789705169418;1068.1614932278123;1069.9144068474504;1073.8926107389198;15354.078755274719;15877.603059923364;15903.840961590236;15955.60110997211;16326.591835204215;585746;590841;592041;592709;594150;59644;60295.79408411895;60341;60395.49011274753;60414.69792651009;1230.7784598772128;1273.3569547378515;1349.5951214635375;1372.3961456958907;1393.4147657983672;29829.254268643457;31439.37121257608;31491.84254078715;31717.462602992167;32182.19544511406;50713;51490.48509514857;51490.9999999985;51583;51591.48408515867;428590;431312;500410;502257;502280.7491176041;23581.646275306226;24134.39664008414;26124;26653;27019.459610808066;44906.77546612246;44980.77509612431;45365.77317113394;45728.31407528956;46112.76943615395;37939;38153.66462173922;38430.423543646306;39191.2161756769;39761.20477590374;37510.62489375071;37657.62342376541;38596.22807543889;38920.6107938917;39331;36996.705115321914;37062;38014.8099259513;38155;38261.617383825804;32097.35805283928;33397;33779;34045;34300.656993429744;24931;25283.873580632717;25618.615720764577;25622;25896.22311330663 06:31:03 INFO - PROCESS | 1950 | |2;jquery.html;324.3334946684563;353.4450912068051;373.65250317205005;377.4432711750168;402.1554735056382;12699.238045717251;14774.965752397336;15481.303341349623;20384.082716277768;20797.584048319026;20335.593288134227;21401.143954241812;21569.67645485319;21585;21848;5771.192033115357;5790.189373487715;6060.030395136757;6076.726547305359;6077.483413909823;5345.572354211673;5728.77084916605;5811.099279611646;5882.852928676774;5938.9703051484685;5693.544516438675;5822.417758224186;5900.232969713931;5907.291125064999;5908.615939963888;5768.134779783024;5899.793507227269;5902.3507414184405;5904.084866845646;5909.7340619672;4926;5104.974475127638;5150.072986862401;5163.7159956202395;5184.818531351385;26090.86954565215;26348.73651263482;26349.473010539874;26439.206823795317;26548;2246.955060898773;2443.0960544598433;2610.464854704781;2840.815347002459;3204.6635103314047;14518.562636489953;15203.239838008056;15558.29987650547;15707.136107514083;15782.974106683143;1824.79927208007;1836.9816301836945;1848.805875383079;1868.1686649441003;1926.8843869367743;111948.88051119466;113054.43472782665;115990.42004789921;122245;122621.99999999911;9397.248220142372;10892.836607450894;10962.397068161168;11108.16688748347;11156.94009069137;13646.181229126285;13670;13674.589762307147;13697.452101915811;13717.0398072134;8261.530157333935;8355.665773369119;8374.1625837417;8386.580670966548;8600.5699715014;8384.832303353898;8412.116727743498;8415.581323837165;8555.315574754004;8583;5564.666120032811;6658.300878407795;6671.833204169838;6685.665716714242;6696.933030669631;1819.4996375996707;1836.8163183681525;1844.6310737852484;1871.8408935240384;1887.9987213553677;373.5610657477453;904.7918978634951;905.5970093308546;1002.4586723169407;1012.7164393969553;11045.840186780433;11608.535658573732;11902.88097119035;12006.459709313101;12057.336846473352;417.7493503897698;438.4169055156634;438.61840199026415;764.9426293028046;945.2579724915907;10816.621418250323;11168.553257869757;11181.944090279496;11302.208845380908;11441.485133169028;204602;398273;469201;474294;580382;101473;137576;140524.29737851245;140572.59427405594;149314;957.707899090784;980.2696990741942;1014.8883622801486;1015.5582321690089;1016.1312078173204;18731.344402945833;19208.903955480135;19427.611447771247;19621;19639.60720785605;53840;55554;55799.72100139473;56677;57160;81392;81738;82666.58666706628;83105;84620.57689711759;7848.686052557834;7891;7975.880361794461;8060.274575288252;8101.392395570238;10726.463676816284;12545.12184147101;12725.854673079468;12732.490700372251;13228.801567976296;9956.751081223027;11065.723356916142;11114.277571957797;11302.717432064264;11355.432228388712;11018.283811552223;11082.279651822606;11109.444527773741;11249.1563132767;11261.49323280438;11281.605143819927;11347.886521134684;11612;11654.650360489199;11656.475458604213;7780.260875216845;7882.132965373919;7969.163237859942;8022.077461092049;8081.232282933112;8067.798305042421;9907.256955728493;11050.06074483678;11230.66308010761;11440.485178166837 06:31:03 INFO - PROCESS | 1950 | |3;mootools.html;1381.5095641047421;1531.7865684086496;1567.9921600392;1753.587906841892;1900.6578815813157;7434.330910218079;7960.164182760806;8187.631556579953;8278.048024477186;8288.58557072147;8402.411831171821;8510.70212542561;8512.489250644965;8514.318854491641;8517.105703901094;2270.6026445372077;2286.4969706664506;2295.896684649186;2299.2642354446502;2305.5504176685554;2264.977350226493;2315.235972129193;2315.363275099353;2316.548273086749;2317.652352147183;2256.954860902781;2263.9773602264013;2287.1880482428746;2289.4848659051745;2292.2091878302044;2242.9102835886547;2249.988750056247;2273.465735552144;2274.1471948019494;2275.8862056897087;2263.6378179491203;2281.327008532487;2285.954280914389;2286.7027286452653;2291.3927809130596;7209.459290553229;8416.873746893802;8525.57372131391;8555.187257210555;8565.914340856636;5046.747662616891;5205.0110479009245;5208.114620514521;5282.234076058989;5287.709175995319;3458.5330980317585;3601.225736466646;3651.3427583035045;3669.5963444021136;3671.889843304705;1033.9741506462399;1053.3521884041336;1057.4818339013905;1058.534244932235;1082.9729256768564;10977.560897564088;11013.449327533592;11109.777804443947;11151.776964460747;11158.218924675277;4213.97893010533;4344.782760861945;4436.6007059364165;4444.466664000341;4452.2431186697695;8775.780605484786;8785.428947118417;8791.604377803014;8793;8799.140279409217;5139.460356662496;5141.485851414828;5143.794248230104;5153.613478989091;5155.097857874932;4023.1752490739327;4290.742555446684;4403.779811009436;4405.889852753707;4729.6452766042685;3532.5978334732113;3562.625924277965;3649.1606930406156;3657.5245218122004;3664.3221004114325;1087.7008822573698;1116.1628778416189;1124.6738445850613;1124.9381284029294;1127.7067962329854;800.9187596744348;827.8923739913893;887.9911200888038;934.2712684106408;952.590386133969;5222.477752224823;5423.267858839085;5703.486686198262;5826.1552074948895;6028.788992385245;940.7695114696943;941.6092321686424;945.7824700318965;950.805084957582;983.5868935047297;3658.286634106377;3713.02706104471;3818.4654148419245;3885.747426417274;3891.8940517753476;9547.236221102296;10266.743331416774;10389.272750907365;10402.115820155372;10408.739781505523;9660.75848103803;9769.804603907882;9792.237397268418;10206.183505319557;10326;7818.569978651115;8046.396520260887;8049.356051515864;8052;8058.274755272054;5290.576753859605;5510.366307874646;5547.195656629847;5797.9420205797405;5951.375105613848;9481.146696797321;9551.044895510393;9566.760830979003;9567.665131720356;9591.232701384011;8778.209961103532;8887.73336799897;9425.434473931586;9833.606655733976;9847.359921605073;6763.391294783493;6945;6962.408195303254;7031.43748500129;7249.963750181215;7709.961450192937;7856.528608283293;7899.486533375312;8197.221263980151;8211.425200235926;7121.82195445118;7242.637868106679;7285.7085716572865;7331.78004659861;7370.815729606588;7112.466565007541;7150.213476517683;7170.39051680613;7203.531770435115;7213.567185968858;6656;6743.5953842769595;6814.795556133324;6829.214640316427;6831.419329356861;4849.418069831643;4880.658353915192;4939.580135688507;4948.554630083166;5005.1241032819835;4849.175640141255;4858.222684370484;4927.60579153674;4983.8504844854715;5019.3976722793495 06:31:03 INFO - PROCESS | 1950 | |4;prototype.html;295.3163426667265;295.68214169767504;300.59719975233185;309.0943535441158;313.44520199247347;4311.978440107795;5164.2770012198325;5198.870028249291;5223.242629818684;5247.344081989751;3676.595574486811;4620.953790462095;4769.523047695237;4834.709917404949;5205.869853253671;3436.896893093211;3632.8001959892194;3659.652333028358;3715.8327875245545;3881.2819628368843;3921.9803900980455;3924.9411258830996;3930.567637559866;3946.6645335146404;3983.0440694233466;2922.810017348876;3686.318031164243;3926.921461570767;3929.2730844793664;3931.958031121755;3896.980515097406;3901.648851603341;3908.9609103909024;3909.9218015639526;3916.784576848272;3397.303552771676;3417.7607567470286;3419.3161367726307;3419.350323438539;3423.5720534933134;5007.521276967887;5054.498023478402;5065.265536497187;5067.34124563808;5081.974590127025;4055.878323650295;4339.60943515082;4404.977975110136;4458.353538736865;4464.17412778637;4639.234526303156;5282.9170020145775;5377.838664840022;5417.810376636839;5457.863553411196;3657.5976642569294;3668.7982160981137;3672.247189326182;3689.9631003689888;3690.317291301118;4197.021308336862;4341.196878577442;5483.643563168421;5491.890162196733;5617.775288988436;3715.071232191952;3738.383166777451;3741.5136032315627;3749.643783840531;3776.3202623527477;3775.4714339992424;3780.7920564368674;3788.3520668509286;3792.488014118114;3808.923821523554;3711.554613446404;3886.7667939923695;4213.262679031157;4424.203643344229;4431.8448854289945;5256.684598924076;5415.377231618336;5424.511793938565;5465.059903734196;5482.479164479368;1011.7369483934231;1203.8142429706731;1257.7736007518733;1278.3161008860216;1280.9231446113263;716.3624374306871;752.450710980987;770.4876257288952;825.3809642767924;825.7440193540021;4988.501149885055;5023.472535383732;5055.241713742895;5074.2642316864585;5093.8726531837;5041.714362837453;5456.91814622781;5476.890462190734;5509.641873278304;5548.306461692288;4649.558981534721;4728.564789133599;4947.554720075211;5034.521720436553;5067.403767813201;2257.57106149831;2536.516138059256;2624.2258533732593;2913.985430072836;2919.1096715501976;4587.3348364486965;5621.943780562224;5695.316562012585;5728.656280623176;5805.216295800097;5284.727567146164;5514.724263786875;5584.441555844464;5627.409122042209;5734.369219385864;4766.856994290177;5453.509184173444;5646.612032780381;5717.771289148471;5738.139279108167;4893.412790465167;4920.852374428773;5088.455772113943;5317.945348279901;5535.916961245504;5421.701806400686;5423;5439.238506609157;5440.374356949002;5457.590680698884;5298.523132918056;5712.885742285214;5725.828225153252;5728.333866325472;5729.054705973635;3212.582364292627;3320.957611069127;3429.3998550254105;3562.6713543045325;3657.2868290683064;5057.797688092435;5310.495502927216;5328.333958255218;5489.945100549103;5528.391876893458;4936.23570800353;5381.004514164892;5411.594130440154;5417.264281537956;5435.2934118564335;4506.571875671806;4771.928421073756;5159.716215608028;5202.3497062867145;5398.730063496888;4972.303877457087;5244.591015839582;5247.55395791362;5268.077151839628;5287.021900948183;4023.0545821732453;4945.455999840086;5099.949000510096;5246.08193566132;5377.978184145157;4882.975585122052;4960.156773348467;5072.54347108762;5241.623244590657;5302.3637163540625 06:31:03 INFO - PROCESS | 1950 | |5;yui.html;720.7009091227144;724.3372314332386;781.413939545341;822.6215940667292;838.5178522349651;14475.203863787487;14964.551063468114;14965.775513367309;15005.099694018352;15226.695466090672;13352.666183345422;13479.528216512424;13483.393247303871;13492.865071349284;13498.595042148727;692.3906961873545;710.783211120608;712.5439718580113;715.0382735221119;865.3336930563478;713.2154629907112;716.4590733995826;857.2841677199546;896.5472436419632;897.4974014551839;940.6237504998021;946.5787724462617;949.6438835436711;955.2453561686259;958.0467434902282;943.3302355327726;944.3955868244329;948.393028461785;948.6964171465133;950.3822515364999;706.7173130747742;706.8798304288283;707.5613119865665;708.2032713197652;708.3447810775012;11695.590654327058;12177;14228.715425691531;14419.855801442061;14714.0435871668;13418.731625367438;13801.171929684251;14044.157350558999;14086.295685215699;14111.153330800185;11486.540538378455;11549.6535103947;11572.074234061254;11573.189876708633;11648.068154547616;3748.475213470116;3753.568339640949;3755.080005398695;3757.906052348686;3866.4780254665543;82983.5850820748;84204;85178;85462;86543;10600.469976501145;10731.731706707395;10826.783464330669;10846.891531084746;10855.565777368816;21275.46811329729;21385;21624.675629865564;21645.35063948084;21652.45868853291;6762.289959554274;7701.191374905667;7792.688292468238;7864.5281283123195;7869.48848324857;4121.10517393506;4195.4336164618;4254.475722334231;4266.87199384019;4362.760048197316;3422.57217847769;3548.6628770266784;3556.946645800315;3580.0870777951454;3586.964130358715;640.4300172846171;650.1742786661009;654.4339146638124;657.1227411405731;663.7378235596913;482.69831355402874;548.3418361023134;578.3118089473513;585.9853503662357;599.7271241585069;8408.32733381328;8677;8738.897691319617;8809.207171354608;8937.642494300286;544.2652419234003;576.9826905192851;619.2506170069481;622.819382379105;623.0809555905095;4149.771762553089;4345.717528360647;4357.9564204358185;4362.4830447618315;4465.24090904547;109527;111073;111849;112260.43869780599;112430;96759.032409675;98627;99137;100256;100304;85379;86234.13765862386;87346.56326718452;87789.68315475273;89767;8382.748517544484;8479.745607631781;8515.531645759544;8524.062353141026;8767.254783343487;50383.24425133699;52302;52398.73800630972;53926.30115216434;54905;73171;73481.6325918367;75863.24136758782;76377.23622763701;76780;10911.83632245501;11426.542938282375;11427.828582571101;11455.770884582429;11618.6514404568;11873.169135906552;11948.663675525893;11980;12102.636920892388;12130.150889437655;11359.943200283946;11910.702232444259;11929.403529823649;12021.699457513632;12142.967847733042;10961.725956850823;11217.326960382403;11264.66206013821;11296.43517824122;11335.659930202108;10893.346399216072;11002.229843910849;11045.668629941114;11125.443727813416;11245.662630120782;8986.955065224893;9053.93175738169;9578.473183974947;9633.710988670351;9657.275704322063;9347.205487533363;9619.374740641835;9791.764271972384;9793.657221997197;9801.9019809801 06:31:03 INFO - PROCESS | 1950 | __end_tp_report 06:31:03 INFO - PROCESS | 1950 | __start_cc_report 06:31:03 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,1989 06:31:03 INFO - PROCESS | 1950 | __end_cc_report 06:31:03 INFO - PROCESS | 1950 | __startTimestamp1477488663691__endTimestamp 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | ------- Summary: start ------- 06:31:03 INFO - PROCESS | 1950 | Number of tests: 6 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | [#0] dojo.html Cycles:165 Average:5686.39 Median:5842.77 stddev:650.99 (11.1%) stddev-sans-first:625.30 06:31:03 INFO - PROCESS | 1950 | Values: 3292.2 3301.1 3311.8 3315.1 3370.2 5540.0 5613.8 5638.5 5681.1 5718.1 5633.6 5664.9 5671.6 5674.0 5780.2 4208.6 5153.9 5214.9 5228.4 5246.6 5101.4 5171.0 5203.9 5224.6 5236.9 5230.7 5261.3 5264.8 5266.7 5270.6 5094.7 5133.3 5169.8 5200.2 5208.8 5138.9 5175.9 5179.3 5184.9 5279.2 5610.6 5651.3 5656.7 5664.7 5670.2 5998.3 6211.2 6253.6 6265.8 6275.3 6089.8 6140.7 6173.8 6191.7 6201.4 5734.3 5735.5 5738.6 5741.7 5786.1 5228.5 6218.4 6333.0 6344.1 6353.2 5878.3 5938.3 5951.7 6042.8 6054.9 6136.8 6255.1 6269.2 6269.9 6287.3 6202.7 6206.8 6212.4 6212.8 6214.9 6059.9 6123.7 6154.6 6208.7 6241.2 4846.1 4853.1 4886.5 4889.4 4943.3 3944.9 4263.9 4391.0 4394.6 4395.3 5631.1 5730.2 5740.3 5744.2 5774.7 5995.3 6111.6 6113.8 6119.3 6176.5 5705.9 5718.1 5718.9 5733.1 5745.9 5327.1 5342.6 5348.0 5357.7 5358.9 6133.4 6244.7 6293.4 6299.5 6305.1 6124.0 6133.2 6142.5 6192.3 6243.1 6285.4 6286.7 6295.2 6299.0 6305.5 6078.8 6142.7 6165.1 6181.8 6202.4 6104.7 6125.7 6140.7 6157.2 6249.3 4918.7 6091.8 6098.5 6105.2 6111.2 6024.3 6075.2 6075.6 6099.5 6102.5 5730.0 5793.7 5840.2 5842.8 5922.8 5941.6 6069.2 6085.1 6112.8 6130.8 5737.9 5809.0 5874.6 5883.4 5899.7 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | [#1] ext.html Cycles:180 Average:63975.66 Median:39261.11 stddev:137459.94 (350.1%) stddev-sans-first:137762.91 06:31:03 INFO - PROCESS | 1950 | Values: 491.7 514.0 520.5 520.6 546.6 30516.7 32593.2 32628.8 41369.6 42565.0 43728.6 44014.3 44175.9 44218.9 44270.9 9473.8 9628.4 9646.8 9656.0 9672.1 8288.8 9619.8 9724.3 9735.4 9760.7 9651.2 9712.2 9721.3 9728.4 9728.7 9653.7 9691.3 9692.2 9699.0 9709.0 9451.5 9528.7 9538.3 9549.0 9558.4 40941.8 41340.8 41356.8 41402.4 41407.0 3382.6 3467.9 3821.2 3983.1 4162.1 27154.5 30476.0 31718.0 31762.8 32125.0 3164.5 3202.2 3217.1 3344.7 3355.3 466302.0 469408.0 471721.0 471956.0 472593.0 33358.0 34529.0 61914.8 62369.4 62409.7 35442.8 35498.6 35538.6 35550.3 35578.1 14187.6 14311.0 14346.4 14357.8 14372.0 12088.0 12164.6 12166.2 12179.0 12203.3 7708.3 7738.0 7757.8 7822.7 7829.9 3189.4 3216.9 3238.6 3240.5 3250.0 906.7 931.7 960.9 979.9 1134.4 29996.6 30000.8 30626.5 30716.7 30752.5 989.9 1039.6 1068.2 1069.9 1073.9 15354.1 15877.6 15903.8 15955.6 16326.6 585746.0 590841.0 592041.0 592709.0 594150.0 59644.0 60295.8 60341.0 60395.5 60414.7 1230.8 1273.4 1349.6 1372.4 1393.4 29829.3 31439.4 31491.8 31717.5 32182.2 50713.0 51490.5 51491.0 51583.0 51591.5 428590.0 431312.0 500410.0 502257.0 502280.7 23581.6 24134.4 26124.0 26653.0 27019.5 44906.8 44980.8 45365.8 45728.3 46112.8 37939.0 38153.7 38430.4 39191.2 39761.2 37510.6 37657.6 38596.2 38920.6 39331.0 36996.7 37062.0 38014.8 38155.0 38261.6 32097.4 33397.0 33779.0 34045.0 34300.7 24931.0 25283.9 25618.6 25622.0 25896.2 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | [#2] jquery.html Cycles:180 Average:30409.08 Median:14479.60 stddev:76380.64 (527.5%) stddev-sans-first:76561.51 06:31:03 INFO - PROCESS | 1950 | Values: 324.3 353.4 373.7 377.4 402.2 12699.2 14775.0 15481.3 20384.1 20797.6 20335.6 21401.1 21569.7 21585.0 21848.0 5771.2 5790.2 6060.0 6076.7 6077.5 5345.6 5728.8 5811.1 5882.9 5939.0 5693.5 5822.4 5900.2 5907.3 5908.6 5768.1 5899.8 5902.4 5904.1 5909.7 4926.0 5105.0 5150.1 5163.7 5184.8 26090.9 26348.7 26349.5 26439.2 26548.0 2247.0 2443.1 2610.5 2840.8 3204.7 14518.6 15203.2 15558.3 15707.1 15783.0 1824.8 1837.0 1848.8 1868.2 1926.9 111948.9 113054.4 115990.4 122245.0 122622.0 9397.2 10892.8 10962.4 11108.2 11156.9 13646.2 13670.0 13674.6 13697.5 13717.0 8261.5 8355.7 8374.2 8386.6 8600.6 8384.8 8412.1 8415.6 8555.3 8583.0 5564.7 6658.3 6671.8 6685.7 6696.9 1819.5 1836.8 1844.6 1871.8 1888.0 373.6 904.8 905.6 1002.5 1012.7 11045.8 11608.5 11902.9 12006.5 12057.3 417.7 438.4 438.6 764.9 945.3 10816.6 11168.6 11181.9 11302.2 11441.5 204602.0 398273.0 469201.0 474294.0 580382.0 101473.0 137576.0 140524.3 140572.6 149314.0 957.7 980.3 1014.9 1015.6 1016.1 18731.3 19208.9 19427.6 19621.0 19639.6 53840.0 55554.0 55799.7 56677.0 57160.0 81392.0 81738.0 82666.6 83105.0 84620.6 7848.7 7891.0 7975.9 8060.3 8101.4 10726.5 12545.1 12725.9 12732.5 13228.8 9956.8 11065.7 11114.3 11302.7 11355.4 11018.3 11082.3 11109.4 11249.2 11261.5 11281.6 11347.9 11612.0 11654.7 11656.5 7780.3 7882.1 7969.2 8022.1 8081.2 8067.8 9907.3 11050.1 11230.7 11440.5 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | [#3] mootools.html Cycles:180 Average:5449.41 Median:5154.36 stddev:3001.30 (58.2%) stddev-sans-first:2994.15 06:31:03 INFO - PROCESS | 1950 | Values: 1381.5 1531.8 1568.0 1753.6 1900.7 7434.3 7960.2 8187.6 8278.0 8288.6 8402.4 8510.7 8512.5 8514.3 8517.1 2270.6 2286.5 2295.9 2299.3 2305.6 2265.0 2315.2 2315.4 2316.5 2317.7 2257.0 2264.0 2287.2 2289.5 2292.2 2242.9 2250.0 2273.5 2274.1 2275.9 2263.6 2281.3 2286.0 2286.7 2291.4 7209.5 8416.9 8525.6 8555.2 8565.9 5046.7 5205.0 5208.1 5282.2 5287.7 3458.5 3601.2 3651.3 3669.6 3671.9 1034.0 1053.4 1057.5 1058.5 1083.0 10977.6 11013.4 11109.8 11151.8 11158.2 4214.0 4344.8 4436.6 4444.5 4452.2 8775.8 8785.4 8791.6 8793.0 8799.1 5139.5 5141.5 5143.8 5153.6 5155.1 4023.2 4290.7 4403.8 4405.9 4729.6 3532.6 3562.6 3649.2 3657.5 3664.3 1087.7 1116.2 1124.7 1124.9 1127.7 800.9 827.9 888.0 934.3 952.6 5222.5 5423.3 5703.5 5826.2 6028.8 940.8 941.6 945.8 950.8 983.6 3658.3 3713.0 3818.5 3885.7 3891.9 9547.2 10266.7 10389.3 10402.1 10408.7 9660.8 9769.8 9792.2 10206.2 10326.0 7818.6 8046.4 8049.4 8052.0 8058.3 5290.6 5510.4 5547.2 5797.9 5951.4 9481.1 9551.0 9566.8 9567.7 9591.2 8778.2 8887.7 9425.4 9833.6 9847.4 6763.4 6945.0 6962.4 7031.4 7250.0 7710.0 7856.5 7899.5 8197.2 8211.4 7121.8 7242.6 7285.7 7331.8 7370.8 7112.5 7150.2 7170.4 7203.5 7213.6 6656.0 6743.6 6814.8 6829.2 6831.4 4849.4 4880.7 4939.6 4948.6 5005.1 4849.2 4858.2 4927.6 4983.9 5019.4 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | [#4] prototype.html Cycles:180 Average:4333.75 Median:4953.86 stddev:1347.44 (27.2%) stddev-sans-first:1316.69 06:31:03 INFO - PROCESS | 1950 | Values: 295.3 295.7 300.6 309.1 313.4 4312.0 5164.3 5198.9 5223.2 5247.3 3676.6 4621.0 4769.5 4834.7 5205.9 3436.9 3632.8 3659.7 3715.8 3881.3 3922.0 3924.9 3930.6 3946.7 3983.0 2922.8 3686.3 3926.9 3929.3 3932.0 3897.0 3901.6 3909.0 3909.9 3916.8 3397.3 3417.8 3419.3 3419.4 3423.6 5007.5 5054.5 5065.3 5067.3 5082.0 4055.9 4339.6 4405.0 4458.4 4464.2 4639.2 5282.9 5377.8 5417.8 5457.9 3657.6 3668.8 3672.2 3690.0 3690.3 4197.0 4341.2 5483.6 5491.9 5617.8 3715.1 3738.4 3741.5 3749.6 3776.3 3775.5 3780.8 3788.4 3792.5 3808.9 3711.6 3886.8 4213.3 4424.2 4431.8 5256.7 5415.4 5424.5 5465.1 5482.5 1011.7 1203.8 1257.8 1278.3 1280.9 716.4 752.5 770.5 825.4 825.7 4988.5 5023.5 5055.2 5074.3 5093.9 5041.7 5456.9 5476.9 5509.6 5548.3 4649.6 4728.6 4947.6 5034.5 5067.4 2257.6 2536.5 2624.2 2914.0 2919.1 4587.3 5621.9 5695.3 5728.7 5805.2 5284.7 5514.7 5584.4 5627.4 5734.4 4766.9 5453.5 5646.6 5717.8 5738.1 4893.4 4920.9 5088.5 5317.9 5535.9 5421.7 5423.0 5439.2 5440.4 5457.6 5298.5 5712.9 5725.8 5728.3 5729.1 3212.6 3321.0 3429.4 3562.7 3657.3 5057.8 5310.5 5328.3 5489.9 5528.4 4936.2 5381.0 5411.6 5417.3 5435.3 4506.6 4771.9 5159.7 5202.3 5398.7 4972.3 5244.6 5247.6 5268.1 5287.0 4023.1 4945.5 5099.9 5246.1 5378.0 4883.0 4960.2 5072.5 5241.6 5302.4 06:31:03 INFO - PROCESS | 1950 | 06:31:03 INFO - PROCESS | 1950 | [#5] yui.html Cycles:180 Average:20394.05 Median:53162.52 stddev:30419.60 (57.2%) stddev-sans-first:30469.07 06:31:03 INFO - PROCESS | 1950 | Values: 720.7 724.3 781.4 822.6 838.5 14475.2 14964.6 14965.8 15005.1 15226.7 13352.7 13479.5 13483.4 13492.9 13498.6 692.4 710.8 712.5 715.0 865.3 713.2 716.5 857.3 896.5 897.5 940.6 946.6 949.6 955.2 958.0 943.3 944.4 948.4 948.7 950.4 706.7 706.9 707.6 708.2 708.3 11695.6 12177.0 14228.7 14419.9 14714.0 13418.7 13801.2 14044.2 14086.3 14111.2 11486.5 11549.7 11572.1 11573.2 11648.1 3748.5 3753.6 3755.1 3757.9 3866.5 82983.6 84204.0 85178.0 85462.0 86543.0 10600.5 10731.7 10826.8 10846.9 10855.6 21275.5 21385.0 21624.7 21645.4 21652.5 6762.3 7701.2 7792.7 7864.5 7869.5 4121.1 4195.4 4254.5 4266.9 4362.8 3422.6 3548.7 3556.9 3580.1 3587.0 640.4 650.2 654.4 657.1 663.7 482.7 548.3 578.3 586.0 599.7 8408.3 8677.0 8738.9 8809.2 8937.6 544.3 577.0 619.3 622.8 623.1 4149.8 4345.7 4358.0 4362.5 4465.2 109527.0 111073.0 111849.0 112260.4 112430.0 96759.0 98627.0 99137.0 100256.0 100304.0 85379.0 86234.1 87346.6 87789.7 89767.0 8382.7 8479.7 8515.5 8524.1 8767.3 50383.2 52302.0 52398.7 53926.3 54905.0 73171.0 73481.6 75863.2 76377.2 76780.0 10911.8 11426.5 11427.8 11455.8 11618.7 11873.2 11948.7 11980.0 12102.6 12130.2 11359.9 11910.7 11929.4 12021.7 12143.0 10961.7 11217.3 11264.7 11296.4 11335.7 10893.3 11002.2 11045.7 11125.4 11245.7 8987.0 9053.9 9578.5 9633.7 9657.3 9347.2 9619.4 9791.8 9793.7 9801.9 06:31:03 INFO - PROCESS | 1950 | -------- Summary: end -------- 06:31:03 INFO - PROCESS | 1950 | 06:31:04 INFO - TEST-INFO | 1950: exit 0 06:31:04 INFO - TEST-OK | dromaeo_css | took 1118861ms 06:31:04 INFO - TEST-START | kraken 06:31:04 INFO - operating with platform_type : mac_ 06:31:04 INFO - Initialising browser for kraken test... 06:31:04 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp2bMjnv/profile http://localhost:51916/getInfo.html) 06:31:06 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 06:31:06 INFO - PROCESS | 1953 | colorDepth:24 06:31:06 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 06:31:06 INFO - PROCESS | 1953 | __metrics 06:31:06 INFO - PROCESS | 1953 | 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:31:06 INFO - PROCESS | 1953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:31:07 INFO - TEST-INFO | 1953: exit 0 06:31:07 INFO - Browser initialized. 06:31:07 INFO - Running cycle 1/1 for kraken test... 06:31:07 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp2bMjnv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:19 INFO - PROCESS | 1955 | RSS: Main: 230940672 06:31:19 INFO - PROCESS | 1955 | 06:31:22 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51916/tests/kraken/driver.html?testName=audio-beat-detection) 06:31:23 INFO - PROCESS | 1955 | RSS: Main: 290447360 06:31:23 INFO - PROCESS | 1955 | 06:31:25 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51916/tests/kraken/driver.html?testName=audio-dft) 06:31:26 INFO - PROCESS | 1955 | RSS: Main: 291561472 06:31:26 INFO - PROCESS | 1955 | 06:31:29 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51916/tests/kraken/driver.html?testName=audio-fft) 06:31:30 INFO - PROCESS | 1955 | RSS: Main: 384479232 06:31:30 INFO - PROCESS | 1955 | 06:31:32 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51916/tests/kraken/driver.html?testName=audio-oscillator) 06:31:33 INFO - PROCESS | 1955 | RSS: Main: 285327360 06:31:33 INFO - PROCESS | 1955 | 06:31:35 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:31:35 INFO - PROCESS | 1955 | RSS: Main: 290717696 06:31:35 INFO - PROCESS | 1955 | 06:31:38 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51916/tests/kraken/driver.html?testName=imaging-darkroom) 06:31:39 INFO - PROCESS | 1955 | RSS: Main: 329736192 06:31:39 INFO - PROCESS | 1955 | 06:31:41 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51916/tests/kraken/driver.html?testName=imaging-desaturate) 06:31:42 INFO - PROCESS | 1955 | RSS: Main: 329146368 06:31:42 INFO - PROCESS | 1955 | 06:31:45 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51916/tests/kraken/driver.html?testName=json-parse-financial) 06:31:45 INFO - PROCESS | 1955 | RSS: Main: 326766592 06:31:45 INFO - PROCESS | 1955 | 06:31:47 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:31:48 INFO - PROCESS | 1955 | RSS: Main: 301846528 06:31:48 INFO - PROCESS | 1955 | 06:31:50 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:50 INFO - PROCESS | 1955 | RSS: Main: 303243264 06:31:50 INFO - PROCESS | 1955 | 06:31:52 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:53 INFO - PROCESS | 1955 | RSS: Main: 305823744 06:31:53 INFO - PROCESS | 1955 | 06:31:56 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:31:57 INFO - PROCESS | 1955 | RSS: Main: 318390272 06:31:57 INFO - PROCESS | 1955 | 06:32:00 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:32:00 INFO - PROCESS | 1955 | RSS: Main: 318099456 06:32:00 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:51916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51916/tests/kraken/driver.html?testName=ai-astar) 06:32:02 INFO - PROCESS | 1955 | RSS: Main: 361914368 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | __start_tp_report 06:32:02 INFO - PROCESS | 1955 | _x_x_mozilla_page_load 06:32:02 INFO - PROCESS | 1955 | _x_x_mozilla_page_load_details 06:32:02 INFO - PROCESS | 1955 | |i|pagename|runs| 06:32:02 INFO - PROCESS | 1955 | |0;ai-astar;112;113;111;113;113;114;113;113;112;119 06:32:02 INFO - PROCESS | 1955 | |1;audio-beat-detection;156;112;117;148;110;121;115;115;150;115 06:32:02 INFO - PROCESS | 1955 | |2;audio-dft;185;184;179;183;185;184;184;180;183;182 06:32:02 INFO - PROCESS | 1955 | |3;audio-fft;81;60;59;88;62;63;56;59;80;57 06:32:02 INFO - PROCESS | 1955 | |4;audio-oscillator;88;69;90;69;67;69;92;66;68;90 06:32:02 INFO - PROCESS | 1955 | |5;imaging-gaussian-blur;88;86;88;86;88;85;93;86;89;85 06:32:02 INFO - PROCESS | 1955 | |6;imaging-darkroom;93;92;94;93;93;93;100;97;93;92 06:32:02 INFO - PROCESS | 1955 | |7;imaging-desaturate;84;121;91;79;84;81;85;85;85;80 06:32:02 INFO - PROCESS | 1955 | |8;json-parse-financial;58;55;54;55;55;55;54;54;54;53 06:32:02 INFO - PROCESS | 1955 | |9;json-stringify-tinderbox;66;77;80;74;72;68;71;69;70;71 06:32:02 INFO - PROCESS | 1955 | |10;stanford-crypto-aes;90;86;87;87;86;85;86;82;87;88 06:32:02 INFO - PROCESS | 1955 | |11;stanford-crypto-ccm;149;148;132;149;154;154;154;147;203;156 06:32:02 INFO - PROCESS | 1955 | |12;stanford-crypto-pbkdf2;172;179;173;172;173;173;170;172;171;172 06:32:02 INFO - PROCESS | 1955 | |13;stanford-crypto-sha256-iterative;69;68;70;68;69;70;70;78;88;86 06:32:02 INFO - PROCESS | 1955 | __end_tp_report 06:32:02 INFO - PROCESS | 1955 | __start_cc_report 06:32:02 INFO - PROCESS | 1955 | _x_x_mozilla_cycle_collect,2225 06:32:02 INFO - PROCESS | 1955 | __end_cc_report 06:32:02 INFO - PROCESS | 1955 | __startTimestamp1477488722948__endTimestamp 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | ------- Summary: start ------- 06:32:02 INFO - PROCESS | 1955 | Number of tests: 14 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:2.16 (1.9%) stddev-sans-first:2.24 06:32:02 INFO - PROCESS | 1955 | Values: 112.0 113.0 111.0 113.0 113.0 114.0 113.0 113.0 112.0 119.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:119.00 stddev:17.89 (15.0%) stddev-sans-first:15.31 06:32:02 INFO - PROCESS | 1955 | Values: 156.0 112.0 117.0 148.0 110.0 121.0 115.0 115.0 150.0 115.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#2] audio-dft Cycles:10 Average:182.90 Median:184.00 stddev:2.02 (1.1%) stddev-sans-first:2.00 06:32:02 INFO - PROCESS | 1955 | Values: 185.0 184.0 179.0 183.0 185.0 184.0 184.0 180.0 183.0 182.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#3] audio-fft Cycles:10 Average:66.50 Median:62.50 stddev:11.75 (18.8%) stddev-sans-first:11.23 06:32:02 INFO - PROCESS | 1955 | Values: 81.0 60.0 59.0 88.0 62.0 63.0 56.0 59.0 80.0 57.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.50 stddev:11.44 (14.6%) stddev-sans-first:11.39 06:32:02 INFO - PROCESS | 1955 | Values: 88.0 69.0 90.0 69.0 67.0 69.0 92.0 66.0 68.0 90.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:2.41 (2.7%) stddev-sans-first:2.55 06:32:02 INFO - PROCESS | 1955 | Values: 88.0 86.0 88.0 86.0 88.0 85.0 93.0 86.0 89.0 85.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:93.00 stddev:2.54 (2.7%) stddev-sans-first:2.67 06:32:02 INFO - PROCESS | 1955 | Values: 93.0 92.0 94.0 93.0 93.0 93.0 100.0 97.0 93.0 92.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#7] imaging-desaturate Cycles:10 Average:87.50 Median:84.50 stddev:12.24 (14.5%) stddev-sans-first:12.92 06:32:02 INFO - PROCESS | 1955 | Values: 84.0 121.0 91.0 79.0 84.0 81.0 85.0 85.0 85.0 80.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.34 (2.4%) stddev-sans-first:0.71 06:32:02 INFO - PROCESS | 1955 | Values: 58.0 55.0 54.0 55.0 55.0 55.0 54.0 54.0 54.0 53.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.50 stddev:4.21 (5.9%) stddev-sans-first:3.91 06:32:02 INFO - PROCESS | 1955 | Values: 66.0 77.0 80.0 74.0 72.0 68.0 71.0 69.0 70.0 71.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.00 stddev:2.07 (2.4%) stddev-sans-first:1.73 06:32:02 INFO - PROCESS | 1955 | Values: 90.0 86.0 87.0 87.0 86.0 85.0 86.0 82.0 87.0 88.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:154.00 stddev:18.32 (11.9%) stddev-sans-first:19.32 06:32:02 INFO - PROCESS | 1955 | Values: 149.0 148.0 132.0 149.0 154.0 154.0 154.0 147.0 203.0 156.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:172.50 stddev:2.41 (1.4%) stddev-sans-first:2.54 06:32:02 INFO - PROCESS | 1955 | Values: 172.0 179.0 173.0 172.0 173.0 173.0 170.0 172.0 171.0 172.0 06:32:02 INFO - PROCESS | 1955 | 06:32:02 INFO - PROCESS | 1955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:70.00 stddev:7.63 (10.9%) stddev-sans-first:7.91 06:32:02 INFO - PROCESS | 1955 | Values: 69.0 68.0 70.0 68.0 69.0 70.0 70.0 78.0 88.0 86.0 06:32:02 INFO - PROCESS | 1955 | -------- Summary: end -------- 06:32:02 INFO - PROCESS | 1955 | 06:32:03 INFO - TEST-INFO | 1955: exit 0 06:32:03 INFO - TEST-OK | kraken | took 59451ms 06:32:03 INFO - SUITE-END | took 1178s 06:32:04 INFO - Completed test suite (00:19:38) 06:32:04 INFO - javascript benchmark 06:32:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.2098696312883, 3301.092199645099, 3311.8178500182494, 3315.1214928044064, 3370.2248482848945, 5539.972300138504, 5613.83158505245, 5638.520725738317, 5681.119426488891, 5718.056520674089, 5633.577481688869, 5664.886702265952, 5671.602987790856, 5674.0, 5780.219670344502, 4208.579142085782, 5153.871153221181, 5214.869628259305, 5228.372595288571, 5246.5802735781235, 5101.38783345999, 5170.974145129269, 5203.947960520384, 5224.582033437316, 5236.895262094756, 5230.6600070995455, 5261.289725886994, 5264.835996971028, 5266.683998960056, 5270.604704647148, 5094.7197904115255, 5133.332666753336, 5169.767360468751, 5200.245964335188, 5208.8437346879655, 5138.922916156223, 5175.896482070375, 5179.326687530597, 5184.8963020739375, 5279.208118782175, 5610.635308704921, 5651.32184137902, 5656.745446454878, 5664.660120392789, 5670.177824215466, 5998.25021872266, 6211.161493198406, 6253.562250642457, 6265.8120256392385, 6275.2783429905685, 6089.817305480843, 6140.688304616519, 6173.81478555644, 6191.721372538246, 6201.410865967726, 5734.283214598176, 5735.512481439125, 5738.569607279429, 5741.684207368551, 5786.103154011135, 5228.529432351031, 6218.409251121137, 6332.968335158387, 6344.080108384258, 6353.205849268841, 5878.323992740804, 5938.287405511366, 5951.732172052181, 6042.788502402483, 6054.939450605526, 6136.7948077883175, 6255.093011513305, 6269.153664255267, 6269.874602508015, 6287.2769631492965, 6202.658853763086, 6206.782762603287, 6212.409821066992, 6212.782552610727, 6214.906776398358, 6059.878802423927, 6123.693815309217, 6154.569180157346, 6208.658523781235, 6241.157443745127, 4846.055019271208, 4853.126437241331, 4886.486918873538, 4889.3888263967, 4943.307936888838, 3944.901377465529, 4263.936040959388, 4391.012022294958, 4394.560543945644, 4395.318725597537, 5631.1271752878365, 5730.19777231188, 5740.282464691913, 5744.195812586241, 5774.711264436762, 5995.280566332068, 6111.622125543816, 6113.841195312599, 6119.289302195972, 6176.536759743038, 5705.885882282331, 5718.142278658234, 5718.942810571841, 5733.140028995684, 5745.913811292834, 5327.067763141435, 5342.6260161788305, 5348.03735327637, 5357.732113394392, 5358.8660283492445, 6133.426475724657, 6244.718987645476, 6293.402126797947, 6299.464545513682, 6305.054241863757, 6124.014786914819, 6133.1510485532735, 6142.498775697809, 6192.256929168529, 6243.125962365181, 6285.371462853678, 6286.685665716787, 6295.150154729053, 6299.0, 6305.527085468517, 6078.756849725962, 6142.723577439116, 6165.136880836776, 6181.783637572664, 6202.379762023762, 6104.664243466652, 6125.723854043132, 6140.718981675666, 6157.199564056644, 6249.312575616587, 4918.729469879191, 6091.847703807441, 6098.46248493007, 6105.236845394325, 6111.236095488064, 6024.337322894566, 6075.2405949256345, 6075.605085669417, 6099.4815440688035, 6102.4507794298725, 5729.9713501432225, 5793.739281732248, 5840.182374467663, 5842.7662893485485, 5922.763089476372, 5941.584089113893, 6069.150318955438, 6085.1480792689945, 6112.755489780359, 6130.754769809158, 5737.8565535861935, 5808.983427900016, 5874.559408044499, 5883.441073098049, 5899.67551784656], "value": 5644.167814002927, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.6926920674578, 513.9922901156482, 520.4873199898102, 520.606941758972, 546.6228302471293, 30516.69483305169, 32593.185170370754, 32628.836855815716, 41369.58630413695, 42565.0, 43728.56271437293, 44014.339784903175, 44175.89560260987, 44218.894527636825, 44270.89322766924, 9473.763155921106, 9628.422294662343, 9646.807063858754, 9656.0, 9672.081152290557, 8288.792780180484, 9619.759506012371, 9724.319297649168, 9735.41587504752, 9760.707178784647, 9651.227901767877, 9712.174465170468, 9721.270904682176, 9728.416295022322, 9728.708138755814, 9653.662121825737, 9691.27315451344, 9692.22462203022, 9699.03009699028, 9708.98055704148, 9451.52742362886, 9528.666496672584, 9538.332316737831, 9548.952255238679, 9558.378705384128, 40941.79529102365, 41340.793296033626, 41356.79321603403, 41402.37896431556, 41407.0, 3382.6109997350372, 3467.878624248164, 3821.197548514815, 3983.063979964706, 4162.105147393295, 27154.45691086167, 30476.0, 31718.0, 31762.841185793925, 32125.0, 3164.493681011027, 3202.231464448539, 3217.099212220582, 3344.7324214062814, 3355.312161007012, 466302.0, 469408.0, 471721.0, 471956.0, 472593.0, 33358.0, 34529.0, 61914.76170476565, 62369.37630623727, 62409.68795156086, 35442.8227858859, 35498.64501355005, 35538.644613554054, 35550.28899421997, 35578.11054723601, 14187.64530886736, 14311.0, 14346.426142954166, 14357.78463323051, 14372.0, 12087.9725223357, 12164.635060948185, 12166.209196402382, 12179.0, 12203.328816914978, 7708.306252437307, 7738.012301200271, 7757.8448431031065, 7822.726204582926, 7829.882551761728, 3189.4259033374215, 3216.903492895217, 3238.6437491875877, 3240.513922911582, 3250.0, 906.7098528470826, 931.7204838548408, 960.9135177834029, 979.9020097990144, 1134.3647557367901, 29996.55005174924, 30000.799968001473, 30626.54060189099, 30716.69283307138, 30752.53871191934, 989.9307048506536, 1039.5789705169418, 1068.1614932278123, 1069.9144068474504, 1073.8926107389198, 15354.078755274719, 15877.603059923364, 15903.840961590236, 15955.60110997211, 16326.591835204215, 585746.0, 590841.0, 592041.0, 592709.0, 594150.0, 59644.0, 60295.79408411895, 60341.0, 60395.49011274753, 60414.69792651009, 1230.7784598772128, 1273.3569547378515, 1349.5951214635375, 1372.3961456958907, 1393.4147657983672, 29829.254268643457, 31439.37121257608, 31491.84254078715, 31717.462602992167, 32182.19544511406, 50713.0, 51490.48509514857, 51490.9999999985, 51583.0, 51591.48408515867, 428590.0, 431312.0, 500410.0, 502257.0, 502280.7491176041, 23581.646275306226, 24134.39664008414, 26124.0, 26653.0, 27019.459610808066, 44906.77546612246, 44980.77509612431, 45365.77317113394, 45728.31407528956, 46112.76943615395, 37939.0, 38153.66462173922, 38430.423543646306, 39191.2161756769, 39761.20477590374, 37510.62489375071, 37657.62342376541, 38596.22807543889, 38920.6107938917, 39331.0, 36996.705115321914, 37062.0, 38014.8099259513, 38155.0, 38261.617383825804, 32097.35805283928, 33397.0, 33779.0, 34045.0, 34300.656993429744, 24931.0, 25283.873580632717, 25618.615720764577, 25622.0, 25896.22311330663], "value": 18457.47893332739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.3334946684563, 353.4450912068051, 373.65250317205005, 377.4432711750168, 402.1554735056382, 12699.238045717251, 14774.965752397336, 15481.303341349623, 20384.082716277768, 20797.584048319026, 20335.593288134227, 21401.143954241812, 21569.67645485319, 21585.0, 21848.0, 5771.192033115357, 5790.189373487715, 6060.030395136757, 6076.726547305359, 6077.483413909823, 5345.572354211673, 5728.77084916605, 5811.099279611646, 5882.852928676774, 5938.9703051484685, 5693.544516438675, 5822.417758224186, 5900.232969713931, 5907.291125064999, 5908.615939963888, 5768.134779783024, 5899.793507227269, 5902.3507414184405, 5904.084866845646, 5909.7340619672, 4926.0, 5104.974475127638, 5150.072986862401, 5163.7159956202395, 5184.818531351385, 26090.86954565215, 26348.73651263482, 26349.473010539874, 26439.206823795317, 26548.0, 2246.955060898773, 2443.0960544598433, 2610.464854704781, 2840.815347002459, 3204.6635103314047, 14518.562636489953, 15203.239838008056, 15558.29987650547, 15707.136107514083, 15782.974106683143, 1824.79927208007, 1836.9816301836945, 1848.805875383079, 1868.1686649441003, 1926.8843869367743, 111948.88051119466, 113054.43472782665, 115990.42004789921, 122245.0, 122621.99999999911, 9397.248220142372, 10892.836607450894, 10962.397068161168, 11108.16688748347, 11156.94009069137, 13646.181229126285, 13670.0, 13674.589762307147, 13697.452101915811, 13717.0398072134, 8261.530157333935, 8355.665773369119, 8374.1625837417, 8386.580670966548, 8600.5699715014, 8384.832303353898, 8412.116727743498, 8415.581323837165, 8555.315574754004, 8583.0, 5564.666120032811, 6658.300878407795, 6671.833204169838, 6685.665716714242, 6696.933030669631, 1819.4996375996707, 1836.8163183681525, 1844.6310737852484, 1871.8408935240384, 1887.9987213553677, 373.5610657477453, 904.7918978634951, 905.5970093308546, 1002.4586723169407, 1012.7164393969553, 11045.840186780433, 11608.535658573732, 11902.88097119035, 12006.459709313101, 12057.336846473352, 417.7493503897698, 438.4169055156634, 438.61840199026415, 764.9426293028046, 945.2579724915907, 10816.621418250323, 11168.553257869757, 11181.944090279496, 11302.208845380908, 11441.485133169028, 204602.0, 398273.0, 469201.0, 474294.0, 580382.0, 101473.0, 137576.0, 140524.29737851245, 140572.59427405594, 149314.0, 957.707899090784, 980.2696990741942, 1014.8883622801486, 1015.5582321690089, 1016.1312078173204, 18731.344402945833, 19208.903955480135, 19427.611447771247, 19621.0, 19639.60720785605, 53840.0, 55554.0, 55799.72100139473, 56677.0, 57160.0, 81392.0, 81738.0, 82666.58666706628, 83105.0, 84620.57689711759, 7848.686052557834, 7891.0, 7975.880361794461, 8060.274575288252, 8101.392395570238, 10726.463676816284, 12545.12184147101, 12725.854673079468, 12732.490700372251, 13228.801567976296, 9956.751081223027, 11065.723356916142, 11114.277571957797, 11302.717432064264, 11355.432228388712, 11018.283811552223, 11082.279651822606, 11109.444527773741, 11249.1563132767, 11261.49323280438, 11281.605143819927, 11347.886521134684, 11612.0, 11654.650360489199, 11656.475458604213, 7780.260875216845, 7882.132965373919, 7969.163237859942, 8022.077461092049, 8081.232282933112, 8067.798305042421, 9907.256955728493, 11050.06074483678, 11230.66308010761, 11440.485178166837], "value": 9350.472622112422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.5095641047421, 1531.7865684086496, 1567.9921600392, 1753.587906841892, 1900.6578815813157, 7434.330910218079, 7960.164182760806, 8187.631556579953, 8278.048024477186, 8288.58557072147, 8402.411831171821, 8510.70212542561, 8512.489250644965, 8514.318854491641, 8517.105703901094, 2270.6026445372077, 2286.4969706664506, 2295.896684649186, 2299.2642354446502, 2305.5504176685554, 2264.977350226493, 2315.235972129193, 2315.363275099353, 2316.548273086749, 2317.652352147183, 2256.954860902781, 2263.9773602264013, 2287.1880482428746, 2289.4848659051745, 2292.2091878302044, 2242.9102835886547, 2249.988750056247, 2273.465735552144, 2274.1471948019494, 2275.8862056897087, 2263.6378179491203, 2281.327008532487, 2285.954280914389, 2286.7027286452653, 2291.3927809130596, 7209.459290553229, 8416.873746893802, 8525.57372131391, 8555.187257210555, 8565.914340856636, 5046.747662616891, 5205.0110479009245, 5208.114620514521, 5282.234076058989, 5287.709175995319, 3458.5330980317585, 3601.225736466646, 3651.3427583035045, 3669.5963444021136, 3671.889843304705, 1033.9741506462399, 1053.3521884041336, 1057.4818339013905, 1058.534244932235, 1082.9729256768564, 10977.560897564088, 11013.449327533592, 11109.777804443947, 11151.776964460747, 11158.218924675277, 4213.97893010533, 4344.782760861945, 4436.6007059364165, 4444.466664000341, 4452.2431186697695, 8775.780605484786, 8785.428947118417, 8791.604377803014, 8793.0, 8799.140279409217, 5139.460356662496, 5141.485851414828, 5143.794248230104, 5153.613478989091, 5155.097857874932, 4023.1752490739327, 4290.742555446684, 4403.779811009436, 4405.889852753707, 4729.6452766042685, 3532.5978334732113, 3562.625924277965, 3649.1606930406156, 3657.5245218122004, 3664.3221004114325, 1087.7008822573698, 1116.1628778416189, 1124.6738445850613, 1124.9381284029294, 1127.7067962329854, 800.9187596744348, 827.8923739913893, 887.9911200888038, 934.2712684106408, 952.590386133969, 5222.477752224823, 5423.267858839085, 5703.486686198262, 5826.1552074948895, 6028.788992385245, 940.7695114696943, 941.6092321686424, 945.7824700318965, 950.805084957582, 983.5868935047297, 3658.286634106377, 3713.02706104471, 3818.4654148419245, 3885.747426417274, 3891.8940517753476, 9547.236221102296, 10266.743331416774, 10389.272750907365, 10402.115820155372, 10408.739781505523, 9660.75848103803, 9769.804603907882, 9792.237397268418, 10206.183505319557, 10326.0, 7818.569978651115, 8046.396520260887, 8049.356051515864, 8052.0, 8058.274755272054, 5290.576753859605, 5510.366307874646, 5547.195656629847, 5797.9420205797405, 5951.375105613848, 9481.146696797321, 9551.044895510393, 9566.760830979003, 9567.665131720356, 9591.232701384011, 8778.209961103532, 8887.73336799897, 9425.434473931586, 9833.606655733976, 9847.359921605073, 6763.391294783493, 6945.0, 6962.408195303254, 7031.43748500129, 7249.963750181215, 7709.961450192937, 7856.528608283293, 7899.486533375312, 8197.221263980151, 8211.425200235926, 7121.82195445118, 7242.637868106679, 7285.7085716572865, 7331.78004659861, 7370.815729606588, 7112.466565007541, 7150.213476517683, 7170.39051680613, 7203.531770435115, 7213.567185968858, 6656.0, 6743.5953842769595, 6814.795556133324, 6829.214640316427, 6831.419329356861, 4849.418069831643, 4880.658353915192, 4939.580135688507, 4948.554630083166, 5005.1241032819835, 4849.175640141255, 4858.222684370484, 4927.60579153674, 4983.8504844854715, 5019.3976722793495], "value": 4406.260572810096, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.3163426667265, 295.68214169767504, 300.59719975233185, 309.0943535441158, 313.44520199247347, 4311.978440107795, 5164.2770012198325, 5198.870028249291, 5223.242629818684, 5247.344081989751, 3676.595574486811, 4620.953790462095, 4769.523047695237, 4834.709917404949, 5205.869853253671, 3436.896893093211, 3632.8001959892194, 3659.652333028358, 3715.8327875245545, 3881.2819628368843, 3921.9803900980455, 3924.9411258830996, 3930.567637559866, 3946.6645335146404, 3983.0440694233466, 2922.810017348876, 3686.318031164243, 3926.921461570767, 3929.2730844793664, 3931.958031121755, 3896.980515097406, 3901.648851603341, 3908.9609103909024, 3909.9218015639526, 3916.784576848272, 3397.303552771676, 3417.7607567470286, 3419.3161367726307, 3419.350323438539, 3423.5720534933134, 5007.521276967887, 5054.498023478402, 5065.265536497187, 5067.34124563808, 5081.974590127025, 4055.878323650295, 4339.60943515082, 4404.977975110136, 4458.353538736865, 4464.17412778637, 4639.234526303156, 5282.9170020145775, 5377.838664840022, 5417.810376636839, 5457.863553411196, 3657.5976642569294, 3668.7982160981137, 3672.247189326182, 3689.9631003689888, 3690.317291301118, 4197.021308336862, 4341.196878577442, 5483.643563168421, 5491.890162196733, 5617.775288988436, 3715.071232191952, 3738.383166777451, 3741.5136032315627, 3749.643783840531, 3776.3202623527477, 3775.4714339992424, 3780.7920564368674, 3788.3520668509286, 3792.488014118114, 3808.923821523554, 3711.554613446404, 3886.7667939923695, 4213.262679031157, 4424.203643344229, 4431.8448854289945, 5256.684598924076, 5415.377231618336, 5424.511793938565, 5465.059903734196, 5482.479164479368, 1011.7369483934231, 1203.8142429706731, 1257.7736007518733, 1278.3161008860216, 1280.9231446113263, 716.3624374306871, 752.450710980987, 770.4876257288952, 825.3809642767924, 825.7440193540021, 4988.501149885055, 5023.472535383732, 5055.241713742895, 5074.2642316864585, 5093.8726531837, 5041.714362837453, 5456.91814622781, 5476.890462190734, 5509.641873278304, 5548.306461692288, 4649.558981534721, 4728.564789133599, 4947.554720075211, 5034.521720436553, 5067.403767813201, 2257.57106149831, 2536.516138059256, 2624.2258533732593, 2913.985430072836, 2919.1096715501976, 4587.3348364486965, 5621.943780562224, 5695.316562012585, 5728.656280623176, 5805.216295800097, 5284.727567146164, 5514.724263786875, 5584.441555844464, 5627.409122042209, 5734.369219385864, 4766.856994290177, 5453.509184173444, 5646.612032780381, 5717.771289148471, 5738.139279108167, 4893.412790465167, 4920.852374428773, 5088.455772113943, 5317.945348279901, 5535.916961245504, 5421.701806400686, 5423.0, 5439.238506609157, 5440.374356949002, 5457.590680698884, 5298.523132918056, 5712.885742285214, 5725.828225153252, 5728.333866325472, 5729.054705973635, 3212.582364292627, 3320.957611069127, 3429.3998550254105, 3562.6713543045325, 3657.2868290683064, 5057.797688092435, 5310.495502927216, 5328.333958255218, 5489.945100549103, 5528.391876893458, 4936.23570800353, 5381.004514164892, 5411.594130440154, 5417.264281537956, 5435.2934118564335, 4506.571875671806, 4771.928421073756, 5159.716215608028, 5202.3497062867145, 5398.730063496888, 4972.303877457087, 5244.591015839582, 5247.55395791362, 5268.077151839628, 5287.021900948183, 4023.0545821732453, 4945.455999840086, 5099.949000510096, 5246.08193566132, 5377.978184145157, 4882.975585122052, 4960.156773348467, 5072.54347108762, 5241.623244590657, 5302.3637163540625], "value": 3899.091912920477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.7009091227144, 724.3372314332386, 781.413939545341, 822.6215940667292, 838.5178522349651, 14475.203863787487, 14964.551063468114, 14965.775513367309, 15005.099694018352, 15226.695466090672, 13352.666183345422, 13479.528216512424, 13483.393247303871, 13492.865071349284, 13498.595042148727, 692.3906961873545, 710.783211120608, 712.5439718580113, 715.0382735221119, 865.3336930563478, 713.2154629907112, 716.4590733995826, 857.2841677199546, 896.5472436419632, 897.4974014551839, 940.6237504998021, 946.5787724462617, 949.6438835436711, 955.2453561686259, 958.0467434902282, 943.3302355327726, 944.3955868244329, 948.393028461785, 948.6964171465133, 950.3822515364999, 706.7173130747742, 706.8798304288283, 707.5613119865665, 708.2032713197652, 708.3447810775012, 11695.590654327058, 12177.0, 14228.715425691531, 14419.855801442061, 14714.0435871668, 13418.731625367438, 13801.171929684251, 14044.157350558999, 14086.295685215699, 14111.153330800185, 11486.540538378455, 11549.6535103947, 11572.074234061254, 11573.189876708633, 11648.068154547616, 3748.475213470116, 3753.568339640949, 3755.080005398695, 3757.906052348686, 3866.4780254665543, 82983.5850820748, 84204.0, 85178.0, 85462.0, 86543.0, 10600.469976501145, 10731.731706707395, 10826.783464330669, 10846.891531084746, 10855.565777368816, 21275.46811329729, 21385.0, 21624.675629865564, 21645.35063948084, 21652.45868853291, 6762.289959554274, 7701.191374905667, 7792.688292468238, 7864.5281283123195, 7869.48848324857, 4121.10517393506, 4195.4336164618, 4254.475722334231, 4266.87199384019, 4362.760048197316, 3422.57217847769, 3548.6628770266784, 3556.946645800315, 3580.0870777951454, 3586.964130358715, 640.4300172846171, 650.1742786661009, 654.4339146638124, 657.1227411405731, 663.7378235596913, 482.69831355402874, 548.3418361023134, 578.3118089473513, 585.9853503662357, 599.7271241585069, 8408.32733381328, 8677.0, 8738.897691319617, 8809.207171354608, 8937.642494300286, 544.2652419234003, 576.9826905192851, 619.2506170069481, 622.819382379105, 623.0809555905095, 4149.771762553089, 4345.717528360647, 4357.9564204358185, 4362.4830447618315, 4465.24090904547, 109527.0, 111073.0, 111849.0, 112260.43869780599, 112430.0, 96759.032409675, 98627.0, 99137.0, 100256.0, 100304.0, 85379.0, 86234.13765862386, 87346.56326718452, 87789.68315475273, 89767.0, 8382.748517544484, 8479.745607631781, 8515.531645759544, 8524.062353141026, 8767.254783343487, 50383.24425133699, 52302.0, 52398.73800630972, 53926.30115216434, 54905.0, 73171.0, 73481.6325918367, 75863.24136758782, 76377.23622763701, 76780.0, 10911.83632245501, 11426.542938282375, 11427.828582571101, 11455.770884582429, 11618.6514404568, 11873.169135906552, 11948.663675525893, 11980.0, 12102.636920892388, 12130.150889437655, 11359.943200283946, 11910.702232444259, 11929.403529823649, 12021.699457513632, 12142.967847733042, 10961.725956850823, 11217.326960382403, 11264.66206013821, 11296.43517824122, 11335.659930202108, 10893.346399216072, 11002.229843910849, 11045.668629941114, 11125.443727813416, 11245.662630120782, 8986.955065224893, 9053.93175738169, 9578.473183974947, 9633.710988670351, 9657.275704322063, 9347.205487533363, 9619.374740641835, 9791.764271972384, 9793.657221997197, 9801.9019809801], "value": 7140.981170854355, "unit": "score"}], "name": "dromaeo_css", "value": 7018.440667878507, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 111.0, 113.0, 113.0, 114.0, 113.0, 113.0, 112.0, 119.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 112.0, 117.0, 148.0, 110.0, 121.0, 115.0, 115.0, 150.0, 115.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 179.0, 183.0, 185.0, 184.0, 184.0, 180.0, 183.0, 182.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 88.0, 62.0, 63.0, 56.0, 59.0, 80.0, 57.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 90.0, 69.0, 67.0, 69.0, 92.0, 66.0, 68.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 88.0, 85.0, 93.0, 86.0, 89.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 93.0, 93.0, 93.0, 100.0, 97.0, 93.0, 92.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 121.0, 91.0, 79.0, 84.0, 81.0, 85.0, 85.0, 85.0, 80.0], "value": 87.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 80.0, 74.0, 72.0, 68.0, 71.0, 69.0, 70.0, 71.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 87.0, 87.0, 86.0, 85.0, 86.0, 82.0, 87.0, 88.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 132.0, 149.0, 154.0, 154.0, 154.0, 147.0, 203.0, 156.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 179.0, 173.0, 172.0, 173.0, 173.0, 170.0, 172.0, 171.0, 172.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 68.0, 69.0, 70.0, 70.0, 78.0, 88.0, 86.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1448.1, "alertThreshold": 2.0}]} 06:32:04 INFO - Return code: 0 06:32:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:32:04 INFO - # TBPL SUCCESS # 06:32:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:32:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:32:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:32:04 INFO - 2016-10-26 06:32:04.248 screenresolution[1959:18781] starting screenresolution argv=screenresolution get 06:32:04 INFO - 2016-10-26 06:32:04.250 screenresolution[1959:18781] Display 0: 1600x1200x32@60 06:32:04 INFO - 2016-10-26 06:32:04.256 screenresolution[1960:18784] starting screenresolution argv=screenresolution list 06:32:04 INFO - Available Modes on Display 0 06:32:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:32:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:32:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:32:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:32:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:32:04 INFO - Intel Iris: 06:32:04 INFO - Chipset Model: Intel Iris 06:32:04 INFO - Type: GPU 06:32:04 INFO - Bus: Built-In 06:32:04 INFO - VRAM (Dynamic, Max): 1536 MB 06:32:04 INFO - Vendor: Intel (0x8086) 06:32:04 INFO - Device ID: 0x0a2e 06:32:04 INFO - Revision ID: 0x0009 06:32:04 INFO - Displays: 06:32:04 INFO - Display: 06:32:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:32:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:32:04 INFO - Display Serial Number: 1600x1200 60 06:32:04 INFO - Main Display: Yes 06:32:04 INFO - Mirror: Off 06:32:04 INFO - Online: Yes 06:32:04 INFO - Rotation: Supported 06:32:04 INFO - Return code: 0 06:32:04 INFO - Running post-action listener: _resource_record_post_action 06:32:04 INFO - [mozharness: 2016-10-26 13:32:04.493648Z] Finished run-tests step (success) 06:32:04 INFO - Running post-run listener: _resource_record_post_run 06:32:04 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 331776; Write bytes: 709962752; Read time: 4; Write time: 1999 06:32:04 INFO - TinderboxPrint: CPU usage
53.5% 06:32:04 INFO - TinderboxPrint: I/O read bytes / time
331,776 / 4 06:32:04 INFO - TinderboxPrint: I/O write bytes / time
709,962,752 / 1,999 06:32:04 INFO - TinderboxPrint: CPU idle
2,257.5 (46.5%) 06:32:04 INFO - TinderboxPrint: CPU system
968.1 (19.9%) 06:32:04 INFO - TinderboxPrint: CPU user
1,628.0 (33.5%) 06:32:04 INFO - TinderboxPrint: Swap in / out
406,114,304 / 0 06:32:04 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399131136; Write bytes: 394216960; Read time: 29283; Write time: 844 06:32:04 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 331776; Write bytes: 299365888; Read time: 4; Write time: 1111 06:32:04 INFO - Running post-run listener: _upload_blobber_files 06:32:04 INFO - Blob upload gear active. 06:32:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:04 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:32:04 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:32:04 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:32:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:06 INFO - (blobuploader) - INFO - Done attempting. 06:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:32:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:07 INFO - (blobuploader) - INFO - Done attempting. 06:32:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:32:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:09 INFO - (blobuploader) - INFO - Done attempting. 06:32:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:09 INFO - Return code: 0 06:32:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0ba1517f3ede0e1e533729bf3e888dddfa25e9a85689fac7ef29be5518e93e85623e127665668de81a58402a723fe863e51fd88d54103b146aabb79d1c363b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e436528e5a2f54f527f2ee5b5002be3ddf7b7ea7fb311189fb64900ef4a04cac37b6229794bde7b258a57f12c010fcec67f7705154da5136dde86d7ea3f23e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4d531df525359827b93e2e5ce6d5c4555c48f0425dac4111ba4726b4007c06d7c51de9d7bd41ba98f39ebfb8f0bc2563fa06a48af678e41a43fd1a2008a6abc"} 06:32:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:09 INFO - Contents: 06:32:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0ba1517f3ede0e1e533729bf3e888dddfa25e9a85689fac7ef29be5518e93e85623e127665668de81a58402a723fe863e51fd88d54103b146aabb79d1c363b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e436528e5a2f54f527f2ee5b5002be3ddf7b7ea7fb311189fb64900ef4a04cac37b6229794bde7b258a57f12c010fcec67f7705154da5136dde86d7ea3f23e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4d531df525359827b93e2e5ce6d5c4555c48f0425dac4111ba4726b4007c06d7c51de9d7bd41ba98f39ebfb8f0bc2563fa06a48af678e41a43fd1a2008a6abc"} 06:32:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:09 INFO - Copying logs to upload dir... 06:32:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.647036 ========= master_lag: 1.59 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 06:32:11.517326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 06:32:11.518657) ========= 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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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/Firefox/sha512/f0ba1517f3ede0e1e533729bf3e888dddfa25e9a85689fac7ef29be5518e93e85623e127665668de81a58402a723fe863e51fd88d54103b146aabb79d1c363b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e436528e5a2f54f527f2ee5b5002be3ddf7b7ea7fb311189fb64900ef4a04cac37b6229794bde7b258a57f12c010fcec67f7705154da5136dde86d7ea3f23e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4d531df525359827b93e2e5ce6d5c4555c48f0425dac4111ba4726b4007c06d7c51de9d7bd41ba98f39ebfb8f0bc2563fa06a48af678e41a43fd1a2008a6abc"} build_url:https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/dlNJEKUCQQ66HsibgMS1kw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0ba1517f3ede0e1e533729bf3e888dddfa25e9a85689fac7ef29be5518e93e85623e127665668de81a58402a723fe863e51fd88d54103b146aabb79d1c363b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16e436528e5a2f54f527f2ee5b5002be3ddf7b7ea7fb311189fb64900ef4a04cac37b6229794bde7b258a57f12c010fcec67f7705154da5136dde86d7ea3f23e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4d531df525359827b93e2e5ce6d5c4555c48f0425dac4111ba4726b4007c06d7c51de9d7bd41ba98f39ebfb8f0bc2563fa06a48af678e41a43fd1a2008a6abc"}' ========= master_lag: 0.23 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 06:32:11.760121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 06:32:11.760538) ========= 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.EyrTwU7RYO/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.fMUeXAjbV6/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.005200 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 06:32:11.790279) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-10-26 06:32:11.790640) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-10-26 06:32:15.449642) ========= ========= Total master_lag: 1.94 =========