builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0061 starttime: 1480485298.01 results: success (0) buildid: 20161129192900 builduid: 5f69be5de11a41faad5048a5ee33a52c revision: a69583d2dbc6fdc18f63761a89cf539c356668be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.011702) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.012183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.012465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.040266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.040677) ========= 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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-11-29 21:54:58-- 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% 166M=0s 2016-11-29 21:54:58 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140248 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.205481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.205806) ========= 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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.026793 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 21:54:58.254259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 21:54:58.254641) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a69583d2dbc6fdc18f63761a89cf539c356668be --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 a69583d2dbc6fdc18f63761a89cf539c356668be --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yf6PpbOveY/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.W0nv7LxWDZ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-11-29 21:54:58,347 truncating revision to first 12 chars 2016-11-29 21:54:58,347 Setting DEBUG logging. 2016-11-29 21:54:58,347 attempt 1/10 2016-11-29 21:54:58,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a69583d2dbc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 21:54:59,936 unpacking tar archive at: mozilla-central-a69583d2dbc6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.862821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 21:55:00.138734) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 21:55:00.139056) ========= script_repo_revision: a69583d2dbc6fdc18f63761a89cf539c356668be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 21:55:00.139453) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 21:55:00.139719) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 21:55:00.159761) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-29 21:55:00.160167) ========= /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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:00 INFO - MultiFileLogger online at 20161129 21:55:00 in /builds/slave/test 21:55:00 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 21:55:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:55:00 INFO - {'append_to_log': False, 21:55:00 INFO - 'base_work_dir': '/builds/slave/test', 21:55:00 INFO - 'blob_upload_branch': 'Firefox', 21:55:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:55:00 INFO - 'branch': 'Firefox', 21:55:00 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:00 INFO - 'config_files': ('talos/mac_config.py',), 21:55:00 INFO - 'default_actions': ('clobber', 21:55:00 INFO - 'read-buildbot-config', 21:55:00 INFO - 'download-and-extract', 21:55:00 INFO - 'populate-webroot', 21:55:00 INFO - 'create-virtualenv', 21:55:00 INFO - 'install', 21:55:00 INFO - 'run-tests'), 21:55:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:00 INFO - 'download_minidump_stackwalk': True, 21:55:00 INFO - 'download_symbols': 'ondemand', 21:55:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:00 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:00 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:00 INFO - 'installer_path': 'installer.exe', 21:55:00 INFO - 'log_level': 'info', 21:55:00 INFO - 'log_name': 'talos', 21:55:00 INFO - 'log_to_console': True, 21:55:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:55:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:55:00 INFO - 'opt_config_files': (), 21:55:00 INFO - 'pip_index': False, 21:55:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:55:00 INFO - 'cmd': ('bash', 21:55:00 INFO - '-c', 21:55:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:55:00 INFO - 'enabled': True, 21:55:00 INFO - 'halt_on_failure': False, 21:55:00 INFO - 'name': 'check_screen_resolution'},), 21:55:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:55:00 INFO - 'cmd': ('bash', 21:55:00 INFO - '-c', 21:55:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:55:00 INFO - 'enabled': True, 21:55:00 INFO - 'halt_on_failure': False, 21:55:00 INFO - 'name': 'check_screen_resolution'},), 21:55:00 INFO - 'run_cmd_checks_enabled': True, 21:55:00 INFO - 'sps_profile': False, 21:55:00 INFO - 'sps_profile_interval': 0, 21:55:00 INFO - 'suite': 'dromaeojs', 21:55:00 INFO - 'system_bits': '32', 21:55:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:00 INFO - 'title': 't-yosemite-r7-0061', 21:55:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:00 INFO - 'use_talos_json': True, 21:55:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:55:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:00 INFO - 'work_dir': 'build'} 21:55:00 INFO - [mozharness: 2016-11-30 05:55:00.352745Z] Running clobber step. 21:55:00 INFO - Running pre-action listener: _resource_record_pre_action 21:55:00 INFO - Running main action method: clobber 21:55:00 INFO - rmtree: /builds/slave/test/build 21:55:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:55:02 INFO - Running post-action listener: _resource_record_post_action 21:55:02 INFO - [mozharness: 2016-11-30 05:55:02.861709Z] Finished clobber step (success) 21:55:02 INFO - [mozharness: 2016-11-30 05:55:02.861843Z] Running read-buildbot-config step. 21:55:02 INFO - Running pre-action listener: _resource_record_pre_action 21:55:02 INFO - Running main action method: read_buildbot_config 21:55:02 INFO - Using buildbot properties: 21:55:02 INFO - { 21:55:02 INFO - "project": "", 21:55:02 INFO - "product": "firefox", 21:55:02 INFO - "script_repo_revision": "production", 21:55:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:55:02 INFO - "repository": "", 21:55:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:55:02 INFO - "buildid": "20161129192900", 21:55:02 INFO - "pgo_build": "False", 21:55:02 INFO - "basedir": "/builds/slave/test", 21:55:02 INFO - "buildnumber": 2, 21:55:02 INFO - "slavename": "t-yosemite-r7-0061", 21:55:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:55:02 INFO - "platform": "yosemite_r7", 21:55:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:55:02 INFO - "branch": "mozilla-central", 21:55:02 INFO - "repo_path": "mozilla-central", 21:55:02 INFO - "revision": "a69583d2dbc6fdc18f63761a89cf539c356668be", 21:55:02 INFO - "stage_platform": "macosx64", 21:55:02 INFO - "builduid": "5f69be5de11a41faad5048a5ee33a52c", 21:55:02 INFO - "slavebuilddir": "test" 21:55:02 INFO - } 21:55:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:55:02 INFO - Running post-action listener: _resource_record_post_action 21:55:02 INFO - [mozharness: 2016-11-30 05:55:02.865091Z] Finished read-buildbot-config step (success) 21:55:02 INFO - [mozharness: 2016-11-30 05:55:02.865178Z] Running download-and-extract step. 21:55:02 INFO - Running pre-action listener: _resource_record_pre_action 21:55:02 INFO - Running main action method: download_and_extract 21:55:02 INFO - mkdir: /builds/slave/test/build/tests 21:55:02 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')]} 21:55:02 INFO - trying https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:55:02 INFO - Downloading https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:55:03 INFO - Downloaded 1199 bytes. 21:55:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:55:03 INFO - Using the following test package requirements: 21:55:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:55:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:55:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:55:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'jsshell-mac.zip'], 21:55:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:55:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:55:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:55:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:55:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:55:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:55:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:55:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:55:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:55:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:55:03 INFO - Fetch https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:55:04 INFO - Http code: 200 21:55:04 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 21:55:04 INFO - x-amz-cf-id: 03nMfAuXS8mke4gyjwh83xYvEqtM23iwN8bajpd3e74N0NHKj3aupg== 21:55:04 INFO - x-amz-version-id: celKo_KgzVBJeA.12Mv8SSBtfD4ZqQvG 21:55:05 INFO - Expected file size: 16286729 21:55:05 INFO - Obtained file size: 16286729 21:55:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:55:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:55:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:55:12 INFO - Fetch https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:55:12 INFO - Http code: 200 21:55:12 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 21:55:12 INFO - x-amz-cf-id: zMB-3CxkkPvp5oL80Xsnb5PlzjWksv1b7DMxEU1h6J9HK7INFJgQXA== 21:55:12 INFO - x-amz-version-id: celKo_KgzVBJeA.12Mv8SSBtfD4ZqQvG 21:55:12 INFO - Expected file size: 16286729 21:55:12 INFO - Obtained file size: 16286729 21:55:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:55:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:55:19 INFO - Fetch https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:55:20 INFO - Http code: 200 21:55:20 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 21:55:20 INFO - x-amz-cf-id: 6e89L6ShkjBOzNc-lSlbhg44I2IW9pDqQnyi3hJxvFCJGVd3AF0gUw== 21:55:20 INFO - x-amz-version-id: kwamtzVSxT7KXbuYmxCPERDzoh8Fyrkp 21:55:21 INFO - Expected file size: 14409702 21:55:21 INFO - Obtained file size: 14409702 21:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:22 INFO - trying https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:55:22 INFO - Downloading https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:55:25 INFO - Downloaded 107590232 bytes. 21:55:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:55:25 INFO - mkdir: /builds/slave/test/properties 21:55:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:55:25 INFO - Writing to file /builds/slave/test/properties/build_url 21:55:25 INFO - Contents: 21:55:25 INFO - build_url:https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:55:26 INFO - Running post-action listener: _resource_record_post_action 21:55:26 INFO - Running post-action listener: set_extra_try_arguments 21:55:26 INFO - [mozharness: 2016-11-30 05:55:26.246487Z] Finished download-and-extract step (success) 21:55:26 INFO - [mozharness: 2016-11-30 05:55:26.246646Z] Running populate-webroot step. 21:55:26 INFO - Running pre-action listener: _resource_record_pre_action 21:55:26 INFO - Running main action method: populate_webroot 21:55:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:55:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:55:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:55:26 INFO - '--tppagecycles', 21:55:26 INFO - '7'], 21:55:26 INFO - 'tests': ['tsvgm']}}, 21:55:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:55:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:55:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:55:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:55:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:55:26 INFO - 'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:55:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:55:26 INFO - 'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['damp', 'tps']}, 21:55:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:55:26 INFO - 'tests': ['damp', 'tps']}, 21:55:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['dromaeo_dom']}, 21:55:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:55:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['basic_compositor_video']}, 21:55:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:55:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['a11yr', 21:55:26 INFO - 'ts_paint', 21:55:26 INFO - 'tpaint', 21:55:26 INFO - 'sessionrestore', 21:55:26 INFO - 'sessionrestore_no_auto_restore', 21:55:26 INFO - 'tabpaint']}, 21:55:26 INFO - 'other-e10s': {'tests': ['a11yr', 21:55:26 INFO - 'ts_paint', 21:55:26 INFO - 'tpaint', 21:55:26 INFO - 'sessionrestore', 21:55:26 INFO - 'sessionrestore_no_auto_restore', 21:55:26 INFO - 'tabpaint']}, 21:55:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:55:26 INFO - 'ts_paint', 21:55:26 INFO - 'tpaint', 21:55:26 INFO - 'sessionrestore', 21:55:26 INFO - 'sessionrestore_no_auto_restore', 21:55:26 INFO - 'tabpaint']}, 21:55:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:55:26 INFO - 'ts_paint', 21:55:26 INFO - 'tpaint', 21:55:26 INFO - 'sessionrestore', 21:55:26 INFO - 'sessionrestore_no_auto_restore', 21:55:26 INFO - 'tabpaint']}, 21:55:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['a11yr', 21:55:26 INFO - 'ts_paint', 21:55:26 INFO - 'tpaint', 21:55:26 INFO - 'sessionrestore', 21:55:26 INFO - 'sessionrestore_no_auto_restore', 21:55:26 INFO - 'tabpaint']}, 21:55:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['a11yr', 21:55:26 INFO - 'ts_paint', 21:55:26 INFO - 'tpaint', 21:55:26 INFO - 'sessionrestore', 21:55:26 INFO - 'sessionrestore_no_auto_restore', 21:55:26 INFO - 'tabpaint']}, 21:55:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['tsvgx', 21:55:26 INFO - 'tsvgr_opacity', 21:55:26 INFO - 'tart', 21:55:26 INFO - 'tscrollx', 21:55:26 INFO - 'cart', 21:55:26 INFO - 'tsvg_static']}, 21:55:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:55:26 INFO - 'tsvgr_opacity', 21:55:26 INFO - 'tart', 21:55:26 INFO - 'tscrollx', 21:55:26 INFO - 'cart', 21:55:26 INFO - 'tsvg_static']}, 21:55:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:55:26 INFO - 'talos_options': ['--disable-e10s'], 21:55:26 INFO - 'tests': ['tp5o']}, 21:55:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:55:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:55:26 INFO - 'talos_options': ['--disable-e10s', 21:55:26 INFO - '--xperf_path', 21:55:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:26 INFO - 'tests': ['tp5n']}, 21:55:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:55:26 INFO - 'talos_options': ['--xperf_path', 21:55:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:26 INFO - 'tests': ['tp5n']}}, 21:55:26 INFO - 'talos.zip': {'path': '', 21:55:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:55:26 INFO - Running post-action listener: _resource_record_post_action 21:55:26 INFO - [mozharness: 2016-11-30 05:55:26.264992Z] Finished populate-webroot step (success) 21:55:26 INFO - [mozharness: 2016-11-30 05:55:26.265114Z] Running create-virtualenv step. 21:55:26 INFO - Running pre-action listener: _resource_record_pre_action 21:55:26 INFO - Running main action method: create_virtualenv 21:55:26 INFO - Creating virtualenv /builds/slave/test/build/venv 21:55:26 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 21:55:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:55:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:55:26 INFO - Using real prefix '/tools/python27' 21:55:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:55:27 INFO - Installing distribute.............................................................................................................................................................................................done. 21:55:30 INFO - Installing pip.................done. 21:55:30 INFO - Return code: 0 21:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:55:30 INFO - Reading from file tmpfile_stdout 21:55:30 INFO - Output received: 21:55:30 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) 21:55:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:30 INFO - 'HOME': '/Users/cltbld', 21:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:30 INFO - 'LOGNAME': 'cltbld', 21:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:30 INFO - 'MOZ_NO_REMOTE': '1', 21:55:30 INFO - 'NO_EM_RESTART': '1', 21:55:30 INFO - 'PAGER': '/bin/cat', 21:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:30 INFO - 'PWD': '/builds/slave/test', 21:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:30 INFO - 'SHELL': '/bin/bash', 21:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:30 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:30 INFO - 'USER': 'cltbld', 21:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:30 INFO - 'XPC_FLAGS': '0x0', 21:55:30 INFO - 'XPC_SERVICE_NAME': '0', 21:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:30 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 21:55:30 INFO - Cleaning up... 21:55:30 INFO - Return code: 0 21:55:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:30 INFO - 'HOME': '/Users/cltbld', 21:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:30 INFO - 'LOGNAME': 'cltbld', 21:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:30 INFO - 'MOZ_NO_REMOTE': '1', 21:55:30 INFO - 'NO_EM_RESTART': '1', 21:55:30 INFO - 'PAGER': '/bin/cat', 21:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:30 INFO - 'PWD': '/builds/slave/test', 21:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:30 INFO - 'SHELL': '/bin/bash', 21:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:30 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:30 INFO - 'USER': 'cltbld', 21:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:30 INFO - 'XPC_FLAGS': '0x0', 21:55:30 INFO - 'XPC_SERVICE_NAME': '0', 21:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:30 INFO - Downloading/unpacking psutil>=3.1.1 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:55:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:34 INFO - Installing collected packages: psutil 21:55:34 INFO - Running setup.py install for psutil 21:55:34 INFO - building 'psutil._psutil_osx' extension 21:55:34 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 21:55:35 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 21:55:35 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 21:55:35 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 21:55:35 INFO - building 'psutil._psutil_posix' extension 21:55:35 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 21:55:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:55:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:55:35 INFO - ^ 21:55:35 INFO - 1 warning generated. 21:55:35 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 21:55:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:35 INFO - Successfully installed psutil 21:55:35 INFO - Cleaning up... 21:55:35 INFO - Return code: 0 21:55:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:55: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 mozsystemmonitor==0.3 21:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:35 INFO - 'HOME': '/Users/cltbld', 21:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:35 INFO - 'LOGNAME': 'cltbld', 21:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:35 INFO - 'MOZ_NO_REMOTE': '1', 21:55:35 INFO - 'NO_EM_RESTART': '1', 21:55:35 INFO - 'PAGER': '/bin/cat', 21:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:35 INFO - 'PWD': '/builds/slave/test', 21:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:35 INFO - 'SHELL': '/bin/bash', 21:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:35 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:35 INFO - 'USER': 'cltbld', 21:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:35 INFO - 'XPC_FLAGS': '0x0', 21:55:35 INFO - 'XPC_SERVICE_NAME': '0', 21:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:55:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:55:38 INFO - Installing collected packages: mozsystemmonitor 21:55:38 INFO - Running setup.py install for mozsystemmonitor 21:55:38 INFO - Successfully installed mozsystemmonitor 21:55:38 INFO - Cleaning up... 21:55:38 INFO - Return code: 0 21:55:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:55:38 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')]} 21:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:38 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')]} 21:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:38 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 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:38 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 21:55:38 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 21:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:38 INFO - 'HOME': '/Users/cltbld', 21:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:38 INFO - 'LOGNAME': 'cltbld', 21:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:38 INFO - 'MOZ_NO_REMOTE': '1', 21:55:38 INFO - 'NO_EM_RESTART': '1', 21:55:38 INFO - 'PAGER': '/bin/cat', 21:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:38 INFO - 'PWD': '/builds/slave/test', 21:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:38 INFO - 'SHELL': '/bin/bash', 21:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:38 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:38 INFO - 'USER': 'cltbld', 21:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:38 INFO - 'XPC_FLAGS': '0x0', 21:55:38 INFO - 'XPC_SERVICE_NAME': '0', 21:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:39 INFO - Downloading/unpacking jsonschema==2.5.1 21:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:55:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:55:41 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 21:55:41 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 21:55:41 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 21:55:41 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 21:55:41 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 21:55:41 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 21:55:42 INFO - Downloading functools32-3.2.3-2.tar.gz 21:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:55:42 INFO - warning: no files found matching '*.txt' 21:55:42 INFO - no previously-included directories found matching 'build' 21:55:42 INFO - no previously-included directories found matching 'dist' 21:55:42 INFO - no previously-included directories found matching '.git*' 21:55:42 INFO - Installing collected packages: jsonschema, functools32 21:55:42 INFO - Running setup.py install for functools32 21:55:42 INFO - warning: no files found matching '*.txt' 21:55:42 INFO - no previously-included directories found matching 'build' 21:55:42 INFO - no previously-included directories found matching 'dist' 21:55:42 INFO - no previously-included directories found matching '.git*' 21:55:42 INFO - Successfully installed jsonschema functools32 21:55:42 INFO - Cleaning up... 21:55:42 INFO - Return code: 0 21:55:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:55:42 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')]} 21:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:43 INFO - 'HOME': '/Users/cltbld', 21:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:43 INFO - 'LOGNAME': 'cltbld', 21:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:43 INFO - 'MOZ_NO_REMOTE': '1', 21:55:43 INFO - 'NO_EM_RESTART': '1', 21:55:43 INFO - 'PAGER': '/bin/cat', 21:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:43 INFO - 'PWD': '/builds/slave/test', 21:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:43 INFO - 'SHELL': '/bin/bash', 21:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:43 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:43 INFO - 'USER': 'cltbld', 21:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:43 INFO - 'XPC_FLAGS': '0x0', 21:55:43 INFO - 'XPC_SERVICE_NAME': '0', 21:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:55:43 INFO - Cleaning up... 21:55:43 INFO - Return code: 0 21:55:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:44 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 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:44 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 21:55:44 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 21:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:44 INFO - 'HOME': '/Users/cltbld', 21:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:44 INFO - 'LOGNAME': 'cltbld', 21:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:44 INFO - 'MOZ_NO_REMOTE': '1', 21:55:44 INFO - 'NO_EM_RESTART': '1', 21:55:44 INFO - 'PAGER': '/bin/cat', 21:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:44 INFO - 'PWD': '/builds/slave/test', 21:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:44 INFO - 'SHELL': '/bin/bash', 21:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:44 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:44 INFO - 'USER': 'cltbld', 21:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:44 INFO - 'XPC_FLAGS': '0x0', 21:55:44 INFO - 'XPC_SERVICE_NAME': '0', 21:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:44 INFO - Downloading/unpacking blobuploader==1.2.4 21:55:44 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 21:55:44 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 21:55:44 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 21:55:44 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 21:55:44 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 21:55:44 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 21:55:47 INFO - Downloading blobuploader-1.2.4.tar.gz 21:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:55:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:55:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:48 INFO - Downloading docopt-0.6.1.tar.gz 21:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:55:48 INFO - Installing collected packages: blobuploader, requests, docopt 21:55:48 INFO - Running setup.py install for blobuploader 21:55:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:55:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:55:48 INFO - Running setup.py install for requests 21:55:49 INFO - Running setup.py install for docopt 21:55:49 INFO - Successfully installed blobuploader requests docopt 21:55:49 INFO - Cleaning up... 21:55:49 INFO - Return code: 0 21:55:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:49 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 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:49 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 21:55:49 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 21:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:49 INFO - 'HOME': '/Users/cltbld', 21:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:49 INFO - 'LOGNAME': 'cltbld', 21:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:49 INFO - 'MOZ_NO_REMOTE': '1', 21:55:49 INFO - 'NO_EM_RESTART': '1', 21:55:49 INFO - 'PAGER': '/bin/cat', 21:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:49 INFO - 'PWD': '/builds/slave/test', 21:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:49 INFO - 'SHELL': '/bin/bash', 21:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:49 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:49 INFO - 'USER': 'cltbld', 21:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:49 INFO - 'XPC_FLAGS': '0x0', 21:55:49 INFO - 'XPC_SERVICE_NAME': '0', 21:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:55:49 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ym_IzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:55:49 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-JfyShp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9fJLLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-B7bmt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wOkJac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-y3EDHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-aDwVj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Tg20Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-EMsZHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ebIEMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nrk20Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:55:50 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-E0oPsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:55:51 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-CnpQ9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:55:51 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wEdb1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:51 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-YMkTIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:55:51 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-dellAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:55:51 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-OHDf6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:55:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:55:51 INFO - Running setup.py install for manifestparser 21:55:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:55:51 INFO - Running setup.py install for mozcrash 21:55:51 INFO - Running setup.py install for mozdebug 21:55:52 INFO - Running setup.py install for mozdevice 21:55:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Running setup.py install for mozfile 21:55:52 INFO - Running setup.py install for mozhttpd 21:55:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Running setup.py install for mozinfo 21:55:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Running setup.py install for mozInstall 21:55:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:55:52 INFO - Running setup.py install for mozleak 21:55:52 INFO - Running setup.py install for mozlog 21:55:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:55:53 INFO - Running setup.py install for moznetwork 21:55:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:55:53 INFO - Running setup.py install for mozprocess 21:55:53 INFO - Running setup.py install for mozprofile 21:55:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:55:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:55:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:55:53 INFO - Running setup.py install for mozrunner 21:55:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:55:53 INFO - Running setup.py install for mozscreenshot 21:55:53 INFO - Running setup.py install for moztest 21:55:54 INFO - Running setup.py install for mozversion 21:55:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:55:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:55:54 INFO - Cleaning up... 21:55:54 INFO - Return code: 0 21:55:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:54 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 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:54 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 21:55:54 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 21:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:54 INFO - 'HOME': '/Users/cltbld', 21:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:54 INFO - 'LOGNAME': 'cltbld', 21:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:54 INFO - 'MOZ_NO_REMOTE': '1', 21:55:54 INFO - 'NO_EM_RESTART': '1', 21:55:54 INFO - 'PAGER': '/bin/cat', 21:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:54 INFO - 'PWD': '/builds/slave/test', 21:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:54 INFO - 'SHELL': '/bin/bash', 21:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:54 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:54 INFO - 'USER': 'cltbld', 21:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:54 INFO - 'XPC_FLAGS': '0x0', 21:55:54 INFO - 'XPC_SERVICE_NAME': '0', 21:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:55:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wxoBk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:55:54 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)) 21:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:55:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-CUeFXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 21:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:55:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-jPaVdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:55:54 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)) 21:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:55:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-xbgXin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 21:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:55:54 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Il3Sz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-3tdhNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-KzbTnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ceyM0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-jrClp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-kkjqfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-cLdIZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-U7QTF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-YVcn9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:55:55 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-0bUHeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 21:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nvRrZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:56 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)) 21:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:55:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-QbaXWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:55:56 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)) 21:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:55:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-iPZgbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:55:56 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)) 21:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:55:56 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)) 21:55:56 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:55:56 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:55:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:58 INFO - Downloading blessings-1.6.tar.gz 21:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:55:59 INFO - Installing collected packages: blessings 21:55:59 INFO - Running setup.py install for blessings 21:55:59 INFO - Successfully installed blessings 21:55:59 INFO - Cleaning up... 21:55:59 INFO - Return code: 0 21:55:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:55:59 INFO - Reading from file tmpfile_stdout 21:55:59 INFO - Current package versions: 21:55:59 INFO - blessings == 1.6 21:55:59 INFO - blobuploader == 1.2.4 21:55:59 INFO - docopt == 0.6.1 21:55:59 INFO - functools32 == 3.2.3-2 21:55:59 INFO - jsonschema == 2.5.1 21:55:59 INFO - manifestparser == 1.1 21:55:59 INFO - mozInstall == 1.12 21:55:59 INFO - mozcrash == 1.0 21:55:59 INFO - mozdebug == 0.1 21:55:59 INFO - mozdevice == 0.49 21:55:59 INFO - mozfile == 1.2 21:55:59 INFO - mozhttpd == 0.7 21:55:59 INFO - mozinfo == 0.9 21:55:59 INFO - mozleak == 0.1 21:55:59 INFO - mozlog == 3.4 21:55:59 INFO - moznetwork == 0.27 21:55:59 INFO - mozprocess == 0.23 21:55:59 INFO - mozprofile == 0.28 21:55:59 INFO - mozrunner == 6.13 21:55:59 INFO - mozscreenshot == 0.1 21:55:59 INFO - mozsystemmonitor == 0.3 21:55:59 INFO - moztest == 0.7 21:55:59 INFO - mozversion == 1.4 21:55:59 INFO - psutil == 3.1.1 21:55:59 INFO - requests == 1.2.3 21:55:59 INFO - wsgiref == 0.1.2 21:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:59 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 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:59 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 21:55:59 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 21:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:59 INFO - 'HOME': '/Users/cltbld', 21:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:59 INFO - 'LOGNAME': 'cltbld', 21:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:59 INFO - 'MOZ_NO_REMOTE': '1', 21:55:59 INFO - 'NO_EM_RESTART': '1', 21:55:59 INFO - 'PAGER': '/bin/cat', 21:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:59 INFO - 'PWD': '/builds/slave/test', 21:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:59 INFO - 'SHELL': '/bin/bash', 21:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:59 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:59 INFO - 'USER': 'cltbld', 21:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:59 INFO - 'XPC_FLAGS': '0x0', 21:55:59 INFO - 'XPC_SERVICE_NAME': '0', 21:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 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)) 21:55:59 INFO - Cleaning up... 21:55:59 INFO - Return code: 0 21:55:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090eb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109061570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc608cc8ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, '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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 21:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:55:59 INFO - 'HOME': '/Users/cltbld', 21:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:55:59 INFO - 'LOGNAME': 'cltbld', 21:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:59 INFO - 'MOZ_NO_REMOTE': '1', 21:55:59 INFO - 'NO_EM_RESTART': '1', 21:55:59 INFO - 'PAGER': '/bin/cat', 21:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:59 INFO - 'PWD': '/builds/slave/test', 21:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:55:59 INFO - 'SHELL': '/bin/bash', 21:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:55:59 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:55:59 INFO - 'USER': 'cltbld', 21:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:59 INFO - 'XPC_FLAGS': '0x0', 21:55:59 INFO - 'XPC_SERVICE_NAME': '0', 21:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:56:00 INFO - Cleaning up... 21:56:00 INFO - Return code: 0 21:56:00 INFO - Running post-action listener: _resource_record_post_action 21:56:00 INFO - Running post-action listener: _start_resource_monitoring 21:56:00 INFO - Starting resource monitoring. 21:56:00 INFO - [mozharness: 2016-11-30 05:56:00.149197Z] Finished create-virtualenv step (success) 21:56:00 INFO - [mozharness: 2016-11-30 05:56:00.150199Z] Running install step. 21:56:00 INFO - Running pre-action listener: _resource_record_pre_action 21:56:00 INFO - Running main action method: install 21:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:00 INFO - Reading from file tmpfile_stdout 21:56:00 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:00 INFO - Reading from file tmpfile_stdout 21:56:00 INFO - Output received: 21:56:00 INFO - Usage: mozinstall [options] installer 21:56:00 INFO - Options: 21:56:00 INFO - -h, --help show this help message and exit 21:56:00 INFO - -d DEST, --destination=DEST 21:56:00 INFO - Directory to install application into. [default: 21:56:00 INFO - "/builds/slave/test"] 21:56:00 INFO - --app=APP Application being installed. [default: firefox] 21:56:00 INFO - mkdir: /builds/slave/test/build/application 21:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:56:33 INFO - Reading from file tmpfile_stdout 21:56:33 INFO - Output received: 21:56:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:56:33 INFO - Running post-action listener: _resource_record_post_action 21:56:33 INFO - [mozharness: 2016-11-30 05:56:33.876196Z] Finished install step (success) 21:56:33 INFO - [mozharness: 2016-11-30 05:56:33.876339Z] Running run-tests step. 21:56:33 INFO - Running pre-action listener: _resource_record_pre_action 21:56:33 INFO - Running main action method: run_tests 21:56:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:56:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:56:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:56:33 INFO - 2016-11-29 21:56:33.890 screenresolution[1631:7948] starting screenresolution argv=screenresolution get 21:56:33 INFO - 2016-11-29 21:56:33.893 screenresolution[1631:7948] Display 0: 1600x1200x32@60 21:56:33 INFO - 2016-11-29 21:56:33.899 screenresolution[1632:7950] starting screenresolution argv=screenresolution list 21:56:33 INFO - Available Modes on Display 0 21:56:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:56:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:56:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:56:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:56:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:56:34 INFO - Intel Iris: 21:56:34 INFO - Chipset Model: Intel Iris 21:56:34 INFO - Type: GPU 21:56:34 INFO - Bus: Built-In 21:56:34 INFO - VRAM (Dynamic, Max): 1536 MB 21:56:34 INFO - Vendor: Intel (0x8086) 21:56:34 INFO - Device ID: 0x0a2e 21:56:34 INFO - Revision ID: 0x0009 21:56:34 INFO - Displays: 21:56:34 INFO - Display: 21:56:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:56:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:56:34 INFO - Display Serial Number: 1600x1200 60 21:56:34 INFO - Main Display: Yes 21:56:34 INFO - Mirror: Off 21:56:34 INFO - Online: Yes 21:56:34 INFO - Rotation: Supported 21:56:34 INFO - Return code: 0 21:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:56:34 INFO - Python 2.7.3 21:56:34 INFO - Return code: 0 21:56:34 INFO - grabbing minidump binary from tooltool 21:56: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')]} 21:56:34 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 0x108f01d30>, '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 0x108d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ef9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:56:34 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 21:56:34 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 21:56:34 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 21:56:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:34 INFO - Return code: 0 21:56:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:56:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:56:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:56:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:56:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:56:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 21:56:34 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 21:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yf6PpbOveY/Render', 21:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:56:34 INFO - 'HOME': '/Users/cltbld', 21:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:56:34 INFO - 'LOGNAME': 'cltbld', 21:56:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:56:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:34 INFO - 'MOZ_NO_REMOTE': '1', 21:56:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:56:34 INFO - 'NO_EM_RESTART': '1', 21:56:34 INFO - 'PAGER': '/bin/cat', 21:56:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:34 INFO - 'PWD': '/builds/slave/test', 21:56:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:56:34 INFO - 'SHELL': '/bin/bash', 21:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W0nv7LxWDZ/Listeners', 21:56:34 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 21:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:56:34 INFO - 'USER': 'cltbld', 21:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:34 INFO - 'XPC_FLAGS': '0x0', 21:56:34 INFO - 'XPC_SERVICE_NAME': '0', 21:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:56:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 21:56:34 INFO - mozversion application_buildid: 20161129192900 21:56:34 INFO - mozversion application_changeset: a69583d2dbc6fdc18f63761a89cf539c356668be 21:56:34 INFO - mozversion application_display_name: Nightly 21:56:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:34 INFO - mozversion application_name: Firefox 21:56:34 INFO - mozversion application_remotingname: firefox 21:56:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:56:34 INFO - mozversion application_vendor: Mozilla 21:56:34 INFO - mozversion application_version: 53.0a1 21:56:34 INFO - mozversion platform_buildid: 20161129192900 21:56:34 INFO - mozversion platform_changeset: a69583d2dbc6fdc18f63761a89cf539c356668be 21:56:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:56:34 INFO - mozversion platform_version: 53.0a1 21:56:34 INFO - using testdate: 1480485394 21:56:34 INFO - actual date: 1480485394 21:56:34 INFO - starting webserver on 'localhost:49238' 21:56:34 INFO - SUITE-START | Running 2 tests 21:56:34 INFO - TEST-START | dromaeo_css 21:56:34 INFO - operating with platform_type : mac_ 21:56:34 INFO - Initialising browser for dromaeo_css test... 21:56:34 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpsVtPeX/profile http://localhost:49238/getInfo.html) 21:56:37 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 21:56:37 INFO - PROCESS | 1645 | colorDepth:24 21:56:37 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 21:56:37 INFO - PROCESS | 1645 | __metrics 21:56:37 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:56:37 INFO - PROCESS | 1645 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:56:38 INFO - TEST-INFO | 1645: exit 0 21:56:38 INFO - Browser initialized. 21:56:38 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:38 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpsVtPeX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:50 INFO - PROCESS | 1647 | RSS: Main: 237432832 21:56:50 INFO - PROCESS | 1647 | 21:57:41 INFO - PROCESS | 1647 | 1480485461619 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] 21:59:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 21:59:56 INFO - PROCESS | 1647 | RSS: Main: 426147840 21:59:56 INFO - PROCESS | 1647 | 22:02:59 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 22:03:00 INFO - PROCESS | 1647 | RSS: Main: 374669312 22:03:00 INFO - PROCESS | 1647 | 22:06:02 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 22:06:03 INFO - PROCESS | 1647 | RSS: Main: 337170432 22:06:03 INFO - PROCESS | 1647 | 22:09:05 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 22:09:06 INFO - PROCESS | 1647 | RSS: Main: 336449536 22:09:06 INFO - PROCESS | 1647 | 22:12:09 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 22:12:10 INFO - PROCESS | 1647 | RSS: Main: 322859008 22:12:10 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 22:15:13 INFO - PROCESS | 1647 | RSS: Main: 452931584 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | __start_tp_report 22:15:13 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 22:15:13 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 22:15:13 INFO - PROCESS | 1647 | |i|pagename|runs| 22:15:13 INFO - PROCESS | 1647 | |0;dojo.html;3326.05207515858;3341.849616767244;3351.247236817812;3373.730101591873;3402.353552824963;5593.468620481058;5617.719114044292;5651.491365777079;5747.33905600856;5775.537956963443;5671.744771485282;5718.6568805871675;5798.246227990356;5815.47660710536;5874.236349274599;5074.086664400406;5107.46371630979;5145.716985565792;5171.17261238202;5238.26664267001;5319.654222475546;5338.386085600147;5344.5724342052545;5346.8395948121615;5401.3248343957;5133.435322114565;5302.469753024705;5313.760880760375;5318.627696061278;5406.621536492447;4369.847055353079;5156.303898973665;5173.534381905646;5207.270982062514;5234.162533994542;4445.2887537993765;5197.272381866542;5228.346456692913;5235.214717792362;5236.8690782730355;5706.629069110494;5747.942520574783;5755.625884317506;5764.682942438164;5797;6103.969480152571;6106.043442834731;6123.448889599913;6167.660778657172;6220.751169953196;6219.626822390671;6225.377462253784;6253.468455181315;6277.372262773686;6332.081848131995;5850.444207800295;5850.5904586678525;5867.325257595346;5884.146798714248;5888.146218798251;6127.571070025145;6263.060540918807;6287.2769631492965;6290.433860952537;6301.14934483848;6046.667433291212;6090.878182436327;6096.512279017757;6097.8475538111015;6194.81415557534;6233.781817636361;6265.310815810257;6273.027680709497;6277.403646653561;6310.7475700971445;6185.567010309235;6236.469900058455;6248.812535623939;6250.6874656267;6255.655938923312;6143.96928015357;6155.630662160284;6263.6241825490615;6267.091271765568;6269.185005949197;4115.9588404116175;4876.609871210295;4912.38595175603;4918.6065114791445;4958.206686930074;4392.780360981938;4399.23013472641;4402.3176407656865;4419.292913133948;4437.356583295404;5720.599558030898;5757.568182386254;5764.308283006066;5772.595918285764;5783.537317014629;6138.051223665364;6177.382261773787;6201.069839524108;6206.72069756853;6219.067139929047;5716.5140963017775;5732.455416735404;5737.827865164052;5758.827235182951;5771.971140144273;5396.406395296514;5403.054465468527;5403.081476149064;5405.5135037846785;5410.810621628224;6188.257409110935;6197.194364732736;6266.749330026748;6267.592606480564;6268.091126786681;5621.55027597783;6103.206583144163;6190.288116866438;6277.560570760185;6288.905666415099;6234.501239900706;6280.7487700491465;6308.211473565804;6316.210473690789;6316.273628532777;5994.220751302303;6165.075238714228;6184.103305020837;6209.875802483834;6213.782517611862;6155.138280640804;6191.752329906753;6213.130161777264;6219.720112594853;6228.532860035425;6139.43080903429;6140.556969112345;6144.969275153596;6149.86227547905;6150.138980542638;5951.375105613848;6004;6144.047672610753;6146.477549408351;6155.784547540815;5792.275965504312;5852.063669812809;5909.793157239476;5912.083627037644;5947.494462970696;6107.977837958671;6125.693326622233;6133.946794548733;6136.96768649703;6149.446549810538;5778.451047150514;5841.211436456024;5841.50347220491;5964.940350596438;5999.850003749942 22:15:13 INFO - PROCESS | 1647 | |1;ext.html;476.2332644442447;482.4813325674899;530.4191909858706;554.9084401073823;555.5833125156136;39392;40345;40565.59434405659;42428.363574546405;42435;41482;42096.57903420965;42139.789301053526;42172.945676358104;43009.569904300944;8303.66785328586;8394.496330220207;8620.568971551429;9350.438973661601;9377.906220937772;10917;11234.831477527843;11252.887471125307;11414.143939204592;11438.714032149179;11238;11312.208145429824;11318.773624527505;11326.490307936163;11376.317420954769;11217.887821121807;11279.266847654917;11297.322160670386;11297.548098076068;11301.660950171508;11074.280171788809;11139.777204455946;11157.497912593954;11168.776624467466;11172.217944743872;39183.804080979695;39558.20883582312;39575.80212098921;39587;39718.80140599279;3500.5449291592186;3535.275268569963;3536.982315088434;3804.4673745675627;3863;28340.574891376647;29619.70380296191;29762.553561696594;29843.701562984308;29945.850270748724;3189.872405103793;3196.2329041030216;3212.775105742599;3223.871045158191;3297.868085276586;350376.49623503693;355910;360179;360395.9604039575;360406.7715259959;59756.40243597596;60044;60178.398216018155;60256;60361.39638603645;53495.39513814592;61251.54993800287;63455;63609.68195159087;63630;14539.3457294422;15445.691086178214;15455.690886182214;15462.072275663497;15477.613059673598;10746.892531074745;10991.395473249047;11000.944995274973;11028;11308.773824523463;13997.160170389809;17652.91173544124;17783.55541111457;17843.910780446015;17907.030226675055;6189.442950134509;6241.438270555672;6268.780592679325;6273.215848018997;6296.811095667137;858.6822875535967;934.8831396075491;949.838527450335;980.7695191629962;1040.1626690514208;27563.72436275652;28369.71630283712;29064.85467572691;29104;30069.69930300669;876.307716903639;981.9558119884622;984.3306551544875;1044.2116202267239;1100.9870918754764;13082.738345233041;15166.924165379103;15297.770533442008;15440.768388474182;15467.690646187013;603056;603474;604941;605396;609179;57258.141127883115;57457;57546.424535754944;57557.424425755205;57955.71022144862;1165.8426112474876;1219.603628820637;1314.4545013819159;1347.7304539092024;1353.3842101843638;28823.423531529672;29952;30004;30399.361420838457;30769.538456922717;48008.03983920232;48439.75780121077;48552.271715924995;48655.75672121617;48824.51175488342;460429;462677;462781;462913;463110;24568.140115095885;25322;26039.73960260373;38707.41938870863;39034.414483782195;45354;45535.54464455313;45558.54441455543;46191.30713039375;46320;30207.848960755055;36958;36970.15149242581;38344.04139896413;38607.6139238604;37712.81143594265;37962.48150073966;37998.43002355022;38080.80959595184;38859.61140388673;35464.822675886455;35876;36320.45519317265;36467.817660911525;36779.44830827593;31862.681373185973;32844.67155328416;33239;33429;33485.497717534745;24020.39949001289;24026.15908443196;24417.872246828367;24524.386890327885;25121.87439062793 22:15:13 INFO - PROCESS | 1647 | |2;jquery.html;308.3832335329341;343.786852151666;355.1175329306671;364.38055305979833;396.6687815673914;14312.35594398252;14712.411503539859;15376.154311512862;16241;19297.61404771907;16735.66528669426;18832.90583547084;19429.514262143417;19722.90138549309;20075.096620652068;5528.115501519757;5894.204282421882;5906.350301466835;5911.3201981772;5919.49684276837;5520.834374968757;5712.857178570527;5759.452851979056;5770.711464426762;5817.767289308423;5778.133280008012;5780.797672081478;5788.652680839142;5789.565782566303;5795;4753.714777113384;5773.797917072903;5788.247527821399;5789.247397838296;5859.824205273849;5104.2343648453025;5115.769790359443;5116.283720279164;5117.897642047175;5123.026624941249;23195.072197112095;23692.881535592212;23966;24142.396440088964;24513.754862451326;2201.482651576878;2202.48241663209;2412.6984126984125;2434.0263894442187;2801.6357873476522;13785.586432406944;14609.342579583945;14876.925615371962;14949.925250373788;15479.22603869802;1778.5286898971783;1813.1115753280797;1835.9908200459047;1889.1404410993102;1913.4546654203625;98055.50972245165;117937;119002.4049879745;119275;119342.403287983;11107.666769996751;11203.831942520868;11332.660020199408;11351.489182986785;11551.249168804;13830.308484575731;14257.358418871176;14308.856911430752;14309.35607897647;14335.78496322556;7994.560299183485;8157.306628936607;8174.059983102019;8313.625886835107;8315.875261871077;8031.317338026216;8032.4778889372;8067.515949042959;8185.672573097009;8191.262786349257;4324.762138082436;4407.405000324915;4455.443069616298;4463.575960283768;4568.908621827612;1717.175755637301;1824.489143039951;1881.791545415064;1888.78278997917;1891.6973284274725;746.9514481558681;778.696308439709;895.230102112183;908.5411867007119;923.2475532441039;19820.306289279804;20580.897095514425;20683;20757.688634670492;20786.168553258;829.8050806838133;846.2679781988536;892.1301730812536;907.3693782821008;935.5696379665294;10141.391516509033;10318.948405257926;10799.730006749895;10805.297655652357;10887.510062047228;481100.5944970323;533221;542873;573248;579291.103544488;99600;99853;119020;124204.37897810634;128038.35980820036;956.6699488676395;957.7940742740205;1007.2143727892255;1010.8180527505119;1013.229945241607;17966.640667186846;18697.06514674288;18983;19172.808271917103;19270.036498175316;49749.75125124351;54885;56034.439655602924;56330;57487.137692935474;81742.59128704556;81949.59025204837;83801.58099209465;84227.57886210529;84363.5781821087;6784.728610855511;7664.11862635804;7670.232976702285;7785.688572457038;8046.959765201136;10193.337433066827;12276.140670153003;12715.618531444072;12746.745065098832;12863.163894346837;10687.89312106869;10926.726831829268;11169.776604468028;11242.775144497227;11299.491522881326;10533;10590.25260831954;10880.510377032893;11016.559337626406;11109.500072496596;10887.618933337295;11172.832407514057;11244.606438774603;11310.964026475314;11317.71705707364;6726.394624483624;7111.715531378687;7274.127104747464;7340.669669864976;7438.5536867788105;10095.798084038424;10423.478826058818;10582.947085264525;10908.34549927007;11129.888701113208 22:15:13 INFO - PROCESS | 1647 | |3;mootools.html;1463.4950941925035;1475.7048590281943;1622.5375767906148;1787.133240378417;1813.9546511337214;7909.169537198598;8346.582670866455;8347.624356903938;8352;8355.997280326354;7347.08161479815;7595.810104747384;7983.9201607983905;8180.672773089069;8197;2237.8881055947218;2278.464560828204;2280.8061314788265;2283.2921794243753;2284.977150228501;2285.3486756274465;2298.747137814839;2323.6049871521795;2325;2326.2904814031713;2184.8252139828774;2189.912403503858;2209.1605190027767;2210.18223257395;2222.1333679864865;2236.821054315651;2246.0903334149616;2266.150193677371;2270.0692715986365;2272.738635056973;2281.7261928568514;2302.3668491164894;2305.5273668897835;2306.2274138163734;2316.073570571768;7770.067591888953;7802.843943121163;7822.765317040498;8250.793730156734;8338.791530211733;4964.87587810304;5131.486851314876;5138.100832354323;5143.588512918957;5148.330717006803;3172.2386627209303;3257.6544887680834;3505.491703702974;3507.140750516114;3513.2270900401872;941.6939494664261;1027.8047171037554;1045.6183493025067;1064.4039337970762;1069.1713921710736;10625.096866766256;10683.091937185349;10788.51451684676;10792.244542882001;10797.40614266215;4315.913681726348;4504.414426124583;4525.275955847049;4645.581897629162;4658.86023419298;9338.066193380608;9342.205912497378;9355.970843207242;9360.4383736976;9365.578548965314;5000.549950504472;5016.523430274118;5017.448080711119;5026.4973502649445;5032.993401319677;4126.938095928564;4244.915101697949;4432.3794668746405;4598.011427543028;4675.4389473262745;3625.836837342326;3671.2473942841652;3754.605766394544;3767.6797472215167;3776.6034566370136;1067.514281002142;1228.4901765767286;1238.0961897814645;1238.962831115068;1253.5737849131158;833.2500749325534;846.2679781988536;885.4244740918326;892.9151730585584;929.2194556572512;5568.805091821767;5695.971520142456;5743.741531631086;5799.710014499258;5888.234529511222;878.3324673248377;889.573004957624;902.1654969153507;919.6873063158558;920.6271460058687;3628.564572251347;3644.2347107107275;3697.6117507661847;3731.253749250161;3770.20825626616;9167.670687750238;9516.23870090391;9553.570089345858;9794.461304628314;9948.204143668489;9411.10594493522;9861.161801246832;10050.949745251373;10067.597296108073;10071.093601575893;7554.546727196386;7659.080910290801;7660.348870345972;7879.645415956295;7893.565853877977;5593.804216852391;5681.715914204356;5685.545156387562;5744.080947048619;5816.156657284755;9158.313126515404;9226.815463690822;9267.44395336282;9322.953385233302;9349.53252337394;7234.421246300178;8835.249003834746;8859.734207973772;9359.906400935903;9395.389299695498;6542.705578249085;6725.19297684281;6928.896066559107;7078.787636370917;7253.274672532704;7582.810429739301;7683.039620047494;7744.341730952932;7763.650635721293;7772.222777722409;7050.788476345718;7055.611941343275;7060.823479413056;7118.394936430462;7205.279472052753;6851.07510486078;6925.653717314215;6945.482446962232;6996.790096297119;7065.505414621133;6533.41199292066;6567.474602031731;6662.833429164116;6672.899906501503;6678;4792.568668819823;4827.372441582572;4844.75776211181;4875.268709693432;4923.163062279349;4817.181079216612;4838.540338667821;4861.538153875376;4933.4819843915875;4952.851414457572 22:15:13 INFO - PROCESS | 1647 | |4;prototype.html;296.2903845290529;299.1250592018346;305.9434004709129;309.64545595293373;314.6837428384473;4890.437599676029;5096.311997880285;5126.154584349636;5144.845654630362;5199.844004679856;4393.780310984446;4812.989272252822;4984.750762461871;5046.343975283217;5066.620003499734;3777.6600105990456;3985.442038114666;3990.3216453203027;3995.9400608990886;4014.598540145991;3512.5082488451635;3657.3416784978695;3667.468217108518;3993.9800300998454;3996.840126394941;3899.6685281751083;3912.3153448146604;3923.1761330120707;3925.6663183629425;3926.646601805837;3900.1279385894786;3900.395438707005;3903.2974064668347;3920.2159568086495;3929.960700392988;3386.4920261960656;3412.8634854605784;3421.36704709627;3423.640517745626;3425.554677891883;4223.194964576154;4321.330193819963;4992.578599379298;5053;5057.393112826448;3761.586225515191;4093.9560412095025;4428.269335559628;4429.667774916894;4458.9331160032625;5368.32895888014;5381.892362152774;5386;5401.297831281908;5401.784598465353;3188.681131886816;3579.9773128182755;3727.869524566627;3731.6081811409954;3735.196932659464;5191.558717509016;5644.604877658566;5651.880544795702;5673.461021202979;5678.466813960207;3412.488126781003;3565.2156525564333;3760.8495660173835;3776.6789822864816;3815.04623844039;3111.797733147338;3288.5067239913724;3835.369967763689;3850.5186851643543;3850.9037274067814;4023.91952160961;4439.667024973075;4447.73313601185;4453.864264612503;4467;5428.457154284619;5437.592180586472;5462.317210348707;5479.506844384025;5528.208254831285;1161.4831400026908;1187.996143258962;1191.8033524468365;1217.5738491527895;1231.445849367788;718.4180813541049;842.9789255268545;844.2865778417228;848.9405741598152;849.7466237299933;4735.313379560013;4743.169945259566;4751.83368582098;4751.976240118777;4874;5216.739163041832;5234.659747116425;5238.245187862109;5239.842804715865;5243.580513558906;4540.842085268301;5090.567301779316;5139.563137133311;5162.948370516322;5169.2861247845185;2407.9036838526613;2536.9238922832346;2586.405126820842;2643.6999810164893;2793.25978615667;4650.4186976627925;4924.818043669565;5484.2596249505805;5488.588355873246;5603.719814009283;5729.682173100127;5738.225339579187;5753.367129615739;5767.307923049261;5793.913091303634;5350.2815543197885;5819.88360232793;5821.854453638693;5832.941670583325;5838.241028666246;5206.97396513015;5598.748056337393;5623.666178535862;5630.47977046187;5649.435056494318;4441;5565.074908705744;5565.805196818092;5568.387477377404;5582.692951887685;5370;5809.041508151107;5811.302643682785;5817.847396463336;5855.828834233085;3591.425371940477;3631.511080457;3646.6353364663323;3884.514435695538;3898.7270891037356;4956.975215123901;5465.808696695596;5548.529639645578;5553.722973580812;5638.633488823213;5043.949560504348;5412.539934105645;5416.079266524622;5422.620416570802;5426.647267927572;5377.542908852792;5405.486478784509;5406.134613751186;5434.701091440009;5471.835844924659;4856.834359753704;4869.41743933216;5201.843944681666;5216.40011398694;5226;4988.483119400741;5169.689818610745;5377.193420986883;5508.394076651485;5549.5837812165055;4446.844360447369;4830.565249127595;4969.552740253394;5302.681839089667;5335.09303418412 22:15:13 INFO - PROCESS | 1647 | |5;yui.html;580.3139647347667;689.23150686984;710.9004739336493;722.7867779005193;727.8524885623183;14587.416503339853;15337.539873803804;15433.3826646934;15471.071735695852;15490.457833975814;11626.186166968315;12603.243805371661;12646.873531264684;13119.409626566803;13964.092333998284;822.4900561651784;841.381584535366;844.3329769482102;844.3582877013483;847.4576271186446;648.0764910003251;672.4385138409434;786.9252421019994;832.2177153475744;834.7829564313262;872.8123453457505;876.1763941894599;885.123727509764;885.5173930208052;890.1721399098835;878.44218920985;879.992408692044;880.7842078690729;883.5802993578063;884.8584226523725;503.96976181428863;524.2843518597087;658.3613894522306;659.5745743995144;660.6366498425847;13715.862841371658;14270.928645356707;14338.283085845771;14640.34118464661;14666.706665866623;14105.36525856339;14204.644883877882;14363;14391.496297629532;14422.423103075864;11778.882211177865;11965.222260553037;12108.15242932995;12130.939345303304;12304.446299916524;3549.0024640330544;3691.686206672436;3714.8142592870518;3718.4980027696183;3770.7926064066464;110329;116535.4173229137;118367;119179.40410297894;119385.61228775463;9181.678641247525;10842.295250808673;10868.565257389615;11165.106791456665;11241.269317494336;22127.225547105772;22312.665310020362;22380.328590142322;22459.32622021342;22463.663045054338;6603.372679595527;7753.340966017951;7762.534247945141;7816.10114836801;7857.960710196527;3876.6898648108086;4238.576142385737;4295.613394794484;4325.805338759764;4501.41481607389;3439.5356626855555;3491.266833964845;3567.250877315741;3570.339487194877;3580.3018411409525;587.2864469669372;591.4617697894981;592.4283066840434;592.431265984651;603.7766026570197;588.976440942366;609.5824360313111;657.1260223902294;662.3145044878528;665.6571865489277;8679.52262625549;9262.259019278576;9329.34694571387;9433.339666223435;9442.291828112919;570.965742055478;607.1499900139839;625.252822876658;633.2780630081711;646.0438550944629;3570.910872183957;3785.9432108517844;4324.978375108104;4543.409356783597;4596.4024676791805;90965;119293;120862.79137208515;121634;121897;106847;107941;108014;108589;109387;68829;92360.53819730859;93713.5314323424;94600.52699736458;94747.52626236963;7008.579485230903;9756.902430975599;9807.55865986018;9950.502474876372;9965.40207587547;32388.514172287905;44472.33291500695;46335.53664463447;47462.050758985315;50940.74529627328;65219;67071.99392009221;69314;70313;73178.53642927005;12387.318697471726;12669.429875655433;12740.299283539494;13148.211107333591;13481.393337299649;14424.350904209126;14429.567112986628;14525.418983240974;14617;14888.62778430548;13426.664333391744;13649.931750341582;13683.86316136826;13817.447302107803;13861.840529970372;13301;13381.933090334485;13518;13551.390187441786;14117.152970821373;13143.671408214872;13197.80203296932;13428.664283392993;13522.391492382669;13881.444742210602;10740.892591073989;10833.458327083772;10894.074003709457;11037.779244415227;11345.546178153112;8886.4668119913;11167.274127181707;11354.829677554679;11443.427828608703;11915.582954596548 22:15:13 INFO - PROCESS | 1647 | __end_tp_report 22:15:13 INFO - PROCESS | 1647 | __start_cc_report 22:15:13 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2114 22:15:13 INFO - PROCESS | 1647 | __end_cc_report 22:15:13 INFO - PROCESS | 1647 | __startTimestamp1480486513945__endTimestamp 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | ------- Summary: start ------- 22:15:13 INFO - PROCESS | 1647 | Number of tests: 6 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5732.80 Median:5912.08 stddev:652.50 (11.0%) stddev-sans-first:626.59 22:15:13 INFO - PROCESS | 1647 | Values: 3326.1 3341.8 3351.2 3373.7 3402.4 5593.5 5617.7 5651.5 5747.3 5775.5 5671.7 5718.7 5798.2 5815.5 5874.2 5074.1 5107.5 5145.7 5171.2 5238.3 5319.7 5338.4 5344.6 5346.8 5401.3 5133.4 5302.5 5313.8 5318.6 5406.6 4369.8 5156.3 5173.5 5207.3 5234.2 4445.3 5197.3 5228.3 5235.2 5236.9 5706.6 5747.9 5755.6 5764.7 5797.0 6104.0 6106.0 6123.4 6167.7 6220.8 6219.6 6225.4 6253.5 6277.4 6332.1 5850.4 5850.6 5867.3 5884.1 5888.1 6127.6 6263.1 6287.3 6290.4 6301.1 6046.7 6090.9 6096.5 6097.8 6194.8 6233.8 6265.3 6273.0 6277.4 6310.7 6185.6 6236.5 6248.8 6250.7 6255.7 6144.0 6155.6 6263.6 6267.1 6269.2 4116.0 4876.6 4912.4 4918.6 4958.2 4392.8 4399.2 4402.3 4419.3 4437.4 5720.6 5757.6 5764.3 5772.6 5783.5 6138.1 6177.4 6201.1 6206.7 6219.1 5716.5 5732.5 5737.8 5758.8 5772.0 5396.4 5403.1 5403.1 5405.5 5410.8 6188.3 6197.2 6266.7 6267.6 6268.1 5621.6 6103.2 6190.3 6277.6 6288.9 6234.5 6280.7 6308.2 6316.2 6316.3 5994.2 6165.1 6184.1 6209.9 6213.8 6155.1 6191.8 6213.1 6219.7 6228.5 6139.4 6140.6 6145.0 6149.9 6150.1 5951.4 6004.0 6144.0 6146.5 6155.8 5792.3 5852.1 5909.8 5912.1 5947.5 6108.0 6125.7 6133.9 6137.0 6149.4 5778.5 5841.2 5841.5 5964.9 5999.9 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:62130.65 Median:360401.37 stddev:129452.20 (35.9%) stddev-sans-first:129732.58 22:15:13 INFO - PROCESS | 1647 | Values: 476.2 482.5 530.4 554.9 555.6 39392.0 40345.0 40565.6 42428.4 42435.0 41482.0 42096.6 42139.8 42172.9 43009.6 8303.7 8394.5 8620.6 9350.4 9377.9 10917.0 11234.8 11252.9 11414.1 11438.7 11238.0 11312.2 11318.8 11326.5 11376.3 11217.9 11279.3 11297.3 11297.5 11301.7 11074.3 11139.8 11157.5 11168.8 11172.2 39183.8 39558.2 39575.8 39587.0 39718.8 3500.5 3535.3 3537.0 3804.5 3863.0 28340.6 29619.7 29762.6 29843.7 29945.9 3189.9 3196.2 3212.8 3223.9 3297.9 350376.5 355910.0 360179.0 360396.0 360406.8 59756.4 60044.0 60178.4 60256.0 60361.4 53495.4 61251.5 63455.0 63609.7 63630.0 14539.3 15445.7 15455.7 15462.1 15477.6 10746.9 10991.4 11000.9 11028.0 11308.8 13997.2 17652.9 17783.6 17843.9 17907.0 6189.4 6241.4 6268.8 6273.2 6296.8 858.7 934.9 949.8 980.8 1040.2 27563.7 28369.7 29064.9 29104.0 30069.7 876.3 982.0 984.3 1044.2 1101.0 13082.7 15166.9 15297.8 15440.8 15467.7 603056.0 603474.0 604941.0 605396.0 609179.0 57258.1 57457.0 57546.4 57557.4 57955.7 1165.8 1219.6 1314.5 1347.7 1353.4 28823.4 29952.0 30004.0 30399.4 30769.5 48008.0 48439.8 48552.3 48655.8 48824.5 460429.0 462677.0 462781.0 462913.0 463110.0 24568.1 25322.0 26039.7 38707.4 39034.4 45354.0 45535.5 45558.5 46191.3 46320.0 30207.8 36958.0 36970.2 38344.0 38607.6 37712.8 37962.5 37998.4 38080.8 38859.6 35464.8 35876.0 36320.5 36467.8 36779.4 31862.7 32844.7 33239.0 33429.0 33485.5 24020.4 24026.2 24417.9 24524.4 25121.9 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:32959.84 Median:13277.55 stddev:90909.51 (684.7%) stddev-sans-first:91131.48 22:15:13 INFO - PROCESS | 1647 | Values: 308.4 343.8 355.1 364.4 396.7 14312.4 14712.4 15376.2 16241.0 19297.6 16735.7 18832.9 19429.5 19722.9 20075.1 5528.1 5894.2 5906.4 5911.3 5919.5 5520.8 5712.9 5759.5 5770.7 5817.8 5778.1 5780.8 5788.7 5789.6 5795.0 4753.7 5773.8 5788.2 5789.2 5859.8 5104.2 5115.8 5116.3 5117.9 5123.0 23195.1 23692.9 23966.0 24142.4 24513.8 2201.5 2202.5 2412.7 2434.0 2801.6 13785.6 14609.3 14876.9 14949.9 15479.2 1778.5 1813.1 1836.0 1889.1 1913.5 98055.5 117937.0 119002.4 119275.0 119342.4 11107.7 11203.8 11332.7 11351.5 11551.2 13830.3 14257.4 14308.9 14309.4 14335.8 7994.6 8157.3 8174.1 8313.6 8315.9 8031.3 8032.5 8067.5 8185.7 8191.3 4324.8 4407.4 4455.4 4463.6 4568.9 1717.2 1824.5 1881.8 1888.8 1891.7 747.0 778.7 895.2 908.5 923.2 19820.3 20580.9 20683.0 20757.7 20786.2 829.8 846.3 892.1 907.4 935.6 10141.4 10318.9 10799.7 10805.3 10887.5 481100.6 533221.0 542873.0 573248.0 579291.1 99600.0 99853.0 119020.0 124204.4 128038.4 956.7 957.8 1007.2 1010.8 1013.2 17966.6 18697.1 18983.0 19172.8 19270.0 49749.8 54885.0 56034.4 56330.0 57487.1 81742.6 81949.6 83801.6 84227.6 84363.6 6784.7 7664.1 7670.2 7785.7 8047.0 10193.3 12276.1 12715.6 12746.7 12863.2 10687.9 10926.7 11169.8 11242.8 11299.5 10533.0 10590.3 10880.5 11016.6 11109.5 10887.6 11172.8 11244.6 11311.0 11317.7 6726.4 7111.7 7274.1 7340.7 7438.6 10095.8 10423.5 10582.9 10908.3 11129.9 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5354.72 Median:5145.96 stddev:2909.28 (56.5%) stddev-sans-first:2902.74 22:15:13 INFO - PROCESS | 1647 | Values: 1463.5 1475.7 1622.5 1787.1 1814.0 7909.2 8346.6 8347.6 8352.0 8356.0 7347.1 7595.8 7983.9 8180.7 8197.0 2237.9 2278.5 2280.8 2283.3 2285.0 2285.3 2298.7 2323.6 2325.0 2326.3 2184.8 2189.9 2209.2 2210.2 2222.1 2236.8 2246.1 2266.2 2270.1 2272.7 2281.7 2302.4 2305.5 2306.2 2316.1 7770.1 7802.8 7822.8 8250.8 8338.8 4964.9 5131.5 5138.1 5143.6 5148.3 3172.2 3257.7 3505.5 3507.1 3513.2 941.7 1027.8 1045.6 1064.4 1069.2 10625.1 10683.1 10788.5 10792.2 10797.4 4315.9 4504.4 4525.3 4645.6 4658.9 9338.1 9342.2 9356.0 9360.4 9365.6 5000.5 5016.5 5017.4 5026.5 5033.0 4126.9 4244.9 4432.4 4598.0 4675.4 3625.8 3671.2 3754.6 3767.7 3776.6 1067.5 1228.5 1238.1 1239.0 1253.6 833.3 846.3 885.4 892.9 929.2 5568.8 5696.0 5743.7 5799.7 5888.2 878.3 889.6 902.2 919.7 920.6 3628.6 3644.2 3697.6 3731.3 3770.2 9167.7 9516.2 9553.6 9794.5 9948.2 9411.1 9861.2 10050.9 10067.6 10071.1 7554.5 7659.1 7660.3 7879.6 7893.6 5593.8 5681.7 5685.5 5744.1 5816.2 9158.3 9226.8 9267.4 9323.0 9349.5 7234.4 8835.2 8859.7 9359.9 9395.4 6542.7 6725.2 6928.9 7078.8 7253.3 7582.8 7683.0 7744.3 7763.7 7772.2 7050.8 7055.6 7060.8 7118.4 7205.3 6851.1 6925.7 6945.5 6996.8 7065.5 6533.4 6567.5 6662.8 6672.9 6678.0 4792.6 4827.4 4844.8 4875.3 4923.2 4817.2 4838.5 4861.5 4933.5 4952.9 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4391.45 Median:4986.62 stddev:1370.55 (27.5%) stddev-sans-first:1339.49 22:15:13 INFO - PROCESS | 1647 | Values: 296.3 299.1 305.9 309.6 314.7 4890.4 5096.3 5126.2 5144.8 5199.8 4393.8 4813.0 4984.8 5046.3 5066.6 3777.7 3985.4 3990.3 3995.9 4014.6 3512.5 3657.3 3667.5 3994.0 3996.8 3899.7 3912.3 3923.2 3925.7 3926.6 3900.1 3900.4 3903.3 3920.2 3930.0 3386.5 3412.9 3421.4 3423.6 3425.6 4223.2 4321.3 4992.6 5053.0 5057.4 3761.6 4094.0 4428.3 4429.7 4458.9 5368.3 5381.9 5386.0 5401.3 5401.8 3188.7 3580.0 3727.9 3731.6 3735.2 5191.6 5644.6 5651.9 5673.5 5678.5 3412.5 3565.2 3760.8 3776.7 3815.0 3111.8 3288.5 3835.4 3850.5 3850.9 4023.9 4439.7 4447.7 4453.9 4467.0 5428.5 5437.6 5462.3 5479.5 5528.2 1161.5 1188.0 1191.8 1217.6 1231.4 718.4 843.0 844.3 848.9 849.7 4735.3 4743.2 4751.8 4752.0 4874.0 5216.7 5234.7 5238.2 5239.8 5243.6 4540.8 5090.6 5139.6 5162.9 5169.3 2407.9 2536.9 2586.4 2643.7 2793.3 4650.4 4924.8 5484.3 5488.6 5603.7 5729.7 5738.2 5753.4 5767.3 5793.9 5350.3 5819.9 5821.9 5832.9 5838.2 5207.0 5598.7 5623.7 5630.5 5649.4 4441.0 5565.1 5565.8 5568.4 5582.7 5370.0 5809.0 5811.3 5817.8 5855.8 3591.4 3631.5 3646.6 3884.5 3898.7 4957.0 5465.8 5548.5 5553.7 5638.6 5043.9 5412.5 5416.1 5422.6 5426.6 5377.5 5405.5 5406.1 5434.7 5471.8 4856.8 4869.4 5201.8 5216.4 5226.0 4988.5 5169.7 5377.2 5508.4 5549.6 4446.8 4830.6 4969.6 5302.7 5335.1 22:15:13 INFO - PROCESS | 1647 | 22:15:13 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:21724.23 Median:3703.25 stddev:33221.85 (897.1%) stddev-sans-first:33277.11 22:15:13 INFO - PROCESS | 1647 | Values: 580.3 689.2 710.9 722.8 727.9 14587.4 15337.5 15433.4 15471.1 15490.5 11626.2 12603.2 12646.9 13119.4 13964.1 822.5 841.4 844.3 844.4 847.5 648.1 672.4 786.9 832.2 834.8 872.8 876.2 885.1 885.5 890.2 878.4 880.0 880.8 883.6 884.9 504.0 524.3 658.4 659.6 660.6 13715.9 14270.9 14338.3 14640.3 14666.7 14105.4 14204.6 14363.0 14391.5 14422.4 11778.9 11965.2 12108.2 12130.9 12304.4 3549.0 3691.7 3714.8 3718.5 3770.8 110329.0 116535.4 118367.0 119179.4 119385.6 9181.7 10842.3 10868.6 11165.1 11241.3 22127.2 22312.7 22380.3 22459.3 22463.7 6603.4 7753.3 7762.5 7816.1 7858.0 3876.7 4238.6 4295.6 4325.8 4501.4 3439.5 3491.3 3567.3 3570.3 3580.3 587.3 591.5 592.4 592.4 603.8 589.0 609.6 657.1 662.3 665.7 8679.5 9262.3 9329.3 9433.3 9442.3 571.0 607.1 625.3 633.3 646.0 3570.9 3785.9 4325.0 4543.4 4596.4 90965.0 119293.0 120862.8 121634.0 121897.0 106847.0 107941.0 108014.0 108589.0 109387.0 68829.0 92360.5 93713.5 94600.5 94747.5 7008.6 9756.9 9807.6 9950.5 9965.4 32388.5 44472.3 46335.5 47462.1 50940.7 65219.0 67072.0 69314.0 70313.0 73178.5 12387.3 12669.4 12740.3 13148.2 13481.4 14424.4 14429.6 14525.4 14617.0 14888.6 13426.7 13649.9 13683.9 13817.4 13861.8 13301.0 13381.9 13518.0 13551.4 14117.2 13143.7 13197.8 13428.7 13522.4 13881.4 10740.9 10833.5 10894.1 11037.8 11345.5 8886.5 11167.3 11354.8 11443.4 11915.6 22:15:13 INFO - PROCESS | 1647 | -------- Summary: end -------- 22:15:13 INFO - PROCESS | 1647 | 22:15:14 INFO - TEST-INFO | 1647: exit 0 22:15:14 INFO - TEST-OK | dromaeo_css | took 1119966ms 22:15:14 INFO - TEST-START | kraken 22:15:14 INFO - operating with platform_type : mac_ 22:15:14 INFO - Initialising browser for kraken test... 22:15:14 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpXlNpWV/profile http://localhost:49238/getInfo.html) 22:15:17 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 22:15:17 INFO - PROCESS | 1654 | colorDepth:24 22:15:17 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 22:15:17 INFO - PROCESS | 1654 | __metrics 22:15:17 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:15:17 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:15:18 INFO - TEST-INFO | 1654: exit 0 22:15:18 INFO - Browser initialized. 22:15:18 INFO - Running cycle 1/1 for kraken test... 22:15:18 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpXlNpWV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:30 INFO - PROCESS | 1655 | RSS: Main: 244527104 22:15:30 INFO - PROCESS | 1655 | 22:15:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:34 INFO - PROCESS | 1655 | RSS: Main: 295690240 22:15:34 INFO - PROCESS | 1655 | 22:15:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 22:15:37 INFO - PROCESS | 1655 | RSS: Main: 296824832 22:15:37 INFO - PROCESS | 1655 | 22:15:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 22:15:41 INFO - PROCESS | 1655 | RSS: Main: 388579328 22:15:41 INFO - PROCESS | 1655 | 22:15:43 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 22:15:44 INFO - PROCESS | 1655 | RSS: Main: 290082816 22:15:44 INFO - PROCESS | 1655 | 22:15:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:46 INFO - PROCESS | 1655 | RSS: Main: 293785600 22:15:46 INFO - PROCESS | 1655 | 22:15:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:50 INFO - PROCESS | 1655 | RSS: Main: 336723968 22:15:50 INFO - PROCESS | 1655 | 22:15:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 22:15:53 INFO - PROCESS | 1655 | RSS: Main: 339181568 22:15:53 INFO - PROCESS | 1655 | 22:15:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 22:15:57 INFO - PROCESS | 1655 | RSS: Main: 334516224 22:15:57 INFO - PROCESS | 1655 | 22:15:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:15:59 INFO - PROCESS | 1655 | RSS: Main: 311275520 22:15:59 INFO - PROCESS | 1655 | 22:16:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:01 INFO - PROCESS | 1655 | RSS: Main: 315084800 22:16:01 INFO - PROCESS | 1655 | 22:16:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:04 INFO - PROCESS | 1655 | RSS: Main: 317165568 22:16:04 INFO - PROCESS | 1655 | 22:16:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:08 INFO - PROCESS | 1655 | RSS: Main: 333660160 22:16:08 INFO - PROCESS | 1655 | 22:16:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:12 INFO - PROCESS | 1655 | RSS: Main: 327614464 22:16:12 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 22:16:14 INFO - PROCESS | 1655 | RSS: Main: 371740672 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | __start_tp_report 22:16:14 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 22:16:14 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 22:16:14 INFO - PROCESS | 1655 | |i|pagename|runs| 22:16:14 INFO - PROCESS | 1655 | |0;ai-astar;112;115;114;112;114;114;114;114;113;113 22:16:14 INFO - PROCESS | 1655 | |1;audio-beat-detection;143;115;118;180;142;125;117;113;133;113 22:16:14 INFO - PROCESS | 1655 | |2;audio-dft;185;183;191;183;184;182;183;182;182;183 22:16:14 INFO - PROCESS | 1655 | |3;audio-fft;81;60;59;85;61;61;62;60;74;58 22:16:14 INFO - PROCESS | 1655 | |4;audio-oscillator;85;73;86;70;69;69;83;68;69;83 22:16:14 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;92;87;89;86;88;85;89;85;89;85 22:16:14 INFO - PROCESS | 1655 | |6;imaging-darkroom;96;98;98;99;98;96;98;99;97;97 22:16:14 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;88;85;85;85;95;120;87;85;87 22:16:14 INFO - PROCESS | 1655 | |8;json-parse-financial;56;54;55;54;55;56;56;56;56;56 22:16:14 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;70;71;70;77;73;69;70;70;69;88 22:16:14 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;89;98;93;88;88;88;87;86;98;109 22:16:14 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;153;164;163;151;151;150;151;147;201;149 22:16:14 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;173;173;173;171;173;174;173;177;239;234 22:16:14 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;70;70;69;69;69;69;68;68;69;68 22:16:14 INFO - PROCESS | 1655 | __end_tp_report 22:16:14 INFO - PROCESS | 1655 | __start_cc_report 22:16:14 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2010 22:16:14 INFO - PROCESS | 1655 | __end_cc_report 22:16:14 INFO - PROCESS | 1655 | __startTimestamp1480486574321__endTimestamp 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | ------- Summary: start ------- 22:16:14 INFO - PROCESS | 1655 | Number of tests: 14 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:0.97 (0.9%) stddev-sans-first:0.87 22:16:14 INFO - PROCESS | 1655 | Values: 112.0 115.0 114.0 112.0 114.0 114.0 114.0 114.0 113.0 113.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:129.00 stddev:20.98 (16.3%) stddev-sans-first:21.71 22:16:14 INFO - PROCESS | 1655 | Values: 143.0 115.0 118.0 180.0 142.0 125.0 117.0 113.0 133.0 113.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:183.80 Median:183.00 stddev:2.70 (1.5%) stddev-sans-first:2.83 22:16:14 INFO - PROCESS | 1655 | Values: 185.0 183.0 191.0 183.0 184.0 182.0 183.0 182.0 182.0 183.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.50 stddev:10.00 (16.3%) stddev-sans-first:9.04 22:16:14 INFO - PROCESS | 1655 | Values: 81.0 60.0 59.0 85.0 61.0 61.0 62.0 60.0 74.0 58.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:78.00 stddev:7.69 (9.9%) stddev-sans-first:7.35 22:16:14 INFO - PROCESS | 1655 | Values: 85.0 73.0 86.0 70.0 69.0 69.0 83.0 68.0 69.0 83.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:2.32 (2.6%) stddev-sans-first:1.80 22:16:14 INFO - PROCESS | 1655 | Values: 92.0 87.0 89.0 86.0 88.0 85.0 89.0 85.0 89.0 85.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:98.00 stddev:1.07 (1.1%) stddev-sans-first:0.97 22:16:14 INFO - PROCESS | 1655 | Values: 96.0 98.0 98.0 99.0 98.0 96.0 98.0 99.0 97.0 97.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:90.30 Median:86.50 stddev:10.86 (12.6%) stddev-sans-first:11.41 22:16:14 INFO - PROCESS | 1655 | Values: 86.0 88.0 85.0 85.0 85.0 95.0 120.0 87.0 85.0 87.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:0.84 (1.5%) stddev-sans-first:0.87 22:16:14 INFO - PROCESS | 1655 | Values: 56.0 54.0 55.0 54.0 55.0 56.0 56.0 56.0 56.0 56.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:70.50 stddev:5.89 (8.4%) stddev-sans-first:6.16 22:16:14 INFO - PROCESS | 1655 | Values: 70.0 71.0 70.0 77.0 73.0 69.0 70.0 70.0 69.0 88.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:88.50 stddev:7.29 (8.2%) stddev-sans-first:7.63 22:16:14 INFO - PROCESS | 1655 | Values: 89.0 98.0 93.0 88.0 88.0 88.0 87.0 86.0 98.0 109.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:158.00 Median:152.00 stddev:16.15 (10.6%) stddev-sans-first:17.03 22:16:14 INFO - PROCESS | 1655 | Values: 153.0 164.0 163.0 151.0 151.0 150.0 151.0 147.0 201.0 149.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.00 Median:173.50 stddev:26.68 (15.4%) stddev-sans-first:27.88 22:16:14 INFO - PROCESS | 1655 | Values: 173.0 173.0 173.0 171.0 173.0 174.0 173.0 177.0 239.0 234.0 22:16:14 INFO - PROCESS | 1655 | 22:16:14 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 22:16:14 INFO - PROCESS | 1655 | Values: 70.0 70.0 69.0 69.0 69.0 69.0 68.0 68.0 69.0 68.0 22:16:14 INFO - PROCESS | 1655 | -------- Summary: end -------- 22:16:14 INFO - PROCESS | 1655 | 22:16:15 INFO - TEST-INFO | 1655: exit 0 22:16:15 INFO - TEST-OK | kraken | took 60832ms 22:16:15 INFO - SUITE-END | took 1180s 22:16:15 INFO - Completed test suite (00:19:40) 22:16:15 INFO - javascript benchmark 22:16:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.05207515858, 3341.849616767244, 3351.247236817812, 3373.730101591873, 3402.353552824963, 5593.468620481058, 5617.719114044292, 5651.491365777079, 5747.33905600856, 5775.537956963443, 5671.744771485282, 5718.6568805871675, 5798.246227990356, 5815.47660710536, 5874.236349274599, 5074.086664400406, 5107.46371630979, 5145.716985565792, 5171.17261238202, 5238.26664267001, 5319.654222475546, 5338.386085600147, 5344.5724342052545, 5346.8395948121615, 5401.3248343957, 5133.435322114565, 5302.469753024705, 5313.760880760375, 5318.627696061278, 5406.621536492447, 4369.847055353079, 5156.303898973665, 5173.534381905646, 5207.270982062514, 5234.162533994542, 4445.2887537993765, 5197.272381866542, 5228.346456692913, 5235.214717792362, 5236.8690782730355, 5706.629069110494, 5747.942520574783, 5755.625884317506, 5764.682942438164, 5797.0, 6103.969480152571, 6106.043442834731, 6123.448889599913, 6167.660778657172, 6220.751169953196, 6219.626822390671, 6225.377462253784, 6253.468455181315, 6277.372262773686, 6332.081848131995, 5850.444207800295, 5850.5904586678525, 5867.325257595346, 5884.146798714248, 5888.146218798251, 6127.571070025145, 6263.060540918807, 6287.2769631492965, 6290.433860952537, 6301.14934483848, 6046.667433291212, 6090.878182436327, 6096.512279017757, 6097.8475538111015, 6194.81415557534, 6233.781817636361, 6265.310815810257, 6273.027680709497, 6277.403646653561, 6310.7475700971445, 6185.567010309235, 6236.469900058455, 6248.812535623939, 6250.6874656267, 6255.655938923312, 6143.96928015357, 6155.630662160284, 6263.6241825490615, 6267.091271765568, 6269.185005949197, 4115.9588404116175, 4876.609871210295, 4912.38595175603, 4918.6065114791445, 4958.206686930074, 4392.780360981938, 4399.23013472641, 4402.3176407656865, 4419.292913133948, 4437.356583295404, 5720.599558030898, 5757.568182386254, 5764.308283006066, 5772.595918285764, 5783.537317014629, 6138.051223665364, 6177.382261773787, 6201.069839524108, 6206.72069756853, 6219.067139929047, 5716.5140963017775, 5732.455416735404, 5737.827865164052, 5758.827235182951, 5771.971140144273, 5396.406395296514, 5403.054465468527, 5403.081476149064, 5405.5135037846785, 5410.810621628224, 6188.257409110935, 6197.194364732736, 6266.749330026748, 6267.592606480564, 6268.091126786681, 5621.55027597783, 6103.206583144163, 6190.288116866438, 6277.560570760185, 6288.905666415099, 6234.501239900706, 6280.7487700491465, 6308.211473565804, 6316.210473690789, 6316.273628532777, 5994.220751302303, 6165.075238714228, 6184.103305020837, 6209.875802483834, 6213.782517611862, 6155.138280640804, 6191.752329906753, 6213.130161777264, 6219.720112594853, 6228.532860035425, 6139.43080903429, 6140.556969112345, 6144.969275153596, 6149.86227547905, 6150.138980542638, 5951.375105613848, 6004.0, 6144.047672610753, 6146.477549408351, 6155.784547540815, 5792.275965504312, 5852.063669812809, 5909.793157239476, 5912.083627037644, 5947.494462970696, 6107.977837958671, 6125.693326622233, 6133.946794548733, 6136.96768649703, 6149.446549810538, 5778.451047150514, 5841.211436456024, 5841.50347220491, 5964.940350596438, 5999.850003749942], "value": 5690.118577476974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.2332644442447, 482.4813325674899, 530.4191909858706, 554.9084401073823, 555.5833125156136, 39392.0, 40345.0, 40565.59434405659, 42428.363574546405, 42435.0, 41482.0, 42096.57903420965, 42139.789301053526, 42172.945676358104, 43009.569904300944, 8303.66785328586, 8394.496330220207, 8620.568971551429, 9350.438973661601, 9377.906220937772, 10917.0, 11234.831477527843, 11252.887471125307, 11414.143939204592, 11438.714032149179, 11238.0, 11312.208145429824, 11318.773624527505, 11326.490307936163, 11376.317420954769, 11217.887821121807, 11279.266847654917, 11297.322160670386, 11297.548098076068, 11301.660950171508, 11074.280171788809, 11139.777204455946, 11157.497912593954, 11168.776624467466, 11172.217944743872, 39183.804080979695, 39558.20883582312, 39575.80212098921, 39587.0, 39718.80140599279, 3500.5449291592186, 3535.275268569963, 3536.982315088434, 3804.4673745675627, 3863.0, 28340.574891376647, 29619.70380296191, 29762.553561696594, 29843.701562984308, 29945.850270748724, 3189.872405103793, 3196.2329041030216, 3212.775105742599, 3223.871045158191, 3297.868085276586, 350376.49623503693, 355910.0, 360179.0, 360395.9604039575, 360406.7715259959, 59756.40243597596, 60044.0, 60178.398216018155, 60256.0, 60361.39638603645, 53495.39513814592, 61251.54993800287, 63455.0, 63609.68195159087, 63630.0, 14539.3457294422, 15445.691086178214, 15455.690886182214, 15462.072275663497, 15477.613059673598, 10746.892531074745, 10991.395473249047, 11000.944995274973, 11028.0, 11308.773824523463, 13997.160170389809, 17652.91173544124, 17783.55541111457, 17843.910780446015, 17907.030226675055, 6189.442950134509, 6241.438270555672, 6268.780592679325, 6273.215848018997, 6296.811095667137, 858.6822875535967, 934.8831396075491, 949.838527450335, 980.7695191629962, 1040.1626690514208, 27563.72436275652, 28369.71630283712, 29064.85467572691, 29104.0, 30069.69930300669, 876.307716903639, 981.9558119884622, 984.3306551544875, 1044.2116202267239, 1100.9870918754764, 13082.738345233041, 15166.924165379103, 15297.770533442008, 15440.768388474182, 15467.690646187013, 603056.0, 603474.0, 604941.0, 605396.0, 609179.0, 57258.141127883115, 57457.0, 57546.424535754944, 57557.424425755205, 57955.71022144862, 1165.8426112474876, 1219.603628820637, 1314.4545013819159, 1347.7304539092024, 1353.3842101843638, 28823.423531529672, 29952.0, 30004.0, 30399.361420838457, 30769.538456922717, 48008.03983920232, 48439.75780121077, 48552.271715924995, 48655.75672121617, 48824.51175488342, 460429.0, 462677.0, 462781.0, 462913.0, 463110.0, 24568.140115095885, 25322.0, 26039.73960260373, 38707.41938870863, 39034.414483782195, 45354.0, 45535.54464455313, 45558.54441455543, 46191.30713039375, 46320.0, 30207.848960755055, 36958.0, 36970.15149242581, 38344.04139896413, 38607.6139238604, 37712.81143594265, 37962.48150073966, 37998.43002355022, 38080.80959595184, 38859.61140388673, 35464.822675886455, 35876.0, 36320.45519317265, 36467.817660911525, 36779.44830827593, 31862.681373185973, 32844.67155328416, 33239.0, 33429.0, 33485.497717534745, 24020.39949001289, 24026.15908443196, 24417.872246828367, 24524.386890327885, 25121.87439062793], "value": 19517.115261523275, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.3832335329341, 343.786852151666, 355.1175329306671, 364.38055305979833, 396.6687815673914, 14312.35594398252, 14712.411503539859, 15376.154311512862, 16241.0, 19297.61404771907, 16735.66528669426, 18832.90583547084, 19429.514262143417, 19722.90138549309, 20075.096620652068, 5528.115501519757, 5894.204282421882, 5906.350301466835, 5911.3201981772, 5919.49684276837, 5520.834374968757, 5712.857178570527, 5759.452851979056, 5770.711464426762, 5817.767289308423, 5778.133280008012, 5780.797672081478, 5788.652680839142, 5789.565782566303, 5795.0, 4753.714777113384, 5773.797917072903, 5788.247527821399, 5789.247397838296, 5859.824205273849, 5104.2343648453025, 5115.769790359443, 5116.283720279164, 5117.897642047175, 5123.026624941249, 23195.072197112095, 23692.881535592212, 23966.0, 24142.396440088964, 24513.754862451326, 2201.482651576878, 2202.48241663209, 2412.6984126984125, 2434.0263894442187, 2801.6357873476522, 13785.586432406944, 14609.342579583945, 14876.925615371962, 14949.925250373788, 15479.22603869802, 1778.5286898971783, 1813.1115753280797, 1835.9908200459047, 1889.1404410993102, 1913.4546654203625, 98055.50972245165, 117937.0, 119002.4049879745, 119275.0, 119342.403287983, 11107.666769996751, 11203.831942520868, 11332.660020199408, 11351.489182986785, 11551.249168804, 13830.308484575731, 14257.358418871176, 14308.856911430752, 14309.35607897647, 14335.78496322556, 7994.560299183485, 8157.306628936607, 8174.059983102019, 8313.625886835107, 8315.875261871077, 8031.317338026216, 8032.4778889372, 8067.515949042959, 8185.672573097009, 8191.262786349257, 4324.762138082436, 4407.405000324915, 4455.443069616298, 4463.575960283768, 4568.908621827612, 1717.175755637301, 1824.489143039951, 1881.791545415064, 1888.78278997917, 1891.6973284274725, 746.9514481558681, 778.696308439709, 895.230102112183, 908.5411867007119, 923.2475532441039, 19820.306289279804, 20580.897095514425, 20683.0, 20757.688634670492, 20786.168553258, 829.8050806838133, 846.2679781988536, 892.1301730812536, 907.3693782821008, 935.5696379665294, 10141.391516509033, 10318.948405257926, 10799.730006749895, 10805.297655652357, 10887.510062047228, 481100.5944970323, 533221.0, 542873.0, 573248.0, 579291.103544488, 99600.0, 99853.0, 119020.0, 124204.37897810634, 128038.35980820036, 956.6699488676395, 957.7940742740205, 1007.2143727892255, 1010.8180527505119, 1013.229945241607, 17966.640667186846, 18697.06514674288, 18983.0, 19172.808271917103, 19270.036498175316, 49749.75125124351, 54885.0, 56034.439655602924, 56330.0, 57487.137692935474, 81742.59128704556, 81949.59025204837, 83801.58099209465, 84227.57886210529, 84363.5781821087, 6784.728610855511, 7664.11862635804, 7670.232976702285, 7785.688572457038, 8046.959765201136, 10193.337433066827, 12276.140670153003, 12715.618531444072, 12746.745065098832, 12863.163894346837, 10687.89312106869, 10926.726831829268, 11169.776604468028, 11242.775144497227, 11299.491522881326, 10533.0, 10590.25260831954, 10880.510377032893, 11016.559337626406, 11109.500072496596, 10887.618933337295, 11172.832407514057, 11244.606438774603, 11310.964026475314, 11317.71705707364, 6726.394624483624, 7111.715531378687, 7274.127104747464, 7340.669669864976, 7438.5536867788105, 10095.798084038424, 10423.478826058818, 10582.947085264525, 10908.34549927007, 11129.888701113208], "value": 9307.954216020114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.4950941925035, 1475.7048590281943, 1622.5375767906148, 1787.133240378417, 1813.9546511337214, 7909.169537198598, 8346.582670866455, 8347.624356903938, 8352.0, 8355.997280326354, 7347.08161479815, 7595.810104747384, 7983.9201607983905, 8180.672773089069, 8197.0, 2237.8881055947218, 2278.464560828204, 2280.8061314788265, 2283.2921794243753, 2284.977150228501, 2285.3486756274465, 2298.747137814839, 2323.6049871521795, 2325.0, 2326.2904814031713, 2184.8252139828774, 2189.912403503858, 2209.1605190027767, 2210.18223257395, 2222.1333679864865, 2236.821054315651, 2246.0903334149616, 2266.150193677371, 2270.0692715986365, 2272.738635056973, 2281.7261928568514, 2302.3668491164894, 2305.5273668897835, 2306.2274138163734, 2316.073570571768, 7770.067591888953, 7802.843943121163, 7822.765317040498, 8250.793730156734, 8338.791530211733, 4964.87587810304, 5131.486851314876, 5138.100832354323, 5143.588512918957, 5148.330717006803, 3172.2386627209303, 3257.6544887680834, 3505.491703702974, 3507.140750516114, 3513.2270900401872, 941.6939494664261, 1027.8047171037554, 1045.6183493025067, 1064.4039337970762, 1069.1713921710736, 10625.096866766256, 10683.091937185349, 10788.51451684676, 10792.244542882001, 10797.40614266215, 4315.913681726348, 4504.414426124583, 4525.275955847049, 4645.581897629162, 4658.86023419298, 9338.066193380608, 9342.205912497378, 9355.970843207242, 9360.4383736976, 9365.578548965314, 5000.549950504472, 5016.523430274118, 5017.448080711119, 5026.4973502649445, 5032.993401319677, 4126.938095928564, 4244.915101697949, 4432.3794668746405, 4598.011427543028, 4675.4389473262745, 3625.836837342326, 3671.2473942841652, 3754.605766394544, 3767.6797472215167, 3776.6034566370136, 1067.514281002142, 1228.4901765767286, 1238.0961897814645, 1238.962831115068, 1253.5737849131158, 833.2500749325534, 846.2679781988536, 885.4244740918326, 892.9151730585584, 929.2194556572512, 5568.805091821767, 5695.971520142456, 5743.741531631086, 5799.710014499258, 5888.234529511222, 878.3324673248377, 889.573004957624, 902.1654969153507, 919.6873063158558, 920.6271460058687, 3628.564572251347, 3644.2347107107275, 3697.6117507661847, 3731.253749250161, 3770.20825626616, 9167.670687750238, 9516.23870090391, 9553.570089345858, 9794.461304628314, 9948.204143668489, 9411.10594493522, 9861.161801246832, 10050.949745251373, 10067.597296108073, 10071.093601575893, 7554.546727196386, 7659.080910290801, 7660.348870345972, 7879.645415956295, 7893.565853877977, 5593.804216852391, 5681.715914204356, 5685.545156387562, 5744.080947048619, 5816.156657284755, 9158.313126515404, 9226.815463690822, 9267.44395336282, 9322.953385233302, 9349.53252337394, 7234.421246300178, 8835.249003834746, 8859.734207973772, 9359.906400935903, 9395.389299695498, 6542.705578249085, 6725.19297684281, 6928.896066559107, 7078.787636370917, 7253.274672532704, 7582.810429739301, 7683.039620047494, 7744.341730952932, 7763.650635721293, 7772.222777722409, 7050.788476345718, 7055.611941343275, 7060.823479413056, 7118.394936430462, 7205.279472052753, 6851.07510486078, 6925.653717314215, 6945.482446962232, 6996.790096297119, 7065.505414621133, 6533.41199292066, 6567.474602031731, 6662.833429164116, 6672.899906501503, 6678.0, 4792.568668819823, 4827.372441582572, 4844.75776211181, 4875.268709693432, 4923.163062279349, 4817.181079216612, 4838.540338667821, 4861.538153875376, 4933.4819843915875, 4952.851414457572], "value": 4349.956256491394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.2903845290529, 299.1250592018346, 305.9434004709129, 309.64545595293373, 314.6837428384473, 4890.437599676029, 5096.311997880285, 5126.154584349636, 5144.845654630362, 5199.844004679856, 4393.780310984446, 4812.989272252822, 4984.750762461871, 5046.343975283217, 5066.620003499734, 3777.6600105990456, 3985.442038114666, 3990.3216453203027, 3995.9400608990886, 4014.598540145991, 3512.5082488451635, 3657.3416784978695, 3667.468217108518, 3993.9800300998454, 3996.840126394941, 3899.6685281751083, 3912.3153448146604, 3923.1761330120707, 3925.6663183629425, 3926.646601805837, 3900.1279385894786, 3900.395438707005, 3903.2974064668347, 3920.2159568086495, 3929.960700392988, 3386.4920261960656, 3412.8634854605784, 3421.36704709627, 3423.640517745626, 3425.554677891883, 4223.194964576154, 4321.330193819963, 4992.578599379298, 5053.0, 5057.393112826448, 3761.586225515191, 4093.9560412095025, 4428.269335559628, 4429.667774916894, 4458.9331160032625, 5368.32895888014, 5381.892362152774, 5386.0, 5401.297831281908, 5401.784598465353, 3188.681131886816, 3579.9773128182755, 3727.869524566627, 3731.6081811409954, 3735.196932659464, 5191.558717509016, 5644.604877658566, 5651.880544795702, 5673.461021202979, 5678.466813960207, 3412.488126781003, 3565.2156525564333, 3760.8495660173835, 3776.6789822864816, 3815.04623844039, 3111.797733147338, 3288.5067239913724, 3835.369967763689, 3850.5186851643543, 3850.9037274067814, 4023.91952160961, 4439.667024973075, 4447.73313601185, 4453.864264612503, 4467.0, 5428.457154284619, 5437.592180586472, 5462.317210348707, 5479.506844384025, 5528.208254831285, 1161.4831400026908, 1187.996143258962, 1191.8033524468365, 1217.5738491527895, 1231.445849367788, 718.4180813541049, 842.9789255268545, 844.2865778417228, 848.9405741598152, 849.7466237299933, 4735.313379560013, 4743.169945259566, 4751.83368582098, 4751.976240118777, 4874.0, 5216.739163041832, 5234.659747116425, 5238.245187862109, 5239.842804715865, 5243.580513558906, 4540.842085268301, 5090.567301779316, 5139.563137133311, 5162.948370516322, 5169.2861247845185, 2407.9036838526613, 2536.9238922832346, 2586.405126820842, 2643.6999810164893, 2793.25978615667, 4650.4186976627925, 4924.818043669565, 5484.2596249505805, 5488.588355873246, 5603.719814009283, 5729.682173100127, 5738.225339579187, 5753.367129615739, 5767.307923049261, 5793.913091303634, 5350.2815543197885, 5819.88360232793, 5821.854453638693, 5832.941670583325, 5838.241028666246, 5206.97396513015, 5598.748056337393, 5623.666178535862, 5630.47977046187, 5649.435056494318, 4441.0, 5565.074908705744, 5565.805196818092, 5568.387477377404, 5582.692951887685, 5370.0, 5809.041508151107, 5811.302643682785, 5817.847396463336, 5855.828834233085, 3591.425371940477, 3631.511080457, 3646.6353364663323, 3884.514435695538, 3898.7270891037356, 4956.975215123901, 5465.808696695596, 5548.529639645578, 5553.722973580812, 5638.633488823213, 5043.949560504348, 5412.539934105645, 5416.079266524622, 5422.620416570802, 5426.647267927572, 5377.542908852792, 5405.486478784509, 5406.134613751186, 5434.701091440009, 5471.835844924659, 4856.834359753704, 4869.41743933216, 5201.843944681666, 5216.40011398694, 5226.0, 4988.483119400741, 5169.689818610745, 5377.193420986883, 5508.394076651485, 5549.5837812165055, 4446.844360447369, 4830.565249127595, 4969.552740253394, 5302.681839089667, 5335.09303418412], "value": 3948.240582249195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.3139647347667, 689.23150686984, 710.9004739336493, 722.7867779005193, 727.8524885623183, 14587.416503339853, 15337.539873803804, 15433.3826646934, 15471.071735695852, 15490.457833975814, 11626.186166968315, 12603.243805371661, 12646.873531264684, 13119.409626566803, 13964.092333998284, 822.4900561651784, 841.381584535366, 844.3329769482102, 844.3582877013483, 847.4576271186446, 648.0764910003251, 672.4385138409434, 786.9252421019994, 832.2177153475744, 834.7829564313262, 872.8123453457505, 876.1763941894599, 885.123727509764, 885.5173930208052, 890.1721399098835, 878.44218920985, 879.992408692044, 880.7842078690729, 883.5802993578063, 884.8584226523725, 503.96976181428863, 524.2843518597087, 658.3613894522306, 659.5745743995144, 660.6366498425847, 13715.862841371658, 14270.928645356707, 14338.283085845771, 14640.34118464661, 14666.706665866623, 14105.36525856339, 14204.644883877882, 14363.0, 14391.496297629532, 14422.423103075864, 11778.882211177865, 11965.222260553037, 12108.15242932995, 12130.939345303304, 12304.446299916524, 3549.0024640330544, 3691.686206672436, 3714.8142592870518, 3718.4980027696183, 3770.7926064066464, 110329.0, 116535.4173229137, 118367.0, 119179.40410297894, 119385.61228775463, 9181.678641247525, 10842.295250808673, 10868.565257389615, 11165.106791456665, 11241.269317494336, 22127.225547105772, 22312.665310020362, 22380.328590142322, 22459.32622021342, 22463.663045054338, 6603.372679595527, 7753.340966017951, 7762.534247945141, 7816.10114836801, 7857.960710196527, 3876.6898648108086, 4238.576142385737, 4295.613394794484, 4325.805338759764, 4501.41481607389, 3439.5356626855555, 3491.266833964845, 3567.250877315741, 3570.339487194877, 3580.3018411409525, 587.2864469669372, 591.4617697894981, 592.4283066840434, 592.431265984651, 603.7766026570197, 588.976440942366, 609.5824360313111, 657.1260223902294, 662.3145044878528, 665.6571865489277, 8679.52262625549, 9262.259019278576, 9329.34694571387, 9433.339666223435, 9442.291828112919, 570.965742055478, 607.1499900139839, 625.252822876658, 633.2780630081711, 646.0438550944629, 3570.910872183957, 3785.9432108517844, 4324.978375108104, 4543.409356783597, 4596.4024676791805, 90965.0, 119293.0, 120862.79137208515, 121634.0, 121897.0, 106847.0, 107941.0, 108014.0, 108589.0, 109387.0, 68829.0, 92360.53819730859, 93713.5314323424, 94600.52699736458, 94747.52626236963, 7008.579485230903, 9756.902430975599, 9807.55865986018, 9950.502474876372, 9965.40207587547, 32388.514172287905, 44472.33291500695, 46335.53664463447, 47462.050758985315, 50940.74529627328, 65219.0, 67071.99392009221, 69314.0, 70313.0, 73178.53642927005, 12387.318697471726, 12669.429875655433, 12740.299283539494, 13148.211107333591, 13481.393337299649, 14424.350904209126, 14429.567112986628, 14525.418983240974, 14617.0, 14888.62778430548, 13426.664333391744, 13649.931750341582, 13683.86316136826, 13817.447302107803, 13861.840529970372, 13301.0, 13381.933090334485, 13518.0, 13551.390187441786, 14117.152970821373, 13143.671408214872, 13197.80203296932, 13428.664283392993, 13522.391492382669, 13881.444742210602, 10740.892591073989, 10833.458327083772, 10894.074003709457, 11037.779244415227, 11345.546178153112, 8886.4668119913, 11167.274127181707, 11354.829677554679, 11443.427828608703, 11915.582954596548], "value": 7385.508032924068, "unit": "score"}], "name": "dromaeo_css", "value": 7127.732442495775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 112.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 118.0, 180.0, 142.0, 125.0, 117.0, 113.0, 133.0, 113.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 191.0, 183.0, 184.0, 182.0, 183.0, 182.0, 182.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 85.0, 61.0, 61.0, 62.0, 60.0, 74.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 86.0, 70.0, 69.0, 69.0, 83.0, 68.0, 69.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 89.0, 86.0, 88.0, 85.0, 89.0, 85.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 98.0, 99.0, 98.0, 96.0, 98.0, 99.0, 97.0, 97.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 85.0, 85.0, 85.0, 95.0, 120.0, 87.0, 85.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 77.0, 73.0, 69.0, 70.0, 70.0, 69.0, 88.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 98.0, 93.0, 88.0, 88.0, 88.0, 87.0, 86.0, 98.0, 109.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 164.0, 163.0, 151.0, 151.0, 150.0, 151.0, 147.0, 201.0, 149.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 173.0, 171.0, 173.0, 174.0, 173.0, 177.0, 239.0, 234.0], "value": 186.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1477.6000000000001, "alertThreshold": 2.0}]} 22:16:15 INFO - Return code: 0 22:16:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:16:15 INFO - # TBPL SUCCESS # 22:16:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:16:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:16:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:16:15 INFO - 2016-11-29 22:16:15.633 screenresolution[1659:10394] starting screenresolution argv=screenresolution get 22:16:15 INFO - 2016-11-29 22:16:15.636 screenresolution[1659:10394] Display 0: 1600x1200x32@60 22:16:15 INFO - 2016-11-29 22:16:15.642 screenresolution[1660:10397] starting screenresolution argv=screenresolution list 22:16:15 INFO - Available Modes on Display 0 22:16:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:16:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:16:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:16:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:16:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:16:15 INFO - Intel Iris: 22:16:15 INFO - Chipset Model: Intel Iris 22:16:15 INFO - Type: GPU 22:16:15 INFO - Bus: Built-In 22:16:15 INFO - VRAM (Dynamic, Max): 1536 MB 22:16:15 INFO - Vendor: Intel (0x8086) 22:16:15 INFO - Device ID: 0x0a2e 22:16:15 INFO - Revision ID: 0x0009 22:16:15 INFO - Displays: 22:16:15 INFO - Display: 22:16:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:16:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:16:15 INFO - Display Serial Number: 1600x1200 60 22:16:15 INFO - Main Display: Yes 22:16:15 INFO - Mirror: Off 22:16:15 INFO - Online: Yes 22:16:15 INFO - Rotation: Supported 22:16:15 INFO - Return code: 0 22:16:15 INFO - Running post-action listener: _resource_record_post_action 22:16:15 INFO - [mozharness: 2016-11-30 06:16:15.886697Z] Finished run-tests step (success) 22:16:15 INFO - Running post-run listener: _resource_record_post_run 22:16:15 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37942272; Write bytes: 696753152; Read time: 372; Write time: 1973 22:16:15 INFO - TinderboxPrint: CPU usage
53.7% 22:16:15 INFO - TinderboxPrint: I/O read bytes / time
37,942,272 / 372 22:16:15 INFO - TinderboxPrint: I/O write bytes / time
696,753,152 / 1,973 22:16:15 INFO - TinderboxPrint: CPU idle
2,249.0 (46.3%) 22:16:15 INFO - TinderboxPrint: CPU system
976.9 (20.1%) 22:16:15 INFO - TinderboxPrint: CPU user
1,635.7 (33.6%) 22:16:15 INFO - TinderboxPrint: Swap in / out
421,285,888 / 0 22:16:15 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 368302592; Write bytes: 368824320; Read time: 29067; Write time: 690 22:16:15 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 36983808; Write bytes: 309455872; Read time: 357; Write time: 1243 22:16:16 INFO - Running post-run listener: _upload_blobber_files 22:16:16 INFO - Blob upload gear active. 22:16:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:16 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 22:16:16 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'] 22:16:16 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 22:16:16 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:17 INFO - (blobuploader) - INFO - Done attempting. 22:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:18 INFO - (blobuploader) - INFO - Done attempting. 22:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:21 INFO - (blobuploader) - INFO - Done attempting. 22:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:21 INFO - Return code: 0 22:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d95240f28d55aa8381189a1ed3d3b737f227802a56a791eb46ce761588763e95d3d06a99a076dbde127d705aba72b200179cc7825036a2da94d9d5e5a13764d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb9bdfd8068c0dae80b4604dde42a8b5ae5a6ae6b8701536f2a6998120c62dde72c8492b7f68d203df4d1e0fafdd9dd05603cdee1fd5d64f040eee959547ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3d45c6a2827bb85ea97dd336fba2e0ae1e51229b33dbd5875b0d930c2abe9320cfe4db291b32d877dff443062708a6bf9042ac92a1999f33fb4f40ef16b273"} 22:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:21 INFO - Contents: 22:16:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d95240f28d55aa8381189a1ed3d3b737f227802a56a791eb46ce761588763e95d3d06a99a076dbde127d705aba72b200179cc7825036a2da94d9d5e5a13764d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb9bdfd8068c0dae80b4604dde42a8b5ae5a6ae6b8701536f2a6998120c62dde72c8492b7f68d203df4d1e0fafdd9dd05603cdee1fd5d64f040eee959547ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3d45c6a2827bb85ea97dd336fba2e0ae1e51229b33dbd5875b0d930c2abe9320cfe4db291b32d877dff443062708a6bf9042ac92a1999f33fb4f40ef16b273"} 22:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:21 INFO - Copying logs to upload dir... 22:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.171904 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-11-29 22:16:21.371745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 22:16:21.375607) ========= 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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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/3d95240f28d55aa8381189a1ed3d3b737f227802a56a791eb46ce761588763e95d3d06a99a076dbde127d705aba72b200179cc7825036a2da94d9d5e5a13764d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb9bdfd8068c0dae80b4604dde42a8b5ae5a6ae6b8701536f2a6998120c62dde72c8492b7f68d203df4d1e0fafdd9dd05603cdee1fd5d64f040eee959547ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3d45c6a2827bb85ea97dd336fba2e0ae1e51229b33dbd5875b0d930c2abe9320cfe4db291b32d877dff443062708a6bf9042ac92a1999f33fb4f40ef16b273"} build_url:https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011046 build_url: 'https://queue.taskcluster.net/v1/task/d_vSb0R7THiN-2NHuTgisg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d95240f28d55aa8381189a1ed3d3b737f227802a56a791eb46ce761588763e95d3d06a99a076dbde127d705aba72b200179cc7825036a2da94d9d5e5a13764d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cb9bdfd8068c0dae80b4604dde42a8b5ae5a6ae6b8701536f2a6998120c62dde72c8492b7f68d203df4d1e0fafdd9dd05603cdee1fd5d64f040eee959547ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3d45c6a2827bb85ea97dd336fba2e0ae1e51229b33dbd5875b0d930c2abe9320cfe4db291b32d877dff443062708a6bf9042ac92a1999f33fb4f40ef16b273"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 22:16:21.410217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:16:21.410583) ========= 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.yf6PpbOveY/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.W0nv7LxWDZ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.004443 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 22:16:21.459452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 22:16:21.459811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 22:16:21.460219) ========= ========= Total master_lag: 0.18 =========