builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0279 starttime: 1476432824.49 results: success (0) buildid: 20161013231535 builduid: eee2eada98b54c85a6a447c90368224e revision: b2f3dd7eec5d028034173a33e4e0ab7da805d8cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:44.486727) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:44.491479) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:44.491792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:44.525697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:44.526045) ========= 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.NpCMQ1DshN/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.jLbp0PifQP/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-14 01:13:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2016-10-14 01:13:45 (14.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.603246 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:45.150485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:45.150825) ========= 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.NpCMQ1DshN/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.jLbp0PifQP/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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.020511 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:45.199380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 01:13:45.199688) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b2f3dd7eec5d028034173a33e4e0ab7da805d8cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b2f3dd7eec5d028034173a33e4e0ab7da805d8cd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NpCMQ1DshN/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.jLbp0PifQP/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-14 01:13:45,281 truncating revision to first 12 chars 2016-10-14 01:13:45,281 Setting DEBUG logging. 2016-10-14 01:13:45,281 attempt 1/10 2016-10-14 01:13:45,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b2f3dd7eec5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 01:13:47,341 unpacking tar archive at: autoland-b2f3dd7eec5d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.336149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 01:13:47.557243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:47.557560) ========= script_repo_revision: b2f3dd7eec5d028034173a33e4e0ab7da805d8cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:47.558010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:47.558278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 01:13:47.576578) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-14 01:13:47.576843) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NpCMQ1DshN/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.jLbp0PifQP/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:13:47 INFO - MultiFileLogger online at 20161014 01:13:47 in /builds/slave/test 01:13:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 01:13:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:13:47 INFO - {'append_to_log': False, 01:13:47 INFO - 'base_work_dir': '/builds/slave/test', 01:13:47 INFO - 'blob_upload_branch': 'Autoland', 01:13:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:13:47 INFO - 'branch': 'Autoland', 01:13:47 INFO - 'buildbot_json_path': 'buildprops.json', 01:13:47 INFO - 'config_files': ('talos/mac_config.py',), 01:13:47 INFO - 'default_actions': ('clobber', 01:13:47 INFO - 'read-buildbot-config', 01:13:47 INFO - 'download-and-extract', 01:13:47 INFO - 'populate-webroot', 01:13:47 INFO - 'create-virtualenv', 01:13:47 INFO - 'install', 01:13:47 INFO - 'run-tests'), 01:13:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:13:47 INFO - 'download_minidump_stackwalk': True, 01:13:47 INFO - 'download_symbols': 'ondemand', 01:13:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:13:47 INFO - 'tooltool.py': '/tools/tooltool.py', 01:13:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:13:47 INFO - '/tools/misc-python/virtualenv.py')}, 01:13:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:13:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:13:47 INFO - 'installer_path': 'installer.exe', 01:13:47 INFO - 'log_level': 'info', 01:13:47 INFO - 'log_name': 'talos', 01:13:47 INFO - 'log_to_console': True, 01:13:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:13:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:13:47 INFO - 'opt_config_files': (), 01:13:47 INFO - 'pip_index': False, 01:13:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:13:47 INFO - 'cmd': ('bash', 01:13:47 INFO - '-c', 01:13:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:13:47 INFO - 'enabled': True, 01:13:47 INFO - 'halt_on_failure': False, 01:13:47 INFO - 'name': 'check_screen_resolution'},), 01:13:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:13:47 INFO - 'cmd': ('bash', 01:13:47 INFO - '-c', 01:13:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:13:47 INFO - 'enabled': True, 01:13:47 INFO - 'halt_on_failure': False, 01:13:47 INFO - 'name': 'check_screen_resolution'},), 01:13:47 INFO - 'run_cmd_checks_enabled': True, 01:13:47 INFO - 'sps_profile': False, 01:13:47 INFO - 'sps_profile_interval': 0, 01:13:47 INFO - 'suite': 'dromaeojs', 01:13:47 INFO - 'system_bits': '32', 01:13:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:13:47 INFO - 'title': 't-yosemite-r7-0279', 01:13:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:13:47 INFO - 'use_talos_json': True, 01:13:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:13:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:13:47 INFO - 'work_dir': 'build'} 01:13:47 INFO - [mozharness: 2016-10-14 08:13:47.775063Z] Running clobber step. 01:13:47 INFO - Running pre-action listener: _resource_record_pre_action 01:13:47 INFO - Running main action method: clobber 01:13:47 INFO - rmtree: /builds/slave/test/build 01:13:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:13:47 INFO - Running post-action listener: _resource_record_post_action 01:13:47 INFO - [mozharness: 2016-10-14 08:13:47.963288Z] Finished clobber step (success) 01:13:47 INFO - [mozharness: 2016-10-14 08:13:47.963440Z] Running read-buildbot-config step. 01:13:47 INFO - Running pre-action listener: _resource_record_pre_action 01:13:47 INFO - Running main action method: read_buildbot_config 01:13:47 INFO - Using buildbot properties: 01:13:47 INFO - { 01:13:47 INFO - "project": "", 01:13:47 INFO - "product": "firefox", 01:13:47 INFO - "script_repo_revision": "production", 01:13:47 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 01:13:47 INFO - "repository": "", 01:13:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 01:13:47 INFO - "buildid": "20161013231535", 01:13:47 INFO - "pgo_build": "False", 01:13:47 INFO - "basedir": "/builds/slave/test", 01:13:47 INFO - "buildnumber": 239, 01:13:47 INFO - "slavename": "t-yosemite-r7-0279", 01:13:47 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:13:47 INFO - "platform": "yosemite_r7", 01:13:47 INFO - "scheduler": "tests-autoland-macosx64-talos", 01:13:47 INFO - "branch": "autoland", 01:13:47 INFO - "repo_path": "integration/autoland", 01:13:47 INFO - "revision": "b2f3dd7eec5d028034173a33e4e0ab7da805d8cd", 01:13:47 INFO - "stage_platform": "macosx64", 01:13:47 INFO - "builduid": "eee2eada98b54c85a6a447c90368224e", 01:13:47 INFO - "slavebuilddir": "test" 01:13:47 INFO - } 01:13:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 01:13:47 INFO - Running post-action listener: _resource_record_post_action 01:13:47 INFO - [mozharness: 2016-10-14 08:13:47.966832Z] Finished read-buildbot-config step (success) 01:13:47 INFO - [mozharness: 2016-10-14 08:13:47.966969Z] Running download-and-extract step. 01:13:47 INFO - Running pre-action listener: _resource_record_pre_action 01:13:47 INFO - Running main action method: download_and_extract 01:13:47 INFO - mkdir: /builds/slave/test/build/tests 01:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:47 INFO - trying https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 01:13:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 01:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 01:13:49 INFO - Downloaded 1199 bytes. 01:13:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 01:13:49 INFO - Using the following test package requirements: 01:13:49 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 01:13:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 01:13:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 01:13:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'jsshell-mac.zip'], 01:13:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 01:13:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 01:13:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 01:13:49 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 01:13:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 01:13:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 01:13:49 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 01:13:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:13:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 01:13:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:13:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 01:13:50 INFO - Http code: 200 01:13:50 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 01:13:50 INFO - x-amz-cf-id: uBMK8RpfKTHDXlZLBgUOrny0FhR9iMx7yn0i2f-G060yCfzH9SKS0g== 01:13:50 INFO - x-amz-version-id: B1YKPG7Ph8gv9Bw4hAmrubPH1L.IJa7j 01:13:51 INFO - Expected file size: 16515219 01:13:51 INFO - Obtained file size: 16515219 01:13:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:13:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 01:13:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:13:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 01:13:59 INFO - Http code: 200 01:13:59 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 01:13:59 INFO - x-amz-cf-id: UADok9mjxhGtOGI9JBEPqskuk-UeXL2M5ZyQpiOuglI5feaesJa0mw== 01:13:59 INFO - x-amz-version-id: B1YKPG7Ph8gv9Bw4hAmrubPH1L.IJa7j 01:13:59 INFO - Expected file size: 16515219 01:13:59 INFO - Obtained file size: 16515219 01:14:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 01:14:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:14:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 01:14:06 INFO - Http code: 200 01:14:06 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 01:14:06 INFO - x-amz-cf-id: FV-uQtE9CkwM4cQ3__0WXsb4PkjxqrpeNf2m9EIy_jfifhSUTkm6pg== 01:14:06 INFO - x-amz-version-id: SS1EBApKLXz4AANPuztk0Pv45F4VUibo 01:14:07 INFO - Expected file size: 14409006 01:14:07 INFO - Obtained file size: 14409006 01:14:07 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')]} 01:14:07 INFO - trying https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 01:14:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 01:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 01:14:10 INFO - Downloaded 111488919 bytes. 01:14:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 01:14:10 INFO - mkdir: /builds/slave/test/properties 01:14:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:14:10 INFO - Writing to file /builds/slave/test/properties/build_url 01:14:10 INFO - Contents: 01:14:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 01:14:10 INFO - Running post-action listener: _resource_record_post_action 01:14:10 INFO - Running post-action listener: set_extra_try_arguments 01:14:10 INFO - [mozharness: 2016-10-14 08:14:10.878975Z] Finished download-and-extract step (success) 01:14:10 INFO - [mozharness: 2016-10-14 08:14:10.879099Z] Running populate-webroot step. 01:14:10 INFO - Running pre-action listener: _resource_record_pre_action 01:14:10 INFO - Running main action method: populate_webroot 01:14:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:14:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:14:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:14:10 INFO - '--tppagecycles', 01:14:10 INFO - '7'], 01:14:10 INFO - 'tests': ['tsvgm']}}, 01:14:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:14:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:14:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:14:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:14:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['damp', 'tps']}, 01:14:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'tests': ['damp', 'tps']}, 01:14:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['dromaeo_dom']}, 01:14:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:14:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['basic_compositor_video']}, 01:14:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:14:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['a11yr', 01:14:10 INFO - 'ts_paint', 01:14:10 INFO - 'tpaint', 01:14:10 INFO - 'sessionrestore', 01:14:10 INFO - 'sessionrestore_no_auto_restore', 01:14:10 INFO - 'tabpaint']}, 01:14:10 INFO - 'other-e10s': {'tests': ['a11yr', 01:14:10 INFO - 'ts_paint', 01:14:10 INFO - 'tpaint', 01:14:10 INFO - 'sessionrestore', 01:14:10 INFO - 'sessionrestore_no_auto_restore', 01:14:10 INFO - 'tabpaint']}, 01:14:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:14:10 INFO - 'ts_paint', 01:14:10 INFO - 'tpaint', 01:14:10 INFO - 'sessionrestore', 01:14:10 INFO - 'sessionrestore_no_auto_restore', 01:14:10 INFO - 'tabpaint']}, 01:14:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:14:10 INFO - 'ts_paint', 01:14:10 INFO - 'tpaint', 01:14:10 INFO - 'sessionrestore', 01:14:10 INFO - 'sessionrestore_no_auto_restore', 01:14:10 INFO - 'tabpaint']}, 01:14:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['a11yr', 01:14:10 INFO - 'ts_paint', 01:14:10 INFO - 'tpaint', 01:14:10 INFO - 'sessionrestore', 01:14:10 INFO - 'sessionrestore_no_auto_restore', 01:14:10 INFO - 'tabpaint']}, 01:14:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['a11yr', 01:14:10 INFO - 'ts_paint', 01:14:10 INFO - 'tpaint', 01:14:10 INFO - 'sessionrestore', 01:14:10 INFO - 'sessionrestore_no_auto_restore', 01:14:10 INFO - 'tabpaint']}, 01:14:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['tsvgx', 01:14:10 INFO - 'tsvgr_opacity', 01:14:10 INFO - 'tart', 01:14:10 INFO - 'tscrollx', 01:14:10 INFO - 'cart']}, 01:14:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:14:10 INFO - 'tsvgr_opacity', 01:14:10 INFO - 'tart', 01:14:10 INFO - 'tscrollx', 01:14:10 INFO - 'cart']}, 01:14:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'talos_options': ['--disable-e10s'], 01:14:10 INFO - 'tests': ['tp5o']}, 01:14:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'tests': ['tp5o']}, 01:14:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'talos_options': ['--disable-e10s', 01:14:10 INFO - '--xperf_path', 01:14:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:10 INFO - 'tests': ['tp5n']}, 01:14:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:10 INFO - 'talos_options': ['--xperf_path', 01:14:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:10 INFO - 'tests': ['tp5n']}}, 01:14:10 INFO - 'talos.zip': {'path': '', 01:14:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:14:10 INFO - Running post-action listener: _resource_record_post_action 01:14:10 INFO - [mozharness: 2016-10-14 08:14:10.898111Z] Finished populate-webroot step (success) 01:14:10 INFO - [mozharness: 2016-10-14 08:14:10.898244Z] Running create-virtualenv step. 01:14:10 INFO - Running pre-action listener: _resource_record_pre_action 01:14:10 INFO - Running main action method: create_virtualenv 01:14:10 INFO - Creating virtualenv /builds/slave/test/build/venv 01:14:10 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 01:14:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:14:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:14:11 INFO - Using real prefix '/tools/python27' 01:14:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:14:11 INFO - Installing distribute.............................................................................................................................................................................................done. 01:14:14 INFO - Installing pip.................done. 01:14:14 INFO - Return code: 0 01:14:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:14:14 INFO - Reading from file tmpfile_stdout 01:14:14 INFO - Output received: 01:14:14 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) 01:14:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:14 INFO - 'HOME': '/Users/cltbld', 01:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:14 INFO - 'LOGNAME': 'cltbld', 01:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:14 INFO - 'MOZ_NO_REMOTE': '1', 01:14:14 INFO - 'NO_EM_RESTART': '1', 01:14:14 INFO - 'PAGER': '/bin/cat', 01:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:14 INFO - 'PWD': '/builds/slave/test', 01:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:14 INFO - 'SHELL': '/bin/bash', 01:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:14 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:14 INFO - 'USER': 'cltbld', 01:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:14 INFO - 'XPC_FLAGS': '0x0', 01:14:14 INFO - 'XPC_SERVICE_NAME': '0', 01:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:15 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 01:14:15 INFO - Cleaning up... 01:14:15 INFO - Return code: 0 01:14:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:15 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:15 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 01:14:15 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 01:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:15 INFO - 'HOME': '/Users/cltbld', 01:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:15 INFO - 'LOGNAME': 'cltbld', 01:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:15 INFO - 'MOZ_NO_REMOTE': '1', 01:14:15 INFO - 'NO_EM_RESTART': '1', 01:14:15 INFO - 'PAGER': '/bin/cat', 01:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:15 INFO - 'PWD': '/builds/slave/test', 01:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:15 INFO - 'SHELL': '/bin/bash', 01:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:15 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:15 INFO - 'USER': 'cltbld', 01:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:15 INFO - 'XPC_FLAGS': '0x0', 01:14:15 INFO - 'XPC_SERVICE_NAME': '0', 01:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:15 INFO - Downloading/unpacking psutil>=3.1.1 01:14:15 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 01:14:15 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 01:14:15 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 01:14:15 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 01:14:15 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 01:14:15 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 01:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:14:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:19 INFO - Installing collected packages: psutil 01:14:19 INFO - Running setup.py install for psutil 01:14:19 INFO - building 'psutil._psutil_osx' extension 01:14:19 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 01:14:19 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 01:14:19 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 01:14:19 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 01:14:19 INFO - building 'psutil._psutil_posix' extension 01:14:19 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 01:14:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:14:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:14:20 INFO - ^ 01:14:20 INFO - 1 warning generated. 01:14:20 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 01:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:20 INFO - Successfully installed psutil 01:14:20 INFO - Cleaning up... 01:14:20 INFO - Return code: 0 01:14:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:14:20 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')]} 01:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:20 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')]} 01:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:20 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:20 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 01:14:20 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 01:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:20 INFO - 'HOME': '/Users/cltbld', 01:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:20 INFO - 'LOGNAME': 'cltbld', 01:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:20 INFO - 'MOZ_NO_REMOTE': '1', 01:14:20 INFO - 'NO_EM_RESTART': '1', 01:14:20 INFO - 'PAGER': '/bin/cat', 01:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:20 INFO - 'PWD': '/builds/slave/test', 01:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:20 INFO - 'SHELL': '/bin/bash', 01:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:20 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:20 INFO - 'USER': 'cltbld', 01:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:20 INFO - 'XPC_FLAGS': '0x0', 01:14:20 INFO - 'XPC_SERVICE_NAME': '0', 01:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:14:20 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 01:14:20 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 01:14:20 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 01:14:20 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 01:14:20 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 01:14:20 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 01:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:14:23 INFO - Installing collected packages: mozsystemmonitor 01:14:23 INFO - Running setup.py install for mozsystemmonitor 01:14:23 INFO - Successfully installed mozsystemmonitor 01:14:23 INFO - Cleaning up... 01:14:23 INFO - Return code: 0 01:14:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:23 INFO - 'HOME': '/Users/cltbld', 01:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:23 INFO - 'LOGNAME': 'cltbld', 01:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:23 INFO - 'MOZ_NO_REMOTE': '1', 01:14:23 INFO - 'NO_EM_RESTART': '1', 01:14:23 INFO - 'PAGER': '/bin/cat', 01:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:23 INFO - 'PWD': '/builds/slave/test', 01:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:23 INFO - 'SHELL': '/bin/bash', 01:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:23 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:23 INFO - 'USER': 'cltbld', 01:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:23 INFO - 'XPC_FLAGS': '0x0', 01:14:23 INFO - 'XPC_SERVICE_NAME': '0', 01:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 01:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:14:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:14:26 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 01:14:26 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 01:14:26 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 01:14:26 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 01:14:26 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 01:14:26 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 01:14:26 INFO - Downloading functools32-3.2.3-2.tar.gz 01:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:14:26 INFO - warning: no files found matching '*.txt' 01:14:26 INFO - no previously-included directories found matching 'build' 01:14:26 INFO - no previously-included directories found matching 'dist' 01:14:26 INFO - no previously-included directories found matching '.git*' 01:14:26 INFO - Installing collected packages: jsonschema, functools32 01:14:26 INFO - Running setup.py install for functools32 01:14:26 INFO - warning: no files found matching '*.txt' 01:14:26 INFO - no previously-included directories found matching 'build' 01:14:26 INFO - no previously-included directories found matching 'dist' 01:14:26 INFO - no previously-included directories found matching '.git*' 01:14:26 INFO - Successfully installed jsonschema functools32 01:14:26 INFO - Cleaning up... 01:14:26 INFO - Return code: 0 01:14:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:14:26 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')]} 01:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:26 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')]} 01:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:26 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:26 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 01:14:26 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 01:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:26 INFO - 'HOME': '/Users/cltbld', 01:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:26 INFO - 'LOGNAME': 'cltbld', 01:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:26 INFO - 'MOZ_NO_REMOTE': '1', 01:14:26 INFO - 'NO_EM_RESTART': '1', 01:14:26 INFO - 'PAGER': '/bin/cat', 01:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:26 INFO - 'PWD': '/builds/slave/test', 01:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:26 INFO - 'SHELL': '/bin/bash', 01:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:26 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:26 INFO - 'USER': 'cltbld', 01:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:26 INFO - 'XPC_FLAGS': '0x0', 01:14:26 INFO - 'XPC_SERVICE_NAME': '0', 01:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:14:27 INFO - Cleaning up... 01:14:27 INFO - Return code: 0 01:14:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:27 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:27 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 01:14:27 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 01:14:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:27 INFO - 'HOME': '/Users/cltbld', 01:14:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:27 INFO - 'LOGNAME': 'cltbld', 01:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:27 INFO - 'MOZ_NO_REMOTE': '1', 01:14:27 INFO - 'NO_EM_RESTART': '1', 01:14:27 INFO - 'PAGER': '/bin/cat', 01:14:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:27 INFO - 'PWD': '/builds/slave/test', 01:14:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:27 INFO - 'SHELL': '/bin/bash', 01:14:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:27 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:27 INFO - 'USER': 'cltbld', 01:14:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:27 INFO - 'XPC_FLAGS': '0x0', 01:14:27 INFO - 'XPC_SERVICE_NAME': '0', 01:14:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:27 INFO - Downloading/unpacking blobuploader==1.2.4 01:14:27 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 01:14:27 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 01:14:27 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 01:14:27 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 01:14:27 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 01:14:27 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 01:14:29 INFO - Downloading blobuploader-1.2.4.tar.gz 01:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:14:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:31 INFO - Downloading docopt-0.6.1.tar.gz 01:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:14:31 INFO - Installing collected packages: blobuploader, requests, docopt 01:14:31 INFO - Running setup.py install for blobuploader 01:14:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:14:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:14:31 INFO - Running setup.py install for requests 01:14:31 INFO - Running setup.py install for docopt 01:14:31 INFO - Successfully installed blobuploader requests docopt 01:14:31 INFO - Cleaning up... 01:14:31 INFO - Return code: 0 01:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:31 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:31 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 01:14:31 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 01:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:31 INFO - 'HOME': '/Users/cltbld', 01:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:31 INFO - 'LOGNAME': 'cltbld', 01:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:31 INFO - 'MOZ_NO_REMOTE': '1', 01:14:31 INFO - 'NO_EM_RESTART': '1', 01:14:31 INFO - 'PAGER': '/bin/cat', 01:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:31 INFO - 'PWD': '/builds/slave/test', 01:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:31 INFO - 'SHELL': '/bin/bash', 01:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:31 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:31 INFO - 'USER': 'cltbld', 01:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:31 INFO - 'XPC_FLAGS': '0x0', 01:14:31 INFO - 'XPC_SERVICE_NAME': '0', 01:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-hTGvsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-cxLkSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-_K7hRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-UcQwij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-VsdyFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-8az7bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-qF6gqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:32 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-jvno4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-R0rig8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-ELjw7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-xMivRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-a5wmMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-H_7RZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-_G7xOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-GeJ12o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-ja5QkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:33 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-9q4SPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:14:34 INFO - Running setup.py install for manifestparser 01:14:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Running setup.py install for mozcrash 01:14:34 INFO - Running setup.py install for mozdebug 01:14:34 INFO - Running setup.py install for mozdevice 01:14:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Running setup.py install for mozfile 01:14:34 INFO - Running setup.py install for mozhttpd 01:14:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Running setup.py install for mozinfo 01:14:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Running setup.py install for mozInstall 01:14:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Running setup.py install for mozleak 01:14:35 INFO - Running setup.py install for mozlog 01:14:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Running setup.py install for moznetwork 01:14:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Running setup.py install for mozprocess 01:14:35 INFO - Running setup.py install for mozprofile 01:14:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:14:35 INFO - Running setup.py install for mozrunner 01:14:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:14:36 INFO - Running setup.py install for mozscreenshot 01:14:36 INFO - Running setup.py install for moztest 01:14:36 INFO - Running setup.py install for mozversion 01:14:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:14:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:14:36 INFO - Cleaning up... 01:14:36 INFO - Return code: 0 01:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:36 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')]} 01:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:36 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')]} 01:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:36 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:36 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 01:14:36 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 01:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:36 INFO - 'HOME': '/Users/cltbld', 01:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:36 INFO - 'LOGNAME': 'cltbld', 01:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:36 INFO - 'MOZ_NO_REMOTE': '1', 01:14:36 INFO - 'NO_EM_RESTART': '1', 01:14:36 INFO - 'PAGER': '/bin/cat', 01:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:36 INFO - 'PWD': '/builds/slave/test', 01:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:36 INFO - 'SHELL': '/bin/bash', 01:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:36 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:36 INFO - 'USER': 'cltbld', 01:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:36 INFO - 'XPC_FLAGS': '0x0', 01:14:36 INFO - 'XPC_SERVICE_NAME': '0', 01:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:36 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-MUDgJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:36 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)) 01:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:36 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-YXSAbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-smKJAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:37 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)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-sVs4aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-4plL6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:37 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)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-LS2yDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:37 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)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-eXn47V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:37 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)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-1TRMyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:37 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)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-DcEUBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:37 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)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-UGIL0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:37 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)) 01:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:37 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-gCknwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:38 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)) 01:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:38 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-rh9m7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:38 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)) 01:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:38 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-eca0Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:38 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)) 01:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:38 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-5uA0tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:38 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-QMLewE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:38 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)) 01:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:38 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-SZ1EGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:38 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)) 01:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:38 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-0xglC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:38 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)) 01:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:14:38 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)) 01:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:14:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:41 INFO - Downloading blessings-1.6.tar.gz 01:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:14:41 INFO - Installing collected packages: blessings 01:14:41 INFO - Running setup.py install for blessings 01:14:41 INFO - Successfully installed blessings 01:14:41 INFO - Cleaning up... 01:14:41 INFO - Return code: 0 01:14:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:14:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:41 INFO - Reading from file tmpfile_stdout 01:14:41 INFO - Current package versions: 01:14:41 INFO - blessings == 1.6 01:14:41 INFO - blobuploader == 1.2.4 01:14:41 INFO - docopt == 0.6.1 01:14:41 INFO - functools32 == 3.2.3-2 01:14:41 INFO - jsonschema == 2.5.1 01:14:41 INFO - manifestparser == 1.1 01:14:41 INFO - mozInstall == 1.12 01:14:41 INFO - mozcrash == 0.17 01:14:41 INFO - mozdebug == 0.1 01:14:41 INFO - mozdevice == 0.48 01:14:41 INFO - mozfile == 1.2 01:14:41 INFO - mozhttpd == 0.7 01:14:41 INFO - mozinfo == 0.9 01:14:41 INFO - mozleak == 0.1 01:14:41 INFO - mozlog == 3.4 01:14:41 INFO - moznetwork == 0.27 01:14:41 INFO - mozprocess == 0.23 01:14:41 INFO - mozprofile == 0.28 01:14:41 INFO - mozrunner == 6.12 01:14:41 INFO - mozscreenshot == 0.1 01:14:41 INFO - mozsystemmonitor == 0.3 01:14:41 INFO - moztest == 0.7 01:14:41 INFO - mozversion == 1.4 01:14:41 INFO - psutil == 3.1.1 01:14:41 INFO - requests == 1.2.3 01:14:41 INFO - wsgiref == 0.1.2 01:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:41 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')]} 01:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:41 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')]} 01:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:41 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:41 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 01:14:41 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 01:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:41 INFO - 'HOME': '/Users/cltbld', 01:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:41 INFO - 'LOGNAME': 'cltbld', 01:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:41 INFO - 'MOZ_NO_REMOTE': '1', 01:14:41 INFO - 'NO_EM_RESTART': '1', 01:14:41 INFO - 'PAGER': '/bin/cat', 01:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:41 INFO - 'PWD': '/builds/slave/test', 01:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:41 INFO - 'SHELL': '/bin/bash', 01:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:41 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:41 INFO - 'USER': 'cltbld', 01:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:41 INFO - 'XPC_FLAGS': '0x0', 01:14:41 INFO - 'XPC_SERVICE_NAME': '0', 01:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 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)) 01:14:42 INFO - Cleaning up... 01:14:42 INFO - Return code: 0 01:14:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:42 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 0x104309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10427f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf9c8a490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, '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.NpCMQ1DshN/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.jLbp0PifQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 01:14:42 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 01:14:42 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 01:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:42 INFO - 'HOME': '/Users/cltbld', 01:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:42 INFO - 'LOGNAME': 'cltbld', 01:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:42 INFO - 'MOZ_NO_REMOTE': '1', 01:14:42 INFO - 'NO_EM_RESTART': '1', 01:14:42 INFO - 'PAGER': '/bin/cat', 01:14:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:42 INFO - 'PWD': '/builds/slave/test', 01:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:42 INFO - 'SHELL': '/bin/bash', 01:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:14:42 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:42 INFO - 'USER': 'cltbld', 01:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:42 INFO - 'XPC_FLAGS': '0x0', 01:14:42 INFO - 'XPC_SERVICE_NAME': '0', 01:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:14:42 INFO - Cleaning up... 01:14:42 INFO - Return code: 0 01:14:42 INFO - Running post-action listener: _resource_record_post_action 01:14:42 INFO - Running post-action listener: _start_resource_monitoring 01:14:42 INFO - Starting resource monitoring. 01:14:42 INFO - [mozharness: 2016-10-14 08:14:42.434426Z] Finished create-virtualenv step (success) 01:14:42 INFO - [mozharness: 2016-10-14 08:14:42.435430Z] Running install step. 01:14:42 INFO - Running pre-action listener: _resource_record_pre_action 01:14:42 INFO - Running main action method: install 01:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:42 INFO - Reading from file tmpfile_stdout 01:14:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:14:42 INFO - Reading from file tmpfile_stdout 01:14:42 INFO - Output received: 01:14:42 INFO - Usage: mozinstall [options] installer 01:14:42 INFO - Options: 01:14:42 INFO - -h, --help show this help message and exit 01:14:42 INFO - -d DEST, --destination=DEST 01:14:42 INFO - Directory to install application into. [default: 01:14:42 INFO - "/builds/slave/test"] 01:14:42 INFO - --app=APP Application being installed. [default: firefox] 01:14:42 INFO - mkdir: /builds/slave/test/build/application 01:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:15:16 INFO - Reading from file tmpfile_stdout 01:15:16 INFO - Output received: 01:15:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:15:16 INFO - Running post-action listener: _resource_record_post_action 01:15:16 INFO - [mozharness: 2016-10-14 08:15:16.732109Z] Finished install step (success) 01:15:16 INFO - [mozharness: 2016-10-14 08:15:16.732265Z] Running run-tests step. 01:15:16 INFO - Running pre-action listener: _resource_record_pre_action 01:15:16 INFO - Running main action method: run_tests 01:15:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:15:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:15:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:15:16 INFO - 2016-10-14 01:15:16.746 screenresolution[1994:278382] starting screenresolution argv=screenresolution get 01:15:16 INFO - 2016-10-14 01:15:16.749 screenresolution[1994:278382] Display 0: 1600x1200x32@60 01:15:16 INFO - 2016-10-14 01:15:16.754 screenresolution[1995:278384] starting screenresolution argv=screenresolution list 01:15:16 INFO - Available Modes on Display 0 01:15:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:15:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:15:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:15:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:15:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:15:16 INFO - Intel Iris: 01:15:16 INFO - Chipset Model: Intel Iris 01:15:16 INFO - Type: GPU 01:15:16 INFO - Bus: Built-In 01:15:16 INFO - VRAM (Dynamic, Max): 1536 MB 01:15:16 INFO - Vendor: Intel (0x8086) 01:15:16 INFO - Device ID: 0x0a2e 01:15:16 INFO - Revision ID: 0x0009 01:15:16 INFO - Displays: 01:15:16 INFO - Display: 01:15:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:15:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:15:16 INFO - Display Serial Number: 1600x1200 60 01:15:16 INFO - Main Display: Yes 01:15:16 INFO - Mirror: Off 01:15:16 INFO - Online: Yes 01:15:16 INFO - Rotation: Supported 01:15:16 INFO - Return code: 0 01:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:15:16 INFO - Python 2.7.3 01:15:16 INFO - Return code: 0 01:15:16 INFO - grabbing minidump binary from tooltool 01:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:15:16 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 0x10411dd30>, '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 0x103f43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104115b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:15:17 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 01:15:17 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 01:15:17 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 01:15:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:15:17 INFO - Return code: 0 01:15:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:15:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:15:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:15:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:15:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0279', '--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 01:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0279 --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 01:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NpCMQ1DshN/Render', 01:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:15:17 INFO - 'HOME': '/Users/cltbld', 01:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:15:17 INFO - 'LOGNAME': 'cltbld', 01:15:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:15:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:17 INFO - 'MOZ_NO_REMOTE': '1', 01:15:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:15:17 INFO - 'NO_EM_RESTART': '1', 01:15:17 INFO - 'PAGER': '/bin/cat', 01:15:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:17 INFO - 'PWD': '/builds/slave/test', 01:15:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:15:17 INFO - 'SHELL': '/bin/bash', 01:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jLbp0PifQP/Listeners', 01:15:17 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 01:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:15:17 INFO - 'USER': 'cltbld', 01:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:17 INFO - 'XPC_FLAGS': '0x0', 01:15:17 INFO - 'XPC_SERVICE_NAME': '0', 01:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:15:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0279', '--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 01:15:17 INFO - mozversion application_buildid: 20161013231535 01:15:17 INFO - mozversion application_changeset: b2f3dd7eec5d028034173a33e4e0ab7da805d8cd 01:15:17 INFO - mozversion application_display_name: Nightly 01:15:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:15:17 INFO - mozversion application_name: Firefox 01:15:17 INFO - mozversion application_remotingname: firefox 01:15:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:15:17 INFO - mozversion application_vendor: Mozilla 01:15:17 INFO - mozversion application_version: 52.0a1 01:15:17 INFO - mozversion platform_buildid: 20161013231535 01:15:17 INFO - mozversion platform_changeset: b2f3dd7eec5d028034173a33e4e0ab7da805d8cd 01:15:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:15:17 INFO - mozversion platform_version: 52.0a1 01:15:17 INFO - using testdate: 1476432917 01:15:17 INFO - actual date: 1476432917 01:15:17 INFO - starting webserver on 'localhost:49372' 01:15:17 INFO - SUITE-START | Running 2 tests 01:15:17 INFO - TEST-START | dromaeo_css 01:15:17 INFO - operating with platform_type : mac_ 01:15:17 INFO - Initialising browser for dromaeo_css test... 01:15:17 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpZN2p0b/profile http://localhost:49372/getInfo.html) 01:15:19 INFO - PROCESS | 2005 | __metrics Screen width/height:1600/1200 01:15:19 INFO - PROCESS | 2005 | colorDepth:24 01:15:19 INFO - PROCESS | 2005 | Browser inner width/height: 1024/689 01:15:19 INFO - PROCESS | 2005 | __metrics 01:15:19 INFO - PROCESS | 2005 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:15:19 INFO - PROCESS | 2005 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:15:20 INFO - TEST-INFO | 2005: exit 0 01:15:20 INFO - Browser initialized. 01:15:20 INFO - Running cycle 1/1 for dromaeo_css test... 01:15:20 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpZN2p0b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:32 INFO - PROCESS | 2009 | RSS: Main: 235208704 01:15:32 INFO - PROCESS | 2009 | 01:16:24 INFO - PROCESS | 2009 | 1476432984215 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] 01:18:37 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49372/tests/dromaeo/cssquery-ext.html) 01:18:39 INFO - PROCESS | 2009 | RSS: Main: 403902464 01:18:39 INFO - PROCESS | 2009 | 01:21:42 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-ext.html (next: http://localhost:49372/tests/dromaeo/cssquery-jquery.html) 01:21:43 INFO - PROCESS | 2009 | RSS: Main: 372547584 01:21:43 INFO - PROCESS | 2009 | 01:24:45 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49372/tests/dromaeo/cssquery-mootools.html) 01:24:45 INFO - PROCESS | 2009 | RSS: Main: 352079872 01:24:45 INFO - PROCESS | 2009 | 01:27:48 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49372/tests/dromaeo/cssquery-prototype.html) 01:27:48 INFO - PROCESS | 2009 | RSS: Main: 357576704 01:27:48 INFO - PROCESS | 2009 | 01:30:52 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49372/tests/dromaeo/cssquery-yui.html) 01:30:52 INFO - PROCESS | 2009 | RSS: Main: 339243008 01:30:52 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-yui.html (next: http://localhost:49372/tests/dromaeo/cssquery-dojo.html) 01:33:56 INFO - PROCESS | 2009 | RSS: Main: 422912000 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | __start_tp_report 01:33:56 INFO - PROCESS | 2009 | _x_x_mozilla_page_load 01:33:56 INFO - PROCESS | 2009 | _x_x_mozilla_page_load_details 01:33:56 INFO - PROCESS | 2009 | |i|pagename|runs| 01:33:56 INFO - PROCESS | 2009 | |0;dojo.html;3233.7898036627603;3238.919027024325;3262.380147771925;3263.967360326397;3303.7687361884664;5556.16657501375;5657.321121465425;5753.741081651326;5783.595148339613;5785.623934444264;4747.7388743619085;5689.6017278790505;5768.625039372438;5794.71026448678;5885.735141918613;5065.670731402465;5105.540501354877;5156.432792392834;5163.509466600685;5223.138182199932;5256.894862102756;5289.788408463657;5289.841304760864;5302.814401495948;5325.600579956499;5225.581953443753;5247.422783493813;5302.469753024705;5317.9468205318035;5324.068288049576;5122.846314610568;5191.273221748958;5206.7917283308625;5235.110031294689;5250.921236181461;5155.61332900034;5177.197534382177;5182.870428239286;5187.948120518784;5204.245384419276;5701.116326969285;5704.2299289595785;5726.5705072119345;5728.914066289009;5732.770689172428;6154.076888466721;6178.38216178383;6180.134781130645;6181.814545563595;6183.814485565395;5801.245838041028;6190.040543715686;6248.3751624837605;6272.717727702265;6274.905876411857;5784.537237021113;5791.218185544982;5802.419758024248;5807.5644326675665;5810.070388737781;6198.81403557894;6255.718492667841;6276.121343011982;6287.339829317947;6317.178766760384;6136.539759518054;6150.815475535741;6153.169322141453;6160.753569857246;6189.947708889499;6126.846828829226;6142.126651371285;6150.938490615126;6267.592606480564;6268.059791031382;6022.3676513966275;6080.422359875804;6102.095423428478;6161.44546990773;6176.289726681399;6147.231596050494;6149.938500615026;6150.938490615036;6162.845928851725;6164.630122192682;4813;4880.633952453581;4887.3890763654545;4893.877653058631;4904.901901961941;4099.585642953177;4272.401863739079;4373.387725718402;4401.933970990438;4404.185225733249;5705.74324155414;5713.857153571194;5750.4249575042995;5761.711914404347;5823.330317013513;6186.969065154645;6266.530010249249;6283.842903927347;6286.371362863677;6297.275813281532;4914.852554423373;5616.326040875121;5654.37801841797;5685.862827434529;5690.345610254791;5308.92036619451;5360.142377219626;5367.78528858849;5386.811461598825;5405.8107966221;6249.593776404519;6250.593711408744;6260.655663938527;6267.874642507033;6283.2460104787715;6115.240341084353;6116.449519543263;6177.106261765094;6200.3179650237535;6209.348018458178;6156.661383623944;6209.875802484015;6242.438180563771;6281.905771413341;6319.304876463493;6156.784512542219;6212.9068063978175;6225.937740622536;6236.064590311489;6247.281562620356;5590.748416321357;6272.791407080592;6303.716332765129;6312.4634406074165;6321.52588555851;5730;5901.144334071621;5978.730957107027;6116.755329786936;6122.510199184144;6003.87992240144;6009.519238460825;6028.397160284112;6047.879042419215;6050.969745151246;5954.3152537458745;5976.521878249817;6005.699715014144;6013.939860601513;6026.578139530367;6035.124906888389;6069.696515174312;6083.6045657032155;6085.330613632408;6103.969480152571;5069.417017043087;5779.306483222041;5820.243368362086;5956.136360227656;5985.40145985398 01:33:56 INFO - PROCESS | 2009 | |1;ext.html;491.8671958571186;500.92986981822526;505.818912838522;539.5575627985052;542.5361316074756;30955.535666965014;40568.188636227256;41684;41771.58228417715;44127;42522.7873860631;42887.785561072225;42946.570534294646;42989.35515967263;42994.785026074824;7780.922190778077;9514.809703805937;9661.4203147811;9681.515924203797;9688.176504997084;9538.427694338361;9604.615815367411;9606.80786384272;9608.711738647851;9631.855522167172;9559.952200239024;9647.758806029835;9650.855237171449;9678.90321096787;9682.419054856697;9622.230221582256;9632.988536203738;9644.75888102796;9666;9667.419954802734;9516.381435206758;9593.808123837483;9601.567929443192;9607.615695372177;9633.903660963371;39607.207855842724;39914.60085399138;39983.60016399828;40013.39979900304;40027.7998610008;3315.187778994162;3688.778673279585;3901.2197560488016;3917.7061720370803;4039.838406463738;29878;30967.845160774275;31050.534241986163;31113.84443077793;31290.843545782354;2812.8171668841665;3168.635606905212;3325.1853295942406;3358.059743271888;3364.226227967581;501847;502291;505029.47485262336;505287.47356262984;507089;60713.392866070775;61199.69400152971;61456.692716536134;61591;61645.38354616486;62996.68501657462;63263.68368158222;63307.6834615824;63391;63521.36478635247;15929.203539822962;16015.119168445848;16165.4342098026;16169.757453638205;16216.918915405347;12367.814482782765;12384.938075309567;12389.256644601353;12398.690032749073;12403.193792403465;13736.587902362746;15362.00146990442;17498.562535936704;17635;17659.470215893543;5862.003459411911;6253.468455181361;6366.299707032223;6625.86748265032;6631.933680663132;854.3976496569903;969.2682025071026;971.3099207379109;995.2784231432298;1063.1282348474176;29823.552646710315;29910;30800.69199307978;31214.687853121177;31858.884939027022;1057.6615483045352;1058.8941105889348;1060.3849767135043;1085.858838351025;1116.1294190531398;15043.172625505484;15099.773503397459;15125.39498420051;15480.458183963507;15560.766588501181;682009;684835;690434;690658;694928;57392.71303643539;57507.42492575021;57629;57646;57889.552761180465;1218.281214083695;1248.4694005047818;1308.4504508106618;1343.9193648381129;1352.8782409583184;26621.201363959113;29102.70897291;29697.812087516257;30642.35590475605;30696.693033070278;48209.75895120642;48717.5128248713;48739.512604874915;48769;48803;501383;503464;505683;506963;507138.2861713947;23270.185543505897;23859.880700596386;25973.870130649226;26603;26622.334441639116;45783;45845.77077114593;46008.769956151344;46508;47130.293045603656;38199.427008594335;38557.036074098374;38941.6105838938;39384.6061539381;39993;37087.81456092702;37958.62041379661;37981.240375192894;39735.80132099321;39738.205235894544;37425.25149497049;37820;38354.61645383511;38400.65597704067;38463;30265.092047238617;31468.685313146576;34252.758025269395;34489.79285724988;34644.48033279453;23801.880990594935;24613.87693061523;24957.876895539383;24962;25409.74590254148 01:33:56 INFO - PROCESS | 2009 | |2;jquery.html;370.2206854571126;376.3789746917586;383.75823231364234;395.9821808018639;408.293651982071;18142.274309027638;19934.40196794095;20181.39455816326;20584.38246852595;20720.171193152295;19830.60338793223;19928.302509412173;20432.28487002955;20990.790092099112;21357.57284854306;4723.952760472403;5789.855253618651;6091;6670.566413183152;6762.087118239048;6492.610443373389;6702.798916032527;6793.422559082459;6797.660116994155;6800.387965083141;6602.933970660304;6670;6672.399484046435;6675.499337549679;6686.364795344434;6374.235091788969;6506.60960342381;6600.933990660128;6652.101966234569;6657.234418041915;5713.771449142029;5716.171155182476;5723.370429252779;5726.68503232322;5730.7707691692285;24027.27918162458;25765.48469030609;25810.096646617465;25887.093951711788;26115.73884261152;2195.3194509702043;2299.4251437140715;2370.4784947311564;2448.7796098351055;2786.749192572678;14820.555383338517;15336.463223787225;15639.296231669488;15813.972091813996;15927.920360398124;1596.2399239221886;1834.917428715711;1910.6847370184041;1915.2626238898124;1948.0454577257183;118060.40969795096;122582;123114;123597;123795;9243.84451943507;10090;10372.948135259276;10707.965486557528;10868.67393978182;13649.658758530917;13674.93162534201;13682.52111176104;13688.041837071309;13707.588772336845;8229.423940324239;8570.228679418882;8602.31181505478;8726.607302671395;8736.825263494695;7231.855362892713;7642.541447513167;8622.09468005863;8636.136386361439;8658.956705216433;6343.492520598341;6508.544401891917;6514.739410423625;6524.869502610016;6582.605043697394;1804.3865085870605;1837.8162183781515;1844.2807305151002;1849.0662215581046;1859.2562974809914;902.4900930973979;957.167264479907;978.9706308810747;985.5909797434128;1002.9598816047422;21241.575168496543;22602.88698556497;22639.320820375415;22727.431814204447;22762.544749104924;715.1811176203219;943.0946291560042;977.3744803325877;999.9000099990088;1007.450939238117;10667.946660266649;11047.944760276147;11301.547938082549;11495.367754773568;11784.764304713857;580350;607328;618047;618890;628514;96407.0359296412;115529;130669;140141.2992935049;148921;942.566419447062;945.9905400946041;997.9850302245617;1016.501914062119;1020.4846552490944;16063.839361606702;16929.74605380945;18310.450686479428;19180.13689384009;19653.08720560148;38926;41918.58081419147;46768.53231467642;55464.72267638797;55617.165742514706;58823;80945.19054809377;81305;81718.18281817106;81945.77081343665;7527.397808175442;7721.343685786546;7919.406044546567;7988.480748751545;8063.153368896416;11653.53385864556;12824.743505130033;12926.35368231566;13246.337683115999;13294.800577991144;11011.944940275247;11439.370834604177;11561.710957226136;11595.8260626089;11708.063354931755;9222.584983675884;10430.426326552113;11061.83407248908;11231.606893758679;11670.824937626112;11214.719632009264;11293.220583623848;11729.296242225493;11734.471948762155;11735.706607334885;7852.136265010959;7923.286904178652;8205.958970205349;8379.58102094905;8493.532855692996;8174.059983102019;9918.900810991798;10720;11547;11652.41737913084 01:33:56 INFO - PROCESS | 2009 | |3;mootools.html;1329.5878277733902;1477.6601381682206;1512.42527839421;1654.4209526665668;1897.9430617081484;7770.883436748446;8816.603252853622;8826.86759698605;8830.02869684335;8847.867281990759;7731.806704832382;7977.601119944009;7993;8396.160383961616;8638.697645582406;2299.1378233162604;2344.824138189634;2344.8475849069755;2347.612643913752;2354.9293521194304;2293.4610366563843;2323.163661082009;2325.593021221288;2338.918137865175;2339.122828939148;2309.3302942146843;2332.3586013846157;2335.521218150275;2337.275444612167;2344.8358614896965;2278.1798552521077;2300.884955752214;2306.5041016181603;2307.377008207783;2312.167619656922;2010.5174758058106;2300.5513924784673;2302.4934514406805;2302.9193978210683;2310.9306720798404;8636.17956294151;8729.912700872974;8733.12668733128;8738.825223495558;8767.956160219159;5093.414257360414;5208.218767184915;5275.446078161776;5277.102892508283;5286.973565132188;3324.883629072995;3399.7790143640586;3545.450455179451;3550.5916819565564;3551.2187318789825;1070.272214893872;1073.3881687438163;1074.6346242277584;1096.6490722968654;1099.1371773158112;11318.26431281964;11427.657170284905;11473.713157171138;11531.07751379896;11542.711432214177;4446.466424029137;4485.798139083749;4667.276572131325;4705.882352941136;4705.95294047062;9740;9757.170640495495;9760.707178784647;9763.951180244054;9773.560189791477;5238.345206849144;5250.107481728115;5251.658642188246;5253.868653283698;5258.579313654975;4322.524522302544;4343.261645520269;4789.473157952622;4790.856274311776;4822.879428014257;3758.6053464385845;3784.6404591563755;3855.267499175148;3893.6301051400637;3895.8831235062994;1075.720312718683;1244.4026867103842;1256.8805963433458;1258.5657948007922;1263.132688796427;762.7406681728239;866.9176428239307;895.5880295064343;909.2634965677822;945.6548359848606;5713.257276554022;5755.769769209269;5889.293284805765;6030.638161710312;6112.2665280165775;730.5142080516504;946.7396465971913;948.7817801905601;954.5227386306847;991.1476130527741;3813.046738315421;3852.749571277858;3893.7079719021185;4042.8180731867137;4051.5745846686264;8921.732348029569;10654;10655.987681170276;10657.147428205724;10660.680179594625;10495.107915827088;10609.469526523642;10623;10627.04356607909;10647.414392208348;6958;7988.16124306951;8000.159983201796;8025.157358477392;8207.466514676527;5770.470825231233;5918.526517878646;5922.1412895130825;6062.42406971337;6142.293636231891;9850.802983940424;9975.950120249352;10006.949965250127;10024.699259022242;10076.89923100789;9434.433933963985;9940.552675129491;10128.139108175888;10143.84784228252;10146.79706405853;7283.271672832674;7468.477206595703;7532.43506736986;7566.35685966699;7571.545707257362;8224.917750822415;8272.04871439792;8293.875591866006;8296.70961516344;8306.875396869173;7135.785926422215;7140.821479463055;7325.560466372035;7443.032405787213;7462.10454745434;7130.322619351154;7232.783016509513;7273.599952002691;7294.598797066;7439.776806695808;6802;6950.4787140965645;6951.826204344932;6973.895391569232;6982.231954485104;4157.417961485455;4867.667775679577;5007.123753343223;5077.162268225849;5113.948860511347;4928.719537360834;4938.728369939688;5048.167052436307;5185.27406163145;5217.973910130425 01:33:56 INFO - PROCESS | 2009 | |4;prototype.html;290.7528600689414;298.08636529038495;306.07107428953134;310.3018209029683;316.2410215482842;4906.926396104052;5143.202803565448;5145.948540514593;5203.427622961476;5308.840734777953;4466.352378905057;5095.3885533736;5131.896642221922;5170.991656626959;5186.6805244643365;3695.5565332160177;3833.4824798652176;3995.1610161866042;3997.5602683704915;3997.7401468904573;4029.7380670256484;4046.433499310099;4055.3308704063793;4066.3087275163293;4081.1837632473475;3332.0503656457913;3482.791032538043;3602.585702644203;3692.280005398948;3957.773090341989;3502.64973502649;3530.5586801649793;3755.511783468159;3916.100691164783;3975.860844870416;3031.575579418883;3093.6442309134513;3317.568716066896;3347.782394144397;3452.982735086334;4842.249451335048;4903.901921961541;4952.306677065214;4976.402831660188;5100.123905831558;4521.434820647419;4529.524399937992;4591.471980722193;4595;4606.930896036562;5382.255049924527;5387.811426600089;5392.460753924615;5396.64921780083;5448.891022179574;3444.2767018925806;3811.6950643948694;3857.9614203858164;3867.8259478323544;3867.9806600966817;4744.83393081244;4887.3402090717655;5475.4524547544925;5650.74571644277;5774.307083150049;3314.105191598255;3655.4882316475714;3690.4279836625365;3754.887353379403;3839.3665045267217;3744.6442587954643;3883.417487376916;3893.262468030722;3924.3524818404644;3924.529056513237;4139.8965025874595;4501.88745281364;4521.773911304422;4538.6369090473345;4555.931661025087;5267.394249661338;5462.289902312754;5490.752916118704;5504.862378440491;5520.6750379908535;1267.2269915351628;1285.395863943945;1316.0325313656144;1316.7695653260641;1335.3041637120803;713.4328209073799;744.2594618354772;770.6300975531776;793.6904607203195;812.3095368936357;3789.829457674411;3865.40086286626;4192.17640326459;4266.722663026893;4314.892127696833;3980.1641655252142;4308.978455107705;4494.977525112354;4521.796519156645;4715.363425937455;3812.8856134316015;3830.751001184914;4050.736702114353;4247.745135291892;4276.807543660543;2066.917323307051;2268.841181117339;2530.519201351737;2532.898684052654;2551.221877327433;4342.609165175086;4745.786439610226;4771.4512831024185;4818.397700287464;4819.891424972206;4391.516933137353;4771.475137734847;4896.853094407174;4900.803967841318;4969.552740253394;4266.679999000149;4384.364267181241;4441.866743997685;4516.029053753393;4866.707997520019;3942.5071866016747;4388.363687265265;4629.745364005012;4631.4989905450675;4656.7659570213245;4146.502419709534;4368.213721530155;4395.7582332972;4577.864163048323;4758.024604955906;3796.601356857601;4165.541790403114;4528.826163441632;4529.97735011336;4840.6127509798425;2825.5337869251343;2917.6207093078615;3251.561039259764;3258.250602361423;3263.934721305608;4071.79641017942;4263.232618128643;4520.033785303403;4524.099878051292;4712.104700107106;4028.778417187083;4276.524599013335;4406.471223453206;4539.7049191802425;4687.9765601171775;3816.153485073996;4247.833604861481;4426.690131690751;4557.316402539645;4580.221362368472;4005.7796821173947;4055.270051390778;4161.585061079248;4485.327200919888;4513.526079761577;4233.491980962304;4349.478062632378;4500.617447516997;4515.9774201128785;4538.500764915922;3984.442178095011;4075.735077219971;4455.554444555519;4463.8617152625875;4495.269321311253 01:33:56 INFO - PROCESS | 2009 | |5;yui.html;603.3483837455547;720.49565304287;723.8986541884137;770.9383249340053;775.3990657240638;15193.164375959332;15582.220888955564;15690.05859648422;15745.291461884213;15745.291461884213;13998.510052148176;14059;14090.154590724564;14138;14148.221847798366;690.2028157478096;713.5148099292479;714.121630394615;832.7876391520153;848.1137211613848;857.8884744983144;863.6718047142077;867.535868310454;869.4913475616772;870.0255713600776;916.326500022483;920.4431319051978;920.8112336970905;922.4557511068501;927.7263207353814;717.5264325545168;734.3501001613557;913.3058875254787;913.9725808225797;921.3688623293066;664.7042066280507;674.5952428542884;679.748493057567;688.7451642892112;689.434663575868;14486.710265794625;14512.346944387422;14532;14533.563993080224;14542.27288635564;12902.06469029653;13325.333733313295;13411.262380569065;13541.365309603807;14088.577342679737;12091.395430228453;12222.449989750483;12393.876061239453;12402.317872517007;12878.484860605564;4431.955680443187;4444.2444784386735;4530.501644819067;4624.745638989854;4652.62778977681;115373.42313288464;120118.39940800327;120999.39500302442;123777;126615.8061032682;9524;10669.09312708413;10731.366730668404;10907;11236.988671019648;20945.266915658183;21006.15975360999;21025.15899364008;21027.369178924655;21050.894745526173;7614.124375696866;7633.732819351296;7675.078990521173;7730.922690773133;7790.143084260727;4227.534971153171;4284.301987649858;4320.978395108004;4330.935035974463;4442.022754993896;3321.1199032256472;3413.0784688134563;3428.6228514863346;3430.811305378178;3438.398280300937;637.8628594852037;647.7765171015992;668.8662267546413;673.8450156463942;675.7972608217515;475.64564399521885;536.533216101986;574.4686165297084;581.8690794571188;629.3950426412721;8424.326053915795;8430.578471076544;8735.606897689619;8846.646134154691;8917.55412229386;581.9330776960619;599.9520038396918;619.6923351494436;625.0904933322006;631.2582715309493;4263.87208383749;4339.392485052095;4345.782710864444;4348.391225228471;4425.911481770347;111836.88163118265;143199.5680043207;161524.1923790397;164914;166442.8389290253;95088;139347;139483;140152;146436;81817.31831566116;97886;99071.50464247777;120204;127469;8421.326293896596;9397.436153830791;9613.807723845344;9645.080201101167;9810.558524866256;53060.73469632627;57237.569060773814;60715.08927366004;61487.38512614817;62706.37293627188;91820;94925.05074949439;96604.51697741466;97783;99717.00282997367;10936.343819370863;11494.425278736197;11507.482163302504;11596.768064638829;11637.825432618349;10093.848592271268;12181.862493969435;12409.44157512896;12534.435950382072;12652.936735316265;10337.328073675188;11548.42257887119;11778.057755379721;11938.22401543897;12163.81754273669;11530.82703759461;11785.410729463321;11823.290602563873;11860.466279017637;12136.635900922987;11392.48733806964;11396.088312935111;11465.19743617972;11529.077673785909;11971.281723096643;9461.905380946102;9527;9724.416535007922;9876.901230987885;10090.69727908164;9764.951175244078;9878.951978975892;9947.253955953478;9973.351732137387;9987.17942371756 01:33:56 INFO - PROCESS | 2009 | __end_tp_report 01:33:56 INFO - PROCESS | 2009 | __start_cc_report 01:33:56 INFO - PROCESS | 2009 | _x_x_mozilla_cycle_collect,1678 01:33:56 INFO - PROCESS | 2009 | __end_cc_report 01:33:56 INFO - PROCESS | 2009 | __startTimestamp1476434036343__endTimestamp 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | ------- Summary: start ------- 01:33:56 INFO - PROCESS | 2009 | Number of tests: 6 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | [#0] dojo.html Cycles:165 Average:5705.86 Median:5954.32 stddev:655.18 (11.0%) stddev-sans-first:627.84 01:33:56 INFO - PROCESS | 2009 | Values: 3233.8 3238.9 3262.4 3264.0 3303.8 5556.2 5657.3 5753.7 5783.6 5785.6 4747.7 5689.6 5768.6 5794.7 5885.7 5065.7 5105.5 5156.4 5163.5 5223.1 5256.9 5289.8 5289.8 5302.8 5325.6 5225.6 5247.4 5302.5 5317.9 5324.1 5122.8 5191.3 5206.8 5235.1 5250.9 5155.6 5177.2 5182.9 5187.9 5204.2 5701.1 5704.2 5726.6 5728.9 5732.8 6154.1 6178.4 6180.1 6181.8 6183.8 5801.2 6190.0 6248.4 6272.7 6274.9 5784.5 5791.2 5802.4 5807.6 5810.1 6198.8 6255.7 6276.1 6287.3 6317.2 6136.5 6150.8 6153.2 6160.8 6189.9 6126.8 6142.1 6150.9 6267.6 6268.1 6022.4 6080.4 6102.1 6161.4 6176.3 6147.2 6149.9 6150.9 6162.8 6164.6 4813.0 4880.6 4887.4 4893.9 4904.9 4099.6 4272.4 4373.4 4401.9 4404.2 5705.7 5713.9 5750.4 5761.7 5823.3 6187.0 6266.5 6283.8 6286.4 6297.3 4914.9 5616.3 5654.4 5685.9 5690.3 5308.9 5360.1 5367.8 5386.8 5405.8 6249.6 6250.6 6260.7 6267.9 6283.2 6115.2 6116.4 6177.1 6200.3 6209.3 6156.7 6209.9 6242.4 6281.9 6319.3 6156.8 6212.9 6225.9 6236.1 6247.3 5590.7 6272.8 6303.7 6312.5 6321.5 5730.0 5901.1 5978.7 6116.8 6122.5 6003.9 6009.5 6028.4 6047.9 6051.0 5954.3 5976.5 6005.7 6013.9 6026.6 6035.1 6069.7 6083.6 6085.3 6104.0 5069.4 5779.3 5820.2 5956.1 5985.4 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | [#1] ext.html Cycles:180 Average:69782.71 Median:22033.82 stddev:153157.68 (695.1%) stddev-sans-first:153498.97 01:33:56 INFO - PROCESS | 2009 | Values: 491.9 500.9 505.8 539.6 542.5 30955.5 40568.2 41684.0 41771.6 44127.0 42522.8 42887.8 42946.6 42989.4 42994.8 7780.9 9514.8 9661.4 9681.5 9688.2 9538.4 9604.6 9606.8 9608.7 9631.9 9560.0 9647.8 9650.9 9678.9 9682.4 9622.2 9633.0 9644.8 9666.0 9667.4 9516.4 9593.8 9601.6 9607.6 9633.9 39607.2 39914.6 39983.6 40013.4 40027.8 3315.2 3688.8 3901.2 3917.7 4039.8 29878.0 30967.8 31050.5 31113.8 31290.8 2812.8 3168.6 3325.2 3358.1 3364.2 501847.0 502291.0 505029.5 505287.5 507089.0 60713.4 61199.7 61456.7 61591.0 61645.4 62996.7 63263.7 63307.7 63391.0 63521.4 15929.2 16015.1 16165.4 16169.8 16216.9 12367.8 12384.9 12389.3 12398.7 12403.2 13736.6 15362.0 17498.6 17635.0 17659.5 5862.0 6253.5 6366.3 6625.9 6631.9 854.4 969.3 971.3 995.3 1063.1 29823.6 29910.0 30800.7 31214.7 31858.9 1057.7 1058.9 1060.4 1085.9 1116.1 15043.2 15099.8 15125.4 15480.5 15560.8 682009.0 684835.0 690434.0 690658.0 694928.0 57392.7 57507.4 57629.0 57646.0 57889.6 1218.3 1248.5 1308.5 1343.9 1352.9 26621.2 29102.7 29697.8 30642.4 30696.7 48209.8 48717.5 48739.5 48769.0 48803.0 501383.0 503464.0 505683.0 506963.0 507138.3 23270.2 23859.9 25973.9 26603.0 26622.3 45783.0 45845.8 46008.8 46508.0 47130.3 38199.4 38557.0 38941.6 39384.6 39993.0 37087.8 37958.6 37981.2 39735.8 39738.2 37425.3 37820.0 38354.6 38400.7 38463.0 30265.1 31468.7 34252.8 34489.8 34644.5 23801.9 24613.9 24957.9 24962.0 25409.7 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | [#2] jquery.html Cycles:180 Average:35503.81 Median:25848.60 stddev:101865.47 (394.1%) stddev-sans-first:102117.07 01:33:56 INFO - PROCESS | 2009 | Values: 370.2 376.4 383.8 396.0 408.3 18142.3 19934.4 20181.4 20584.4 20720.2 19830.6 19928.3 20432.3 20990.8 21357.6 4724.0 5789.9 6091.0 6670.6 6762.1 6492.6 6702.8 6793.4 6797.7 6800.4 6602.9 6670.0 6672.4 6675.5 6686.4 6374.2 6506.6 6600.9 6652.1 6657.2 5713.8 5716.2 5723.4 5726.7 5730.8 24027.3 25765.5 25810.1 25887.1 26115.7 2195.3 2299.4 2370.5 2448.8 2786.7 14820.6 15336.5 15639.3 15814.0 15927.9 1596.2 1834.9 1910.7 1915.3 1948.0 118060.4 122582.0 123114.0 123597.0 123795.0 9243.8 10090.0 10372.9 10708.0 10868.7 13649.7 13674.9 13682.5 13688.0 13707.6 8229.4 8570.2 8602.3 8726.6 8736.8 7231.9 7642.5 8622.1 8636.1 8659.0 6343.5 6508.5 6514.7 6524.9 6582.6 1804.4 1837.8 1844.3 1849.1 1859.3 902.5 957.2 979.0 985.6 1003.0 21241.6 22602.9 22639.3 22727.4 22762.5 715.2 943.1 977.4 999.9 1007.5 10667.9 11047.9 11301.5 11495.4 11784.8 580350.0 607328.0 618047.0 618890.0 628514.0 96407.0 115529.0 130669.0 140141.3 148921.0 942.6 946.0 998.0 1016.5 1020.5 16063.8 16929.7 18310.5 19180.1 19653.1 38926.0 41918.6 46768.5 55464.7 55617.2 58823.0 80945.2 81305.0 81718.2 81945.8 7527.4 7721.3 7919.4 7988.5 8063.2 11653.5 12824.7 12926.4 13246.3 13294.8 11011.9 11439.4 11561.7 11595.8 11708.1 9222.6 10430.4 11061.8 11231.6 11670.8 11214.7 11293.2 11729.3 11734.5 11735.7 7852.1 7923.3 8206.0 8379.6 8493.5 8174.1 9918.9 10720.0 11547.0 11652.4 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | [#3] mootools.html Cycles:180 Average:5627.37 Median:5062.66 stddev:3148.96 (62.2%) stddev-sans-first:3141.22 01:33:56 INFO - PROCESS | 2009 | Values: 1329.6 1477.7 1512.4 1654.4 1897.9 7770.9 8816.6 8826.9 8830.0 8847.9 7731.8 7977.6 7993.0 8396.2 8638.7 2299.1 2344.8 2344.8 2347.6 2354.9 2293.5 2323.2 2325.6 2338.9 2339.1 2309.3 2332.4 2335.5 2337.3 2344.8 2278.2 2300.9 2306.5 2307.4 2312.2 2010.5 2300.6 2302.5 2302.9 2310.9 8636.2 8729.9 8733.1 8738.8 8768.0 5093.4 5208.2 5275.4 5277.1 5287.0 3324.9 3399.8 3545.5 3550.6 3551.2 1070.3 1073.4 1074.6 1096.6 1099.1 11318.3 11427.7 11473.7 11531.1 11542.7 4446.5 4485.8 4667.3 4705.9 4706.0 9740.0 9757.2 9760.7 9764.0 9773.6 5238.3 5250.1 5251.7 5253.9 5258.6 4322.5 4343.3 4789.5 4790.9 4822.9 3758.6 3784.6 3855.3 3893.6 3895.9 1075.7 1244.4 1256.9 1258.6 1263.1 762.7 866.9 895.6 909.3 945.7 5713.3 5755.8 5889.3 6030.6 6112.3 730.5 946.7 948.8 954.5 991.1 3813.0 3852.7 3893.7 4042.8 4051.6 8921.7 10654.0 10656.0 10657.1 10660.7 10495.1 10609.5 10623.0 10627.0 10647.4 6958.0 7988.2 8000.2 8025.2 8207.5 5770.5 5918.5 5922.1 6062.4 6142.3 9850.8 9976.0 10006.9 10024.7 10076.9 9434.4 9940.6 10128.1 10143.8 10146.8 7283.3 7468.5 7532.4 7566.4 7571.5 8224.9 8272.0 8293.9 8296.7 8306.9 7135.8 7140.8 7325.6 7443.0 7462.1 7130.3 7232.8 7273.6 7294.6 7439.8 6802.0 6950.5 6951.8 6973.9 6982.2 4157.4 4867.7 5007.1 5077.2 5113.9 4928.7 4938.7 5048.2 5185.3 5218.0 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | [#4] prototype.html Cycles:180 Average:3996.97 Median:4346.04 stddev:1175.75 (27.1%) stddev-sans-first:1145.67 01:33:56 INFO - PROCESS | 2009 | Values: 290.8 298.1 306.1 310.3 316.2 4906.9 5143.2 5145.9 5203.4 5308.8 4466.4 5095.4 5131.9 5171.0 5186.7 3695.6 3833.5 3995.2 3997.6 3997.7 4029.7 4046.4 4055.3 4066.3 4081.2 3332.1 3482.8 3602.6 3692.3 3957.8 3502.6 3530.6 3755.5 3916.1 3975.9 3031.6 3093.6 3317.6 3347.8 3453.0 4842.2 4903.9 4952.3 4976.4 5100.1 4521.4 4529.5 4591.5 4595.0 4606.9 5382.3 5387.8 5392.5 5396.6 5448.9 3444.3 3811.7 3858.0 3867.8 3868.0 4744.8 4887.3 5475.5 5650.7 5774.3 3314.1 3655.5 3690.4 3754.9 3839.4 3744.6 3883.4 3893.3 3924.4 3924.5 4139.9 4501.9 4521.8 4538.6 4555.9 5267.4 5462.3 5490.8 5504.9 5520.7 1267.2 1285.4 1316.0 1316.8 1335.3 713.4 744.3 770.6 793.7 812.3 3789.8 3865.4 4192.2 4266.7 4314.9 3980.2 4309.0 4495.0 4521.8 4715.4 3812.9 3830.8 4050.7 4247.7 4276.8 2066.9 2268.8 2530.5 2532.9 2551.2 4342.6 4745.8 4771.5 4818.4 4819.9 4391.5 4771.5 4896.9 4900.8 4969.6 4266.7 4384.4 4441.9 4516.0 4866.7 3942.5 4388.4 4629.7 4631.5 4656.8 4146.5 4368.2 4395.8 4577.9 4758.0 3796.6 4165.5 4528.8 4530.0 4840.6 2825.5 2917.6 3251.6 3258.3 3263.9 4071.8 4263.2 4520.0 4524.1 4712.1 4028.8 4276.5 4406.5 4539.7 4688.0 3816.2 4247.8 4426.7 4557.3 4580.2 4005.8 4055.3 4161.6 4485.3 4513.5 4233.5 4349.5 4500.6 4516.0 4538.5 3984.4 4075.7 4455.6 4463.9 4495.3 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - PROCESS | 2009 | [#5] yui.html Cycles:180 Average:24783.02 Median:4436.99 stddev:40960.01 (923.1%) stddev-sans-first:41034.68 01:33:56 INFO - PROCESS | 2009 | Values: 603.3 720.5 723.9 770.9 775.4 15193.2 15582.2 15690.1 15745.3 15745.3 13998.5 14059.0 14090.2 14138.0 14148.2 690.2 713.5 714.1 832.8 848.1 857.9 863.7 867.5 869.5 870.0 916.3 920.4 920.8 922.5 927.7 717.5 734.4 913.3 914.0 921.4 664.7 674.6 679.7 688.7 689.4 14486.7 14512.3 14532.0 14533.6 14542.3 12902.1 13325.3 13411.3 13541.4 14088.6 12091.4 12222.4 12393.9 12402.3 12878.5 4432.0 4444.2 4530.5 4624.7 4652.6 115373.4 120118.4 120999.4 123777.0 126615.8 9524.0 10669.1 10731.4 10907.0 11237.0 20945.3 21006.2 21025.2 21027.4 21050.9 7614.1 7633.7 7675.1 7730.9 7790.1 4227.5 4284.3 4321.0 4330.9 4442.0 3321.1 3413.1 3428.6 3430.8 3438.4 637.9 647.8 668.9 673.8 675.8 475.6 536.5 574.5 581.9 629.4 8424.3 8430.6 8735.6 8846.6 8917.6 581.9 600.0 619.7 625.1 631.3 4263.9 4339.4 4345.8 4348.4 4425.9 111836.9 143199.6 161524.2 164914.0 166442.8 95088.0 139347.0 139483.0 140152.0 146436.0 81817.3 97886.0 99071.5 120204.0 127469.0 8421.3 9397.4 9613.8 9645.1 9810.6 53060.7 57237.6 60715.1 61487.4 62706.4 91820.0 94925.1 96604.5 97783.0 99717.0 10936.3 11494.4 11507.5 11596.8 11637.8 10093.8 12181.9 12409.4 12534.4 12652.9 10337.3 11548.4 11778.1 11938.2 12163.8 11530.8 11785.4 11823.3 11860.5 12136.6 11392.5 11396.1 11465.2 11529.1 11971.3 9461.9 9527.0 9724.4 9876.9 10090.7 9765.0 9879.0 9947.3 9973.4 9987.2 01:33:56 INFO - PROCESS | 2009 | -------- Summary: end -------- 01:33:56 INFO - PROCESS | 2009 | 01:33:56 INFO - TEST-INFO | 2009: exit 0 01:33:57 INFO - TEST-OK | dromaeo_css | took 1119677ms 01:33:57 INFO - TEST-START | kraken 01:33:57 INFO - operating with platform_type : mac_ 01:33:57 INFO - Initialising browser for kraken test... 01:33:57 INFO - TEST-INFO | started process 2014 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpJI2GtG/profile http://localhost:49372/getInfo.html) 01:33:59 INFO - PROCESS | 2014 | __metrics Screen width/height:1600/1200 01:33:59 INFO - PROCESS | 2014 | colorDepth:24 01:33:59 INFO - PROCESS | 2014 | Browser inner width/height: 1024/689 01:33:59 INFO - PROCESS | 2014 | __metrics 01:33:59 INFO - PROCESS | 2014 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:33:59 INFO - PROCESS | 2014 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:34:00 INFO - TEST-INFO | 2014: exit 0 01:34:00 INFO - Browser initialized. 01:34:00 INFO - Running cycle 1/1 for kraken test... 01:34:00 INFO - TEST-INFO | started process 2015 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpJI2GtG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:12 INFO - PROCESS | 2015 | RSS: Main: 235053056 01:34:12 INFO - PROCESS | 2015 | 01:34:15 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection) 01:34:16 INFO - PROCESS | 2015 | RSS: Main: 293658624 01:34:16 INFO - PROCESS | 2015 | 01:34:18 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-dft) 01:34:19 INFO - PROCESS | 2015 | RSS: Main: 293490688 01:34:19 INFO - PROCESS | 2015 | 01:34:22 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-fft) 01:34:23 INFO - PROCESS | 2015 | RSS: Main: 384643072 01:34:23 INFO - PROCESS | 2015 | 01:34:25 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator) 01:34:26 INFO - PROCESS | 2015 | RSS: Main: 284827648 01:34:26 INFO - PROCESS | 2015 | 01:34:28 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:34:28 INFO - PROCESS | 2015 | RSS: Main: 290000896 01:34:28 INFO - PROCESS | 2015 | 01:34:31 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom) 01:34:32 INFO - PROCESS | 2015 | RSS: Main: 327716864 01:34:32 INFO - PROCESS | 2015 | 01:34:35 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate) 01:34:35 INFO - PROCESS | 2015 | RSS: Main: 329285632 01:34:35 INFO - PROCESS | 2015 | 01:34:38 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial) 01:34:39 INFO - PROCESS | 2015 | RSS: Main: 325787648 01:34:39 INFO - PROCESS | 2015 | 01:34:40 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:34:41 INFO - PROCESS | 2015 | RSS: Main: 300568576 01:34:41 INFO - PROCESS | 2015 | 01:34:43 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:34:43 INFO - PROCESS | 2015 | RSS: Main: 306085888 01:34:43 INFO - PROCESS | 2015 | 01:34:46 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:34:46 INFO - PROCESS | 2015 | RSS: Main: 315052032 01:34:46 INFO - PROCESS | 2015 | 01:34:49 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:34:50 INFO - PROCESS | 2015 | RSS: Main: 322891776 01:34:50 INFO - PROCESS | 2015 | 01:34:53 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:34:54 INFO - PROCESS | 2015 | RSS: Main: 322285568 01:34:54 INFO - PROCESS | 2015 | 01:34:55 INFO - PROCESS | 2015 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49372/tests/kraken/driver.html?testName=ai-astar) 01:34:56 INFO - PROCESS | 2015 | RSS: Main: 366133248 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | __start_tp_report 01:34:56 INFO - PROCESS | 2015 | _x_x_mozilla_page_load 01:34:56 INFO - PROCESS | 2015 | _x_x_mozilla_page_load_details 01:34:56 INFO - PROCESS | 2015 | |i|pagename|runs| 01:34:56 INFO - PROCESS | 2015 | |0;ai-astar;111;113;112;113;111;112;112;111;112;113 01:34:56 INFO - PROCESS | 2015 | |1;audio-beat-detection;152;114;114;149;111;113;113;110;140;111 01:34:56 INFO - PROCESS | 2015 | |2;audio-dft;182;184;182;186;182;185;183;182;184;183 01:34:56 INFO - PROCESS | 2015 | |3;audio-fft;76;58;58;92;85;81;80;58;83;69 01:34:56 INFO - PROCESS | 2015 | |4;audio-oscillator;88;71;93;71;69;70;92;68;68;92 01:34:56 INFO - PROCESS | 2015 | |5;imaging-gaussian-blur;87;84;87;85;86;83;87;85;87;84 01:34:56 INFO - PROCESS | 2015 | |6;imaging-darkroom;94;100;93;94;94;94;94;94;93;93 01:34:56 INFO - PROCESS | 2015 | |7;imaging-desaturate;93;89;99;133;92;92;93;90;93;85 01:34:56 INFO - PROCESS | 2015 | |8;json-parse-financial;58;55;53;52;54;54;54;54;57;57 01:34:56 INFO - PROCESS | 2015 | |9;json-stringify-tinderbox;74;79;76;73;74;71;68;71;70;71 01:34:56 INFO - PROCESS | 2015 | |10;stanford-crypto-aes;86;85;90;90;84;87;85;89;85;91 01:34:56 INFO - PROCESS | 2015 | |11;stanford-crypto-ccm;148;143;145;146;145;143;148;143;217;154 01:34:56 INFO - PROCESS | 2015 | |12;stanford-crypto-pbkdf2;174;172;175;171;171;172;169;169;173;167 01:34:56 INFO - PROCESS | 2015 | |13;stanford-crypto-sha256-iterative;69;84;85;72;70;69;68;69;68;68 01:34:56 INFO - PROCESS | 2015 | __end_tp_report 01:34:56 INFO - PROCESS | 2015 | __start_cc_report 01:34:56 INFO - PROCESS | 2015 | _x_x_mozilla_cycle_collect,2008 01:34:56 INFO - PROCESS | 2015 | __end_cc_report 01:34:56 INFO - PROCESS | 2015 | __startTimestamp1476434096048__endTimestamp 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | ------- Summary: start ------- 01:34:56 INFO - PROCESS | 2015 | Number of tests: 14 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 01:34:56 INFO - PROCESS | 2015 | Values: 111.0 113.0 112.0 113.0 111.0 112.0 112.0 111.0 112.0 113.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:114.00 stddev:17.08 (15.0%) stddev-sans-first:14.45 01:34:56 INFO - PROCESS | 2015 | Values: 152.0 114.0 114.0 149.0 111.0 113.0 113.0 110.0 140.0 111.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.42 (0.8%) stddev-sans-first:1.42 01:34:56 INFO - PROCESS | 2015 | Values: 182.0 184.0 182.0 186.0 182.0 185.0 183.0 182.0 184.0 183.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#3] audio-fft Cycles:10 Average:74.00 Median:80.50 stddev:12.51 (15.5%) stddev-sans-first:13.25 01:34:56 INFO - PROCESS | 2015 | Values: 76.0 58.0 58.0 92.0 85.0 81.0 80.0 58.0 83.0 69.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:79.50 stddev:11.35 (14.3%) stddev-sans-first:11.47 01:34:56 INFO - PROCESS | 2015 | Values: 88.0 71.0 93.0 71.0 69.0 70.0 92.0 68.0 68.0 92.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:1.51 (1.7%) stddev-sans-first:1.50 01:34:56 INFO - PROCESS | 2015 | Values: 87.0 84.0 87.0 85.0 86.0 83.0 87.0 85.0 87.0 84.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:2.06 (2.2%) stddev-sans-first:2.18 01:34:56 INFO - PROCESS | 2015 | Values: 94.0 100.0 93.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:92.50 stddev:13.51 (14.6%) stddev-sans-first:14.29 01:34:56 INFO - PROCESS | 2015 | Values: 93.0 89.0 99.0 133.0 92.0 92.0 93.0 90.0 93.0 85.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:1.93 (3.5%) stddev-sans-first:1.67 01:34:56 INFO - PROCESS | 2015 | Values: 58.0 55.0 53.0 52.0 54.0 54.0 54.0 54.0 57.0 57.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:73.50 stddev:3.20 (4.4%) stddev-sans-first:3.36 01:34:56 INFO - PROCESS | 2015 | Values: 74.0 79.0 76.0 73.0 74.0 71.0 68.0 71.0 70.0 71.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:88.00 stddev:2.57 (2.9%) stddev-sans-first:2.69 01:34:56 INFO - PROCESS | 2015 | Values: 86.0 85.0 90.0 90.0 84.0 87.0 85.0 89.0 85.0 91.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:147.00 stddev:22.67 (15.4%) stddev-sans-first:23.96 01:34:56 INFO - PROCESS | 2015 | Values: 148.0 143.0 145.0 146.0 145.0 143.0 148.0 143.0 217.0 154.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:172.00 stddev:2.45 (1.4%) stddev-sans-first:2.40 01:34:56 INFO - PROCESS | 2015 | Values: 174.0 172.0 175.0 171.0 171.0 172.0 169.0 169.0 173.0 167.0 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - PROCESS | 2015 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:69.50 stddev:6.60 (9.5%) stddev-sans-first:6.89 01:34:56 INFO - PROCESS | 2015 | Values: 69.0 84.0 85.0 72.0 70.0 69.0 68.0 69.0 68.0 68.0 01:34:56 INFO - PROCESS | 2015 | -------- Summary: end -------- 01:34:56 INFO - PROCESS | 2015 | 01:34:56 INFO - TEST-INFO | 2015: exit 0 01:34:56 INFO - TEST-OK | kraken | took 59904ms 01:34:56 INFO - SUITE-END | took 1179s 01:34:57 INFO - Completed test suite (00:19:39) 01:34:57 INFO - javascript benchmark 01:34:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.7898036627603, 3238.919027024325, 3262.380147771925, 3263.967360326397, 3303.7687361884664, 5556.16657501375, 5657.321121465425, 5753.741081651326, 5783.595148339613, 5785.623934444264, 4747.7388743619085, 5689.6017278790505, 5768.625039372438, 5794.71026448678, 5885.735141918613, 5065.670731402465, 5105.540501354877, 5156.432792392834, 5163.509466600685, 5223.138182199932, 5256.894862102756, 5289.788408463657, 5289.841304760864, 5302.814401495948, 5325.600579956499, 5225.581953443753, 5247.422783493813, 5302.469753024705, 5317.9468205318035, 5324.068288049576, 5122.846314610568, 5191.273221748958, 5206.7917283308625, 5235.110031294689, 5250.921236181461, 5155.61332900034, 5177.197534382177, 5182.870428239286, 5187.948120518784, 5204.245384419276, 5701.116326969285, 5704.2299289595785, 5726.5705072119345, 5728.914066289009, 5732.770689172428, 6154.076888466721, 6178.38216178383, 6180.134781130645, 6181.814545563595, 6183.814485565395, 5801.245838041028, 6190.040543715686, 6248.3751624837605, 6272.717727702265, 6274.905876411857, 5784.537237021113, 5791.218185544982, 5802.419758024248, 5807.5644326675665, 5810.070388737781, 6198.81403557894, 6255.718492667841, 6276.121343011982, 6287.339829317947, 6317.178766760384, 6136.539759518054, 6150.815475535741, 6153.169322141453, 6160.753569857246, 6189.947708889499, 6126.846828829226, 6142.126651371285, 6150.938490615126, 6267.592606480564, 6268.059791031382, 6022.3676513966275, 6080.422359875804, 6102.095423428478, 6161.44546990773, 6176.289726681399, 6147.231596050494, 6149.938500615026, 6150.938490615036, 6162.845928851725, 6164.630122192682, 4813.0, 4880.633952453581, 4887.3890763654545, 4893.877653058631, 4904.901901961941, 4099.585642953177, 4272.401863739079, 4373.387725718402, 4401.933970990438, 4404.185225733249, 5705.74324155414, 5713.857153571194, 5750.4249575042995, 5761.711914404347, 5823.330317013513, 6186.969065154645, 6266.530010249249, 6283.842903927347, 6286.371362863677, 6297.275813281532, 4914.852554423373, 5616.326040875121, 5654.37801841797, 5685.862827434529, 5690.345610254791, 5308.92036619451, 5360.142377219626, 5367.78528858849, 5386.811461598825, 5405.8107966221, 6249.593776404519, 6250.593711408744, 6260.655663938527, 6267.874642507033, 6283.2460104787715, 6115.240341084353, 6116.449519543263, 6177.106261765094, 6200.3179650237535, 6209.348018458178, 6156.661383623944, 6209.875802484015, 6242.438180563771, 6281.905771413341, 6319.304876463493, 6156.784512542219, 6212.9068063978175, 6225.937740622536, 6236.064590311489, 6247.281562620356, 5590.748416321357, 6272.791407080592, 6303.716332765129, 6312.4634406074165, 6321.52588555851, 5730.0, 5901.144334071621, 5978.730957107027, 6116.755329786936, 6122.510199184144, 6003.87992240144, 6009.519238460825, 6028.397160284112, 6047.879042419215, 6050.969745151246, 5954.3152537458745, 5976.521878249817, 6005.699715014144, 6013.939860601513, 6026.578139530367, 6035.124906888389, 6069.696515174312, 6083.6045657032155, 6085.330613632408, 6103.969480152571, 5069.417017043087, 5779.306483222041, 5820.243368362086, 5956.136360227656, 5985.40145985398], "value": 5662.412267678282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.8671958571186, 500.92986981822526, 505.818912838522, 539.5575627985052, 542.5361316074756, 30955.535666965014, 40568.188636227256, 41684.0, 41771.58228417715, 44127.0, 42522.7873860631, 42887.785561072225, 42946.570534294646, 42989.35515967263, 42994.785026074824, 7780.922190778077, 9514.809703805937, 9661.4203147811, 9681.515924203797, 9688.176504997084, 9538.427694338361, 9604.615815367411, 9606.80786384272, 9608.711738647851, 9631.855522167172, 9559.952200239024, 9647.758806029835, 9650.855237171449, 9678.90321096787, 9682.419054856697, 9622.230221582256, 9632.988536203738, 9644.75888102796, 9666.0, 9667.419954802734, 9516.381435206758, 9593.808123837483, 9601.567929443192, 9607.615695372177, 9633.903660963371, 39607.207855842724, 39914.60085399138, 39983.60016399828, 40013.39979900304, 40027.7998610008, 3315.187778994162, 3688.778673279585, 3901.2197560488016, 3917.7061720370803, 4039.838406463738, 29878.0, 30967.845160774275, 31050.534241986163, 31113.84443077793, 31290.843545782354, 2812.8171668841665, 3168.635606905212, 3325.1853295942406, 3358.059743271888, 3364.226227967581, 501847.0, 502291.0, 505029.47485262336, 505287.47356262984, 507089.0, 60713.392866070775, 61199.69400152971, 61456.692716536134, 61591.0, 61645.38354616486, 62996.68501657462, 63263.68368158222, 63307.6834615824, 63391.0, 63521.36478635247, 15929.203539822962, 16015.119168445848, 16165.4342098026, 16169.757453638205, 16216.918915405347, 12367.814482782765, 12384.938075309567, 12389.256644601353, 12398.690032749073, 12403.193792403465, 13736.587902362746, 15362.00146990442, 17498.562535936704, 17635.0, 17659.470215893543, 5862.003459411911, 6253.468455181361, 6366.299707032223, 6625.86748265032, 6631.933680663132, 854.3976496569903, 969.2682025071026, 971.3099207379109, 995.2784231432298, 1063.1282348474176, 29823.552646710315, 29910.0, 30800.69199307978, 31214.687853121177, 31858.884939027022, 1057.6615483045352, 1058.8941105889348, 1060.3849767135043, 1085.858838351025, 1116.1294190531398, 15043.172625505484, 15099.773503397459, 15125.39498420051, 15480.458183963507, 15560.766588501181, 682009.0, 684835.0, 690434.0, 690658.0, 694928.0, 57392.71303643539, 57507.42492575021, 57629.0, 57646.0, 57889.552761180465, 1218.281214083695, 1248.4694005047818, 1308.4504508106618, 1343.9193648381129, 1352.8782409583184, 26621.201363959113, 29102.70897291, 29697.812087516257, 30642.35590475605, 30696.693033070278, 48209.75895120642, 48717.5128248713, 48739.512604874915, 48769.0, 48803.0, 501383.0, 503464.0, 505683.0, 506963.0, 507138.2861713947, 23270.185543505897, 23859.880700596386, 25973.870130649226, 26603.0, 26622.334441639116, 45783.0, 45845.77077114593, 46008.769956151344, 46508.0, 47130.293045603656, 38199.427008594335, 38557.036074098374, 38941.6105838938, 39384.6061539381, 39993.0, 37087.81456092702, 37958.62041379661, 37981.240375192894, 39735.80132099321, 39738.205235894544, 37425.25149497049, 37820.0, 38354.61645383511, 38400.65597704067, 38463.0, 30265.092047238617, 31468.685313146576, 34252.758025269395, 34489.79285724988, 34644.48033279453, 23801.880990594935, 24613.87693061523, 24957.876895539383, 24962.0, 25409.74590254148], "value": 19729.34280232824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2206854571126, 376.3789746917586, 383.75823231364234, 395.9821808018639, 408.293651982071, 18142.274309027638, 19934.40196794095, 20181.39455816326, 20584.38246852595, 20720.171193152295, 19830.60338793223, 19928.302509412173, 20432.28487002955, 20990.790092099112, 21357.57284854306, 4723.952760472403, 5789.855253618651, 6091.0, 6670.566413183152, 6762.087118239048, 6492.610443373389, 6702.798916032527, 6793.422559082459, 6797.660116994155, 6800.387965083141, 6602.933970660304, 6670.0, 6672.399484046435, 6675.499337549679, 6686.364795344434, 6374.235091788969, 6506.60960342381, 6600.933990660128, 6652.101966234569, 6657.234418041915, 5713.771449142029, 5716.171155182476, 5723.370429252779, 5726.68503232322, 5730.7707691692285, 24027.27918162458, 25765.48469030609, 25810.096646617465, 25887.093951711788, 26115.73884261152, 2195.3194509702043, 2299.4251437140715, 2370.4784947311564, 2448.7796098351055, 2786.749192572678, 14820.555383338517, 15336.463223787225, 15639.296231669488, 15813.972091813996, 15927.920360398124, 1596.2399239221886, 1834.917428715711, 1910.6847370184041, 1915.2626238898124, 1948.0454577257183, 118060.40969795096, 122582.0, 123114.0, 123597.0, 123795.0, 9243.84451943507, 10090.0, 10372.948135259276, 10707.965486557528, 10868.67393978182, 13649.658758530917, 13674.93162534201, 13682.52111176104, 13688.041837071309, 13707.588772336845, 8229.423940324239, 8570.228679418882, 8602.31181505478, 8726.607302671395, 8736.825263494695, 7231.855362892713, 7642.541447513167, 8622.09468005863, 8636.136386361439, 8658.956705216433, 6343.492520598341, 6508.544401891917, 6514.739410423625, 6524.869502610016, 6582.605043697394, 1804.3865085870605, 1837.8162183781515, 1844.2807305151002, 1849.0662215581046, 1859.2562974809914, 902.4900930973979, 957.167264479907, 978.9706308810747, 985.5909797434128, 1002.9598816047422, 21241.575168496543, 22602.88698556497, 22639.320820375415, 22727.431814204447, 22762.544749104924, 715.1811176203219, 943.0946291560042, 977.3744803325877, 999.9000099990088, 1007.450939238117, 10667.946660266649, 11047.944760276147, 11301.547938082549, 11495.367754773568, 11784.764304713857, 580350.0, 607328.0, 618047.0, 618890.0, 628514.0, 96407.0359296412, 115529.0, 130669.0, 140141.2992935049, 148921.0, 942.566419447062, 945.9905400946041, 997.9850302245617, 1016.501914062119, 1020.4846552490944, 16063.839361606702, 16929.74605380945, 18310.450686479428, 19180.13689384009, 19653.08720560148, 38926.0, 41918.58081419147, 46768.53231467642, 55464.72267638797, 55617.165742514706, 58823.0, 80945.19054809377, 81305.0, 81718.18281817106, 81945.77081343665, 7527.397808175442, 7721.343685786546, 7919.406044546567, 7988.480748751545, 8063.153368896416, 11653.53385864556, 12824.743505130033, 12926.35368231566, 13246.337683115999, 13294.800577991144, 11011.944940275247, 11439.370834604177, 11561.710957226136, 11595.8260626089, 11708.063354931755, 9222.584983675884, 10430.426326552113, 11061.83407248908, 11231.606893758679, 11670.824937626112, 11214.719632009264, 11293.220583623848, 11729.296242225493, 11734.471948762155, 11735.706607334885, 7852.136265010959, 7923.286904178652, 8205.958970205349, 8379.58102094905, 8493.532855692996, 8174.059983102019, 9918.900810991798, 10720.0, 11547.0, 11652.41737913084], "value": 9838.936824729211, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.5878277733902, 1477.6601381682206, 1512.42527839421, 1654.4209526665668, 1897.9430617081484, 7770.883436748446, 8816.603252853622, 8826.86759698605, 8830.02869684335, 8847.867281990759, 7731.806704832382, 7977.601119944009, 7993.0, 8396.160383961616, 8638.697645582406, 2299.1378233162604, 2344.824138189634, 2344.8475849069755, 2347.612643913752, 2354.9293521194304, 2293.4610366563843, 2323.163661082009, 2325.593021221288, 2338.918137865175, 2339.122828939148, 2309.3302942146843, 2332.3586013846157, 2335.521218150275, 2337.275444612167, 2344.8358614896965, 2278.1798552521077, 2300.884955752214, 2306.5041016181603, 2307.377008207783, 2312.167619656922, 2010.5174758058106, 2300.5513924784673, 2302.4934514406805, 2302.9193978210683, 2310.9306720798404, 8636.17956294151, 8729.912700872974, 8733.12668733128, 8738.825223495558, 8767.956160219159, 5093.414257360414, 5208.218767184915, 5275.446078161776, 5277.102892508283, 5286.973565132188, 3324.883629072995, 3399.7790143640586, 3545.450455179451, 3550.5916819565564, 3551.2187318789825, 1070.272214893872, 1073.3881687438163, 1074.6346242277584, 1096.6490722968654, 1099.1371773158112, 11318.26431281964, 11427.657170284905, 11473.713157171138, 11531.07751379896, 11542.711432214177, 4446.466424029137, 4485.798139083749, 4667.276572131325, 4705.882352941136, 4705.95294047062, 9740.0, 9757.170640495495, 9760.707178784647, 9763.951180244054, 9773.560189791477, 5238.345206849144, 5250.107481728115, 5251.658642188246, 5253.868653283698, 5258.579313654975, 4322.524522302544, 4343.261645520269, 4789.473157952622, 4790.856274311776, 4822.879428014257, 3758.6053464385845, 3784.6404591563755, 3855.267499175148, 3893.6301051400637, 3895.8831235062994, 1075.720312718683, 1244.4026867103842, 1256.8805963433458, 1258.5657948007922, 1263.132688796427, 762.7406681728239, 866.9176428239307, 895.5880295064343, 909.2634965677822, 945.6548359848606, 5713.257276554022, 5755.769769209269, 5889.293284805765, 6030.638161710312, 6112.2665280165775, 730.5142080516504, 946.7396465971913, 948.7817801905601, 954.5227386306847, 991.1476130527741, 3813.046738315421, 3852.749571277858, 3893.7079719021185, 4042.8180731867137, 4051.5745846686264, 8921.732348029569, 10654.0, 10655.987681170276, 10657.147428205724, 10660.680179594625, 10495.107915827088, 10609.469526523642, 10623.0, 10627.04356607909, 10647.414392208348, 6958.0, 7988.16124306951, 8000.159983201796, 8025.157358477392, 8207.466514676527, 5770.470825231233, 5918.526517878646, 5922.1412895130825, 6062.42406971337, 6142.293636231891, 9850.802983940424, 9975.950120249352, 10006.949965250127, 10024.699259022242, 10076.89923100789, 9434.433933963985, 9940.552675129491, 10128.139108175888, 10143.84784228252, 10146.79706405853, 7283.271672832674, 7468.477206595703, 7532.43506736986, 7566.35685966699, 7571.545707257362, 8224.917750822415, 8272.04871439792, 8293.875591866006, 8296.70961516344, 8306.875396869173, 7135.785926422215, 7140.821479463055, 7325.560466372035, 7443.032405787213, 7462.10454745434, 7130.322619351154, 7232.783016509513, 7273.599952002691, 7294.598797066, 7439.776806695808, 6802.0, 6950.4787140965645, 6951.826204344932, 6973.895391569232, 6982.231954485104, 4157.417961485455, 4867.667775679577, 5007.123753343223, 5077.162268225849, 5113.948860511347, 4928.719537360834, 4938.728369939688, 5048.167052436307, 5185.27406163145, 5217.973910130425], "value": 4519.732630442167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.7528600689414, 298.08636529038495, 306.07107428953134, 310.3018209029683, 316.2410215482842, 4906.926396104052, 5143.202803565448, 5145.948540514593, 5203.427622961476, 5308.840734777953, 4466.352378905057, 5095.3885533736, 5131.896642221922, 5170.991656626959, 5186.6805244643365, 3695.5565332160177, 3833.4824798652176, 3995.1610161866042, 3997.5602683704915, 3997.7401468904573, 4029.7380670256484, 4046.433499310099, 4055.3308704063793, 4066.3087275163293, 4081.1837632473475, 3332.0503656457913, 3482.791032538043, 3602.585702644203, 3692.280005398948, 3957.773090341989, 3502.64973502649, 3530.5586801649793, 3755.511783468159, 3916.100691164783, 3975.860844870416, 3031.575579418883, 3093.6442309134513, 3317.568716066896, 3347.782394144397, 3452.982735086334, 4842.249451335048, 4903.901921961541, 4952.306677065214, 4976.402831660188, 5100.123905831558, 4521.434820647419, 4529.524399937992, 4591.471980722193, 4595.0, 4606.930896036562, 5382.255049924527, 5387.811426600089, 5392.460753924615, 5396.64921780083, 5448.891022179574, 3444.2767018925806, 3811.6950643948694, 3857.9614203858164, 3867.8259478323544, 3867.9806600966817, 4744.83393081244, 4887.3402090717655, 5475.4524547544925, 5650.74571644277, 5774.307083150049, 3314.105191598255, 3655.4882316475714, 3690.4279836625365, 3754.887353379403, 3839.3665045267217, 3744.6442587954643, 3883.417487376916, 3893.262468030722, 3924.3524818404644, 3924.529056513237, 4139.8965025874595, 4501.88745281364, 4521.773911304422, 4538.6369090473345, 4555.931661025087, 5267.394249661338, 5462.289902312754, 5490.752916118704, 5504.862378440491, 5520.6750379908535, 1267.2269915351628, 1285.395863943945, 1316.0325313656144, 1316.7695653260641, 1335.3041637120803, 713.4328209073799, 744.2594618354772, 770.6300975531776, 793.6904607203195, 812.3095368936357, 3789.829457674411, 3865.40086286626, 4192.17640326459, 4266.722663026893, 4314.892127696833, 3980.1641655252142, 4308.978455107705, 4494.977525112354, 4521.796519156645, 4715.363425937455, 3812.8856134316015, 3830.751001184914, 4050.736702114353, 4247.745135291892, 4276.807543660543, 2066.917323307051, 2268.841181117339, 2530.519201351737, 2532.898684052654, 2551.221877327433, 4342.609165175086, 4745.786439610226, 4771.4512831024185, 4818.397700287464, 4819.891424972206, 4391.516933137353, 4771.475137734847, 4896.853094407174, 4900.803967841318, 4969.552740253394, 4266.679999000149, 4384.364267181241, 4441.866743997685, 4516.029053753393, 4866.707997520019, 3942.5071866016747, 4388.363687265265, 4629.745364005012, 4631.4989905450675, 4656.7659570213245, 4146.502419709534, 4368.213721530155, 4395.7582332972, 4577.864163048323, 4758.024604955906, 3796.601356857601, 4165.541790403114, 4528.826163441632, 4529.97735011336, 4840.6127509798425, 2825.5337869251343, 2917.6207093078615, 3251.561039259764, 3258.250602361423, 3263.934721305608, 4071.79641017942, 4263.232618128643, 4520.033785303403, 4524.099878051292, 4712.104700107106, 4028.778417187083, 4276.524599013335, 4406.471223453206, 4539.7049191802425, 4687.9765601171775, 3816.153485073996, 4247.833604861481, 4426.690131690751, 4557.316402539645, 4580.221362368472, 4005.7796821173947, 4055.270051390778, 4161.585061079248, 4485.327200919888, 4513.526079761577, 4233.491980962304, 4349.478062632378, 4500.617447516997, 4515.9774201128785, 4538.500764915922, 3984.442178095011, 4075.735077219971, 4455.554444555519, 4463.8617152625875, 4495.269321311253], "value": 3632.2021460372616, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.3483837455547, 720.49565304287, 723.8986541884137, 770.9383249340053, 775.3990657240638, 15193.164375959332, 15582.220888955564, 15690.05859648422, 15745.291461884213, 15745.291461884213, 13998.510052148176, 14059.0, 14090.154590724564, 14138.0, 14148.221847798366, 690.2028157478096, 713.5148099292479, 714.121630394615, 832.7876391520153, 848.1137211613848, 857.8884744983144, 863.6718047142077, 867.535868310454, 869.4913475616772, 870.0255713600776, 916.326500022483, 920.4431319051978, 920.8112336970905, 922.4557511068501, 927.7263207353814, 717.5264325545168, 734.3501001613557, 913.3058875254787, 913.9725808225797, 921.3688623293066, 664.7042066280507, 674.5952428542884, 679.748493057567, 688.7451642892112, 689.434663575868, 14486.710265794625, 14512.346944387422, 14532.0, 14533.563993080224, 14542.27288635564, 12902.06469029653, 13325.333733313295, 13411.262380569065, 13541.365309603807, 14088.577342679737, 12091.395430228453, 12222.449989750483, 12393.876061239453, 12402.317872517007, 12878.484860605564, 4431.955680443187, 4444.2444784386735, 4530.501644819067, 4624.745638989854, 4652.62778977681, 115373.42313288464, 120118.39940800327, 120999.39500302442, 123777.0, 126615.8061032682, 9524.0, 10669.09312708413, 10731.366730668404, 10907.0, 11236.988671019648, 20945.266915658183, 21006.15975360999, 21025.15899364008, 21027.369178924655, 21050.894745526173, 7614.124375696866, 7633.732819351296, 7675.078990521173, 7730.922690773133, 7790.143084260727, 4227.534971153171, 4284.301987649858, 4320.978395108004, 4330.935035974463, 4442.022754993896, 3321.1199032256472, 3413.0784688134563, 3428.6228514863346, 3430.811305378178, 3438.398280300937, 637.8628594852037, 647.7765171015992, 668.8662267546413, 673.8450156463942, 675.7972608217515, 475.64564399521885, 536.533216101986, 574.4686165297084, 581.8690794571188, 629.3950426412721, 8424.326053915795, 8430.578471076544, 8735.606897689619, 8846.646134154691, 8917.55412229386, 581.9330776960619, 599.9520038396918, 619.6923351494436, 625.0904933322006, 631.2582715309493, 4263.87208383749, 4339.392485052095, 4345.782710864444, 4348.391225228471, 4425.911481770347, 111836.88163118265, 143199.5680043207, 161524.1923790397, 164914.0, 166442.8389290253, 95088.0, 139347.0, 139483.0, 140152.0, 146436.0, 81817.31831566116, 97886.0, 99071.50464247777, 120204.0, 127469.0, 8421.326293896596, 9397.436153830791, 9613.807723845344, 9645.080201101167, 9810.558524866256, 53060.73469632627, 57237.569060773814, 60715.08927366004, 61487.38512614817, 62706.37293627188, 91820.0, 94925.05074949439, 96604.51697741466, 97783.0, 99717.00282997367, 10936.343819370863, 11494.425278736197, 11507.482163302504, 11596.768064638829, 11637.825432618349, 10093.848592271268, 12181.862493969435, 12409.44157512896, 12534.435950382072, 12652.936735316265, 10337.328073675188, 11548.42257887119, 11778.057755379721, 11938.22401543897, 12163.81754273669, 11530.82703759461, 11785.410729463321, 11823.290602563873, 11860.466279017637, 12136.635900922987, 11392.48733806964, 11396.088312935111, 11465.19743617972, 11529.077673785909, 11971.281723096643, 9461.905380946102, 9527.0, 9724.416535007922, 9876.901230987885, 10090.69727908164, 9764.951175244078, 9878.951978975892, 9947.253955953478, 9973.351732137387, 9987.17942371756], "value": 7529.233777958591, "unit": "score"}], "name": "dromaeo_css", "value": 7170.092540685437, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 113.0, 111.0, 112.0, 112.0, 111.0, 112.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 114.0, 149.0, 111.0, 113.0, 113.0, 110.0, 140.0, 111.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 182.0, 186.0, 182.0, 185.0, 183.0, 182.0, 184.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 58.0, 58.0, 92.0, 85.0, 81.0, 80.0, 58.0, 83.0, 69.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 93.0, 71.0, 69.0, 70.0, 92.0, 68.0, 68.0, 92.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 86.0, 83.0, 87.0, 85.0, 87.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 99.0, 133.0, 92.0, 92.0, 93.0, 90.0, 93.0, 85.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 53.0, 52.0, 54.0, 54.0, 54.0, 54.0, 57.0, 57.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 76.0, 73.0, 74.0, 71.0, 68.0, 71.0, 70.0, 71.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 90.0, 90.0, 84.0, 87.0, 85.0, 89.0, 85.0, 91.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 143.0, 145.0, 146.0, 145.0, 143.0, 148.0, 143.0, 217.0, 154.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 175.0, 171.0, 171.0, 172.0, 169.0, 169.0, 173.0, 167.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 85.0, 72.0, 70.0, 69.0, 68.0, 69.0, 68.0, 68.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1457.3, "alertThreshold": 2.0}]} 01:34:57 INFO - Return code: 0 01:34:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:34:57 INFO - # TBPL SUCCESS # 01:34:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:34:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:34:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:34:57 INFO - 2016-10-14 01:34:57.376 screenresolution[2019:280681] starting screenresolution argv=screenresolution get 01:34:57 INFO - 2016-10-14 01:34:57.380 screenresolution[2019:280681] Display 0: 1600x1200x32@60 01:34:57 INFO - 2016-10-14 01:34:57.386 screenresolution[2020:280684] starting screenresolution argv=screenresolution list 01:34:57 INFO - Available Modes on Display 0 01:34:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:34:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:34:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:34:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:34:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:34:57 INFO - Intel Iris: 01:34:57 INFO - Chipset Model: Intel Iris 01:34:57 INFO - Type: GPU 01:34:57 INFO - Bus: Built-In 01:34:57 INFO - VRAM (Dynamic, Max): 1536 MB 01:34:57 INFO - Vendor: Intel (0x8086) 01:34:57 INFO - Device ID: 0x0a2e 01:34:57 INFO - Revision ID: 0x0009 01:34:57 INFO - Displays: 01:34:57 INFO - Display: 01:34:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:34:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:34:57 INFO - Display Serial Number: 1600x1200 60 01:34:57 INFO - Main Display: Yes 01:34:57 INFO - Mirror: Off 01:34:57 INFO - Online: Yes 01:34:57 INFO - Rotation: Supported 01:34:57 INFO - Return code: 0 01:34:57 INFO - Running post-action listener: _resource_record_post_action 01:34:57 INFO - [mozharness: 2016-10-14 08:34:57.625216Z] Finished run-tests step (success) 01:34:57 INFO - Running post-run listener: _resource_record_post_run 01:34:57 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 1559552; Write bytes: 707911680; Read time: 23; Write time: 2005 01:34:57 INFO - TinderboxPrint: CPU usage
54.1% 01:34:57 INFO - TinderboxPrint: I/O read bytes / time
1,559,552 / 23 01:34:57 INFO - TinderboxPrint: I/O write bytes / time
707,911,680 / 2,005 01:34:57 INFO - TinderboxPrint: CPU idle
2,227.6 (45.9%) 01:34:57 INFO - TinderboxPrint: CPU system
984.1 (20.3%) 01:34:57 INFO - TinderboxPrint: CPU user
1,646.1 (33.9%) 01:34:57 INFO - TinderboxPrint: Swap in / out
423,780,352 / 0 01:34:57 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402854400; Write bytes: 396707840; Read time: 29825; Write time: 843 01:34:57 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1522688; Write bytes: 298264576; Read time: 23; Write time: 1118 01:34:58 INFO - Running post-run listener: _upload_blobber_files 01:34:58 INFO - Blob upload gear active. 01:34:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:34:58 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 01:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:34:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:59 INFO - (blobuploader) - INFO - Done attempting. 01:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:00 INFO - (blobuploader) - INFO - Done attempting. 01:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:35:02 INFO - (blobuploader) - INFO - Done attempting. 01:35:02 INFO - (blobuploader) - INFO - Iteration through files over. 01:35:02 INFO - Return code: 0 01:35:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:35:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:35:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bea20577b8d603fe40484fddbea77550ceb4b2dc1c4483bfd881885de8b2692163854dfc60fd91317a7317fd513dd52a9a22b4446bfb62bd195732832ffbc2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfe43b340d0bf10e623bf48124235e93ae7c5f0d97dabab6ca7bfa6042dc217dab6111cfd7ff9e47437008677015eb9474275298fa8503a5b1860a742510a7af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03250c6829a4db4877ca7e82c1ba9b87068574dda217a441b36278cf69c4702a496d40b035d64b29a7477b3fd024b39dcd8b530c5b33d132abf94fe16def5ab1"} 01:35:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:35:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:35:02 INFO - Contents: 01:35:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bea20577b8d603fe40484fddbea77550ceb4b2dc1c4483bfd881885de8b2692163854dfc60fd91317a7317fd513dd52a9a22b4446bfb62bd195732832ffbc2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfe43b340d0bf10e623bf48124235e93ae7c5f0d97dabab6ca7bfa6042dc217dab6111cfd7ff9e47437008677015eb9474275298fa8503a5b1860a742510a7af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03250c6829a4db4877ca7e82c1ba9b87068574dda217a441b36278cf69c4702a496d40b035d64b29a7477b3fd024b39dcd8b530c5b33d132abf94fe16def5ab1"} 01:35:02 INFO - Running post-run listener: copy_logs_to_upload_dir 01:35:02 INFO - Copying logs to upload dir... 01:35:02 INFO - mkdir: /builds/slave/test/build/upload/logs 01:35:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.898929 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-14 01:35:02.510916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 01:35:02.514503) ========= 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.NpCMQ1DshN/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.jLbp0PifQP/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bea20577b8d603fe40484fddbea77550ceb4b2dc1c4483bfd881885de8b2692163854dfc60fd91317a7317fd513dd52a9a22b4446bfb62bd195732832ffbc2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfe43b340d0bf10e623bf48124235e93ae7c5f0d97dabab6ca7bfa6042dc217dab6111cfd7ff9e47437008677015eb9474275298fa8503a5b1860a742510a7af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03250c6829a4db4877ca7e82c1ba9b87068574dda217a441b36278cf69c4702a496d40b035d64b29a7477b3fd024b39dcd8b530c5b33d132abf94fe16def5ab1"} build_url:https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010957 build_url: 'https://queue.taskcluster.net/v1/task/ToTEArXDSsSbndjQEjM7zw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bea20577b8d603fe40484fddbea77550ceb4b2dc1c4483bfd881885de8b2692163854dfc60fd91317a7317fd513dd52a9a22b4446bfb62bd195732832ffbc2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dfe43b340d0bf10e623bf48124235e93ae7c5f0d97dabab6ca7bfa6042dc217dab6111cfd7ff9e47437008677015eb9474275298fa8503a5b1860a742510a7af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03250c6829a4db4877ca7e82c1ba9b87068574dda217a441b36278cf69c4702a496d40b035d64b29a7477b3fd024b39dcd8b530c5b33d132abf94fe16def5ab1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 01:35:02.547184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 01:35:02.547503) ========= 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.NpCMQ1DshN/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.jLbp0PifQP/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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.005234 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 01:35:02.599706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 01:35:02.600044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 01:35:02.600356) ========= ========= Total master_lag: 0.17 =========