builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0126 starttime: 1477500780.43 results: success (0) buildid: 20161026075925 builduid: f81a8cd53e81403ebf91535ba5557b82 revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.426103) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.426523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.426793) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.451241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.451588) ========= 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.JNPg6eJp6h/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.XAZNtKrob2/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-26 09:53:00-- 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% 15.8M=0.001s 2016-10-26 09:53:00 (15.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.595596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.595907) ========= 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.JNPg6eJp6h/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.XAZNtKrob2/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.027533 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:00.643828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 09:53:00.644184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JNPg6eJp6h/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.XAZNtKrob2/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-26 09:53:00,717 truncating revision to first 12 chars 2016-10-26 09:53:00,717 Setting DEBUG logging. 2016-10-26 09:53:00,717 attempt 1/10 2016-10-26 09:53:00,717 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d26ac63f1b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 09:53:01,813 unpacking tar archive at: fx-team-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348665 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 09:53:02.014807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:02.015141) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:02.015518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:02.015779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 09:53:02.034224) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 09:53:02.034591) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JNPg6eJp6h/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.XAZNtKrob2/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:02 INFO - MultiFileLogger online at 20161026 09:53:02 in /builds/slave/test 09:53:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:53:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:53:02 INFO - {'append_to_log': False, 09:53:02 INFO - 'base_work_dir': '/builds/slave/test', 09:53:02 INFO - 'blob_upload_branch': 'Fx-Team', 09:53:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:53:02 INFO - 'branch': 'Fx-Team', 09:53:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:53:02 INFO - 'config_files': ('talos/mac_config.py',), 09:53:02 INFO - 'default_actions': ('clobber', 09:53:02 INFO - 'read-buildbot-config', 09:53:02 INFO - 'download-and-extract', 09:53:02 INFO - 'populate-webroot', 09:53:02 INFO - 'create-virtualenv', 09:53:02 INFO - 'install', 09:53:02 INFO - 'run-tests'), 09:53:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:53:02 INFO - 'download_minidump_stackwalk': True, 09:53:02 INFO - 'download_symbols': 'ondemand', 09:53:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:53:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:53:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:53:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:53:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:53:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:53:02 INFO - 'installer_path': 'installer.exe', 09:53:02 INFO - 'log_level': 'info', 09:53:02 INFO - 'log_name': 'talos', 09:53:02 INFO - 'log_to_console': True, 09:53:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:53:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:53:02 INFO - 'opt_config_files': (), 09:53:02 INFO - 'pip_index': False, 09:53:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:02 INFO - 'cmd': ('bash', 09:53:02 INFO - '-c', 09:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:02 INFO - 'enabled': True, 09:53:02 INFO - 'halt_on_failure': False, 09:53:02 INFO - 'name': 'check_screen_resolution'},), 09:53:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:02 INFO - 'cmd': ('bash', 09:53:02 INFO - '-c', 09:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:02 INFO - 'enabled': True, 09:53:02 INFO - 'halt_on_failure': False, 09:53:02 INFO - 'name': 'check_screen_resolution'},), 09:53:02 INFO - 'run_cmd_checks_enabled': True, 09:53:02 INFO - 'sps_profile': False, 09:53:02 INFO - 'sps_profile_interval': 0, 09:53:02 INFO - 'suite': 'dromaeojs', 09:53:02 INFO - 'system_bits': '32', 09:53:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:53:02 INFO - 'title': 't-yosemite-r7-0126', 09:53:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:53:02 INFO - 'use_talos_json': True, 09:53:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:53:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:53:02 INFO - 'work_dir': 'build'} 09:53:02 INFO - [mozharness: 2016-10-26 16:53:02.239100Z] Running clobber step. 09:53:02 INFO - Running pre-action listener: _resource_record_pre_action 09:53:02 INFO - Running main action method: clobber 09:53:02 INFO - rmtree: /builds/slave/test/build 09:53:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:53:04 INFO - Running post-action listener: _resource_record_post_action 09:53:04 INFO - [mozharness: 2016-10-26 16:53:04.470102Z] Finished clobber step (success) 09:53:04 INFO - [mozharness: 2016-10-26 16:53:04.470226Z] Running read-buildbot-config step. 09:53:04 INFO - Running pre-action listener: _resource_record_pre_action 09:53:04 INFO - Running main action method: read_buildbot_config 09:53:04 INFO - Using buildbot properties: 09:53:04 INFO - { 09:53:04 INFO - "project": "", 09:53:04 INFO - "product": "firefox", 09:53:04 INFO - "script_repo_revision": "production", 09:53:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:53:04 INFO - "repository": "", 09:53:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:53:04 INFO - "buildid": "20161026075925", 09:53:04 INFO - "pgo_build": "False", 09:53:04 INFO - "basedir": "/builds/slave/test", 09:53:04 INFO - "buildnumber": 864, 09:53:04 INFO - "slavename": "t-yosemite-r7-0126", 09:53:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:53:04 INFO - "platform": "yosemite_r7", 09:53:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:53:04 INFO - "branch": "fx-team", 09:53:04 INFO - "repo_path": "integration/fx-team", 09:53:04 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 09:53:04 INFO - "stage_platform": "macosx64", 09:53:04 INFO - "builduid": "f81a8cd53e81403ebf91535ba5557b82", 09:53:04 INFO - "slavebuilddir": "test" 09:53:04 INFO - } 09:53:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:53:04 INFO - Running post-action listener: _resource_record_post_action 09:53:04 INFO - [mozharness: 2016-10-26 16:53:04.473771Z] Finished read-buildbot-config step (success) 09:53:04 INFO - [mozharness: 2016-10-26 16:53:04.473898Z] Running download-and-extract step. 09:53:04 INFO - Running pre-action listener: _resource_record_pre_action 09:53:04 INFO - Running main action method: download_and_extract 09:53:04 INFO - mkdir: /builds/slave/test/build/tests 09:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:04 INFO - trying https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:53:04 INFO - Downloading https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/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 09:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/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 09:53:05 INFO - Downloaded 1199 bytes. 09:53:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:53:05 INFO - Using the following test package requirements: 09:53:05 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:53:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:53:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:53:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'jsshell-mac.zip'], 09:53:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:53:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:53:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:53:05 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:53:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:53:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:53:05 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:53:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:53:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:53:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:53:05 INFO - Fetch https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:53:06 INFO - Http code: 200 09:53:06 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:53:06 INFO - x-amz-cf-id: Zq_UHxrYZoUaxuY71glq3O31wJq1Cc8VOhnZybgY4LLuRCyClgIFKQ== 09:53:06 INFO - x-amz-version-id: eT9LjBq45vPeta5cZs01rcJS.dYdjDy8 09:53:06 INFO - Expected file size: 16442737 09:53:06 INFO - Obtained file size: 16442737 09:53:13 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 09:53:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:53:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:53:13 INFO - Fetch https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:53:13 INFO - Http code: 200 09:53:13 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 09:53:13 INFO - x-amz-cf-id: ijjfZ2GIiCpPFPt6keXcPVHZkcE2-GEyprX8Awm4-LCjV1GwGGHGAg== 09:53:13 INFO - x-amz-version-id: eT9LjBq45vPeta5cZs01rcJS.dYdjDy8 09:53:14 INFO - Expected file size: 16442737 09:53:14 INFO - Obtained file size: 16442737 09:53:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:53:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:53:20 INFO - Fetch https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:53:21 INFO - Http code: 200 09:53:21 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 09:53:21 INFO - x-amz-cf-id: mB2zGUsKJJVfSq2s7G2CJmrAi15WZdTq1C2Cdc7OSJc06-r_iZ_xVQ== 09:53:21 INFO - x-amz-version-id: 3FhhRKxXjKogPK1k49ad.zUNeNq523lL 09:53:21 INFO - Expected file size: 14409028 09:53:21 INFO - Obtained file size: 14409028 09:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:22 INFO - trying https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:53:22 INFO - Downloading https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/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 09:53:25 INFO - Downloaded 111707504 bytes. 09:53:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:53:25 INFO - mkdir: /builds/slave/test/properties 09:53:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:53:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:53:25 INFO - Contents: 09:53:25 INFO - build_url:https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:53:25 INFO - Running post-action listener: _resource_record_post_action 09:53:25 INFO - Running post-action listener: set_extra_try_arguments 09:53:25 INFO - [mozharness: 2016-10-26 16:53:25.934710Z] Finished download-and-extract step (success) 09:53:25 INFO - [mozharness: 2016-10-26 16:53:25.934838Z] Running populate-webroot step. 09:53:25 INFO - Running pre-action listener: _resource_record_pre_action 09:53:25 INFO - Running main action method: populate_webroot 09:53:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:53:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:53:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:53:25 INFO - '--tppagecycles', 09:53:25 INFO - '7'], 09:53:25 INFO - 'tests': ['tsvgm']}}, 09:53:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:53:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:53:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:53:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:53:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['damp', 'tps']}, 09:53:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'tests': ['damp', 'tps']}, 09:53:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['dromaeo_dom']}, 09:53:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:53:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['basic_compositor_video']}, 09:53:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:53:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['a11yr', 09:53:25 INFO - 'ts_paint', 09:53:25 INFO - 'tpaint', 09:53:25 INFO - 'sessionrestore', 09:53:25 INFO - 'sessionrestore_no_auto_restore', 09:53:25 INFO - 'tabpaint']}, 09:53:25 INFO - 'other-e10s': {'tests': ['a11yr', 09:53:25 INFO - 'ts_paint', 09:53:25 INFO - 'tpaint', 09:53:25 INFO - 'sessionrestore', 09:53:25 INFO - 'sessionrestore_no_auto_restore', 09:53:25 INFO - 'tabpaint']}, 09:53:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:53:25 INFO - 'ts_paint', 09:53:25 INFO - 'tpaint', 09:53:25 INFO - 'sessionrestore', 09:53:25 INFO - 'sessionrestore_no_auto_restore', 09:53:25 INFO - 'tabpaint']}, 09:53:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:53:25 INFO - 'ts_paint', 09:53:25 INFO - 'tpaint', 09:53:25 INFO - 'sessionrestore', 09:53:25 INFO - 'sessionrestore_no_auto_restore', 09:53:25 INFO - 'tabpaint']}, 09:53:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['a11yr', 09:53:25 INFO - 'ts_paint', 09:53:25 INFO - 'tpaint', 09:53:25 INFO - 'sessionrestore', 09:53:25 INFO - 'sessionrestore_no_auto_restore', 09:53:25 INFO - 'tabpaint']}, 09:53:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['a11yr', 09:53:25 INFO - 'ts_paint', 09:53:25 INFO - 'tpaint', 09:53:25 INFO - 'sessionrestore', 09:53:25 INFO - 'sessionrestore_no_auto_restore', 09:53:25 INFO - 'tabpaint']}, 09:53:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['tsvgx', 09:53:25 INFO - 'tsvgr_opacity', 09:53:25 INFO - 'tart', 09:53:25 INFO - 'tscrollx', 09:53:25 INFO - 'cart']}, 09:53:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:53:25 INFO - 'tsvgr_opacity', 09:53:25 INFO - 'tart', 09:53:25 INFO - 'tscrollx', 09:53:25 INFO - 'cart']}, 09:53:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'talos_options': ['--disable-e10s'], 09:53:25 INFO - 'tests': ['tp5o']}, 09:53:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'tests': ['tp5o']}, 09:53:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'talos_options': ['--disable-e10s', 09:53:25 INFO - '--xperf_path', 09:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:25 INFO - 'tests': ['tp5n']}, 09:53:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:25 INFO - 'talos_options': ['--xperf_path', 09:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:25 INFO - 'tests': ['tp5n']}}, 09:53:25 INFO - 'talos.zip': {'path': '', 09:53:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:53:25 INFO - Running post-action listener: _resource_record_post_action 09:53:25 INFO - [mozharness: 2016-10-26 16:53:25.953736Z] Finished populate-webroot step (success) 09:53:25 INFO - [mozharness: 2016-10-26 16:53:25.953866Z] Running create-virtualenv step. 09:53:25 INFO - Running pre-action listener: _resource_record_pre_action 09:53:25 INFO - Running main action method: create_virtualenv 09:53:25 INFO - Creating virtualenv /builds/slave/test/build/venv 09:53:25 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 09:53:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:53:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:53:26 INFO - Using real prefix '/tools/python27' 09:53:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:53:29 INFO - Installing pip.................done. 09:53:29 INFO - Return code: 0 09:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:53:29 INFO - Reading from file tmpfile_stdout 09:53:29 INFO - Output received: 09:53:29 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) 09:53:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:53:29 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')]} 09:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:29 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')]} 09:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:29 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 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:29 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 09:53:29 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 09:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:29 INFO - 'HOME': '/Users/cltbld', 09:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:29 INFO - 'LOGNAME': 'cltbld', 09:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:29 INFO - 'MOZ_NO_REMOTE': '1', 09:53:29 INFO - 'NO_EM_RESTART': '1', 09:53:29 INFO - 'PAGER': '/bin/cat', 09:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:29 INFO - 'PWD': '/builds/slave/test', 09:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:29 INFO - 'SHELL': '/bin/bash', 09:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:29 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:29 INFO - 'USER': 'cltbld', 09:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:29 INFO - 'XPC_FLAGS': '0x0', 09:53:29 INFO - 'XPC_SERVICE_NAME': '0', 09:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:53:30 INFO - Cleaning up... 09:53:30 INFO - Return code: 0 09:53:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:30 INFO - 'HOME': '/Users/cltbld', 09:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:30 INFO - 'LOGNAME': 'cltbld', 09:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:30 INFO - 'MOZ_NO_REMOTE': '1', 09:53:30 INFO - 'NO_EM_RESTART': '1', 09:53:30 INFO - 'PAGER': '/bin/cat', 09:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:30 INFO - 'PWD': '/builds/slave/test', 09:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:30 INFO - 'SHELL': '/bin/bash', 09:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:30 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:30 INFO - 'USER': 'cltbld', 09:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:30 INFO - 'XPC_FLAGS': '0x0', 09:53:30 INFO - 'XPC_SERVICE_NAME': '0', 09:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:30 INFO - Downloading/unpacking psutil>=3.1.1 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:53:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:33 INFO - Installing collected packages: psutil 09:53:33 INFO - Running setup.py install for psutil 09:53:34 INFO - building 'psutil._psutil_osx' extension 09:53:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:53:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:53:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:53:34 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 09:53:34 INFO - building 'psutil._psutil_posix' extension 09:53:34 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 09:53:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:53:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:53:34 INFO - ^ 09:53:34 INFO - 1 warning generated. 09:53:34 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 09:53:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:35 INFO - Successfully installed psutil 09:53:35 INFO - Cleaning up... 09:53:35 INFO - Return code: 0 09:53:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:35 INFO - 'HOME': '/Users/cltbld', 09:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:35 INFO - 'LOGNAME': 'cltbld', 09:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:35 INFO - 'MOZ_NO_REMOTE': '1', 09:53:35 INFO - 'NO_EM_RESTART': '1', 09:53:35 INFO - 'PAGER': '/bin/cat', 09:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:35 INFO - 'PWD': '/builds/slave/test', 09:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:35 INFO - 'SHELL': '/bin/bash', 09:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:35 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:35 INFO - 'USER': 'cltbld', 09:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:35 INFO - 'XPC_FLAGS': '0x0', 09:53:35 INFO - 'XPC_SERVICE_NAME': '0', 09:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:53:38 INFO - Installing collected packages: mozsystemmonitor 09:53:38 INFO - Running setup.py install for mozsystemmonitor 09:53:38 INFO - Successfully installed mozsystemmonitor 09:53:38 INFO - Cleaning up... 09:53:38 INFO - Return code: 0 09:53:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:38 INFO - 'HOME': '/Users/cltbld', 09:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:38 INFO - 'LOGNAME': 'cltbld', 09:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:38 INFO - 'MOZ_NO_REMOTE': '1', 09:53:38 INFO - 'NO_EM_RESTART': '1', 09:53:38 INFO - 'PAGER': '/bin/cat', 09:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:38 INFO - 'PWD': '/builds/slave/test', 09:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:38 INFO - 'SHELL': '/bin/bash', 09:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:38 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:38 INFO - 'USER': 'cltbld', 09:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:38 INFO - 'XPC_FLAGS': '0x0', 09:53:38 INFO - 'XPC_SERVICE_NAME': '0', 09:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:38 INFO - Downloading/unpacking jsonschema==2.5.1 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:53:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:41 INFO - Downloading functools32-3.2.3-2.tar.gz 09:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:53:41 INFO - warning: no files found matching '*.txt' 09:53:41 INFO - no previously-included directories found matching 'build' 09:53:41 INFO - no previously-included directories found matching 'dist' 09:53:41 INFO - no previously-included directories found matching '.git*' 09:53:41 INFO - Installing collected packages: jsonschema, functools32 09:53:41 INFO - Running setup.py install for functools32 09:53:41 INFO - warning: no files found matching '*.txt' 09:53:41 INFO - no previously-included directories found matching 'build' 09:53:41 INFO - no previously-included directories found matching 'dist' 09:53:41 INFO - no previously-included directories found matching '.git*' 09:53:41 INFO - Successfully installed jsonschema functools32 09:53:41 INFO - Cleaning up... 09:53:41 INFO - Return code: 0 09:53:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:41 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 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:41 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 09:53:41 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 09:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:41 INFO - 'HOME': '/Users/cltbld', 09:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:41 INFO - 'LOGNAME': 'cltbld', 09:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:41 INFO - 'MOZ_NO_REMOTE': '1', 09:53:41 INFO - 'NO_EM_RESTART': '1', 09:53:41 INFO - 'PAGER': '/bin/cat', 09:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:41 INFO - 'PWD': '/builds/slave/test', 09:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:41 INFO - 'SHELL': '/bin/bash', 09:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:41 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:41 INFO - 'USER': 'cltbld', 09:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:41 INFO - 'XPC_FLAGS': '0x0', 09:53:41 INFO - 'XPC_SERVICE_NAME': '0', 09:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:53:42 INFO - Cleaning up... 09:53:42 INFO - Return code: 0 09:53:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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', '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 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:53: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 blobuploader==1.2.4 09:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:42 INFO - 'HOME': '/Users/cltbld', 09:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:42 INFO - 'LOGNAME': 'cltbld', 09:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:42 INFO - 'MOZ_NO_REMOTE': '1', 09:53:42 INFO - 'NO_EM_RESTART': '1', 09:53:42 INFO - 'PAGER': '/bin/cat', 09:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:42 INFO - 'PWD': '/builds/slave/test', 09:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:42 INFO - 'SHELL': '/bin/bash', 09:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:42 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:42 INFO - 'USER': 'cltbld', 09:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:42 INFO - 'XPC_FLAGS': '0x0', 09:53:42 INFO - 'XPC_SERVICE_NAME': '0', 09:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:53:42 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 09:53:42 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 09:53:42 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 09:53:42 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 09:53:42 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 09:53:42 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 09:53:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:53:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:53:45 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 09:53:45 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 09:53:45 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 09:53:45 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 09:53:45 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 09:53:45 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 09:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:53:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:53:45 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 09:53:45 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 09:53:45 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 09:53:45 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 09:53:45 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 09:53:45 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 09:53:46 INFO - Downloading docopt-0.6.1.tar.gz 09:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:53:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:53:46 INFO - Running setup.py install for blobuploader 09:53:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:53:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:53:46 INFO - Running setup.py install for requests 09:53:46 INFO - Running setup.py install for docopt 09:53:47 INFO - Successfully installed blobuploader requests docopt 09:53:47 INFO - Cleaning up... 09:53:47 INFO - Return code: 0 09:53:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:47 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 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:47 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 09:53:47 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 09:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:47 INFO - 'HOME': '/Users/cltbld', 09:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:47 INFO - 'LOGNAME': 'cltbld', 09:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:47 INFO - 'MOZ_NO_REMOTE': '1', 09:53:47 INFO - 'NO_EM_RESTART': '1', 09:53:47 INFO - 'PAGER': '/bin/cat', 09:53:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:47 INFO - 'PWD': '/builds/slave/test', 09:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:47 INFO - 'SHELL': '/bin/bash', 09:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:47 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:47 INFO - 'USER': 'cltbld', 09:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:47 INFO - 'XPC_FLAGS': '0x0', 09:53:47 INFO - 'XPC_SERVICE_NAME': '0', 09:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-aFbvj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Nd898l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Thm8J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-my4fLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-lreHVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:47 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-v704rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-6ECCzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-DsPEfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-FQkBmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jDZQ9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-oKFxKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Dlv7VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Dvy5YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-HkFvfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-XDkdZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:48 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-DKoor9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:49 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-e7NgxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:53:49 INFO - Running setup.py install for manifestparser 09:53:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:53:49 INFO - Running setup.py install for mozcrash 09:53:49 INFO - Running setup.py install for mozdebug 09:53:49 INFO - Running setup.py install for mozdevice 09:53:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:53:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:53:49 INFO - Running setup.py install for mozfile 09:53:49 INFO - Running setup.py install for mozhttpd 09:53:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Running setup.py install for mozinfo 09:53:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Running setup.py install for mozInstall 09:53:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Running setup.py install for mozleak 09:53:50 INFO - Running setup.py install for mozlog 09:53:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Running setup.py install for moznetwork 09:53:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:53:50 INFO - Running setup.py install for mozprocess 09:53:50 INFO - Running setup.py install for mozprofile 09:53:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:53:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:53:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:53:51 INFO - Running setup.py install for mozrunner 09:53:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:53:51 INFO - Running setup.py install for mozscreenshot 09:53:51 INFO - Running setup.py install for moztest 09:53:51 INFO - Running setup.py install for mozversion 09:53:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:53:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:53:51 INFO - Cleaning up... 09:53:51 INFO - Return code: 0 09:53:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:51 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 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:51 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 09:53:51 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 09:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:51 INFO - 'HOME': '/Users/cltbld', 09:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:51 INFO - 'LOGNAME': 'cltbld', 09:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:51 INFO - 'MOZ_NO_REMOTE': '1', 09:53:51 INFO - 'NO_EM_RESTART': '1', 09:53:51 INFO - 'PAGER': '/bin/cat', 09:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:51 INFO - 'PWD': '/builds/slave/test', 09:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:51 INFO - 'SHELL': '/bin/bash', 09:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:51 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:51 INFO - 'USER': 'cltbld', 09:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:51 INFO - 'XPC_FLAGS': '0x0', 09:53:51 INFO - 'XPC_SERVICE_NAME': '0', 09:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-6qbr7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ZZ01nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ld7TJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-sSQ17K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-IID4ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Sl85V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-CVLXHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-NBRXd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-gLK0UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:52 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)) 09:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:52 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-kEu06c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:53 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)) 09:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-za6cbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:53 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)) 09:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-A_ofBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:53 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)) 09:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-q9qXmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:53 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)) 09:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-9tQlwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:53 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)) 09:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-rt5zSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:53 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)) 09:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-J3CMOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:53 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)) 09:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:53 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-6dYpuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:53 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)) 09:53:53 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)) 09:53:53 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)) 09:53:53 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)) 09:53:53 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)) 09:53:53 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)) 09:53:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:56 INFO - Downloading blessings-1.6.tar.gz 09:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:56 INFO - Installing collected packages: blessings 09:53:56 INFO - Running setup.py install for blessings 09:53:56 INFO - Successfully installed blessings 09:53:56 INFO - Cleaning up... 09:53:56 INFO - Return code: 0 09:53:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:56 INFO - Reading from file tmpfile_stdout 09:53:56 INFO - Current package versions: 09:53:56 INFO - blessings == 1.6 09:53:56 INFO - blobuploader == 1.2.4 09:53:56 INFO - docopt == 0.6.1 09:53:56 INFO - functools32 == 3.2.3-2 09:53:56 INFO - jsonschema == 2.5.1 09:53:56 INFO - manifestparser == 1.1 09:53:56 INFO - mozInstall == 1.12 09:53:56 INFO - mozcrash == 0.17 09:53:56 INFO - mozdebug == 0.1 09:53:56 INFO - mozdevice == 0.48 09:53:56 INFO - mozfile == 1.2 09:53:56 INFO - mozhttpd == 0.7 09:53:56 INFO - mozinfo == 0.9 09:53:56 INFO - mozleak == 0.1 09:53:56 INFO - mozlog == 3.4 09:53:56 INFO - moznetwork == 0.27 09:53:56 INFO - mozprocess == 0.23 09:53:56 INFO - mozprofile == 0.28 09:53:56 INFO - mozrunner == 6.12 09:53:56 INFO - mozscreenshot == 0.1 09:53:56 INFO - mozsystemmonitor == 0.3 09:53:56 INFO - moztest == 0.7 09:53:56 INFO - mozversion == 1.4 09:53:56 INFO - psutil == 3.1.1 09:53:56 INFO - requests == 1.2.3 09:53:56 INFO - wsgiref == 0.1.2 09:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:57 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')]} 09:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:58 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 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:58 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 09:53:58 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 09:53:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:58 INFO - 'HOME': '/Users/cltbld', 09:53:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:58 INFO - 'LOGNAME': 'cltbld', 09:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:58 INFO - 'MOZ_NO_REMOTE': '1', 09:53:58 INFO - 'NO_EM_RESTART': '1', 09:53:58 INFO - 'PAGER': '/bin/cat', 09:53:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:58 INFO - 'PWD': '/builds/slave/test', 09:53:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:58 INFO - 'SHELL': '/bin/bash', 09:53:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:58 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:58 INFO - 'USER': 'cltbld', 09:53:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:58 INFO - 'XPC_FLAGS': '0x0', 09:53:58 INFO - 'XPC_SERVICE_NAME': '0', 09:53:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 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)) 09:53:58 INFO - Cleaning up... 09:53:58 INFO - Return code: 0 09:53:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:58 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')]} 09:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:58 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')]} 09:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:58 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 0x108988490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088fe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1cad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, '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.JNPg6eJp6h/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.XAZNtKrob2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 09:53:58 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 09:53:58 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 09:53:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:53:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:58 INFO - 'HOME': '/Users/cltbld', 09:53:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:58 INFO - 'LOGNAME': 'cltbld', 09:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:58 INFO - 'MOZ_NO_REMOTE': '1', 09:53:58 INFO - 'NO_EM_RESTART': '1', 09:53:58 INFO - 'PAGER': '/bin/cat', 09:53:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:58 INFO - 'PWD': '/builds/slave/test', 09:53:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:58 INFO - 'SHELL': '/bin/bash', 09:53:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:53:58 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:53:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:58 INFO - 'USER': 'cltbld', 09:53:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:58 INFO - 'XPC_FLAGS': '0x0', 09:53:58 INFO - 'XPC_SERVICE_NAME': '0', 09:53:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:53:58 INFO - Cleaning up... 09:53:59 INFO - Return code: 0 09:53:59 INFO - Running post-action listener: _resource_record_post_action 09:53:59 INFO - Running post-action listener: _start_resource_monitoring 09:53:59 INFO - Starting resource monitoring. 09:53:59 INFO - [mozharness: 2016-10-26 16:53:59.034599Z] Finished create-virtualenv step (success) 09:53:59 INFO - [mozharness: 2016-10-26 16:53:59.035568Z] Running install step. 09:53:59 INFO - Running pre-action listener: _resource_record_pre_action 09:53:59 INFO - Running main action method: install 09:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:59 INFO - Reading from file tmpfile_stdout 09:53:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:59 INFO - Reading from file tmpfile_stdout 09:53:59 INFO - Output received: 09:53:59 INFO - Usage: mozinstall [options] installer 09:53:59 INFO - Options: 09:53:59 INFO - -h, --help show this help message and exit 09:53:59 INFO - -d DEST, --destination=DEST 09:53:59 INFO - Directory to install application into. [default: 09:53:59 INFO - "/builds/slave/test"] 09:53:59 INFO - --app=APP Application being installed. [default: firefox] 09:53:59 INFO - mkdir: /builds/slave/test/build/application 09:53:59 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'] 09:53:59 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 09:54:33 INFO - Reading from file tmpfile_stdout 09:54:33 INFO - Output received: 09:54:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:54:33 INFO - Running post-action listener: _resource_record_post_action 09:54:33 INFO - [mozharness: 2016-10-26 16:54:33.946878Z] Finished install step (success) 09:54:33 INFO - [mozharness: 2016-10-26 16:54:33.947004Z] Running run-tests step. 09:54:33 INFO - Running pre-action listener: _resource_record_pre_action 09:54:33 INFO - Running main action method: run_tests 09:54:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:54:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:54:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:54:33 INFO - 2016-10-26 09:54:33.961 screenresolution[1645:7632] starting screenresolution argv=screenresolution get 09:54:33 INFO - 2016-10-26 09:54:33.964 screenresolution[1645:7632] Display 0: 1600x1200x32@60 09:54:33 INFO - 2016-10-26 09:54:33.970 screenresolution[1646:7634] starting screenresolution argv=screenresolution list 09:54:33 INFO - Available Modes on Display 0 09:54:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:54:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:54:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:54:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:54:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:54:34 INFO - Intel Iris: 09:54:34 INFO - Chipset Model: Intel Iris 09:54:34 INFO - Type: GPU 09:54:34 INFO - Bus: Built-In 09:54:34 INFO - VRAM (Dynamic, Max): 1536 MB 09:54:34 INFO - Vendor: Intel (0x8086) 09:54:34 INFO - Device ID: 0x0a2e 09:54:34 INFO - Revision ID: 0x0009 09:54:34 INFO - Displays: 09:54:34 INFO - Display: 09:54:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:54:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:54:34 INFO - Display Serial Number: 1600x1200 60 09:54:34 INFO - Main Display: Yes 09:54:34 INFO - Mirror: Off 09:54:34 INFO - Online: Yes 09:54:34 INFO - Rotation: Supported 09:54:34 INFO - Return code: 0 09:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:54:34 INFO - Python 2.7.3 09:54:34 INFO - Return code: 0 09:54:34 INFO - grabbing minidump binary from tooltool 09:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10879cd30>, '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 0x1085c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108794b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:54:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:54:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:54:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:54:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:54:34 INFO - Return code: 0 09:54:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:54:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 09:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --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 09:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JNPg6eJp6h/Render', 09:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:34 INFO - 'HOME': '/Users/cltbld', 09:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:34 INFO - 'LOGNAME': 'cltbld', 09:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:34 INFO - 'MOZ_NO_REMOTE': '1', 09:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:54:34 INFO - 'NO_EM_RESTART': '1', 09:54:34 INFO - 'PAGER': '/bin/cat', 09:54:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:34 INFO - 'PWD': '/builds/slave/test', 09:54:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:34 INFO - 'SHELL': '/bin/bash', 09:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XAZNtKrob2/Listeners', 09:54:34 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 09:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:34 INFO - 'USER': 'cltbld', 09:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:34 INFO - 'XPC_FLAGS': '0x0', 09:54:34 INFO - 'XPC_SERVICE_NAME': '0', 09:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 09:54:34 INFO - mozversion application_buildid: 20161026075925 09:54:34 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 09:54:34 INFO - mozversion application_display_name: Nightly 09:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:54:34 INFO - mozversion application_name: Firefox 09:54:34 INFO - mozversion application_remotingname: firefox 09:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:54:34 INFO - mozversion application_vendor: Mozilla 09:54:34 INFO - mozversion application_version: 52.0a1 09:54:34 INFO - mozversion platform_buildid: 20161026075925 09:54:34 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 09:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:54:34 INFO - mozversion platform_version: 52.0a1 09:54:34 INFO - using testdate: 1477500874 09:54:34 INFO - actual date: 1477500874 09:54:34 INFO - starting webserver on 'localhost:49272' 09:54:34 INFO - SUITE-START | Running 2 tests 09:54:34 INFO - TEST-START | dromaeo_css 09:54:34 INFO - operating with platform_type : mac_ 09:54:34 INFO - Initialising browser for dromaeo_css test... 09:54:34 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpCRKOn4/profile http://localhost:49272/getInfo.html) 09:54:37 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 09:54:37 INFO - PROCESS | 1656 | colorDepth:24 09:54:37 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 09:54:37 INFO - PROCESS | 1656 | __metrics 09:54:37 INFO - PROCESS | 1656 | 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" 09:54:37 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:54:37 INFO - TEST-INFO | 1656: exit 0 09:54:37 INFO - Browser initialized. 09:54:37 INFO - Running cycle 1/1 for dromaeo_css test... 09:54:37 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpCRKOn4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:49 INFO - PROCESS | 1658 | RSS: Main: 230756352 09:54:49 INFO - PROCESS | 1658 | 09:55:41 INFO - PROCESS | 1658 | 1477500941473 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] 09:57:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:57:55 INFO - PROCESS | 1658 | RSS: Main: 412917760 09:57:55 INFO - PROCESS | 1658 | 10:00:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 10:00:59 INFO - PROCESS | 1658 | RSS: Main: 372072448 10:00:59 INFO - PROCESS | 1658 | 10:04:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 10:04:02 INFO - PROCESS | 1658 | RSS: Main: 341999616 10:04:02 INFO - PROCESS | 1658 | 10:07:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 10:07:05 INFO - PROCESS | 1658 | RSS: Main: 351727616 10:07:05 INFO - PROCESS | 1658 | 10:10:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 10:10:09 INFO - PROCESS | 1658 | RSS: Main: 332636160 10:10:09 INFO - PROCESS | 1658 | 10:13:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 10:13:13 INFO - PROCESS | 1658 | RSS: Main: 422875136 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | __start_tp_report 10:13:13 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 10:13:13 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 10:13:13 INFO - PROCESS | 1658 | |i|pagename|runs| 10:13:13 INFO - PROCESS | 1658 | |0;dojo.html;3317.1541256979467;3324.900252992411;3347.6819702128305;3359.076254030143;3394.575678040245;4754.7860346284415;5578.163275508676;5669.716514174295;5685.317761868577;5778.566607504433;5668.631538949965;5692.715364231793;5772.538196944245;5780.913286300698;5808.738606762706;5041.57146642534;5101.51535604117;5111.769970351324;5172.612054095958;5191.039657663326;4584.404027476424;5218.373795144569;5272.92090618641;5306.442823503535;5337.039332920072;5243.3970093439175;5253.159494480865;5260.605454590883;5283.313169287987;5339.70631615261;5108.948910510921;5141.665791723563;5168.3539557555305;5168.8449346519665;5185.611079169077;5141.53726164647;5161.793528258865;5175.068487672217;5197.506236907488;5230.581553475713;4700.2009658358165;5700.828975130753;5733.262195273958;5741.913871291892;5742.97128514359;6101.389861013863;6114.71942267015;6143.3412978496;6201.255849298113;6230.657313847737;5275.920861187085;6131.595232866864;6151.0773383992755;6212.689365531705;6227.09707092469;4723.45680246776;5764.394738552475;5774.769009239667;5787;5793.159991801165;6166.383361663798;6305.684715764193;6312.684365781693;6321;6323.873522529616;5976.402359763989;6050.45545900871;6080.966235739935;6106.339326077069;6112.194539520766;6270.184875966095;6273.247210334789;6279.277883043417;6280.309165991737;6293.118963345044;6172.4136207060255;6198.659073750897;6216.7824126155365;6230.190075290183;6246;6109.070667813081;6111.713288451782;6112.419320164578;6184.134221209034;6235.407636274546;4876.902461950741;4923.630727695438;4930.038642464685;4933.136701077297;4936.555709986119;4390.385346051556;4422.955770442319;4501.279795232747;4503.617192538605;4506.459224892968;5777.075667893117;5796.072628379439;5797.971010145006;5798.9130163047585;5811.244538210006;6213.65824879636;6228.408301211378;6230.501559875199;6233.594816336924;6241.594296370721;5750.539956803445;5786.797462088806;5787.189793428924;5790.178482201727;5797.188393624896;5358.5177334039345;5364.6512976656395;5375.569954403638;5407.432219616962;5408.621396502207;6273.7176827042895;6292.968535157295;6307.337729538424;6326.810195694136;6328;6110.7250173741395;6140.136169957769;6300.086487459201;6307.873842523032;6316.936830631818;6216.658083805434;6272.996320588684;6287.591306565058;6290.716917738621;6314.968425157845;6174.567780255339;6175.475084617858;6181.103739957771;6185.226846644169;6202.751889924352;6092.543059270483;6253.968730156502;6265.749370025148;6281.780137695158;6283.02613094971;5938.109283607493;5962.970185149046;5983.341832398346;6061.878762424639;6066.908996365147;6090.817275481742;6108.511319094373;6110.741024289911;6121.173641558333;6133.50931925436;5867.237259156283;5921.14143449206;5922.230110085661;5926.67403292823;5929.881402371842;5944.3164036136395;5978.4021597839865;5995.700214989146;6043.939560604338;6104.755809767559;5875.294964604275;5926.555508336805;5927.081302398135;6018.4583387493585;6021.367756385516 10:13:13 INFO - PROCESS | 1658 | |1;ext.html;422.37066770511933;469.4577762684099;530.014173637035;539.7382269599246;544;24948.87525562372;26921.865390673018;32182.712691492314;32364.514532282035;32369.497185478467;35272.470912936325;43160.56839431605;43650.78174609123;45046;45058.09883802322;9618.134367906887;9771.853422198672;9773.609055637766;9777.755556111082;9802.656907008257;7512.511686740344;9703.2722545809;9775.413475191475;9781.608735650565;9788.55951482185;8440.451370660887;11786.292822430638;11967.401629918513;11991.520339186422;12143.210691305081;10541.631042913461;11406.574178227722;11850.466728997173;11858.110641701907;11887;11634.6509604712;11695.824562631567;11706.12204084697;11730.824037639442;11886.167968242227;39524;39771.8011409944;39843.40234896479;39965.40051899195;40024;2898.68114507404;3385.39062968668;3509.982450087759;3659.0669379308106;3661.780293182391;23227.883860580758;25019;30703.846480767676;30991.535126973115;31396.21509462259;3127.9061628151194;3204.2309845637114;3239.64363919971;3260.4294248506653;3270.149761062141;316539;318469;318970;319715;320503;55991;56230.939215470804;56237;56280.718596406754;56311.43688563062;31770.682293177233;32002.839985800387;32224.83887580547;32357.676423235465;32406.83796581002;16007.919960400124;16147.192640367935;16162.030278183347;16170.27233774483;16187.838121618868;12319.753604927851;12421.130520863633;12449.128561000824;12449.377531123408;12463;16241.350345986264;16409.179541022902;16534;18928.62142757165;18942.43172704821;7557.319841214317;7785.174657790501;7956.880646790303;7979;8013.6794528218215;734.937530309919;997.7749618351118;1053.3206082077018;1061.8991195836384;1099.378850949211;27790.16629501078;29679.703202968125;29997;30372.392552148835;30649.233769155948;1020.7193021918883;1057.5663977769232;1074.5648012554927;1139.8290256461432;1149.827525871126;15654.45209417665;15672.529824105295;15674.529764107096;15938.442154524537;16049;607712;613188;613520;614007.9299603563;614208;49461;50392.24411633828;54623;55967.44032559704;56259;1324.5893772930422;1371.1978492581952;1372.5882235329561;1379.1035826712716;1381.3231516557016;25204.243872683848;30387.58142204679;30935;31097;32192;38001.049973749774;48201;48488;48540.75729621329;48605.513944861515;540835;545220;791953;817034;818433;39891.601083989946;40300.99247518835;40375.59624403718;40912.59087409088;41161.58838411697;44749.55250447454;44968;45545.54454455546;45590.08819823651;45725.54274457213;37559.62440375561;37820.810895945346;38289.80855095707;39052.41421378625;39160.80419597884;37639.435408468344;37915.62084379121;38534.42198366971;39045.02387440337;39354.60645393509;36739.63260367469;37470.06324841901;37550.81224593859;37551.620354168255;39361.40957885691;32388.60758234494;33118.834405827816;34482.65517344895;34707.305853883285;34855.47716784301;24200.668963206488;25507;25672.871635641703;25756.742432576182;26222.475550489264 10:13:13 INFO - PROCESS | 1658 | |2;jquery.html;332.25574712643686;370;379.9810009499525;388.5997422654665;412.1694785008209;15118.773218401719;15335.923320383396;16903.23935422906;20293.49266268344;20961.266355677555;19872.9006354968;20536.589268214662;20696.68954965673;20897.37307880762;21076.57846843066;4476.843310484133;5319.441458646835;5558.6942718150485;5560.555155587564;5581.302337207849;6019.3980601939675;6084.908726369108;6134.723937422827;6151.169592105053;6158.599691020092;5397.2443857859935;5463.48096930791;5938.617981508538;6098.878022439549;6103.389661033883;5464.890702185974;5519.420460851633;5521.585881058896;5529;5529.612927095105;5206.088934436459;5280.3663560372615;5301.575873930076;5359.196120581905;5372.7045012524295;13286.402111904987;13385.397657105454;13433.19400835953;13516.729665406736;13577.253251071186;2111.9788802111934;2172.7609962904066;2303.608386574286;2305.8155347572156;2706.9052583159496;9918.801623967553;12262.896339329414;12608.495660173581;15464.564107158776;15767.211639417983;1835.5869929265941;1877.7840548336978;1916.2718167096414;1920.0319672335827;2021.1006102284489;116613;120289;122729;122956.54086918301;125439.49121017529;11115.610953616584;11300.830487542693;11495.367754773568;11507.309561426173;11759.706007349714;14494.492692755914;14500.419983200554;14509.564713058626;14515.983881128219;14523.128612283297;6529;8392.580370981426;8423.873641895376;8523.445976011664;8543.188397102265;6611.834704132339;7117.466190035664;8044.758657240292;8317.500949943023;8475.406721529556;4498.212812757754;4505.211587972091;4522.615577675869;4529.728216307032;4577.702449340783;1450.6373406648338;1790.873730776526;1822.7630408047135;1898.7246849206788;1962.9214831406584;847.7583888591722;912.7991841794794;914.9588268527932;921.9170274675178;925.5233554719325;19779;20904.163833446797;21053.84203868771;21306.633940953947;21445.356639300848;916.6241840845222;948.2224575847739;948.8671585977969;977.6333874796951;1030.1449796668746;10566.577336906592;11224;11228.157888158257;11244.66266012021;11252.381119038531;489771;492454;496094;578792;591930;127064.36467817602;129411;130861.69138308495;130989;133170;939.4034787909726;978.2174260591498;1007.5163921317809;1020.6019652335596;1022.5040855185377;14873.628159296104;15174.924125379302;18932.43202703921;18965.43103706891;19942.90028549848;54355.06047864796;54926.72536637291;55020.724896375265;55736.44263557313;55970.60073498195;76490;77113;77610.6716798497;79158.60420697859;79323;7729.381649468141;7757.92242077572;7931.127575966524;8014.879776803469;8017.594721583385;9038;12143.14997950135;12449.626511204679;12505.874941250471;12620.305883176514;9458.858117128386;10776.784464310513;10838.349699018085;10912.127029837435;11151.933218365015;10457.529411176667;10551.683449496528;10718.338657508099;10761.784764304826;10762.946185269024;10827.566897324019;11128.721781955515;11160.162987775788;11299.039581635652;11342.489587968726;7783.649735762017;7844.568548729646;7979.640916158671;8096.919030809617;8169.632366543401;8135.901653276732;10704.518296676824;10984.725381865197;11051.336919784517;11104.944475277573 10:13:13 INFO - PROCESS | 1658 | |3;mootools.html;1464.3264098514683;1551.6431220819209;1773.6807374672553;1921.4139687395357;1958.1873522488158;8299.543525106117;8674.306055515559;8684;8694.434861733991;8721.040685524587;7566;7865.488743231686;7865.646045927932;7947.682092716284;7956.4828286161355;2248.336740661505;2339.4502291961376;2344.6131388320905;2348.367884320398;2355.057976809273;2356.0929042318658;2368;2399.7720216579396;2400.7719266669637;2403.735589085199;2352.3531028967;2371.3241726108063;2371.4308565944134;2372.51363470489;2373.181252467896;1985.2555291765589;2314.2941402872116;2333.661619065226;2341.484873327865;2354.058376649337;2335.1710142899365;2342.2856028911174;2369.6327069304284;2371.324172610815;2372.9881350593137;8542.658293668246;8632.697855575025;8640.697575584887;8661.263792577638;8698.695545655935;5139.254808052811;5293.470652934714;5295;5295.894082118336;5305;2947.7199666031693;3370.679785420381;3524.207053412987;3593.1376469647357;3594.856205751767;971.2958105373618;1024.948752562369;1062.102523367753;1076.860008198937;1079.3955384984433;9696.660616878446;11320.26418282809;11334.829977550344;11370.658880233523;11378.31730096197;4464.486584042812;4637.7449240291435;4733.455652599995;4751.909159969671;4802.351682522814;9642.95178524117;9748.610055597697;9766.974467680791;9774.071463210983;9778.315517913677;5299.019681358884;5392.946070539323;5397.460253974571;5398.109311963561;5401.054815407367;4351.151525452569;4560.84037058708;4778.904421911542;4884.974155427329;4901.019796040806;3580.874669386559;3688.0595448161084;3689.815509224528;3696.796676182782;3700.2784457031157;1070.464767616192;1197.8143387774908;1249.4814651919532;1249.9062570307262;1272.5418849214275;908.1735620585367;923.409018228321;927.6456373694347;928.6888892221046;988.8615593816871;5431.34823821144;5854.7072646367515;5912.201852749824;6131.754729810847;6134.8159555213415;904.2856143646577;907.8456662367413;941.204682043672;964.4298488565402;972.5866506734609;3725.701943844486;3876.8643097491454;3928.842846286174;4011.438398624195;4013.7190396672536;7781.727639532703;10356.430396328124;10425.582976680847;10452.425116618659;10474.581016759397;10411.791764164826;10412.843807342895;10424.113950314308;10445.477726113664;10456.424896630759;7637.15991240963;8022.879656805036;8065.870778091072;8163.673453061811;8173.427860049739;5933.110033495011;5976.832278892194;5981.671008094597;6056.121862329849;6120.265568131853;9328.253739700944;9663.226941844496;9670.274729395183;9751.219902407933;9810.509474526389;9576.664816731382;9744.561494732612;9898.257630677585;9946.850797238192;9948.751281218027;7183.5330703504105;7307.02710268214;7360.116785985716;7416.592087435243;7424.8143796403365;7250.383717384081;8034.116247212919;8094.190580941859;8102.270795628422;8118.431709780259;6343.55595108338;7273.0181425509;7307.2327405621645;7332.266773322838;7346.816329591803;7107.644617769194;7190.6404679764755;7194.2086370498155;7245.7826265212125;7255;5895.94104058954;5921.289445266596;6789.490788191004;6911.827204319932;6936.4797640176175;4864.562189402829;4873.561379475864;4987.326710893983;5018.974905125451;5147.841735609458;4919.975400122977;5002.449730529566;5032.446430892525;5059.114654935445;5173.63784535079 10:13:13 INFO - PROCESS | 1658 | |4;prototype.html;300.32726692209457;301.3310450799226;310.6831032347005;313.5375321400934;314.19409215362606;4441.733495990243;5251.002309561185;5287.576993840488;5302.08385388037;5360.731963401829;3723.9704361123186;4327.502337231212;4341.956580434195;4932.457429682732;5124.615653825959;3904.809033244859;3989.960100398988;3999.22015207034;4016.3975403689533;4061.776602286873;3361.7646764726355;3507.2985402919517;4024.839006439739;4031.6169963853386;4044.6562042226446;3169.2710676544293;3587.3004764071015;3998.860039898604;4013.6387725104737;4035.939460908074;3508.736844736642;3852.5376954765466;3970.1265721541213;3975.324194886847;4012;3430.2967891582416;3433.8111403872776;3437.5187473753695;3445.3970555153;3458.948115778265;5105.336306280197;5141.5115564021735;5142.820001299974;5199.766010529535;5200.713960732158;4373.671974601886;4423.292273236267;4536.319552067183;4580.473245576768;4581.816727330903;5514.834554963358;5525.254090697745;5546.223528705985;5546.667199967975;5565.41563135873;3757.586665466824;3758.39865621502;3772.264408440355;3775.754575952582;3792.639699228569;5467.371252305996;5509.135249670149;5633.887322253532;5806.22910012446;5851.736671849777;3315.9171020724193;3501.824908754552;3772.396416573335;3839.155385815116;3840.5007349044445;3910.2179564086728;3910.9804450977563;3918.7844668542934;3921.6666583340734;3923;4204.495460544754;4241.830326786956;4558.9772051139535;4559.726416415026;4581.839635612738;5080.74596270185;5532.585056120726;5576.693281869536;5595.195267218331;5606.6636001840025;1293.6701141208932;1317.7693903566837;1327.349598696651;1328.4088580581742;1338.9866101339057;829.8589439520659;851.1020872979067;853.0701535326524;876.8031636815828;904.3895370624801;4283.571642835692;5223.2948551945;5246.029484545371;5260.605454590921;5292.629515933924;4579.450465944042;5345.65253258537;5455.236266922634;5641.351244606841;5706.429357064343;4359.694821362537;4691.437027556715;5163.870903227375;5241.217985884818;5245.082110630625;2687.475942191254;2970.702929707012;2975.5090410082526;2981.6720160782297;2983.7165469280385;5000.0499605312125;5501.0098182327565;5612.831615051555;5726.885462290814;5749.706316078848;4847.903041939141;5010.797408621905;5606.196901549225;5717.799877004285;5720.598453378949;4928.704277743275;5449.863753406038;5648.915266271009;5756.913646295309;5803.622764520293;4884.780184891617;5147.6654017488745;5299.178627312773;5596.664200148004;5642.294713160855;4506.842260520866;4693.671442998957;5588.916166257428;5593.720313984203;5595.558731380253;5505.724713764376;5802.6808525531505;5805.535557155502;5813.854653633693;5835.67903765297;2971.4205729882465;3772.283955551998;3790.6019867913474;3838.1556057667267;3866.9419958701205;4984.925226121683;5532.419095994863;5722.570807189561;5749.885002299847;5771.538276937918;4877.439094504178;4921.883590056167;5615.775368985358;5638.887222255614;5640.730835561966;4714.504976977368;4987.376577927759;5553;5598.300212473441;5600.35595906476;3995.841206050213;5390.97304513475;5415;5457.808976685797;5498.340199176125;4674.859754207379;4804.726747412008;5340.465953404629;5573.665580065209;5622.831315060391;5539.362973258127;5539.396483652677;5540.260324281175;5543.417941116125;5561.555075594024 10:13:13 INFO - PROCESS | 1658 | |5;yui.html;714.4355958792554;732.4726197138059;771.0400551313616;803.216863558031;823.7446391618595;15246.313915873785;15519;15545.766813497807;15547.611309717262;15566.299516521756;13901.513447029356;14026.649333766662;14034;14053.297335133253;14062.085964412307;704.7322017633293;723.6851969393331;724.6340597998004;875.6103533927405;877.7191298784392;883.337496877342;888.8933328000617;895.511945989434;897.4391005621486;899.5727029660892;958.7842735384553;958.9328746987713;960.2126256469697;960.3133759362055;962.6101428921298;952.599908038622;952.8951815300311;955.8327292723781;956.2493442647558;958.1137447860771;546.0716781471475;564.5596434780878;677.4377266868487;700.7792545348199;703.8908969109796;12066.577669781604;14790.890683198802;14817.333220005126;14878.181700006495;14884.181370024644;13361.66595835102;13496.865031349756;13525.188488690612;13573.796393054112;13655.795163072562;12130.332831694253;12161;12208.08439367051;12388.876111238862;12479.376031198495;4298.505671847715;4377.562243775629;4380.824767009316;4445.866624001285;4522.29904364824;87852.56073719655;87939.68090478648;88042;88254.55872720595;88357.55821220917;10459.633912813168;10481.790364192673;10640.308379955279;10640.733981650521;10688.78622427547;21135.260265890927;21168.259110931045;21171.576568468852;21172.47068823261;21175.470613234793;7626.42801789868;7689.231076892266;7777.533347999025;7785.961070194613;7849.01887264092;4237.406763053175;4244.087521182961;4324.502682191525;4337.7614231217585;4486.551344865553;3416;3520.1727594015388;3520.7359448041498;3523.3834079036064;3528.2414280929725;549.2722143160329;623.2583225961092;623.7941479311907;624.7046827982429;631.1479502671449;531.44994930247;582.7552427980258;584.8303991842403;632.276043929698;637.1048676609371;7745.683233850259;8365.476978513856;8541.957290213633;8679.826403472021;8706.738797836075;483.04617265421695;574.7528562718071;575.6776205325032;628.6470701972706;638.6040654793965;4212.441396683247;4253.149370125925;4421.093675796454;4756.262779269219;4769.165396055746;107104;112447.43776281066;113147;116657;117493;97773.19505859536;100244.99755002503;102291;103122;104906;90255;90708.30083788408;92172.07827921769;92188;94062.0593794067;9614.663486777928;9722.173615242784;9743.853842192231;9745;9780.315377923476;45513.77243113763;55583.72208138934;55853.603659908826;57140.714296428254;57920.2623921283;63197.68401157965;75519.62240188764;84473.57763211144;84795;86491;12069.879301207227;12846.743065138831;12872.871271287167;13033.674158146123;13366.398512067175;11874.709195846024;14164.787528187291;14369.425222990963;14714.852851471349;15300.846991529943;13047.086703931014;13260.53588124411;13476.730465390441;13548.729025419634;13738.313084345542;13154.165502375048;13168.934155329545;13487.393067311797;13549.86450135486;13551.322433878464;12785.474162295423;12918.870811292143;13433.462661493822;13570.525031623845;13688.041837071707;10801.837972430578;10956.890431095906;11135.443227838738;11543.422828858356;11558.653240402466;10279.383237005804;10968.725781855199;11236.213465057368;11325.603603873826;11332.093432525213 10:13:13 INFO - PROCESS | 1658 | __end_tp_report 10:13:13 INFO - PROCESS | 1658 | __start_cc_report 10:13:13 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1786 10:13:13 INFO - PROCESS | 1658 | __end_cc_report 10:13:13 INFO - PROCESS | 1658 | __startTimestamp1477501993078__endTimestamp 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | ------- Summary: start ------- 10:13:13 INFO - PROCESS | 1658 | Number of tests: 6 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5712.71 Median:5927.08 stddev:649.59 (11.0%) stddev-sans-first:623.80 10:13:13 INFO - PROCESS | 1658 | Values: 3317.2 3324.9 3347.7 3359.1 3394.6 4754.8 5578.2 5669.7 5685.3 5778.6 5668.6 5692.7 5772.5 5780.9 5808.7 5041.6 5101.5 5111.8 5172.6 5191.0 4584.4 5218.4 5272.9 5306.4 5337.0 5243.4 5253.2 5260.6 5283.3 5339.7 5108.9 5141.7 5168.4 5168.8 5185.6 5141.5 5161.8 5175.1 5197.5 5230.6 4700.2 5700.8 5733.3 5741.9 5743.0 6101.4 6114.7 6143.3 6201.3 6230.7 5275.9 6131.6 6151.1 6212.7 6227.1 4723.5 5764.4 5774.8 5787.0 5793.2 6166.4 6305.7 6312.7 6321.0 6323.9 5976.4 6050.5 6081.0 6106.3 6112.2 6270.2 6273.2 6279.3 6280.3 6293.1 6172.4 6198.7 6216.8 6230.2 6246.0 6109.1 6111.7 6112.4 6184.1 6235.4 4876.9 4923.6 4930.0 4933.1 4936.6 4390.4 4423.0 4501.3 4503.6 4506.5 5777.1 5796.1 5798.0 5798.9 5811.2 6213.7 6228.4 6230.5 6233.6 6241.6 5750.5 5786.8 5787.2 5790.2 5797.2 5358.5 5364.7 5375.6 5407.4 5408.6 6273.7 6293.0 6307.3 6326.8 6328.0 6110.7 6140.1 6300.1 6307.9 6316.9 6216.7 6273.0 6287.6 6290.7 6315.0 6174.6 6175.5 6181.1 6185.2 6202.8 6092.5 6254.0 6265.7 6281.8 6283.0 5938.1 5963.0 5983.3 6061.9 6066.9 6090.8 6108.5 6110.7 6121.2 6133.5 5867.2 5921.1 5922.2 5926.7 5929.9 5944.3 5978.4 5995.7 6043.9 6104.8 5875.3 5926.6 5927.1 6018.5 6021.4 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:67102.63 Median:18934.02 stddev:154381.72 (815.4%) stddev-sans-first:154733.62 10:13:13 INFO - PROCESS | 1658 | Values: 422.4 469.5 530.0 539.7 544.0 24948.9 26921.9 32182.7 32364.5 32369.5 35272.5 43160.6 43650.8 45046.0 45058.1 9618.1 9771.9 9773.6 9777.8 9802.7 7512.5 9703.3 9775.4 9781.6 9788.6 8440.5 11786.3 11967.4 11991.5 12143.2 10541.6 11406.6 11850.5 11858.1 11887.0 11634.7 11695.8 11706.1 11730.8 11886.2 39524.0 39771.8 39843.4 39965.4 40024.0 2898.7 3385.4 3510.0 3659.1 3661.8 23227.9 25019.0 30703.8 30991.5 31396.2 3127.9 3204.2 3239.6 3260.4 3270.1 316539.0 318469.0 318970.0 319715.0 320503.0 55991.0 56230.9 56237.0 56280.7 56311.4 31770.7 32002.8 32224.8 32357.7 32406.8 16007.9 16147.2 16162.0 16170.3 16187.8 12319.8 12421.1 12449.1 12449.4 12463.0 16241.4 16409.2 16534.0 18928.6 18942.4 7557.3 7785.2 7956.9 7979.0 8013.7 734.9 997.8 1053.3 1061.9 1099.4 27790.2 29679.7 29997.0 30372.4 30649.2 1020.7 1057.6 1074.6 1139.8 1149.8 15654.5 15672.5 15674.5 15938.4 16049.0 607712.0 613188.0 613520.0 614007.9 614208.0 49461.0 50392.2 54623.0 55967.4 56259.0 1324.6 1371.2 1372.6 1379.1 1381.3 25204.2 30387.6 30935.0 31097.0 32192.0 38001.0 48201.0 48488.0 48540.8 48605.5 540835.0 545220.0 791953.0 817034.0 818433.0 39891.6 40301.0 40375.6 40912.6 41161.6 44749.6 44968.0 45545.5 45590.1 45725.5 37559.6 37820.8 38289.8 39052.4 39160.8 37639.4 37915.6 38534.4 39045.0 39354.6 36739.6 37470.1 37550.8 37551.6 39361.4 32388.6 33118.8 34482.7 34707.3 34855.5 24200.7 25507.0 25672.9 25756.7 26222.5 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:32872.49 Median:11809.06 stddev:89714.32 (759.7%) stddev-sans-first:89932.72 10:13:13 INFO - PROCESS | 1658 | Values: 332.3 370.0 380.0 388.6 412.2 15118.8 15335.9 16903.2 20293.5 20961.3 19872.9 20536.6 20696.7 20897.4 21076.6 4476.8 5319.4 5558.7 5560.6 5581.3 6019.4 6084.9 6134.7 6151.2 6158.6 5397.2 5463.5 5938.6 6098.9 6103.4 5464.9 5519.4 5521.6 5529.0 5529.6 5206.1 5280.4 5301.6 5359.2 5372.7 13286.4 13385.4 13433.2 13516.7 13577.3 2112.0 2172.8 2303.6 2305.8 2706.9 9918.8 12262.9 12608.5 15464.6 15767.2 1835.6 1877.8 1916.3 1920.0 2021.1 116613.0 120289.0 122729.0 122956.5 125439.5 11115.6 11300.8 11495.4 11507.3 11759.7 14494.5 14500.4 14509.6 14516.0 14523.1 6529.0 8392.6 8423.9 8523.4 8543.2 6611.8 7117.5 8044.8 8317.5 8475.4 4498.2 4505.2 4522.6 4529.7 4577.7 1450.6 1790.9 1822.8 1898.7 1962.9 847.8 912.8 915.0 921.9 925.5 19779.0 20904.2 21053.8 21306.6 21445.4 916.6 948.2 948.9 977.6 1030.1 10566.6 11224.0 11228.2 11244.7 11252.4 489771.0 492454.0 496094.0 578792.0 591930.0 127064.4 129411.0 130861.7 130989.0 133170.0 939.4 978.2 1007.5 1020.6 1022.5 14873.6 15174.9 18932.4 18965.4 19942.9 54355.1 54926.7 55020.7 55736.4 55970.6 76490.0 77113.0 77610.7 79158.6 79323.0 7729.4 7757.9 7931.1 8014.9 8017.6 9038.0 12143.1 12449.6 12505.9 12620.3 9458.9 10776.8 10838.3 10912.1 11151.9 10457.5 10551.7 10718.3 10761.8 10762.9 10827.6 11128.7 11160.2 11299.0 11342.5 7783.6 7844.6 7979.6 8096.9 8169.6 8135.9 10704.5 10984.7 11051.3 11104.9 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5561.69 Median:5297.46 stddev:3054.29 (57.7%) stddev-sans-first:3047.33 10:13:13 INFO - PROCESS | 1658 | Values: 1464.3 1551.6 1773.7 1921.4 1958.2 8299.5 8674.3 8684.0 8694.4 8721.0 7566.0 7865.5 7865.6 7947.7 7956.5 2248.3 2339.5 2344.6 2348.4 2355.1 2356.1 2368.0 2399.8 2400.8 2403.7 2352.4 2371.3 2371.4 2372.5 2373.2 1985.3 2314.3 2333.7 2341.5 2354.1 2335.2 2342.3 2369.6 2371.3 2373.0 8542.7 8632.7 8640.7 8661.3 8698.7 5139.3 5293.5 5295.0 5295.9 5305.0 2947.7 3370.7 3524.2 3593.1 3594.9 971.3 1024.9 1062.1 1076.9 1079.4 9696.7 11320.3 11334.8 11370.7 11378.3 4464.5 4637.7 4733.5 4751.9 4802.4 9643.0 9748.6 9767.0 9774.1 9778.3 5299.0 5392.9 5397.5 5398.1 5401.1 4351.2 4560.8 4778.9 4885.0 4901.0 3580.9 3688.1 3689.8 3696.8 3700.3 1070.5 1197.8 1249.5 1249.9 1272.5 908.2 923.4 927.6 928.7 988.9 5431.3 5854.7 5912.2 6131.8 6134.8 904.3 907.8 941.2 964.4 972.6 3725.7 3876.9 3928.8 4011.4 4013.7 7781.7 10356.4 10425.6 10452.4 10474.6 10411.8 10412.8 10424.1 10445.5 10456.4 7637.2 8022.9 8065.9 8163.7 8173.4 5933.1 5976.8 5981.7 6056.1 6120.3 9328.3 9663.2 9670.3 9751.2 9810.5 9576.7 9744.6 9898.3 9946.9 9948.8 7183.5 7307.0 7360.1 7416.6 7424.8 7250.4 8034.1 8094.2 8102.3 8118.4 6343.6 7273.0 7307.2 7332.3 7346.8 7107.6 7190.6 7194.2 7245.8 7255.0 5895.9 5921.3 6789.5 6911.8 6936.5 4864.6 4873.6 4987.3 5019.0 5147.8 4920.0 5002.4 5032.4 5059.1 5173.6 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4437.26 Median:4986.15 stddev:1364.50 (27.4%) stddev-sans-first:1332.53 10:13:13 INFO - PROCESS | 1658 | Values: 300.3 301.3 310.7 313.5 314.2 4441.7 5251.0 5287.6 5302.1 5360.7 3724.0 4327.5 4342.0 4932.5 5124.6 3904.8 3990.0 3999.2 4016.4 4061.8 3361.8 3507.3 4024.8 4031.6 4044.7 3169.3 3587.3 3998.9 4013.6 4035.9 3508.7 3852.5 3970.1 3975.3 4012.0 3430.3 3433.8 3437.5 3445.4 3458.9 5105.3 5141.5 5142.8 5199.8 5200.7 4373.7 4423.3 4536.3 4580.5 4581.8 5514.8 5525.3 5546.2 5546.7 5565.4 3757.6 3758.4 3772.3 3775.8 3792.6 5467.4 5509.1 5633.9 5806.2 5851.7 3315.9 3501.8 3772.4 3839.2 3840.5 3910.2 3911.0 3918.8 3921.7 3923.0 4204.5 4241.8 4559.0 4559.7 4581.8 5080.7 5532.6 5576.7 5595.2 5606.7 1293.7 1317.8 1327.3 1328.4 1339.0 829.9 851.1 853.1 876.8 904.4 4283.6 5223.3 5246.0 5260.6 5292.6 4579.5 5345.7 5455.2 5641.4 5706.4 4359.7 4691.4 5163.9 5241.2 5245.1 2687.5 2970.7 2975.5 2981.7 2983.7 5000.0 5501.0 5612.8 5726.9 5749.7 4847.9 5010.8 5606.2 5717.8 5720.6 4928.7 5449.9 5648.9 5756.9 5803.6 4884.8 5147.7 5299.2 5596.7 5642.3 4506.8 4693.7 5588.9 5593.7 5595.6 5505.7 5802.7 5805.5 5813.9 5835.7 2971.4 3772.3 3790.6 3838.2 3866.9 4984.9 5532.4 5722.6 5749.9 5771.5 4877.4 4921.9 5615.8 5638.9 5640.7 4714.5 4987.4 5553.0 5598.3 5600.4 3995.8 5391.0 5415.0 5457.8 5498.3 4674.9 4804.7 5340.5 5573.7 5622.8 5539.4 5539.4 5540.3 5543.4 5561.6 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:21339.72 Median:4357.66 stddev:31393.38 (720.4%) stddev-sans-first:31443.24 10:13:13 INFO - PROCESS | 1658 | Values: 714.4 732.5 771.0 803.2 823.7 15246.3 15519.0 15545.8 15547.6 15566.3 13901.5 14026.6 14034.0 14053.3 14062.1 704.7 723.7 724.6 875.6 877.7 883.3 888.9 895.5 897.4 899.6 958.8 958.9 960.2 960.3 962.6 952.6 952.9 955.8 956.2 958.1 546.1 564.6 677.4 700.8 703.9 12066.6 14790.9 14817.3 14878.2 14884.2 13361.7 13496.9 13525.2 13573.8 13655.8 12130.3 12161.0 12208.1 12388.9 12479.4 4298.5 4377.6 4380.8 4445.9 4522.3 87852.6 87939.7 88042.0 88254.6 88357.6 10459.6 10481.8 10640.3 10640.7 10688.8 21135.3 21168.3 21171.6 21172.5 21175.5 7626.4 7689.2 7777.5 7786.0 7849.0 4237.4 4244.1 4324.5 4337.8 4486.6 3416.0 3520.2 3520.7 3523.4 3528.2 549.3 623.3 623.8 624.7 631.1 531.4 582.8 584.8 632.3 637.1 7745.7 8365.5 8542.0 8679.8 8706.7 483.0 574.8 575.7 628.6 638.6 4212.4 4253.1 4421.1 4756.3 4769.2 107104.0 112447.4 113147.0 116657.0 117493.0 97773.2 100245.0 102291.0 103122.0 104906.0 90255.0 90708.3 92172.1 92188.0 94062.1 9614.7 9722.2 9743.9 9745.0 9780.3 45513.8 55583.7 55853.6 57140.7 57920.3 63197.7 75519.6 84473.6 84795.0 86491.0 12069.9 12846.7 12872.9 13033.7 13366.4 11874.7 14164.8 14369.4 14714.9 15300.8 13047.1 13260.5 13476.7 13548.7 13738.3 13154.2 13168.9 13487.4 13549.9 13551.3 12785.5 12918.9 13433.5 13570.5 13688.0 10801.8 10956.9 11135.4 11543.4 11558.7 10279.4 10968.7 11236.2 11325.6 11332.1 10:13:13 INFO - PROCESS | 1658 | -------- Summary: end -------- 10:13:13 INFO - PROCESS | 1658 | 10:13:13 INFO - TEST-INFO | 1658: exit 0 10:13:13 INFO - TEST-OK | dromaeo_css | took 1119312ms 10:13:13 INFO - TEST-START | kraken 10:13:13 INFO - operating with platform_type : mac_ 10:13:13 INFO - Initialising browser for kraken test... 10:13:13 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmplWB0py/profile http://localhost:49272/getInfo.html) 10:13:16 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 10:13:16 INFO - PROCESS | 1665 | colorDepth:24 10:13:16 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 10:13:16 INFO - PROCESS | 1665 | __metrics 10:13:16 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:13:16 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:13:17 INFO - TEST-INFO | 1665: exit 0 10:13:17 INFO - Browser initialized. 10:13:17 INFO - Running cycle 1/1 for kraken test... 10:13:17 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmplWB0py/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:29 INFO - PROCESS | 1666 | RSS: Main: 231698432 10:13:29 INFO - PROCESS | 1666 | 10:13:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 10:13:32 INFO - PROCESS | 1666 | RSS: Main: 290357248 10:13:32 INFO - PROCESS | 1666 | 10:13:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 10:13:36 INFO - PROCESS | 1666 | RSS: Main: 291790848 10:13:36 INFO - PROCESS | 1666 | 10:13:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 10:13:40 INFO - PROCESS | 1666 | RSS: Main: 383553536 10:13:40 INFO - PROCESS | 1666 | 10:13:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 10:13:43 INFO - PROCESS | 1666 | RSS: Main: 285294592 10:13:43 INFO - PROCESS | 1666 | 10:13:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:13:45 INFO - PROCESS | 1666 | RSS: Main: 289607680 10:13:45 INFO - PROCESS | 1666 | 10:13:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 10:13:49 INFO - PROCESS | 1666 | RSS: Main: 327626752 10:13:49 INFO - PROCESS | 1666 | 10:13:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 10:13:52 INFO - PROCESS | 1666 | RSS: Main: 328343552 10:13:52 INFO - PROCESS | 1666 | 10:13:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 10:13:55 INFO - PROCESS | 1666 | RSS: Main: 326995968 10:13:55 INFO - PROCESS | 1666 | 10:13:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:13:57 INFO - PROCESS | 1666 | RSS: Main: 303083520 10:13:57 INFO - PROCESS | 1666 | 10:13:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:00 INFO - PROCESS | 1666 | RSS: Main: 305332224 10:14:00 INFO - PROCESS | 1666 | 10:14:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:14:03 INFO - PROCESS | 1666 | RSS: Main: 309854208 10:14:03 INFO - PROCESS | 1666 | 10:14:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:14:07 INFO - PROCESS | 1666 | RSS: Main: 318025728 10:14:07 INFO - PROCESS | 1666 | 10:14:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:14:10 INFO - PROCESS | 1666 | RSS: Main: 318062592 10:14:10 INFO - PROCESS | 1666 | 10:14:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 10:14:13 INFO - PROCESS | 1666 | RSS: Main: 361709568 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | __start_tp_report 10:14:13 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 10:14:13 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 10:14:13 INFO - PROCESS | 1666 | |i|pagename|runs| 10:14:13 INFO - PROCESS | 1666 | |0;ai-astar;103;114;112;113;113;114;110;114;112;113 10:14:13 INFO - PROCESS | 1666 | |1;audio-beat-detection;150;113;114;154;114;115;137;145;178;109 10:14:13 INFO - PROCESS | 1666 | |2;audio-dft;184;179;181;186;185;218;265;182;183;182 10:14:13 INFO - PROCESS | 1666 | |3;audio-fft;80;59;61;88;60;59;60;58;83;57 10:14:13 INFO - PROCESS | 1666 | |4;audio-oscillator;88;72;89;69;67;69;123;98;100;89 10:14:13 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;87;84;87;84;86;83;86;84;86;84 10:14:13 INFO - PROCESS | 1666 | |6;imaging-darkroom;93;94;93;94;93;93;93;92;93;92 10:14:13 INFO - PROCESS | 1666 | |7;imaging-desaturate;84;81;78;81;82;80;84;85;81;81 10:14:13 INFO - PROCESS | 1666 | |8;json-parse-financial;56;53;55;54;55;54;56;54;54;55 10:14:13 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;69;68;67;75;69;68;69;70;70;70 10:14:13 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;91;86;87;87;89;86;85;93;106;108 10:14:13 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;149;146;148;138;151;155;156;143;181;148 10:14:13 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;183;215;199;233;169;237;227;168;164;170 10:14:13 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;70;66;68;68;68;68;70;78;87;87 10:14:13 INFO - PROCESS | 1666 | __end_tp_report 10:14:13 INFO - PROCESS | 1666 | __start_cc_report 10:14:13 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1996 10:14:13 INFO - PROCESS | 1666 | __end_cc_report 10:14:13 INFO - PROCESS | 1666 | __startTimestamp1477502053000__endTimestamp 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | ------- Summary: start ------- 10:14:13 INFO - PROCESS | 1666 | Number of tests: 14 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.33 (2.9%) stddev-sans-first:1.30 10:14:13 INFO - PROCESS | 1666 | Values: 103.0 114.0 112.0 113.0 113.0 114.0 110.0 114.0 112.0 113.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:141.00 stddev:23.42 (16.6%) stddev-sans-first:24.01 10:14:13 INFO - PROCESS | 1666 | Values: 150.0 113.0 114.0 154.0 114.0 115.0 137.0 145.0 178.0 109.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:194.50 Median:184.50 stddev:27.21 (14.7%) stddev-sans-first:28.59 10:14:13 INFO - PROCESS | 1666 | Values: 184.0 179.0 181.0 186.0 185.0 218.0 265.0 182.0 183.0 182.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.50 stddev:12.05 (19.9%) stddev-sans-first:11.75 10:14:13 INFO - PROCESS | 1666 | Values: 80.0 59.0 61.0 88.0 60.0 59.0 60.0 58.0 83.0 57.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:80.00 stddev:17.84 (22.3%) stddev-sans-first:18.91 10:14:13 INFO - PROCESS | 1666 | Values: 88.0 72.0 89.0 69.0 67.0 69.0 123.0 98.0 100.0 89.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.45 (1.7%) stddev-sans-first:1.36 10:14:13 INFO - PROCESS | 1666 | Values: 87.0 84.0 87.0 84.0 86.0 83.0 86.0 84.0 86.0 84.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:14:13 INFO - PROCESS | 1666 | Values: 93.0 94.0 93.0 94.0 93.0 93.0 93.0 92.0 93.0 92.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:81.70 Median:81.50 stddev:2.11 (2.6%) stddev-sans-first:2.07 10:14:13 INFO - PROCESS | 1666 | Values: 84.0 81.0 78.0 81.0 82.0 80.0 84.0 85.0 81.0 81.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.88 10:14:13 INFO - PROCESS | 1666 | Values: 56.0 53.0 55.0 54.0 55.0 54.0 56.0 54.0 54.0 55.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:2.17 (3.1%) stddev-sans-first:2.30 10:14:13 INFO - PROCESS | 1666 | Values: 69.0 68.0 67.0 75.0 69.0 68.0 69.0 70.0 70.0 70.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:87.00 stddev:8.39 (9.6%) stddev-sans-first:8.89 10:14:13 INFO - PROCESS | 1666 | Values: 91.0 86.0 87.0 87.0 89.0 86.0 85.0 93.0 106.0 108.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:150.00 stddev:11.64 (7.8%) stddev-sans-first:12.31 10:14:13 INFO - PROCESS | 1666 | Values: 149.0 146.0 148.0 138.0 151.0 155.0 156.0 143.0 181.0 148.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.50 Median:207.00 stddev:29.36 (14.2%) stddev-sans-first:30.74 10:14:13 INFO - PROCESS | 1666 | Values: 183.0 215.0 199.0 233.0 169.0 237.0 227.0 168.0 164.0 170.0 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:70.00 stddev:8.06 (11.5%) stddev-sans-first:8.47 10:14:13 INFO - PROCESS | 1666 | Values: 70.0 66.0 68.0 68.0 68.0 68.0 70.0 78.0 87.0 87.0 10:14:13 INFO - PROCESS | 1666 | -------- Summary: end -------- 10:14:13 INFO - PROCESS | 1666 | 10:14:13 INFO - TEST-INFO | 1666: exit 0 10:14:13 INFO - TEST-OK | kraken | took 60016ms 10:14:13 INFO - SUITE-END | took 1179s 10:14:14 INFO - Completed test suite (00:19:39) 10:14:14 INFO - javascript benchmark 10:14:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.1541256979467, 3324.900252992411, 3347.6819702128305, 3359.076254030143, 3394.575678040245, 4754.7860346284415, 5578.163275508676, 5669.716514174295, 5685.317761868577, 5778.566607504433, 5668.631538949965, 5692.715364231793, 5772.538196944245, 5780.913286300698, 5808.738606762706, 5041.57146642534, 5101.51535604117, 5111.769970351324, 5172.612054095958, 5191.039657663326, 4584.404027476424, 5218.373795144569, 5272.92090618641, 5306.442823503535, 5337.039332920072, 5243.3970093439175, 5253.159494480865, 5260.605454590883, 5283.313169287987, 5339.70631615261, 5108.948910510921, 5141.665791723563, 5168.3539557555305, 5168.8449346519665, 5185.611079169077, 5141.53726164647, 5161.793528258865, 5175.068487672217, 5197.506236907488, 5230.581553475713, 4700.2009658358165, 5700.828975130753, 5733.262195273958, 5741.913871291892, 5742.97128514359, 6101.389861013863, 6114.71942267015, 6143.3412978496, 6201.255849298113, 6230.657313847737, 5275.920861187085, 6131.595232866864, 6151.0773383992755, 6212.689365531705, 6227.09707092469, 4723.45680246776, 5764.394738552475, 5774.769009239667, 5787.0, 5793.159991801165, 6166.383361663798, 6305.684715764193, 6312.684365781693, 6321.0, 6323.873522529616, 5976.402359763989, 6050.45545900871, 6080.966235739935, 6106.339326077069, 6112.194539520766, 6270.184875966095, 6273.247210334789, 6279.277883043417, 6280.309165991737, 6293.118963345044, 6172.4136207060255, 6198.659073750897, 6216.7824126155365, 6230.190075290183, 6246.0, 6109.070667813081, 6111.713288451782, 6112.419320164578, 6184.134221209034, 6235.407636274546, 4876.902461950741, 4923.630727695438, 4930.038642464685, 4933.136701077297, 4936.555709986119, 4390.385346051556, 4422.955770442319, 4501.279795232747, 4503.617192538605, 4506.459224892968, 5777.075667893117, 5796.072628379439, 5797.971010145006, 5798.9130163047585, 5811.244538210006, 6213.65824879636, 6228.408301211378, 6230.501559875199, 6233.594816336924, 6241.594296370721, 5750.539956803445, 5786.797462088806, 5787.189793428924, 5790.178482201727, 5797.188393624896, 5358.5177334039345, 5364.6512976656395, 5375.569954403638, 5407.432219616962, 5408.621396502207, 6273.7176827042895, 6292.968535157295, 6307.337729538424, 6326.810195694136, 6328.0, 6110.7250173741395, 6140.136169957769, 6300.086487459201, 6307.873842523032, 6316.936830631818, 6216.658083805434, 6272.996320588684, 6287.591306565058, 6290.716917738621, 6314.968425157845, 6174.567780255339, 6175.475084617858, 6181.103739957771, 6185.226846644169, 6202.751889924352, 6092.543059270483, 6253.968730156502, 6265.749370025148, 6281.780137695158, 6283.02613094971, 5938.109283607493, 5962.970185149046, 5983.341832398346, 6061.878762424639, 6066.908996365147, 6090.817275481742, 6108.511319094373, 6110.741024289911, 6121.173641558333, 6133.50931925436, 5867.237259156283, 5921.14143449206, 5922.230110085661, 5926.67403292823, 5929.881402371842, 5944.3164036136395, 5978.4021597839865, 5995.700214989146, 6043.939560604338, 6104.755809767559, 5875.294964604275, 5926.555508336805, 5927.081302398135, 6018.4583387493585, 6021.367756385516], "value": 5671.490659932093, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.37066770511933, 469.4577762684099, 530.014173637035, 539.7382269599246, 544.0, 24948.87525562372, 26921.865390673018, 32182.712691492314, 32364.514532282035, 32369.497185478467, 35272.470912936325, 43160.56839431605, 43650.78174609123, 45046.0, 45058.09883802322, 9618.134367906887, 9771.853422198672, 9773.609055637766, 9777.755556111082, 9802.656907008257, 7512.511686740344, 9703.2722545809, 9775.413475191475, 9781.608735650565, 9788.55951482185, 8440.451370660887, 11786.292822430638, 11967.401629918513, 11991.520339186422, 12143.210691305081, 10541.631042913461, 11406.574178227722, 11850.466728997173, 11858.110641701907, 11887.0, 11634.6509604712, 11695.824562631567, 11706.12204084697, 11730.824037639442, 11886.167968242227, 39524.0, 39771.8011409944, 39843.40234896479, 39965.40051899195, 40024.0, 2898.68114507404, 3385.39062968668, 3509.982450087759, 3659.0669379308106, 3661.780293182391, 23227.883860580758, 25019.0, 30703.846480767676, 30991.535126973115, 31396.21509462259, 3127.9061628151194, 3204.2309845637114, 3239.64363919971, 3260.4294248506653, 3270.149761062141, 316539.0, 318469.0, 318970.0, 319715.0, 320503.0, 55991.0, 56230.939215470804, 56237.0, 56280.718596406754, 56311.43688563062, 31770.682293177233, 32002.839985800387, 32224.83887580547, 32357.676423235465, 32406.83796581002, 16007.919960400124, 16147.192640367935, 16162.030278183347, 16170.27233774483, 16187.838121618868, 12319.753604927851, 12421.130520863633, 12449.128561000824, 12449.377531123408, 12463.0, 16241.350345986264, 16409.179541022902, 16534.0, 18928.62142757165, 18942.43172704821, 7557.319841214317, 7785.174657790501, 7956.880646790303, 7979.0, 8013.6794528218215, 734.937530309919, 997.7749618351118, 1053.3206082077018, 1061.8991195836384, 1099.378850949211, 27790.16629501078, 29679.703202968125, 29997.0, 30372.392552148835, 30649.233769155948, 1020.7193021918883, 1057.5663977769232, 1074.5648012554927, 1139.8290256461432, 1149.827525871126, 15654.45209417665, 15672.529824105295, 15674.529764107096, 15938.442154524537, 16049.0, 607712.0, 613188.0, 613520.0, 614007.9299603563, 614208.0, 49461.0, 50392.24411633828, 54623.0, 55967.44032559704, 56259.0, 1324.5893772930422, 1371.1978492581952, 1372.5882235329561, 1379.1035826712716, 1381.3231516557016, 25204.243872683848, 30387.58142204679, 30935.0, 31097.0, 32192.0, 38001.049973749774, 48201.0, 48488.0, 48540.75729621329, 48605.513944861515, 540835.0, 545220.0, 791953.0, 817034.0, 818433.0, 39891.601083989946, 40300.99247518835, 40375.59624403718, 40912.59087409088, 41161.58838411697, 44749.55250447454, 44968.0, 45545.54454455546, 45590.08819823651, 45725.54274457213, 37559.62440375561, 37820.810895945346, 38289.80855095707, 39052.41421378625, 39160.80419597884, 37639.435408468344, 37915.62084379121, 38534.42198366971, 39045.02387440337, 39354.60645393509, 36739.63260367469, 37470.06324841901, 37550.81224593859, 37551.620354168255, 39361.40957885691, 32388.60758234494, 33118.834405827816, 34482.65517344895, 34707.305853883285, 34855.47716784301, 24200.668963206488, 25507.0, 25672.871635641703, 25756.742432576182, 26222.475550489264], "value": 19605.04788020842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.25574712643686, 370.0, 379.9810009499525, 388.5997422654665, 412.1694785008209, 15118.773218401719, 15335.923320383396, 16903.23935422906, 20293.49266268344, 20961.266355677555, 19872.9006354968, 20536.589268214662, 20696.68954965673, 20897.37307880762, 21076.57846843066, 4476.843310484133, 5319.441458646835, 5558.6942718150485, 5560.555155587564, 5581.302337207849, 6019.3980601939675, 6084.908726369108, 6134.723937422827, 6151.169592105053, 6158.599691020092, 5397.2443857859935, 5463.48096930791, 5938.617981508538, 6098.878022439549, 6103.389661033883, 5464.890702185974, 5519.420460851633, 5521.585881058896, 5529.0, 5529.612927095105, 5206.088934436459, 5280.3663560372615, 5301.575873930076, 5359.196120581905, 5372.7045012524295, 13286.402111904987, 13385.397657105454, 13433.19400835953, 13516.729665406736, 13577.253251071186, 2111.9788802111934, 2172.7609962904066, 2303.608386574286, 2305.8155347572156, 2706.9052583159496, 9918.801623967553, 12262.896339329414, 12608.495660173581, 15464.564107158776, 15767.211639417983, 1835.5869929265941, 1877.7840548336978, 1916.2718167096414, 1920.0319672335827, 2021.1006102284489, 116613.0, 120289.0, 122729.0, 122956.54086918301, 125439.49121017529, 11115.610953616584, 11300.830487542693, 11495.367754773568, 11507.309561426173, 11759.706007349714, 14494.492692755914, 14500.419983200554, 14509.564713058626, 14515.983881128219, 14523.128612283297, 6529.0, 8392.580370981426, 8423.873641895376, 8523.445976011664, 8543.188397102265, 6611.834704132339, 7117.466190035664, 8044.758657240292, 8317.500949943023, 8475.406721529556, 4498.212812757754, 4505.211587972091, 4522.615577675869, 4529.728216307032, 4577.702449340783, 1450.6373406648338, 1790.873730776526, 1822.7630408047135, 1898.7246849206788, 1962.9214831406584, 847.7583888591722, 912.7991841794794, 914.9588268527932, 921.9170274675178, 925.5233554719325, 19779.0, 20904.163833446797, 21053.84203868771, 21306.633940953947, 21445.356639300848, 916.6241840845222, 948.2224575847739, 948.8671585977969, 977.6333874796951, 1030.1449796668746, 10566.577336906592, 11224.0, 11228.157888158257, 11244.66266012021, 11252.381119038531, 489771.0, 492454.0, 496094.0, 578792.0, 591930.0, 127064.36467817602, 129411.0, 130861.69138308495, 130989.0, 133170.0, 939.4034787909726, 978.2174260591498, 1007.5163921317809, 1020.6019652335596, 1022.5040855185377, 14873.628159296104, 15174.924125379302, 18932.43202703921, 18965.43103706891, 19942.90028549848, 54355.06047864796, 54926.72536637291, 55020.724896375265, 55736.44263557313, 55970.60073498195, 76490.0, 77113.0, 77610.6716798497, 79158.60420697859, 79323.0, 7729.381649468141, 7757.92242077572, 7931.127575966524, 8014.879776803469, 8017.594721583385, 9038.0, 12143.14997950135, 12449.626511204679, 12505.874941250471, 12620.305883176514, 9458.858117128386, 10776.784464310513, 10838.349699018085, 10912.127029837435, 11151.933218365015, 10457.529411176667, 10551.683449496528, 10718.338657508099, 10761.784764304826, 10762.946185269024, 10827.566897324019, 11128.721781955515, 11160.162987775788, 11299.039581635652, 11342.489587968726, 7783.649735762017, 7844.568548729646, 7979.640916158671, 8096.919030809617, 8169.632366543401, 8135.901653276732, 10704.518296676824, 10984.725381865197, 11051.336919784517, 11104.944475277573], "value": 9256.913590399508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.3264098514683, 1551.6431220819209, 1773.6807374672553, 1921.4139687395357, 1958.1873522488158, 8299.543525106117, 8674.306055515559, 8684.0, 8694.434861733991, 8721.040685524587, 7566.0, 7865.488743231686, 7865.646045927932, 7947.682092716284, 7956.4828286161355, 2248.336740661505, 2339.4502291961376, 2344.6131388320905, 2348.367884320398, 2355.057976809273, 2356.0929042318658, 2368.0, 2399.7720216579396, 2400.7719266669637, 2403.735589085199, 2352.3531028967, 2371.3241726108063, 2371.4308565944134, 2372.51363470489, 2373.181252467896, 1985.2555291765589, 2314.2941402872116, 2333.661619065226, 2341.484873327865, 2354.058376649337, 2335.1710142899365, 2342.2856028911174, 2369.6327069304284, 2371.324172610815, 2372.9881350593137, 8542.658293668246, 8632.697855575025, 8640.697575584887, 8661.263792577638, 8698.695545655935, 5139.254808052811, 5293.470652934714, 5295.0, 5295.894082118336, 5305.0, 2947.7199666031693, 3370.679785420381, 3524.207053412987, 3593.1376469647357, 3594.856205751767, 971.2958105373618, 1024.948752562369, 1062.102523367753, 1076.860008198937, 1079.3955384984433, 9696.660616878446, 11320.26418282809, 11334.829977550344, 11370.658880233523, 11378.31730096197, 4464.486584042812, 4637.7449240291435, 4733.455652599995, 4751.909159969671, 4802.351682522814, 9642.95178524117, 9748.610055597697, 9766.974467680791, 9774.071463210983, 9778.315517913677, 5299.019681358884, 5392.946070539323, 5397.460253974571, 5398.109311963561, 5401.054815407367, 4351.151525452569, 4560.84037058708, 4778.904421911542, 4884.974155427329, 4901.019796040806, 3580.874669386559, 3688.0595448161084, 3689.815509224528, 3696.796676182782, 3700.2784457031157, 1070.464767616192, 1197.8143387774908, 1249.4814651919532, 1249.9062570307262, 1272.5418849214275, 908.1735620585367, 923.409018228321, 927.6456373694347, 928.6888892221046, 988.8615593816871, 5431.34823821144, 5854.7072646367515, 5912.201852749824, 6131.754729810847, 6134.8159555213415, 904.2856143646577, 907.8456662367413, 941.204682043672, 964.4298488565402, 972.5866506734609, 3725.701943844486, 3876.8643097491454, 3928.842846286174, 4011.438398624195, 4013.7190396672536, 7781.727639532703, 10356.430396328124, 10425.582976680847, 10452.425116618659, 10474.581016759397, 10411.791764164826, 10412.843807342895, 10424.113950314308, 10445.477726113664, 10456.424896630759, 7637.15991240963, 8022.879656805036, 8065.870778091072, 8163.673453061811, 8173.427860049739, 5933.110033495011, 5976.832278892194, 5981.671008094597, 6056.121862329849, 6120.265568131853, 9328.253739700944, 9663.226941844496, 9670.274729395183, 9751.219902407933, 9810.509474526389, 9576.664816731382, 9744.561494732612, 9898.257630677585, 9946.850797238192, 9948.751281218027, 7183.5330703504105, 7307.02710268214, 7360.116785985716, 7416.592087435243, 7424.8143796403365, 7250.383717384081, 8034.116247212919, 8094.190580941859, 8102.270795628422, 8118.431709780259, 6343.55595108338, 7273.0181425509, 7307.2327405621645, 7332.266773322838, 7346.816329591803, 7107.644617769194, 7190.6404679764755, 7194.2086370498155, 7245.7826265212125, 7255.0, 5895.94104058954, 5921.289445266596, 6789.490788191004, 6911.827204319932, 6936.4797640176175, 4864.562189402829, 4873.561379475864, 4987.326710893983, 5018.974905125451, 5147.841735609458, 4919.975400122977, 5002.449730529566, 5032.446430892525, 5059.114654935445, 5173.63784535079], "value": 4506.901332287268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.32726692209457, 301.3310450799226, 310.6831032347005, 313.5375321400934, 314.19409215362606, 4441.733495990243, 5251.002309561185, 5287.576993840488, 5302.08385388037, 5360.731963401829, 3723.9704361123186, 4327.502337231212, 4341.956580434195, 4932.457429682732, 5124.615653825959, 3904.809033244859, 3989.960100398988, 3999.22015207034, 4016.3975403689533, 4061.776602286873, 3361.7646764726355, 3507.2985402919517, 4024.839006439739, 4031.6169963853386, 4044.6562042226446, 3169.2710676544293, 3587.3004764071015, 3998.860039898604, 4013.6387725104737, 4035.939460908074, 3508.736844736642, 3852.5376954765466, 3970.1265721541213, 3975.324194886847, 4012.0, 3430.2967891582416, 3433.8111403872776, 3437.5187473753695, 3445.3970555153, 3458.948115778265, 5105.336306280197, 5141.5115564021735, 5142.820001299974, 5199.766010529535, 5200.713960732158, 4373.671974601886, 4423.292273236267, 4536.319552067183, 4580.473245576768, 4581.816727330903, 5514.834554963358, 5525.254090697745, 5546.223528705985, 5546.667199967975, 5565.41563135873, 3757.586665466824, 3758.39865621502, 3772.264408440355, 3775.754575952582, 3792.639699228569, 5467.371252305996, 5509.135249670149, 5633.887322253532, 5806.22910012446, 5851.736671849777, 3315.9171020724193, 3501.824908754552, 3772.396416573335, 3839.155385815116, 3840.5007349044445, 3910.2179564086728, 3910.9804450977563, 3918.7844668542934, 3921.6666583340734, 3923.0, 4204.495460544754, 4241.830326786956, 4558.9772051139535, 4559.726416415026, 4581.839635612738, 5080.74596270185, 5532.585056120726, 5576.693281869536, 5595.195267218331, 5606.6636001840025, 1293.6701141208932, 1317.7693903566837, 1327.349598696651, 1328.4088580581742, 1338.9866101339057, 829.8589439520659, 851.1020872979067, 853.0701535326524, 876.8031636815828, 904.3895370624801, 4283.571642835692, 5223.2948551945, 5246.029484545371, 5260.605454590921, 5292.629515933924, 4579.450465944042, 5345.65253258537, 5455.236266922634, 5641.351244606841, 5706.429357064343, 4359.694821362537, 4691.437027556715, 5163.870903227375, 5241.217985884818, 5245.082110630625, 2687.475942191254, 2970.702929707012, 2975.5090410082526, 2981.6720160782297, 2983.7165469280385, 5000.0499605312125, 5501.0098182327565, 5612.831615051555, 5726.885462290814, 5749.706316078848, 4847.903041939141, 5010.797408621905, 5606.196901549225, 5717.799877004285, 5720.598453378949, 4928.704277743275, 5449.863753406038, 5648.915266271009, 5756.913646295309, 5803.622764520293, 4884.780184891617, 5147.6654017488745, 5299.178627312773, 5596.664200148004, 5642.294713160855, 4506.842260520866, 4693.671442998957, 5588.916166257428, 5593.720313984203, 5595.558731380253, 5505.724713764376, 5802.6808525531505, 5805.535557155502, 5813.854653633693, 5835.67903765297, 2971.4205729882465, 3772.283955551998, 3790.6019867913474, 3838.1556057667267, 3866.9419958701205, 4984.925226121683, 5532.419095994863, 5722.570807189561, 5749.885002299847, 5771.538276937918, 4877.439094504178, 4921.883590056167, 5615.775368985358, 5638.887222255614, 5640.730835561966, 4714.504976977368, 4987.376577927759, 5553.0, 5598.300212473441, 5600.35595906476, 3995.841206050213, 5390.97304513475, 5415.0, 5457.808976685797, 5498.340199176125, 4674.859754207379, 4804.726747412008, 5340.465953404629, 5573.665580065209, 5622.831315060391, 5539.362973258127, 5539.396483652677, 5540.260324281175, 5543.417941116125, 5561.555075594024], "value": 4007.580290355289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.4355958792554, 732.4726197138059, 771.0400551313616, 803.216863558031, 823.7446391618595, 15246.313915873785, 15519.0, 15545.766813497807, 15547.611309717262, 15566.299516521756, 13901.513447029356, 14026.649333766662, 14034.0, 14053.297335133253, 14062.085964412307, 704.7322017633293, 723.6851969393331, 724.6340597998004, 875.6103533927405, 877.7191298784392, 883.337496877342, 888.8933328000617, 895.511945989434, 897.4391005621486, 899.5727029660892, 958.7842735384553, 958.9328746987713, 960.2126256469697, 960.3133759362055, 962.6101428921298, 952.599908038622, 952.8951815300311, 955.8327292723781, 956.2493442647558, 958.1137447860771, 546.0716781471475, 564.5596434780878, 677.4377266868487, 700.7792545348199, 703.8908969109796, 12066.577669781604, 14790.890683198802, 14817.333220005126, 14878.181700006495, 14884.181370024644, 13361.66595835102, 13496.865031349756, 13525.188488690612, 13573.796393054112, 13655.795163072562, 12130.332831694253, 12161.0, 12208.08439367051, 12388.876111238862, 12479.376031198495, 4298.505671847715, 4377.562243775629, 4380.824767009316, 4445.866624001285, 4522.29904364824, 87852.56073719655, 87939.68090478648, 88042.0, 88254.55872720595, 88357.55821220917, 10459.633912813168, 10481.790364192673, 10640.308379955279, 10640.733981650521, 10688.78622427547, 21135.260265890927, 21168.259110931045, 21171.576568468852, 21172.47068823261, 21175.470613234793, 7626.42801789868, 7689.231076892266, 7777.533347999025, 7785.961070194613, 7849.01887264092, 4237.406763053175, 4244.087521182961, 4324.502682191525, 4337.7614231217585, 4486.551344865553, 3416.0, 3520.1727594015388, 3520.7359448041498, 3523.3834079036064, 3528.2414280929725, 549.2722143160329, 623.2583225961092, 623.7941479311907, 624.7046827982429, 631.1479502671449, 531.44994930247, 582.7552427980258, 584.8303991842403, 632.276043929698, 637.1048676609371, 7745.683233850259, 8365.476978513856, 8541.957290213633, 8679.826403472021, 8706.738797836075, 483.04617265421695, 574.7528562718071, 575.6776205325032, 628.6470701972706, 638.6040654793965, 4212.441396683247, 4253.149370125925, 4421.093675796454, 4756.262779269219, 4769.165396055746, 107104.0, 112447.43776281066, 113147.0, 116657.0, 117493.0, 97773.19505859536, 100244.99755002503, 102291.0, 103122.0, 104906.0, 90255.0, 90708.30083788408, 92172.07827921769, 92188.0, 94062.0593794067, 9614.663486777928, 9722.173615242784, 9743.853842192231, 9745.0, 9780.315377923476, 45513.77243113763, 55583.72208138934, 55853.603659908826, 57140.714296428254, 57920.2623921283, 63197.68401157965, 75519.62240188764, 84473.57763211144, 84795.0, 86491.0, 12069.879301207227, 12846.743065138831, 12872.871271287167, 13033.674158146123, 13366.398512067175, 11874.709195846024, 14164.787528187291, 14369.425222990963, 14714.852851471349, 15300.846991529943, 13047.086703931014, 13260.53588124411, 13476.730465390441, 13548.729025419634, 13738.313084345542, 13154.165502375048, 13168.934155329545, 13487.393067311797, 13549.86450135486, 13551.322433878464, 12785.474162295423, 12918.870811292143, 13433.462661493822, 13570.525031623845, 13688.041837071707, 10801.837972430578, 10956.890431095906, 11135.443227838738, 11543.422828858356, 11558.653240402466, 10279.383237005804, 10968.725781855199, 11236.213465057368, 11325.603603873826, 11332.093432525213], "value": 7495.078315294915, "unit": "score"}], "name": "dromaeo_css", "value": 7200.329441334823, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 113.0, 113.0, 114.0, 110.0, 114.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 114.0, 154.0, 114.0, 115.0, 137.0, 145.0, 178.0, 109.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 181.0, 186.0, 185.0, 218.0, 265.0, 182.0, 183.0, 182.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 61.0, 88.0, 60.0, 59.0, 60.0, 58.0, 83.0, 57.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 89.0, 69.0, 67.0, 69.0, 123.0, 98.0, 100.0, 89.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 83.0, 86.0, 84.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 92.0, 93.0, 92.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 78.0, 81.0, 82.0, 80.0, 84.0, 85.0, 81.0, 81.0], "value": 81.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 54.0, 55.0, 54.0, 56.0, 54.0, 54.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 75.0, 69.0, 68.0, 69.0, 70.0, 70.0, 70.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 87.0, 87.0, 89.0, 86.0, 85.0, 93.0, 106.0, 108.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 148.0, 138.0, 151.0, 155.0, 156.0, 143.0, 181.0, 148.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 215.0, 199.0, 233.0, 169.0, 237.0, 227.0, 168.0, 164.0, 170.0], "value": 196.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 68.0, 68.0, 68.0, 68.0, 70.0, 78.0, 87.0, 87.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1488.8000000000002, "alertThreshold": 2.0}]} 10:14:14 INFO - Return code: 0 10:14:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:14:14 INFO - # TBPL SUCCESS # 10:14:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:14:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:14:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:14:14 INFO - 2016-10-26 10:14:14.289 screenresolution[1670:9879] starting screenresolution argv=screenresolution get 10:14:14 INFO - 2016-10-26 10:14:14.291 screenresolution[1670:9879] Display 0: 1600x1200x32@60 10:14:14 INFO - 2016-10-26 10:14:14.298 screenresolution[1671:9882] starting screenresolution argv=screenresolution list 10:14:14 INFO - Available Modes on Display 0 10:14:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:14:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:14:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:14:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:14:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:14:14 INFO - Intel Iris: 10:14:14 INFO - Chipset Model: Intel Iris 10:14:14 INFO - Type: GPU 10:14:14 INFO - Bus: Built-In 10:14:14 INFO - VRAM (Dynamic, Max): 1536 MB 10:14:14 INFO - Vendor: Intel (0x8086) 10:14:14 INFO - Device ID: 0x0a2e 10:14:14 INFO - Revision ID: 0x0009 10:14:14 INFO - Displays: 10:14:14 INFO - Display: 10:14:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:14:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:14:14 INFO - Display Serial Number: 1600x1200 60 10:14:14 INFO - Main Display: Yes 10:14:14 INFO - Mirror: Off 10:14:14 INFO - Online: Yes 10:14:14 INFO - Rotation: Supported 10:14:14 INFO - Return code: 0 10:14:14 INFO - Running post-action listener: _resource_record_post_action 10:14:14 INFO - [mozharness: 2016-10-26 17:14:14.535211Z] Finished run-tests step (success) 10:14:14 INFO - Running post-run listener: _resource_record_post_run 10:14:14 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 38425600; Write bytes: 707773440; Read time: 375; Write time: 1815 10:14:14 INFO - TinderboxPrint: CPU usage
53.4% 10:14:14 INFO - TinderboxPrint: I/O read bytes / time
38,425,600 / 375 10:14:14 INFO - TinderboxPrint: I/O write bytes / time
707,773,440 / 1,815 10:14:14 INFO - TinderboxPrint: CPU idle
2,264.8 (46.6%) 10:14:14 INFO - TinderboxPrint: CPU system
968.6 (19.9%) 10:14:14 INFO - TinderboxPrint: CPU user
1,628.3 (33.5%) 10:14:14 INFO - TinderboxPrint: Swap in / out
444,264,448 / 0 10:14:14 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392221184; Write bytes: 381863424; Read time: 29039; Write time: 663 10:14:14 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 32254976; Write bytes: 297938432; Read time: 296; Write time: 1095 10:14:15 INFO - Running post-run listener: _upload_blobber_files 10:14:15 INFO - Blob upload gear active. 10:14:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:14:15 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 10:14:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:14:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:16 INFO - (blobuploader) - INFO - Done attempting. 10:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:17 INFO - (blobuploader) - INFO - Done attempting. 10:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:19 INFO - (blobuploader) - INFO - Done attempting. 10:14:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:14:19 INFO - Return code: 0 10:14:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:14:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:14:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ec1683b0d54c59a47b15d6d0b9a48dd1998107bd9ee4b4b56f4ba4bf0d4a1c08c6d824d04328174a787d958ccc2692f2c9c122f410eb2e68c62275e2162a3aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e19f0708d8df649479ad7b45dfa19029e0d5645e9f6d89967c2c1700722383c692b06e19eee2fe86072f010c0a2fa52335f08c79e5a0be131a343c2c1078bcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9599cf71f288162bca3a54390c817baa0b34e62403f54654239b98452860d8e0aed5ecaf518ba377f0d68aec155acf5ccc3786a1e3246fe31ce901710b3c1019"} 10:14:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:14:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:14:19 INFO - Contents: 10:14:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ec1683b0d54c59a47b15d6d0b9a48dd1998107bd9ee4b4b56f4ba4bf0d4a1c08c6d824d04328174a787d958ccc2692f2c9c122f410eb2e68c62275e2162a3aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e19f0708d8df649479ad7b45dfa19029e0d5645e9f6d89967c2c1700722383c692b06e19eee2fe86072f010c0a2fa52335f08c79e5a0be131a343c2c1078bcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9599cf71f288162bca3a54390c817baa0b34e62403f54654239b98452860d8e0aed5ecaf518ba377f0d68aec155acf5ccc3786a1e3246fe31ce901710b3c1019"} 10:14:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:14:19 INFO - Copying logs to upload dir... 10:14:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:14:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.921719 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 10:14:19.992138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 10:14:19.995422) ========= 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.JNPg6eJp6h/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.XAZNtKrob2/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ec1683b0d54c59a47b15d6d0b9a48dd1998107bd9ee4b4b56f4ba4bf0d4a1c08c6d824d04328174a787d958ccc2692f2c9c122f410eb2e68c62275e2162a3aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e19f0708d8df649479ad7b45dfa19029e0d5645e9f6d89967c2c1700722383c692b06e19eee2fe86072f010c0a2fa52335f08c79e5a0be131a343c2c1078bcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9599cf71f288162bca3a54390c817baa0b34e62403f54654239b98452860d8e0aed5ecaf518ba377f0d68aec155acf5ccc3786a1e3246fe31ce901710b3c1019"} build_url:https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011031 build_url: 'https://queue.taskcluster.net/v1/task/A5QKcB31ReSb113_moQEow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ec1683b0d54c59a47b15d6d0b9a48dd1998107bd9ee4b4b56f4ba4bf0d4a1c08c6d824d04328174a787d958ccc2692f2c9c122f410eb2e68c62275e2162a3aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e19f0708d8df649479ad7b45dfa19029e0d5645e9f6d89967c2c1700722383c692b06e19eee2fe86072f010c0a2fa52335f08c79e5a0be131a343c2c1078bcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9599cf71f288162bca3a54390c817baa0b34e62403f54654239b98452860d8e0aed5ecaf518ba377f0d68aec155acf5ccc3786a1e3246fe31ce901710b3c1019"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 10:14:20.028027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 10:14:20.028361) ========= 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.JNPg6eJp6h/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.XAZNtKrob2/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 10:14:20.077219) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 10:14:20.077617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 10:14:20.078326) ========= ========= Total master_lag: 0.17 =========