builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0095 starttime: 1476705656.93 results: success (0) buildid: 20161017023737 builduid: 717dd20414864fbda93530bc3e22ea0a revision: 94b0fddf96b43942bdd851a3275042909ea37e09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:00:56.925295) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:00:56.925667) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-10-17 05:00:56.925940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-10-17 05:01:00.210404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:01:00.210758) ========= 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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-17 05:01: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% 14.6M=0.001s 2016-10-17 05:01:00 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148934 ========= master_lag: 0.89 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:01:01.253165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:01:01.256569) ========= 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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.027694 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:01:01.304500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:01:01.304897) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 94b0fddf96b43942bdd851a3275042909ea37e09 --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 94b0fddf96b43942bdd851a3275042909ea37e09 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WWs9r34WsQ/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.vT9MLT3ooK/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-17 05:01:01,384 truncating revision to first 12 chars 2016-10-17 05:01:01,384 Setting DEBUG logging. 2016-10-17 05:01:01,384 attempt 1/10 2016-10-17 05:01:01,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/94b0fddf96b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 05:01:02,418 unpacking tar archive at: fx-team-94b0fddf96b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.275659 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:01:02.607739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:01:02.608319) ========= script_repo_revision: 94b0fddf96b43942bdd851a3275042909ea37e09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:01:02.608977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:01:02.609469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:01:02.629016) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-17 05:01:02.629663) ========= /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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01:02 INFO - MultiFileLogger online at 20161017 05:01:02 in /builds/slave/test 05:01: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 05:01:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:02 INFO - {'append_to_log': False, 05:01:02 INFO - 'base_work_dir': '/builds/slave/test', 05:01:02 INFO - 'blob_upload_branch': 'Fx-Team', 05:01:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:02 INFO - 'branch': 'Fx-Team', 05:01:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:02 INFO - 'config_files': ('talos/mac_config.py',), 05:01:02 INFO - 'default_actions': ('clobber', 05:01:02 INFO - 'read-buildbot-config', 05:01:02 INFO - 'download-and-extract', 05:01:02 INFO - 'populate-webroot', 05:01:02 INFO - 'create-virtualenv', 05:01:02 INFO - 'install', 05:01:02 INFO - 'run-tests'), 05:01:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:02 INFO - 'download_minidump_stackwalk': True, 05:01:02 INFO - 'download_symbols': 'ondemand', 05:01:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:02 INFO - 'installer_path': 'installer.exe', 05:01:02 INFO - 'log_level': 'info', 05:01:02 INFO - 'log_name': 'talos', 05:01:02 INFO - 'log_to_console': True, 05:01:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:01:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:01:02 INFO - 'opt_config_files': (), 05:01:02 INFO - 'pip_index': False, 05:01:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:01:02 INFO - 'cmd': ('bash', 05:01:02 INFO - '-c', 05:01:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:01:02 INFO - 'enabled': True, 05:01:02 INFO - 'halt_on_failure': False, 05:01:02 INFO - 'name': 'check_screen_resolution'},), 05:01:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:01:02 INFO - 'cmd': ('bash', 05:01:02 INFO - '-c', 05:01:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:01:02 INFO - 'enabled': True, 05:01:02 INFO - 'halt_on_failure': False, 05:01:02 INFO - 'name': 'check_screen_resolution'},), 05:01:02 INFO - 'run_cmd_checks_enabled': True, 05:01:02 INFO - 'sps_profile': False, 05:01:02 INFO - 'sps_profile_interval': 0, 05:01:02 INFO - 'suite': 'dromaeojs', 05:01:02 INFO - 'system_bits': '32', 05:01:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:02 INFO - 'title': 't-yosemite-r7-0095', 05:01:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:02 INFO - 'use_talos_json': True, 05:01:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:02 INFO - 'work_dir': 'build'} 05:01:02 INFO - [mozharness: 2016-10-17 12:01:02.836352Z] Running clobber step. 05:01:02 INFO - Running pre-action listener: _resource_record_pre_action 05:01:02 INFO - Running main action method: clobber 05:01:02 INFO - rmtree: /builds/slave/test/build 05:01:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:05 INFO - Running post-action listener: _resource_record_post_action 05:01:05 INFO - [mozharness: 2016-10-17 12:01:05.093294Z] Finished clobber step (success) 05:01:05 INFO - [mozharness: 2016-10-17 12:01:05.093530Z] Running read-buildbot-config step. 05:01:05 INFO - Running pre-action listener: _resource_record_pre_action 05:01:05 INFO - Running main action method: read_buildbot_config 05:01:05 INFO - Using buildbot properties: 05:01:05 INFO - { 05:01:05 INFO - "project": "", 05:01:05 INFO - "product": "firefox", 05:01:05 INFO - "script_repo_revision": "production", 05:01:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:01:05 INFO - "repository": "", 05:01:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:01:05 INFO - "buildid": "20161017023737", 05:01:05 INFO - "pgo_build": "False", 05:01:05 INFO - "basedir": "/builds/slave/test", 05:01:05 INFO - "buildnumber": 861, 05:01:05 INFO - "slavename": "t-yosemite-r7-0095", 05:01:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:01:05 INFO - "platform": "yosemite_r7", 05:01:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:01:05 INFO - "branch": "fx-team", 05:01:05 INFO - "repo_path": "integration/fx-team", 05:01:05 INFO - "revision": "94b0fddf96b43942bdd851a3275042909ea37e09", 05:01:05 INFO - "stage_platform": "macosx64", 05:01:05 INFO - "builduid": "717dd20414864fbda93530bc3e22ea0a", 05:01:05 INFO - "slavebuilddir": "test" 05:01:05 INFO - } 05:01:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:01:05 INFO - Running post-action listener: _resource_record_post_action 05:01:05 INFO - [mozharness: 2016-10-17 12:01:05.099239Z] Finished read-buildbot-config step (success) 05:01:05 INFO - [mozharness: 2016-10-17 12:01:05.099472Z] Running download-and-extract step. 05:01:05 INFO - Running pre-action listener: _resource_record_pre_action 05:01:05 INFO - Running main action method: download_and_extract 05:01:05 INFO - mkdir: /builds/slave/test/build/tests 05:01:05 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')]} 05:01:05 INFO - trying https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:01:05 INFO - Downloading https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/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 05:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/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 05:01:06 INFO - Downloaded 1199 bytes. 05:01:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:01:06 INFO - Using the following test package requirements: 05:01:06 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:01:06 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:01:06 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:01:06 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'jsshell-mac.zip'], 05:01:06 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:01:06 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:01:06 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:01:06 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:01:06 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:01:06 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:01:06 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:01:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:01:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:01:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:01:06 INFO - Fetch https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:01:06 INFO - Http code: 200 05:01:06 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 05:01:06 INFO - x-amz-cf-id: CpMXI7IZ82pwzAFxjiZfs0IiDBv4vL8EuL67jxj5jxVBzNwMd9Xz7w== 05:01:06 INFO - x-amz-version-id: XCKnyHpOhkq9YTT3DTj0QN.OD7aKu9Mh 05:01:06 INFO - Expected file size: 16482899 05:01:06 INFO - Obtained file size: 16482899 05:01: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 05:01:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:01:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:01:13 INFO - Fetch https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:01:14 INFO - Http code: 200 05:01:14 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 05:01:14 INFO - x-amz-cf-id: j9EbmD-MriXY2JP1Gm6KytFcoTIVu0O8d8r3CHoHGAKy5InG1Yfk-w== 05:01:14 INFO - x-amz-version-id: XCKnyHpOhkq9YTT3DTj0QN.OD7aKu9Mh 05:01:14 INFO - Expected file size: 16482899 05:01:14 INFO - Obtained file size: 16482899 05:01:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:01:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:01:20 INFO - Fetch https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:01:21 INFO - Http code: 200 05:01:21 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 05:01:21 INFO - x-amz-cf-id: h11AiD4wCySYDxeOonYhdHKxwCgORRWvaR0pIWPihaKsggFD8_jXCQ== 05:01:21 INFO - x-amz-version-id: SYgXmQMrqS4eVmW8gnGRCDj.Zp46bCSa 05:01:22 INFO - Expected file size: 14409028 05:01:22 INFO - Obtained file size: 14409028 05:01: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')]} 05:01:22 INFO - trying https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:01:22 INFO - Downloading https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/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 05:01:25 INFO - Downloaded 111639287 bytes. 05:01:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:01:25 INFO - mkdir: /builds/slave/test/properties 05:01:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:01:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:01:25 INFO - Contents: 05:01:25 INFO - build_url:https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:01:26 INFO - Running post-action listener: _resource_record_post_action 05:01:26 INFO - Running post-action listener: set_extra_try_arguments 05:01:26 INFO - [mozharness: 2016-10-17 12:01:26.455549Z] Finished download-and-extract step (success) 05:01:26 INFO - [mozharness: 2016-10-17 12:01:26.455670Z] Running populate-webroot step. 05:01:26 INFO - Running pre-action listener: _resource_record_pre_action 05:01:26 INFO - Running main action method: populate_webroot 05:01:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:26 INFO - '--tppagecycles', 05:01:26 INFO - '7'], 05:01:26 INFO - 'tests': ['tsvgm']}}, 05:01:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:01:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:01:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:01:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['damp', 'tps']}, 05:01:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'tests': ['damp', 'tps']}, 05:01:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['dromaeo_dom']}, 05:01:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['basic_compositor_video']}, 05:01:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:01:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['a11yr', 05:01:26 INFO - 'ts_paint', 05:01:26 INFO - 'tpaint', 05:01:26 INFO - 'sessionrestore', 05:01:26 INFO - 'sessionrestore_no_auto_restore', 05:01:26 INFO - 'tabpaint']}, 05:01:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:01:26 INFO - 'ts_paint', 05:01:26 INFO - 'tpaint', 05:01:26 INFO - 'sessionrestore', 05:01:26 INFO - 'sessionrestore_no_auto_restore', 05:01:26 INFO - 'tabpaint']}, 05:01:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:01:26 INFO - 'ts_paint', 05:01:26 INFO - 'tpaint', 05:01:26 INFO - 'sessionrestore', 05:01:26 INFO - 'sessionrestore_no_auto_restore', 05:01:26 INFO - 'tabpaint']}, 05:01:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:01:26 INFO - 'ts_paint', 05:01:26 INFO - 'tpaint', 05:01:26 INFO - 'sessionrestore', 05:01:26 INFO - 'sessionrestore_no_auto_restore', 05:01:26 INFO - 'tabpaint']}, 05:01:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['a11yr', 05:01:26 INFO - 'ts_paint', 05:01:26 INFO - 'tpaint', 05:01:26 INFO - 'sessionrestore', 05:01:26 INFO - 'sessionrestore_no_auto_restore', 05:01:26 INFO - 'tabpaint']}, 05:01:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['a11yr', 05:01:26 INFO - 'ts_paint', 05:01:26 INFO - 'tpaint', 05:01:26 INFO - 'sessionrestore', 05:01:26 INFO - 'sessionrestore_no_auto_restore', 05:01:26 INFO - 'tabpaint']}, 05:01:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['tsvgx', 05:01:26 INFO - 'tsvgr_opacity', 05:01:26 INFO - 'tart', 05:01:26 INFO - 'tscrollx', 05:01:26 INFO - 'cart']}, 05:01:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:01:26 INFO - 'tsvgr_opacity', 05:01:26 INFO - 'tart', 05:01:26 INFO - 'tscrollx', 05:01:26 INFO - 'cart']}, 05:01:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'talos_options': ['--disable-e10s'], 05:01:26 INFO - 'tests': ['tp5o']}, 05:01:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'tests': ['tp5o']}, 05:01:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'talos_options': ['--disable-e10s', 05:01:26 INFO - '--xperf_path', 05:01:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:26 INFO - 'tests': ['tp5n']}, 05:01:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:26 INFO - 'talos_options': ['--xperf_path', 05:01:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:26 INFO - 'tests': ['tp5n']}}, 05:01:26 INFO - 'talos.zip': {'path': '', 05:01:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:26 INFO - Running post-action listener: _resource_record_post_action 05:01:26 INFO - [mozharness: 2016-10-17 12:01:26.474019Z] Finished populate-webroot step (success) 05:01:26 INFO - [mozharness: 2016-10-17 12:01:26.474126Z] Running create-virtualenv step. 05:01:26 INFO - Running pre-action listener: _resource_record_pre_action 05:01:26 INFO - Running main action method: create_virtualenv 05:01:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:01:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:01:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:01:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:26 INFO - Using real prefix '/tools/python27' 05:01:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:01:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:30 INFO - Installing pip.................done. 05:01:30 INFO - Return code: 0 05:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:01:30 INFO - Reading from file tmpfile_stdout 05:01:30 INFO - Output received: 05:01:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:01:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:30 INFO - 'HOME': '/Users/cltbld', 05:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:30 INFO - 'LOGNAME': 'cltbld', 05:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:30 INFO - 'MOZ_NO_REMOTE': '1', 05:01:30 INFO - 'NO_EM_RESTART': '1', 05:01:30 INFO - 'PAGER': '/bin/cat', 05:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:30 INFO - 'PWD': '/builds/slave/test', 05:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:30 INFO - 'SHELL': '/bin/bash', 05:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:30 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:30 INFO - 'USER': 'cltbld', 05:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:30 INFO - 'XPC_FLAGS': '0x0', 05:01:30 INFO - 'XPC_SERVICE_NAME': '0', 05:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01: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 05:01:30 INFO - Cleaning up... 05:01:30 INFO - Return code: 0 05:01:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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 05:01: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 05:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:30 INFO - 'HOME': '/Users/cltbld', 05:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:30 INFO - 'LOGNAME': 'cltbld', 05:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:30 INFO - 'MOZ_NO_REMOTE': '1', 05:01:30 INFO - 'NO_EM_RESTART': '1', 05:01:30 INFO - 'PAGER': '/bin/cat', 05:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:30 INFO - 'PWD': '/builds/slave/test', 05:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:30 INFO - 'SHELL': '/bin/bash', 05:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:30 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:30 INFO - 'USER': 'cltbld', 05:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:30 INFO - 'XPC_FLAGS': '0x0', 05:01:30 INFO - 'XPC_SERVICE_NAME': '0', 05:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:30 INFO - Downloading/unpacking psutil>=3.1.1 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:01:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:34 INFO - Installing collected packages: psutil 05:01:34 INFO - Running setup.py install for psutil 05:01:34 INFO - building 'psutil._psutil_osx' extension 05:01: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 05:01:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:01:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:01:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:01:35 INFO - building 'psutil._psutil_posix' extension 05:01:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:01:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:01:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:01:35 INFO - ^ 05:01:35 INFO - 1 warning generated. 05:01:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:35 INFO - Successfully installed psutil 05:01:35 INFO - Cleaning up... 05:01:35 INFO - Return code: 0 05:01:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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 05:01: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 05:01:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:35 INFO - 'HOME': '/Users/cltbld', 05:01:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:35 INFO - 'LOGNAME': 'cltbld', 05:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:35 INFO - 'MOZ_NO_REMOTE': '1', 05:01:35 INFO - 'NO_EM_RESTART': '1', 05:01:35 INFO - 'PAGER': '/bin/cat', 05:01:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:35 INFO - 'PWD': '/builds/slave/test', 05:01:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:35 INFO - 'SHELL': '/bin/bash', 05:01:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:35 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:35 INFO - 'USER': 'cltbld', 05:01:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:35 INFO - 'XPC_FLAGS': '0x0', 05:01:35 INFO - 'XPC_SERVICE_NAME': '0', 05:01:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:01:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:01:38 INFO - Installing collected packages: mozsystemmonitor 05:01:38 INFO - Running setup.py install for mozsystemmonitor 05:01:38 INFO - Successfully installed mozsystemmonitor 05:01:38 INFO - Cleaning up... 05:01:38 INFO - Return code: 0 05:01:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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 05:01: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 05:01:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:38 INFO - 'HOME': '/Users/cltbld', 05:01:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:38 INFO - 'LOGNAME': 'cltbld', 05:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:38 INFO - 'MOZ_NO_REMOTE': '1', 05:01:38 INFO - 'NO_EM_RESTART': '1', 05:01:38 INFO - 'PAGER': '/bin/cat', 05:01:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:38 INFO - 'PWD': '/builds/slave/test', 05:01:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:38 INFO - 'SHELL': '/bin/bash', 05:01:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:38 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:38 INFO - 'USER': 'cltbld', 05:01:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:38 INFO - 'XPC_FLAGS': '0x0', 05:01:38 INFO - 'XPC_SERVICE_NAME': '0', 05:01:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:42 INFO - warning: no files found matching '*.txt' 05:01:42 INFO - no previously-included directories found matching 'build' 05:01:42 INFO - no previously-included directories found matching 'dist' 05:01:42 INFO - no previously-included directories found matching '.git*' 05:01:42 INFO - Installing collected packages: jsonschema, functools32 05:01:42 INFO - Running setup.py install for functools32 05:01:42 INFO - warning: no files found matching '*.txt' 05:01:42 INFO - no previously-included directories found matching 'build' 05:01:42 INFO - no previously-included directories found matching 'dist' 05:01:42 INFO - no previously-included directories found matching '.git*' 05:01:42 INFO - Successfully installed jsonschema functools32 05:01:42 INFO - Cleaning up... 05:01:42 INFO - Return code: 0 05:01:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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', '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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:01: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 functools32==3.2.3-2 05:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:42 INFO - 'HOME': '/Users/cltbld', 05:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:42 INFO - 'LOGNAME': 'cltbld', 05:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:42 INFO - 'MOZ_NO_REMOTE': '1', 05:01:42 INFO - 'NO_EM_RESTART': '1', 05:01:42 INFO - 'PAGER': '/bin/cat', 05:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:42 INFO - 'PWD': '/builds/slave/test', 05:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:42 INFO - 'SHELL': '/bin/bash', 05:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:42 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:42 INFO - 'USER': 'cltbld', 05:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:42 INFO - 'XPC_FLAGS': '0x0', 05:01:42 INFO - 'XPC_SERVICE_NAME': '0', 05:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:01:42 INFO - Cleaning up... 05:01:42 INFO - Return code: 0 05:01:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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 05:01: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 05:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:42 INFO - 'HOME': '/Users/cltbld', 05:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:42 INFO - 'LOGNAME': 'cltbld', 05:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:42 INFO - 'MOZ_NO_REMOTE': '1', 05:01:42 INFO - 'NO_EM_RESTART': '1', 05:01:42 INFO - 'PAGER': '/bin/cat', 05:01:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:42 INFO - 'PWD': '/builds/slave/test', 05:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:42 INFO - 'SHELL': '/bin/bash', 05:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:42 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:42 INFO - 'USER': 'cltbld', 05:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:42 INFO - 'XPC_FLAGS': '0x0', 05:01:42 INFO - 'XPC_SERVICE_NAME': '0', 05:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:01:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:46 INFO - Downloading docopt-0.6.1.tar.gz 05:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:46 INFO - Running setup.py install for blobuploader 05:01:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:01:46 INFO - Running setup.py install for requests 05:01:47 INFO - Running setup.py install for docopt 05:01:47 INFO - Successfully installed blobuploader requests docopt 05:01:47 INFO - Cleaning up... 05:01:47 INFO - Return code: 0 05:01:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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 05:01: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 05:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:47 INFO - 'HOME': '/Users/cltbld', 05:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:47 INFO - 'LOGNAME': 'cltbld', 05:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:47 INFO - 'MOZ_NO_REMOTE': '1', 05:01:47 INFO - 'NO_EM_RESTART': '1', 05:01:47 INFO - 'PAGER': '/bin/cat', 05:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:47 INFO - 'PWD': '/builds/slave/test', 05:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:47 INFO - 'SHELL': '/bin/bash', 05:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:47 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:47 INFO - 'USER': 'cltbld', 05:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:47 INFO - 'XPC_FLAGS': '0x0', 05:01:47 INFO - 'XPC_SERVICE_NAME': '0', 05:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:47 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QZ34nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:47 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-NFxem3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:47 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-XG6Fah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Sg1lZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-w6RV9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-HwNBgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-gqRDaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-uF3PDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-JDdM9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-70y3zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-PDScld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Q86Yq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:48 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-tOTR1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:49 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Judxdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:49 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-yJCHN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:49 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-xNQCXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:49 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-e9kpI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:49 INFO - Running setup.py install for manifestparser 05:01:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:01:49 INFO - Running setup.py install for mozcrash 05:01:49 INFO - Running setup.py install for mozdebug 05:01:49 INFO - Running setup.py install for mozdevice 05:01:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Running setup.py install for mozfile 05:01:50 INFO - Running setup.py install for mozhttpd 05:01:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Running setup.py install for mozinfo 05:01:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Running setup.py install for mozInstall 05:01:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:01:50 INFO - Running setup.py install for mozleak 05:01:50 INFO - Running setup.py install for mozlog 05:01:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:01:51 INFO - Running setup.py install for moznetwork 05:01:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:01:51 INFO - Running setup.py install for mozprocess 05:01:51 INFO - Running setup.py install for mozprofile 05:01:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:01:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:01:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:01:51 INFO - Running setup.py install for mozrunner 05:01:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:01:51 INFO - Running setup.py install for mozscreenshot 05:01:51 INFO - Running setup.py install for moztest 05:01:51 INFO - Running setup.py install for mozversion 05:01:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:52 INFO - Cleaning up... 05:01:52 INFO - Return code: 0 05:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:52 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')]} 05:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:52 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')]} 05:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:52 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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01:52 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 05:01:52 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 05:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:52 INFO - 'HOME': '/Users/cltbld', 05:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:52 INFO - 'LOGNAME': 'cltbld', 05:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:52 INFO - 'MOZ_NO_REMOTE': '1', 05:01:52 INFO - 'NO_EM_RESTART': '1', 05:01:52 INFO - 'PAGER': '/bin/cat', 05:01:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:52 INFO - 'PWD': '/builds/slave/test', 05:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:52 INFO - 'SHELL': '/bin/bash', 05:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:52 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:52 INFO - 'USER': 'cltbld', 05:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:52 INFO - 'XPC_FLAGS': '0x0', 05:01:52 INFO - 'XPC_SERVICE_NAME': '0', 05:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-nW_u_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01: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)) 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-JNjuP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01: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)) 05:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:52 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-BQKXsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-OpiwQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ynU_Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-yAs26V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-BJC275-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-DhXtVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-h9lXYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:53 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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-TDidUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01: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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-EnIMSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01: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)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:53 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-inxxCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:54 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)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:54 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-whJyK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:54 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)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:54 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-gyHJRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:54 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)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:54 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-nQwb2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:54 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)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:54 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-8DpaLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:54 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)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:54 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-9CBGrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:54 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)) 05:01:54 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)) 05:01:54 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)) 05:01:54 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)) 05:01:54 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)) 05:01:54 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)) 05:01:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:57 INFO - Downloading blessings-1.6.tar.gz 05:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:57 INFO - Installing collected packages: blessings 05:01:57 INFO - Running setup.py install for blessings 05:01:57 INFO - Successfully installed blessings 05:01:57 INFO - Cleaning up... 05:01:57 INFO - Return code: 0 05:01:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:58 INFO - Reading from file tmpfile_stdout 05:01:58 INFO - Current package versions: 05:01:58 INFO - blessings == 1.6 05:01:58 INFO - blobuploader == 1.2.4 05:01:58 INFO - docopt == 0.6.1 05:01:58 INFO - functools32 == 3.2.3-2 05:01:58 INFO - jsonschema == 2.5.1 05:01:58 INFO - manifestparser == 1.1 05:01:58 INFO - mozInstall == 1.12 05:01:58 INFO - mozcrash == 0.17 05:01:58 INFO - mozdebug == 0.1 05:01:58 INFO - mozdevice == 0.48 05:01:58 INFO - mozfile == 1.2 05:01:58 INFO - mozhttpd == 0.7 05:01:58 INFO - mozinfo == 0.9 05:01:58 INFO - mozleak == 0.1 05:01:58 INFO - mozlog == 3.4 05:01:58 INFO - moznetwork == 0.27 05:01:58 INFO - mozprocess == 0.23 05:01:58 INFO - mozprofile == 0.28 05:01:58 INFO - mozrunner == 6.12 05:01:58 INFO - mozscreenshot == 0.1 05:01:58 INFO - mozsystemmonitor == 0.3 05:01:58 INFO - moztest == 0.7 05:01:58 INFO - mozversion == 1.4 05:01:58 INFO - psutil == 3.1.1 05:01:58 INFO - requests == 1.2.3 05:01:58 INFO - wsgiref == 0.1.2 05:01:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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 05:01: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 05:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:58 INFO - 'HOME': '/Users/cltbld', 05:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:58 INFO - 'LOGNAME': 'cltbld', 05:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:58 INFO - 'MOZ_NO_REMOTE': '1', 05:01:58 INFO - 'NO_EM_RESTART': '1', 05:01:58 INFO - 'PAGER': '/bin/cat', 05:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:58 INFO - 'PWD': '/builds/slave/test', 05:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:58 INFO - 'SHELL': '/bin/bash', 05:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:58 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:58 INFO - 'USER': 'cltbld', 05:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:58 INFO - 'XPC_FLAGS': '0x0', 05:01:58 INFO - 'XPC_SERVICE_NAME': '0', 05:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01: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)) 05:01:58 INFO - Cleaning up... 05:01:58 INFO - Return code: 0 05:01:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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 0x1093a4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10931a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeaa4a58b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, '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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 05:01: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 05:01: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 05:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:58 INFO - 'HOME': '/Users/cltbld', 05:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:58 INFO - 'LOGNAME': 'cltbld', 05:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:58 INFO - 'MOZ_NO_REMOTE': '1', 05:01:58 INFO - 'NO_EM_RESTART': '1', 05:01:58 INFO - 'PAGER': '/bin/cat', 05:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:58 INFO - 'PWD': '/builds/slave/test', 05:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:58 INFO - 'SHELL': '/bin/bash', 05:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:01:58 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:58 INFO - 'USER': 'cltbld', 05:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:58 INFO - 'XPC_FLAGS': '0x0', 05:01:58 INFO - 'XPC_SERVICE_NAME': '0', 05:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:01:58 INFO - Cleaning up... 05:01:58 INFO - Return code: 0 05:01:58 INFO - Running post-action listener: _resource_record_post_action 05:01:58 INFO - Running post-action listener: _start_resource_monitoring 05:01:58 INFO - Starting resource monitoring. 05:01:58 INFO - [mozharness: 2016-10-17 12:01:58.646036Z] Finished create-virtualenv step (success) 05:01:58 INFO - [mozharness: 2016-10-17 12:01:58.647001Z] Running install step. 05:01:58 INFO - Running pre-action listener: _resource_record_pre_action 05:01:58 INFO - Running main action method: install 05:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:58 INFO - Reading from file tmpfile_stdout 05:01:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:01:59 INFO - Reading from file tmpfile_stdout 05:01:59 INFO - Output received: 05:01:59 INFO - Usage: mozinstall [options] installer 05:01:59 INFO - Options: 05:01:59 INFO - -h, --help show this help message and exit 05:01:59 INFO - -d DEST, --destination=DEST 05:01:59 INFO - Directory to install application into. [default: 05:01:59 INFO - "/builds/slave/test"] 05:01:59 INFO - --app=APP Application being installed. [default: firefox] 05:01:59 INFO - mkdir: /builds/slave/test/build/application 05:01: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'] 05:01: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 05:02:32 INFO - Reading from file tmpfile_stdout 05:02:32 INFO - Output received: 05:02:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:02:32 INFO - Running post-action listener: _resource_record_post_action 05:02:32 INFO - [mozharness: 2016-10-17 12:02:32.947181Z] Finished install step (success) 05:02:32 INFO - [mozharness: 2016-10-17 12:02:32.947325Z] Running run-tests step. 05:02:32 INFO - Running pre-action listener: _resource_record_pre_action 05:02:32 INFO - Running main action method: run_tests 05:02:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:32 INFO - 2016-10-17 05:02:32.961 screenresolution[1639:7547] starting screenresolution argv=screenresolution get 05:02:32 INFO - 2016-10-17 05:02:32.964 screenresolution[1639:7547] Display 0: 1600x1200x32@60 05:02:32 INFO - 2016-10-17 05:02:32.970 screenresolution[1640:7549] starting screenresolution argv=screenresolution list 05:02:32 INFO - Available Modes on Display 0 05:02:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:02:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:02:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:02:33 INFO - Intel Iris: 05:02:33 INFO - Chipset Model: Intel Iris 05:02:33 INFO - Type: GPU 05:02:33 INFO - Bus: Built-In 05:02:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:33 INFO - Vendor: Intel (0x8086) 05:02:33 INFO - Device ID: 0x0a2e 05:02:33 INFO - Revision ID: 0x0009 05:02:33 INFO - Displays: 05:02:33 INFO - Display: 05:02:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:02:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:33 INFO - Display Serial Number: 1600x1200 60 05:02:33 INFO - Main Display: Yes 05:02:33 INFO - Mirror: Off 05:02:33 INFO - Online: Yes 05:02:33 INFO - Rotation: Supported 05:02:33 INFO - Return code: 0 05:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:33 INFO - Python 2.7.3 05:02:33 INFO - Return code: 0 05:02:33 INFO - grabbing minidump binary from tooltool 05:02:33 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')]} 05:02:33 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 0x1091b8d30>, '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 0x108fdedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091b0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:33 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 05:02:33 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 05:02:33 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 05:02:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:33 INFO - Return code: 0 05:02:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:02:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:02:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:33 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/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 05:02:33 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/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0095 --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 05:02:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWs9r34WsQ/Render', 05:02:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:33 INFO - 'HOME': '/Users/cltbld', 05:02:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:33 INFO - 'LOGNAME': 'cltbld', 05:02:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:33 INFO - 'MOZ_NO_REMOTE': '1', 05:02:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:33 INFO - 'NO_EM_RESTART': '1', 05:02:33 INFO - 'PAGER': '/bin/cat', 05:02:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:33 INFO - 'PWD': '/builds/slave/test', 05:02:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:33 INFO - 'SHELL': '/bin/bash', 05:02:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vT9MLT3ooK/Listeners', 05:02:33 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 05:02:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:33 INFO - 'USER': 'cltbld', 05:02:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:33 INFO - 'XPC_FLAGS': '0x0', 05:02:33 INFO - 'XPC_SERVICE_NAME': '0', 05:02:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:33 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/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 05:02:33 INFO - mozversion application_buildid: 20161017023737 05:02:33 INFO - mozversion application_changeset: 94b0fddf96b43942bdd851a3275042909ea37e09 05:02:33 INFO - mozversion application_display_name: Nightly 05:02:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:33 INFO - mozversion application_name: Firefox 05:02:33 INFO - mozversion application_remotingname: firefox 05:02:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:02:33 INFO - mozversion application_vendor: Mozilla 05:02:33 INFO - mozversion application_version: 52.0a1 05:02:33 INFO - mozversion platform_buildid: 20161017023737 05:02:33 INFO - mozversion platform_changeset: 94b0fddf96b43942bdd851a3275042909ea37e09 05:02:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:02:33 INFO - mozversion platform_version: 52.0a1 05:02:33 INFO - using testdate: 1476705753 05:02:33 INFO - actual date: 1476705753 05:02:33 INFO - starting webserver on 'localhost:49273' 05:02:33 INFO - SUITE-START | Running 2 tests 05:02:33 INFO - TEST-START | dromaeo_css 05:02:33 INFO - operating with platform_type : mac_ 05:02:33 INFO - Initialising browser for dromaeo_css test... 05:02:33 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpj5KWO1/profile http://localhost:49273/getInfo.html) 05:02:36 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 05:02:36 INFO - PROCESS | 1650 | colorDepth:24 05:02:36 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 05:02:36 INFO - PROCESS | 1650 | __metrics 05:02:36 INFO - PROCESS | 1650 | 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" 05:02:36 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:37 INFO - TEST-INFO | 1650: exit 0 05:02:37 INFO - Browser initialized. 05:02:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:37 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpj5KWO1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:49 INFO - PROCESS | 1655 | RSS: Main: 231854080 05:02:49 INFO - PROCESS | 1655 | 05:03:40 INFO - PROCESS | 1655 | 1476705820216 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] 05:05:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 05:05:55 INFO - PROCESS | 1655 | RSS: Main: 381661184 05:05:55 INFO - PROCESS | 1655 | 05:08:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:08:59 INFO - PROCESS | 1655 | RSS: Main: 373821440 05:08:59 INFO - PROCESS | 1655 | 05:12:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:12:02 INFO - PROCESS | 1655 | RSS: Main: 341250048 05:12:02 INFO - PROCESS | 1655 | 05:15:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:15:05 INFO - PROCESS | 1655 | RSS: Main: 353075200 05:15:05 INFO - PROCESS | 1655 | 05:18:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:18:09 INFO - PROCESS | 1655 | RSS: Main: 339914752 05:18:09 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:21:12 INFO - PROCESS | 1655 | RSS: Main: 409583616 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | __start_tp_report 05:21:12 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 05:21:12 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 05:21:12 INFO - PROCESS | 1655 | |i|pagename|runs| 05:21:12 INFO - PROCESS | 1655 | |0;dojo.html;3272.623648280448;3296.604407471104;3314.5535224609857;3329.6836800503975;3356.1945133168047;5461.126219804832;5505.834824955253;5556.861078473035;5564.387917329091;5585.9999999999945;5520.861978450541;5536.058869992101;5600.299962504687;5605.635633683818;5620.4660557247;5056.393232812049;5056.570191533724;5058.064258112261;5114.28400023997;5122.078025955327;5151.4333423323405;5239.869003274911;5242.528172464477;5247.003069416818;5290.656107353029;5191.195364718475;5208.322918020671;5215.660982036175;5252.658577192489;5285.524302812746;5015.22264049073;5036.79852805891;5055.090083784918;5101.464346243665;5116.718580478072;5070.31550740649;5096.439391666913;5107.514786095315;5118.07874582575;5140.126178549618;5482.5613950884235;5567.220589117527;5584.553235741171;5584.832455026356;5597.524210442118;6030.66831324277;6036.396360363972;6036.913355595991;6045.3047899491685;6051.546134039921;4693.694909830884;5917.911231331534;5933.110033494967;6064.302605200371;6079.452849243545;5343.664083979005;5605.243292155547;5643.463870932255;5644.379118296984;5645.350784659735;5633.183188437735;6255.937440625627;6273.0904018917;6282.183316168869;6285.245770507477;5810.41895810424;5835.766569337179;5851.1223316502865;5855.531557475391;5935.347111817697;6077.9392206078255;6090.451859332681;6099.43084549468;6105.277797093309;6129.264488261348;5078.908034772541;5912.763489460373;5983.820485385445;6017;6049.606775559662;5873.353931067664;5892.558058145656;5944.197533333031;6040.124181993587;6052.697365131726;4776.259679749644;4808.855734327975;4843.75781210938;4849.951500485021;4885.511448855086;4340.696151269444;4343.131373725268;4351.717138385995;4353.368761529624;4385.802638881258;5592.720363981784;5607.355154157242;5620.297462817148;5622.357984674434;5673.687947162945;5973.940260597338;5980.401959803985;6050.122732203894;6086.147939288503;6100.066499260575;5572.192032155396;5613.045782217033;5639.154126881001;5651.773929042874;5655.434456554394;5275.7362131894015;5282.181261904411;5295.12630415977;5298.0463516566615;5298.443663415363;5284.392294886137;6095.226761080279;6135.417135372132;6297.905531417033;6322;6033.276006879202;6048.758049677964;6052.697365131814;6065.5754097212775;6067.362926892612;6171.259448866164;6174.043023331391;6178.845528861814;6182.381761823962;6198.008318668992;6010.879782404415;6019.1573179754;6079.422454866957;6115.296740874678;6129.754809807558;6001.309849367379;6117.3270940197435;6151.415615516519;6158.507319414346;6170.598911070766;4978.726170060681;5768.567357448292;5947.31605865331;5962.956482615438;5964.373740757158;5824.679642619527;5870.031444811559;5871.706414679335;5904.734286957011;5992.61048031894;5788.594798364243;5805.216295800182;5809.012467880555;5812.070068788974;5814.76740930358;5945.40545945402;5947.167396564398;5961.791337303173;5964.671943043174;5967.76128954837;5648.5763567731765;5683.545316374597;5736.770529178786;5808.76764929415;5810.535157187331 05:21:12 INFO - PROCESS | 1655 | |1;ext.html;501.6839391183554;510.7676007416626;528.9497497737714;530.2814686100335;549.7663493015467;29925.850370748143;31411;31439.68560314396;31474.68525314746;31531.84234078832;32010.35979280413;40737.79631101848;41697.37453938193;41752.16495670085;43767.56232437675;9333.20667743241;9484.66803661872;9495.762605934873;9498.477583732893;9501.049895010512;9257.305702072337;9345.252379809634;9352.111549402796;9358.906410935906;9371.625134994592;9331.926828414751;9356.953215233914;9368.7657808555;9371.95314023429;9376.484293363863;9286.767830804216;9335.019822918564;9351.158395744416;9362.531873406302;9362.719118426457;9274.026227246177;9334.439933603937;9344.579493922722;9345.439273643604;9350.766230844283;39371.40942885859;39630.405543916866;39662;39727.4040889384;39732.60267397318;3410.215650400397;3475.14858859581;3655.3968595181764;3882;3970.3845903884653;25537.61693574598;28661.487899611635;30115;30134.397312053636;30243;3061.678523755018;3145.1822526143137;3185.904422867318;3186.6972637599392;3244.8702051917894;484384;486702;489904.99999999645;490526;494837;56097.71951140218;56603.71698141483;56618;56637.7168114165;56684.71657641685;57941.130883036785;58359.70820145957;58402.415975840544;58610.12084818731;58632;15717.44988925405;15894.68210635804;15903.363865445253;15908.522744317688;15923.840761592235;12477.939375153213;12574.43415046325;12580.81128783069;12581;12594.307313097685;14156.221407822668;14672.779908301383;14732.410703571952;14758.188299643623;14815.851841481663;5229.843104706865;6081.563916387316;6181.8454538636;6184.319724830265;6190.7523699051535;864.7362554420836;967.1827305926481;979.7256768104942;1000.8348622477209;1045.2369770067894;27852.442951141267;28953.565696514568;29002.27494312659;29714;29726.554101688493;973.352720440913;973.4597298499259;1036.5024788101753;1066.36018388966;1088.820344643125;13321.866781332063;14618.122912625277;15202.543923682308;15233.6191595211;15262.007969481949;616560.9171954112;618701;620557;620613;621995;55747.442525574224;55902;55917;55932.16101758477;56035;1231.119749379198;1271.8982481401652;1329.056369977327;1366.1052010932856;1378.689794796163;24361.634575481738;29164.70835291705;29897;30522.84738576293;30681.53977690381;46248.07503849837;46758.53241467542;46937.76531117323;46938.29592556046;46951;498892;498954;501186;503277;810200;23706;23797.52404951926;24145.51708965846;24331.148409805573;24385;43851;43856.78071609622;44037.559624403344;44503.55496444994;44814.77592612016;36845.44731828971;37543.112497375456;37566.812165938994;38087.61912380951;39589;37401.4389784148;37583.81208093942;37816.43275350927;38801.223975520894;39035.6096439032;37383.81308093442;37671;38272;38307.425388618634;39641;30156.09531714052;30684.386312273182;33976;34101.31797363989;34120.48819267663;24406.87796561006;24853.378665533506;24907.626385603868;25535;25670.973161073347 05:21:12 INFO - PROCESS | 1655 | |2;jquery.html;352.2778304475824;363.92903383840155;367.6801182970817;371.901446116779;392.2938710321421;14113.389023030733;15033.548993530198;20088.89955550222;21147.365579032616;21515.784842151574;20428.795712042876;20501.589968200627;20642;21129.577408451823;21327.25354612585;5669.376368599461;5959.612625179371;5978.581499295029;6003.459688628022;6008.866852267448;5737.913931291013;6014.037753959367;6044.576879618428;6075.088736689488;6096.878062438748;5908.911366329487;6030.396960303979;6090.177825993501;6095.634261944276;6096.268447786249;6026.548008899328;6109.205803245594;6113.847153821145;6115.3884611538715;6115.724792384353;5106.08090543702;5358;5394.8921021579745;5870.97064514679;5903.704814759245;13167.407466663928;13234.933825330812;13247.271400072992;13418.329083545783;13431.932840335834;2127.95744085119;2180.291405293286;2254.875981820999;2260.9321720348416;2360.280114565057;9742.366746161477;9964.003599639978;9967.202623790152;10204.132648724868;14575.562733118024;1775.1834156288123;1782.8484578810817;1807.5390775352332;1849.1401498303353;1857.19212142717;112172.31741523884;117807;118550;119387.403062985;122888.77111228862;10605.522751476203;10736.677899663022;11553.422328883522;11556.768864622829;11783.941080294544;10787;12886.871131288755;13441.260730659713;13446.93276533611;14375.496857609933;8461.830763384822;8591.742247732578;8623.827523449496;8745.976850648773;8782.253508451726;6988.336108069725;8650.610722517502;8679.218870301704;8786.16531429513;8794.560271986375;3592.497050412944;3719.795411252407;4153.691587150038;4358.694891357574;4438.689291749611;1829.0049200431013;1841.8028281617055;1921.3755529452703;1934.1973081171157;1937.2928880958348;729.4638440746047;826.4793180296375;870.3385427075342;914.4513292024732;939.3049143633798;21517.78482215189;21947.561048778934;22220.666689999664;22297.554048919254;22361.776382236294;898.7753061734567;949.2216382566368;979.3438396274371;980.7695191629962;1042.2339580408393;5171.7672704728375;5544.750486228129;6005.498625343664;6032.1856549365275;10910.290831095954;556270;569165;571556;586766;587797;123292.5891949506;131414.68585314215;132458;134291;134617;438.32279128746165;454.9567791059844;456.1333466413774;457.3094627113083;458.50939494740976;11287.20989530725;11396.430178490877;11618.360990145286;11667.59163429276;11752.353620550952;53160;53316.73341633267;54399;54478;55177.172342414095;76214;77240.5389478737;78744;80100;81040.59479702564;8040.035195776544;8119.4722343047515;8155.143709910374;8324.958375208085;8476.364272679697;11910;12054.337011464102;12137.393130343271;12745.872541274839;13395.531156409479;11109;11461.713457163303;11598.478068487108;11719.531218751154;11725.530978760755;10875.293105948089;11045.558177672803;11149;11572.421378931189;11605.245659032136;11443;11485.942570287096;11714.648560543197;11824;11875.168738188244;8134.75595732129;8262.297704695167;8264.545450000307;8329.54187519668;8387.119352467904;10905.727356816144;11360.431978400882;11498.77002459963;11561.017313528444;11681.897258493213 05:21:12 INFO - PROCESS | 1655 | |3;mootools.html;1545.9922700386496;1574.283700916083;1809.5928416106378;1917.6356492266477;1964.2437661500328;7890.132085470594;8209.589520523965;8465.873011904818;8893;8926.732198034062;8050.95974520128;8126.796830079251;8146.348292136615;8147.837043259146;8353.248207661325;1978.8614796964146;2307.9884600576975;2366.7396586375485;2371.6561098640686;2372.9406764830933;2315.0392587076344;2331.63859601762;2353.646952957062;2366.1954935321987;2366.7751563601514;2332.3586013846157;2345.847519911209;2353.1293421434093;2360.232924299601;2372.110458578033;2303.1478353009325;2319.559283736093;2325.4651430170984;2327.2552783109413;2329.5457385809773;2333.1484008337006;2340.414896275931;2340.7776261255153;2340.97659023411;2345.5074434368803;8567.657293708244;8719.869201961976;8727.781805454852;8740.08229135938;8753.343499237582;5191.974040129813;5333.653312534673;5334.093204155303;5335.759890804923;5338.546223571001;3418.4872269159578;3508.3158784037123;3646.106703857545;3652.3243200008083;3656.8902932911788;1053.9262251642388;1060.8355704865758;1064.4518073192312;1081.453865797775;1082.0207712020556;11259.718507037307;11353.602623908206;11510.194286399956;11519.251248668726;11533.250338727956;4543.432070991126;4550.340200670884;4762.857114286577;4848.466668666444;4854.368932038812;9910.10809027191;9916.107550320507;9916.80166396668;9917.355371900803;9932.155766759763;4537.977310113428;5313.760880760375;5315.840524784263;5322.121849894801;5333.866653333697;4356.803943822536;4363.890902727458;4790.688605240648;4824.565789079;4877.073356062337;3543.2204914918675;3695.6858667013066;3879.7109705274024;3985.222881538072;4016.457778199964;1270.8093785931999;1273.38877338876;1281.3401098434315;1289.1105137455127;1297.3253907967992;843.7595285343771;863.4171933944688;904.5838914099588;913.5067063785482;950.5722424908819;4375.934360984587;5568.6101972862325;5775.826725198251;5777.162311464814;6013.338532761392;920.8664743612272;943.6602822983721;954.179405711088;976.1605019683067;1011.1102230037667;3709.406494960793;3741.8129093545213;3875.2830726315724;3942.758031220214;4000.0199951012187;10370;10547.84178237327;10701.732456688489;10708.78582428347;10722.356658600509;10159.695209143738;10355.844662330072;10547.630832920964;10574.471276436301;10651.627193048205;7972.880406793903;8117.512949223184;8118.75643730689;8123.593820309079;8132.146124656944;5588.217649529151;5614.410486898817;5714.685692286964;5749.770009199585;5841.970790146022;9785;9907.900920990698;9923.156531694598;9944.801103978025;9952.751181220527;8549;9505.192058674813;10188.796224075626;10202.030807073315;10205;6440.6135631862235;6676.799696009128;6682.031105489774;6977.7208911642965;7121.501494895515;8030.83938321242;8154.796130096795;8289.834203315779;8357.66569337244;8422.494650321001;7303.561786292839;7408.6666100026705;7429.368503677032;7493.250674932681;7574.772756817304;7076.858462830612;7259.963700181465;7282.817929551804;7284.271572842674;7387.9261207387235;6812.693428795816;6822.11312529368;6902.620355880475;6926.06498122747;6930.896036559557;4909.042736666459;4948.183549714401;4974.37820272466;4997.525235102659;5070.138076526926;4904.7302398367;4934.432540257916;4988.376452943382;5001.574866136273;5208.723862653674 05:21:12 INFO - PROCESS | 1655 | |4;prototype.html;295.9375840731771;303.1557113439073;312.3908378661609;317.3795230324715;320.0414757800388;5034.7986080556775;5040.36188238822;5200.4019537753165;5310.814121505743;5356.27690261815;4669.836555720551;5194.8701282467955;5273.419923808378;5276.472352764731;5284.920726189101;4053.9391909121387;4058.208649313385;4062.02511397264;4074.3888416737577;4076.7350122242105;4087.89780255493;4088.1619268049976;4088.5911408859174;4099.405586190001;4106.466159399289;3044.4672182368;3378.645242249553;3826.8469261229516;3895.8441662333616;3914.8042597869994;3978.1049263915675;3982.8605998790194;4001;4002.699797515198;4036.6770658347264;3166.9208269793207;3395.5246265522846;3478.826058697055;3490.6334834842482;3495.5281037059926;4494.550544945512;5028.547430731252;5117.283580298761;5131.666441681279;5193.584513238932;4565.497795242521;4580.198465268565;4600.308819340689;4610.308453731934;4616.484016211173;5493.335732169894;5496.395396506381;5520.908291356813;5546.140348245988;5558.221848941152;3227.144391974624;3353.597568291796;3584.964150358489;3774.3960966245545;3882.417637354391;4566.949601591619;4918.336024636664;5094.643374963791;5803.100519419497;5892.351841297454;3624.3113808376324;3706.944395834065;3707.629237076271;3845.3270677631863;3865.8840234793;3744.307303148926;3910.1397692507603;3911.3155197840265;3926.9018274542796;3933.4099885017476;3887.727859049896;4369.257226271541;4552.816267770338;4595.149897268949;4599.919019030525;5443.156310771837;5621.578381621394;5662.943370566324;5719.3422756382715;5728.513076388554;1131.903788178014;1303.9608811735663;1328.7873940169527;1331.660426591213;1335.4057444437133;658.1575583253443;745.8955746195537;803.7186984555359;807.4105902690951;820.8835983063029;3666.5416822897137;3861.706328379968;3962.7622342659533;4372.584604462571;4410.867673969786;4430.490493593214;4467.553244675506;4786.787626888316;4819.0002298092495;4826.372571565674;3839.9040023999623;3963.4451176835264;4082.4896887889013;4185.455890734246;4373.825046998085;2332.405236664674;2533.5305522796734;2545.325488745484;2546.910858119957;2554.846709197417;3987.7407968481957;4119.8970025749595;4726.810927562928;4989.675671081368;4997.650164488451;3867.207222519377;4499.595036446735;4846.636502262344;4918.286693546421;4935.901281974412;4457.554244575516;4567.520410356931;4641.443026836801;4988.308651597864;5041.437154482122;3993.8049560352183;4240.703150779415;4459.866204013885;4542.5249683991115;4849.466558678613;3916.804159792056;4725.314829349656;4791;4796.904061918812;4812.903741925212;4442.225107360354;4517.864464066083;4587.793549290357;4716.834910778106;4973.378327709036;2954.084233887502;3342.8997130086136;3352.401888536404;3358.177246574507;3376.831158442117;4018.805049985327;4126.690498212586;4468.078726147658;4556.362109304766;4789;4009.8997525062105;4411.404460397934;4686.250199967989;4711.021371024247;4734.834280800155;4263.126059157928;4671.509491503479;4672;4679.227927391942;4712.764361781966;3796.5064541609413;4242.533321334712;4548.88627784308;4596.540345965511;4608.516105808976;4141.254574176677;4142.91714165709;4395.582419670126;4688.6483513737285;4743.644226682944;4267.061246525759;4337.154254920387;4555.772211389483;4619.88450288732;4620.561046700558 05:21:12 INFO - PROCESS | 1655 | |5;yui.html;702.5714314268297;712.8807771798278;725.300085417572;734.1007266099026;766.6588368176164;15125.924370378147;15956.441524546643;15982.520524384287;15993.76009359859;16311.918440407811;14272.4291028359;14397.568072957802;14405.13569185847;14416.639584010405;14426.927865360685;707.3563057617569;727.2218725963221;881.4050515901756;883.0595415882098;908.7955210077713;898.0435835834847;904.0191392339319;911.079809392515;913.8903331600218;913.949732764701;933.2300851797295;935.2938531408777;971.6696323250094;977.2231076294363;988.5106872098321;749.6514120933792;776.5185584937375;981.2885657897967;983.2527279267737;983.7393090830935;694.7464175575928;716.2729829223342;720.2689270390558;721.3399739238642;722.8445884134936;15033;15084.094954302667;15097.698046039017;15099.698006039927;15117.168555729431;13403.396847141901;13672.93163534186;13861.514846980308;13870;14297.571072867726;12345.814812777815;12502.937485312606;12508.687282817911;12549.937250313782;12887.935560322232;4433.7118087324225;4435.135148646015;4529.275315949432;4641.628669706415;4645.187092258875;114377.42811285974;115417.99999999916;115680;116103;118426;10742.462876856125;10883.455827208609;10908.563657453613;10993.945030274797;11012.50443730034;17953.820461795476;22101.447463813533;22184.667229991563;22207.22274720377;22239.55520889573;7679.500832445873;7729.149793522708;7926.009248843895;7983.161768014391;7999.0801057877925;4141.772202528829;4220.451341325608;4316.374125751811;4409.845655402046;4410.757408342508;3489.5986961499752;3560.7507474477056;3597.442396428558;3605.369060414417;3609.314230296235;529.7986765029265;611.9877602448015;620.0048921481048;622.0948519903529;642.8714257148589;554.9112142057332;584.0742423259181;612.5099920063931;626.295417655138;629.276332217953;8863.911360886308;8904.8664270036;8984.55077246135;9054.954725226331;9071.501067441222;594.8126340202822;628.355935166458;630.6346759266138;634.8793729191439;644.8645784385238;3694.5935947045805;4295.591918767712;4468.195724769573;4488.820447182142;4494.910101797946;128019.07732917399;141124.88312675318;147432.26283868725;156245.2187739054;157501;82126;86389.70415443773;98223;120287;121323;90824.63763043427;95207.52396238114;96327.51836240773;105529;115008.3996640125;9198.256085328736;9337.439753614804;9570.377925434825;9758.658446954323;9845.803083938137;51063.234051488515;55997.44002559922;59613.442521323486;60179;62728;86185.56907215675;92220;92467.53766231125;92831;95981;12686.238825670489;12844.678883027998;12947.5468358607;13019.869801301866;13269.137506062076;14246.786298205743;14447.638809029859;14650.780238296222;14736.189509577076;15286.082835029934;13532.985026123277;13564.38960246811;13860.06324321944;13920.373583188579;14026.298685065502;13358;13779.311034448037;13792.379342929793;14135.222562759147;14327.498537551135;13102.148360356547;13432.261225632294;13433.261170635318;13496;13603.79594306106;11188.216824822184;11253.7749245013;11330.886691132982;11331.716707082389;11735.295882247092;10570.682879513626;10573.312734672221;11278.436078196222;11571.5949941755;11588.6523404298 05:21:12 INFO - PROCESS | 1655 | __end_tp_report 05:21:12 INFO - PROCESS | 1655 | __start_cc_report 05:21:12 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1627 05:21:12 INFO - PROCESS | 1655 | __end_cc_report 05:21:12 INFO - PROCESS | 1655 | __startTimestamp1476706872976__endTimestamp 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | ------- Summary: start ------- 05:21:12 INFO - PROCESS | 1655 | Number of tests: 6 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5583.93 Median:5736.77 stddev:606.15 (10.6%) stddev-sans-first:580.26 05:21:12 INFO - PROCESS | 1655 | Values: 3272.6 3296.6 3314.6 3329.7 3356.2 5461.1 5505.8 5556.9 5564.4 5586.0 5520.9 5536.1 5600.3 5605.6 5620.5 5056.4 5056.6 5058.1 5114.3 5122.1 5151.4 5239.9 5242.5 5247.0 5290.7 5191.2 5208.3 5215.7 5252.7 5285.5 5015.2 5036.8 5055.1 5101.5 5116.7 5070.3 5096.4 5107.5 5118.1 5140.1 5482.6 5567.2 5584.6 5584.8 5597.5 6030.7 6036.4 6036.9 6045.3 6051.5 4693.7 5917.9 5933.1 6064.3 6079.5 5343.7 5605.2 5643.5 5644.4 5645.4 5633.2 6255.9 6273.1 6282.2 6285.2 5810.4 5835.8 5851.1 5855.5 5935.3 6077.9 6090.5 6099.4 6105.3 6129.3 5078.9 5912.8 5983.8 6017.0 6049.6 5873.4 5892.6 5944.2 6040.1 6052.7 4776.3 4808.9 4843.8 4850.0 4885.5 4340.7 4343.1 4351.7 4353.4 4385.8 5592.7 5607.4 5620.3 5622.4 5673.7 5973.9 5980.4 6050.1 6086.1 6100.1 5572.2 5613.0 5639.2 5651.8 5655.4 5275.7 5282.2 5295.1 5298.0 5298.4 5284.4 6095.2 6135.4 6297.9 6322.0 6033.3 6048.8 6052.7 6065.6 6067.4 6171.3 6174.0 6178.8 6182.4 6198.0 6010.9 6019.2 6079.4 6115.3 6129.8 6001.3 6117.3 6151.4 6158.5 6170.6 4978.7 5768.6 5947.3 5963.0 5964.4 5824.7 5870.0 5871.7 5904.7 5992.6 5788.6 5805.2 5809.0 5812.1 5814.8 5945.4 5947.2 5961.8 5964.7 5967.8 5648.6 5683.5 5736.8 5808.8 5810.5 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:68007.96 Median:39635.70 stddev:151084.69 (381.2%) stddev-sans-first:151423.50 05:21:12 INFO - PROCESS | 1655 | Values: 501.7 510.8 528.9 530.3 549.8 29925.9 31411.0 31439.7 31474.7 31531.8 32010.4 40737.8 41697.4 41752.2 43767.6 9333.2 9484.7 9495.8 9498.5 9501.0 9257.3 9345.3 9352.1 9358.9 9371.6 9331.9 9357.0 9368.8 9372.0 9376.5 9286.8 9335.0 9351.2 9362.5 9362.7 9274.0 9334.4 9344.6 9345.4 9350.8 39371.4 39630.4 39662.0 39727.4 39732.6 3410.2 3475.1 3655.4 3882.0 3970.4 25537.6 28661.5 30115.0 30134.4 30243.0 3061.7 3145.2 3185.9 3186.7 3244.9 484384.0 486702.0 489905.0 490526.0 494837.0 56097.7 56603.7 56618.0 56637.7 56684.7 57941.1 58359.7 58402.4 58610.1 58632.0 15717.4 15894.7 15903.4 15908.5 15923.8 12477.9 12574.4 12580.8 12581.0 12594.3 14156.2 14672.8 14732.4 14758.2 14815.9 5229.8 6081.6 6181.8 6184.3 6190.8 864.7 967.2 979.7 1000.8 1045.2 27852.4 28953.6 29002.3 29714.0 29726.6 973.4 973.5 1036.5 1066.4 1088.8 13321.9 14618.1 15202.5 15233.6 15262.0 616560.9 618701.0 620557.0 620613.0 621995.0 55747.4 55902.0 55917.0 55932.2 56035.0 1231.1 1271.9 1329.1 1366.1 1378.7 24361.6 29164.7 29897.0 30522.8 30681.5 46248.1 46758.5 46937.8 46938.3 46951.0 498892.0 498954.0 501186.0 503277.0 810200.0 23706.0 23797.5 24145.5 24331.1 24385.0 43851.0 43856.8 44037.6 44503.6 44814.8 36845.4 37543.1 37566.8 38087.6 39589.0 37401.4 37583.8 37816.4 38801.2 39035.6 37383.8 37671.0 38272.0 38307.4 39641.0 30156.1 30684.4 33976.0 34101.3 34120.5 24406.9 24853.4 24907.6 25535.0 25671.0 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33846.08 Median:1978.21 stddev:96340.23 (4870.1%) stddev-sans-first:96577.66 05:21:12 INFO - PROCESS | 1655 | Values: 352.3 363.9 367.7 371.9 392.3 14113.4 15033.5 20088.9 21147.4 21515.8 20428.8 20501.6 20642.0 21129.6 21327.3 5669.4 5959.6 5978.6 6003.5 6008.9 5737.9 6014.0 6044.6 6075.1 6096.9 5908.9 6030.4 6090.2 6095.6 6096.3 6026.5 6109.2 6113.8 6115.4 6115.7 5106.1 5358.0 5394.9 5871.0 5903.7 13167.4 13234.9 13247.3 13418.3 13431.9 2128.0 2180.3 2254.9 2260.9 2360.3 9742.4 9964.0 9967.2 10204.1 14575.6 1775.2 1782.8 1807.5 1849.1 1857.2 112172.3 117807.0 118550.0 119387.4 122888.8 10605.5 10736.7 11553.4 11556.8 11783.9 10787.0 12886.9 13441.3 13446.9 14375.5 8461.8 8591.7 8623.8 8746.0 8782.3 6988.3 8650.6 8679.2 8786.2 8794.6 3592.5 3719.8 4153.7 4358.7 4438.7 1829.0 1841.8 1921.4 1934.2 1937.3 729.5 826.5 870.3 914.5 939.3 21517.8 21947.6 22220.7 22297.6 22361.8 898.8 949.2 979.3 980.8 1042.2 5171.8 5544.8 6005.5 6032.2 10910.3 556270.0 569165.0 571556.0 586766.0 587797.0 123292.6 131414.7 132458.0 134291.0 134617.0 438.3 455.0 456.1 457.3 458.5 11287.2 11396.4 11618.4 11667.6 11752.4 53160.0 53316.7 54399.0 54478.0 55177.2 76214.0 77240.5 78744.0 80100.0 81040.6 8040.0 8119.5 8155.1 8325.0 8476.4 11910.0 12054.3 12137.4 12745.9 13395.5 11109.0 11461.7 11598.5 11719.5 11725.5 10875.3 11045.6 11149.0 11572.4 11605.2 11443.0 11485.9 11714.6 11824.0 11875.2 8134.8 8262.3 8264.5 8329.5 8387.1 10905.7 11360.4 11498.8 11561.0 11681.9 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5610.64 Median:4981.38 stddev:3124.01 (62.7%) stddev-sans-first:3117.84 05:21:12 INFO - PROCESS | 1655 | Values: 1546.0 1574.3 1809.6 1917.6 1964.2 7890.1 8209.6 8465.9 8893.0 8926.7 8051.0 8126.8 8146.3 8147.8 8353.2 1978.9 2308.0 2366.7 2371.7 2372.9 2315.0 2331.6 2353.6 2366.2 2366.8 2332.4 2345.8 2353.1 2360.2 2372.1 2303.1 2319.6 2325.5 2327.3 2329.5 2333.1 2340.4 2340.8 2341.0 2345.5 8567.7 8719.9 8727.8 8740.1 8753.3 5192.0 5333.7 5334.1 5335.8 5338.5 3418.5 3508.3 3646.1 3652.3 3656.9 1053.9 1060.8 1064.5 1081.5 1082.0 11259.7 11353.6 11510.2 11519.3 11533.3 4543.4 4550.3 4762.9 4848.5 4854.4 9910.1 9916.1 9916.8 9917.4 9932.2 4538.0 5313.8 5315.8 5322.1 5333.9 4356.8 4363.9 4790.7 4824.6 4877.1 3543.2 3695.7 3879.7 3985.2 4016.5 1270.8 1273.4 1281.3 1289.1 1297.3 843.8 863.4 904.6 913.5 950.6 4375.9 5568.6 5775.8 5777.2 6013.3 920.9 943.7 954.2 976.2 1011.1 3709.4 3741.8 3875.3 3942.8 4000.0 10370.0 10547.8 10701.7 10708.8 10722.4 10159.7 10355.8 10547.6 10574.5 10651.6 7972.9 8117.5 8118.8 8123.6 8132.1 5588.2 5614.4 5714.7 5749.8 5842.0 9785.0 9907.9 9923.2 9944.8 9952.8 8549.0 9505.2 10188.8 10202.0 10205.0 6440.6 6676.8 6682.0 6977.7 7121.5 8030.8 8154.8 8289.8 8357.7 8422.5 7303.6 7408.7 7429.4 7493.3 7574.8 7076.9 7260.0 7282.8 7284.3 7387.9 6812.7 6822.1 6902.6 6926.1 6930.9 4909.0 4948.2 4974.4 4997.5 5070.1 4904.7 4934.4 4988.4 5001.6 5208.7 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4067.05 Median:4436.36 stddev:1199.08 (27.0%) stddev-sans-first:1168.56 05:21:12 INFO - PROCESS | 1655 | Values: 295.9 303.2 312.4 317.4 320.0 5034.8 5040.4 5200.4 5310.8 5356.3 4669.8 5194.9 5273.4 5276.5 5284.9 4053.9 4058.2 4062.0 4074.4 4076.7 4087.9 4088.2 4088.6 4099.4 4106.5 3044.5 3378.6 3826.8 3895.8 3914.8 3978.1 3982.9 4001.0 4002.7 4036.7 3166.9 3395.5 3478.8 3490.6 3495.5 4494.6 5028.5 5117.3 5131.7 5193.6 4565.5 4580.2 4600.3 4610.3 4616.5 5493.3 5496.4 5520.9 5546.1 5558.2 3227.1 3353.6 3585.0 3774.4 3882.4 4566.9 4918.3 5094.6 5803.1 5892.4 3624.3 3706.9 3707.6 3845.3 3865.9 3744.3 3910.1 3911.3 3926.9 3933.4 3887.7 4369.3 4552.8 4595.1 4599.9 5443.2 5621.6 5662.9 5719.3 5728.5 1131.9 1304.0 1328.8 1331.7 1335.4 658.2 745.9 803.7 807.4 820.9 3666.5 3861.7 3962.8 4372.6 4410.9 4430.5 4467.6 4786.8 4819.0 4826.4 3839.9 3963.4 4082.5 4185.5 4373.8 2332.4 2533.5 2545.3 2546.9 2554.8 3987.7 4119.9 4726.8 4989.7 4997.7 3867.2 4499.6 4846.6 4918.3 4935.9 4457.6 4567.5 4641.4 4988.3 5041.4 3993.8 4240.7 4459.9 4542.5 4849.5 3916.8 4725.3 4791.0 4796.9 4812.9 4442.2 4517.9 4587.8 4716.8 4973.4 2954.1 3342.9 3352.4 3358.2 3376.8 4018.8 4126.7 4468.1 4556.4 4789.0 4009.9 4411.4 4686.3 4711.0 4734.8 4263.1 4671.5 4672.0 4679.2 4712.8 3796.5 4242.5 4548.9 4596.5 4608.5 4141.3 4142.9 4395.6 4688.6 4743.6 4267.1 4337.2 4555.8 4619.9 4620.6 05:21:12 INFO - PROCESS | 1655 | 05:21:12 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:23868.44 Median:4181.11 stddev:37429.57 (895.2%) stddev-sans-first:37494.16 05:21:12 INFO - PROCESS | 1655 | Values: 702.6 712.9 725.3 734.1 766.7 15125.9 15956.4 15982.5 15993.8 16311.9 14272.4 14397.6 14405.1 14416.6 14426.9 707.4 727.2 881.4 883.1 908.8 898.0 904.0 911.1 913.9 913.9 933.2 935.3 971.7 977.2 988.5 749.7 776.5 981.3 983.3 983.7 694.7 716.3 720.3 721.3 722.8 15033.0 15084.1 15097.7 15099.7 15117.2 13403.4 13672.9 13861.5 13870.0 14297.6 12345.8 12502.9 12508.7 12549.9 12887.9 4433.7 4435.1 4529.3 4641.6 4645.2 114377.4 115418.0 115680.0 116103.0 118426.0 10742.5 10883.5 10908.6 10993.9 11012.5 17953.8 22101.4 22184.7 22207.2 22239.6 7679.5 7729.1 7926.0 7983.2 7999.1 4141.8 4220.5 4316.4 4409.8 4410.8 3489.6 3560.8 3597.4 3605.4 3609.3 529.8 612.0 620.0 622.1 642.9 554.9 584.1 612.5 626.3 629.3 8863.9 8904.9 8984.6 9055.0 9071.5 594.8 628.4 630.6 634.9 644.9 3694.6 4295.6 4468.2 4488.8 4494.9 128019.1 141124.9 147432.3 156245.2 157501.0 82126.0 86389.7 98223.0 120287.0 121323.0 90824.6 95207.5 96327.5 105529.0 115008.4 9198.3 9337.4 9570.4 9758.7 9845.8 51063.2 55997.4 59613.4 60179.0 62728.0 86185.6 92220.0 92467.5 92831.0 95981.0 12686.2 12844.7 12947.5 13019.9 13269.1 14246.8 14447.6 14650.8 14736.2 15286.1 13533.0 13564.4 13860.1 13920.4 14026.3 13358.0 13779.3 13792.4 14135.2 14327.5 13102.1 13432.3 13433.3 13496.0 13603.8 11188.2 11253.8 11330.9 11331.7 11735.3 10570.7 10573.3 11278.4 11571.6 11588.7 05:21:12 INFO - PROCESS | 1655 | -------- Summary: end -------- 05:21:13 INFO - PROCESS | 1655 | 05:21:13 INFO - TEST-INFO | 1655: exit 0 05:21:13 INFO - TEST-OK | dromaeo_css | took 1120165ms 05:21:13 INFO - TEST-START | kraken 05:21:13 INFO - operating with platform_type : mac_ 05:21:13 INFO - Initialising browser for kraken test... 05:21:13 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpadZRK4/profile http://localhost:49273/getInfo.html) 05:21:16 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:21:16 INFO - PROCESS | 1661 | colorDepth:24 05:21:16 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:21:16 INFO - PROCESS | 1661 | __metrics 05:21:16 INFO - PROCESS | 1661 | 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" 05:21:16 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:16 INFO - TEST-INFO | 1661: exit 0 05:21:16 INFO - Browser initialized. 05:21:16 INFO - Running cycle 1/1 for kraken test... 05:21:16 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpadZRK4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:28 INFO - PROCESS | 1662 | RSS: Main: 240406528 05:21:28 INFO - PROCESS | 1662 | 05:21:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:32 INFO - PROCESS | 1662 | RSS: Main: 290521088 05:21:32 INFO - PROCESS | 1662 | 05:21:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:21:35 INFO - PROCESS | 1662 | RSS: Main: 289546240 05:21:35 INFO - PROCESS | 1662 | 05:21:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:21:39 INFO - PROCESS | 1662 | RSS: Main: 384364544 05:21:39 INFO - PROCESS | 1662 | 05:21:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:21:42 INFO - PROCESS | 1662 | RSS: Main: 286961664 05:21:42 INFO - PROCESS | 1662 | 05:21:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:45 INFO - PROCESS | 1662 | RSS: Main: 288448512 05:21:45 INFO - PROCESS | 1662 | 05:21:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:48 INFO - PROCESS | 1662 | RSS: Main: 326336512 05:21:48 INFO - PROCESS | 1662 | 05:21:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:51 INFO - PROCESS | 1662 | RSS: Main: 329273344 05:21:51 INFO - PROCESS | 1662 | 05:21:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:21:55 INFO - PROCESS | 1662 | RSS: Main: 326610944 05:21:55 INFO - PROCESS | 1662 | 05:21:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:21:57 INFO - PROCESS | 1662 | RSS: Main: 302878720 05:21:57 INFO - PROCESS | 1662 | 05:21:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:00 INFO - PROCESS | 1662 | RSS: Main: 304676864 05:22:00 INFO - PROCESS | 1662 | 05:22:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:02 INFO - PROCESS | 1662 | RSS: Main: 308002816 05:22:02 INFO - PROCESS | 1662 | 05:22:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:06 INFO - PROCESS | 1662 | RSS: Main: 318087168 05:22:06 INFO - PROCESS | 1662 | 05:22:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:10 INFO - PROCESS | 1662 | RSS: Main: 318164992 05:22:10 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:22:12 INFO - PROCESS | 1662 | RSS: Main: 362221568 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | __start_tp_report 05:22:12 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:22:12 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:22:12 INFO - PROCESS | 1662 | |i|pagename|runs| 05:22:12 INFO - PROCESS | 1662 | |0;ai-astar;116;113;112;113;112;114;112;113;116;161 05:22:12 INFO - PROCESS | 1662 | |1;audio-beat-detection;150;113;112;151;112;113;113;110;144;112 05:22:12 INFO - PROCESS | 1662 | |2;audio-dft;185;184;195;220;184;185;183;179;184;186 05:22:12 INFO - PROCESS | 1662 | |3;audio-fft;92;60;58;76;78;84;82;81;84;59 05:22:12 INFO - PROCESS | 1662 | |4;audio-oscillator;87;69;96;70;68;69;91;67;68;89 05:22:12 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;90;110;113;135;90;88;84;87;85 05:22:12 INFO - PROCESS | 1662 | |6;imaging-darkroom;93;94;93;94;95;94;93;95;94;94 05:22:12 INFO - PROCESS | 1662 | |7;imaging-desaturate;130;67;127;122;134;82;84;83;81;81 05:22:12 INFO - PROCESS | 1662 | |8;json-parse-financial;59;54;54;51;54;54;54;54;54;54 05:22:12 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;63;71;76;73;72;68;70;69;69;70 05:22:12 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;86;87;85;86;87;84;87;85;87;89 05:22:12 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;156;153;173;159;147;146;147;142;168;143 05:22:12 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;168;172;171;168;172;171;170;170;171;171 05:22:12 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;69;68;68;69;70;67;68;65;68;69 05:22:12 INFO - PROCESS | 1662 | __end_tp_report 05:22:12 INFO - PROCESS | 1662 | __start_cc_report 05:22:12 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2070 05:22:12 INFO - PROCESS | 1662 | __end_cc_report 05:22:12 INFO - PROCESS | 1662 | __startTimestamp1476706932295__endTimestamp 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:22:12 INFO - PROCESS | 1662 | Number of tests: 14 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:118.20 Median:113.50 stddev:15.11 (13.3%) stddev-sans-first:16.01 05:22:12 INFO - PROCESS | 1662 | Values: 116.0 113.0 112.0 113.0 112.0 114.0 112.0 113.0 116.0 161.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:113.00 stddev:17.59 (15.6%) stddev-sans-first:15.72 05:22:12 INFO - PROCESS | 1662 | Values: 150.0 113.0 112.0 151.0 112.0 113.0 113.0 110.0 144.0 112.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:188.50 Median:185.00 stddev:11.77 (6.4%) stddev-sans-first:12.41 05:22:12 INFO - PROCESS | 1662 | Values: 185.0 184.0 195.0 220.0 184.0 185.0 183.0 179.0 184.0 186.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:75.40 Median:81.50 stddev:12.08 (14.8%) stddev-sans-first:11.23 05:22:12 INFO - PROCESS | 1662 | Values: 92.0 60.0 58.0 76.0 78.0 84.0 82.0 81.0 84.0 59.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.50 stddev:11.73 (14.9%) stddev-sans-first:11.92 05:22:12 INFO - PROCESS | 1662 | Values: 87.0 69.0 96.0 70.0 68.0 69.0 91.0 67.0 68.0 89.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:87.00 stddev:16.87 (19.4%) stddev-sans-first:17.51 05:22:12 INFO - PROCESS | 1662 | Values: 87.0 90.0 110.0 113.0 135.0 90.0 88.0 84.0 87.0 85.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 05:22:12 INFO - PROCESS | 1662 | Values: 93.0 94.0 93.0 94.0 95.0 94.0 93.0 95.0 94.0 94.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:99.10 Median:81.00 stddev:25.69 (31.7%) stddev-sans-first:24.70 05:22:12 INFO - PROCESS | 1662 | Values: 130.0 67.0 127.0 122.0 134.0 82.0 84.0 83.0 81.0 81.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.93 (3.6%) stddev-sans-first:1.00 05:22:12 INFO - PROCESS | 1662 | Values: 59.0 54.0 54.0 51.0 54.0 54.0 54.0 54.0 54.0 54.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:3.41 (4.8%) stddev-sans-first:2.47 05:22:12 INFO - PROCESS | 1662 | Values: 63.0 71.0 76.0 73.0 72.0 68.0 70.0 69.0 69.0 70.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:87.00 stddev:1.42 (1.6%) stddev-sans-first:1.50 05:22:12 INFO - PROCESS | 1662 | Values: 86.0 87.0 85.0 86.0 87.0 84.0 87.0 85.0 87.0 89.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:154.50 stddev:10.60 (6.9%) stddev-sans-first:11.20 05:22:12 INFO - PROCESS | 1662 | Values: 156.0 153.0 173.0 159.0 147.0 146.0 147.0 142.0 168.0 143.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:1.43 (0.8%) stddev-sans-first:1.22 05:22:12 INFO - PROCESS | 1662 | Values: 168.0 172.0 171.0 168.0 172.0 171.0 170.0 170.0 171.0 171.0 05:22:12 INFO - PROCESS | 1662 | 05:22:12 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.37 (2.0%) stddev-sans-first:1.41 05:22:12 INFO - PROCESS | 1662 | Values: 69.0 68.0 68.0 69.0 70.0 67.0 68.0 65.0 68.0 69.0 05:22:12 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:22:12 INFO - PROCESS | 1662 | 05:22:13 INFO - TEST-INFO | 1662: exit 0 05:22:13 INFO - TEST-OK | kraken | took 59499ms 05:22:13 INFO - SUITE-END | took 1179s 05:22:13 INFO - Completed test suite (00:19:39) 05:22:13 INFO - javascript benchmark 05:22:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.623648280448, 3296.604407471104, 3314.5535224609857, 3329.6836800503975, 3356.1945133168047, 5461.126219804832, 5505.834824955253, 5556.861078473035, 5564.387917329091, 5585.9999999999945, 5520.861978450541, 5536.058869992101, 5600.299962504687, 5605.635633683818, 5620.4660557247, 5056.393232812049, 5056.570191533724, 5058.064258112261, 5114.28400023997, 5122.078025955327, 5151.4333423323405, 5239.869003274911, 5242.528172464477, 5247.003069416818, 5290.656107353029, 5191.195364718475, 5208.322918020671, 5215.660982036175, 5252.658577192489, 5285.524302812746, 5015.22264049073, 5036.79852805891, 5055.090083784918, 5101.464346243665, 5116.718580478072, 5070.31550740649, 5096.439391666913, 5107.514786095315, 5118.07874582575, 5140.126178549618, 5482.5613950884235, 5567.220589117527, 5584.553235741171, 5584.832455026356, 5597.524210442118, 6030.66831324277, 6036.396360363972, 6036.913355595991, 6045.3047899491685, 6051.546134039921, 4693.694909830884, 5917.911231331534, 5933.110033494967, 6064.302605200371, 6079.452849243545, 5343.664083979005, 5605.243292155547, 5643.463870932255, 5644.379118296984, 5645.350784659735, 5633.183188437735, 6255.937440625627, 6273.0904018917, 6282.183316168869, 6285.245770507477, 5810.41895810424, 5835.766569337179, 5851.1223316502865, 5855.531557475391, 5935.347111817697, 6077.9392206078255, 6090.451859332681, 6099.43084549468, 6105.277797093309, 6129.264488261348, 5078.908034772541, 5912.763489460373, 5983.820485385445, 6017.0, 6049.606775559662, 5873.353931067664, 5892.558058145656, 5944.197533333031, 6040.124181993587, 6052.697365131726, 4776.259679749644, 4808.855734327975, 4843.75781210938, 4849.951500485021, 4885.511448855086, 4340.696151269444, 4343.131373725268, 4351.717138385995, 4353.368761529624, 4385.802638881258, 5592.720363981784, 5607.355154157242, 5620.297462817148, 5622.357984674434, 5673.687947162945, 5973.940260597338, 5980.401959803985, 6050.122732203894, 6086.147939288503, 6100.066499260575, 5572.192032155396, 5613.045782217033, 5639.154126881001, 5651.773929042874, 5655.434456554394, 5275.7362131894015, 5282.181261904411, 5295.12630415977, 5298.0463516566615, 5298.443663415363, 5284.392294886137, 6095.226761080279, 6135.417135372132, 6297.905531417033, 6322.0, 6033.276006879202, 6048.758049677964, 6052.697365131814, 6065.5754097212775, 6067.362926892612, 6171.259448866164, 6174.043023331391, 6178.845528861814, 6182.381761823962, 6198.008318668992, 6010.879782404415, 6019.1573179754, 6079.422454866957, 6115.296740874678, 6129.754809807558, 6001.309849367379, 6117.3270940197435, 6151.415615516519, 6158.507319414346, 6170.598911070766, 4978.726170060681, 5768.567357448292, 5947.31605865331, 5962.956482615438, 5964.373740757158, 5824.679642619527, 5870.031444811559, 5871.706414679335, 5904.734286957011, 5992.61048031894, 5788.594798364243, 5805.216295800182, 5809.012467880555, 5812.070068788974, 5814.76740930358, 5945.40545945402, 5947.167396564398, 5961.791337303173, 5964.671943043174, 5967.76128954837, 5648.5763567731765, 5683.545316374597, 5736.770529178786, 5808.76764929415, 5810.535157187331], "value": 5547.444749267811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.6839391183554, 510.7676007416626, 528.9497497737714, 530.2814686100335, 549.7663493015467, 29925.850370748143, 31411.0, 31439.68560314396, 31474.68525314746, 31531.84234078832, 32010.35979280413, 40737.79631101848, 41697.37453938193, 41752.16495670085, 43767.56232437675, 9333.20667743241, 9484.66803661872, 9495.762605934873, 9498.477583732893, 9501.049895010512, 9257.305702072337, 9345.252379809634, 9352.111549402796, 9358.906410935906, 9371.625134994592, 9331.926828414751, 9356.953215233914, 9368.7657808555, 9371.95314023429, 9376.484293363863, 9286.767830804216, 9335.019822918564, 9351.158395744416, 9362.531873406302, 9362.719118426457, 9274.026227246177, 9334.439933603937, 9344.579493922722, 9345.439273643604, 9350.766230844283, 39371.40942885859, 39630.405543916866, 39662.0, 39727.4040889384, 39732.60267397318, 3410.215650400397, 3475.14858859581, 3655.3968595181764, 3882.0, 3970.3845903884653, 25537.61693574598, 28661.487899611635, 30115.0, 30134.397312053636, 30243.0, 3061.678523755018, 3145.1822526143137, 3185.904422867318, 3186.6972637599392, 3244.8702051917894, 484384.0, 486702.0, 489904.99999999645, 490526.0, 494837.0, 56097.71951140218, 56603.71698141483, 56618.0, 56637.7168114165, 56684.71657641685, 57941.130883036785, 58359.70820145957, 58402.415975840544, 58610.12084818731, 58632.0, 15717.44988925405, 15894.68210635804, 15903.363865445253, 15908.522744317688, 15923.840761592235, 12477.939375153213, 12574.43415046325, 12580.81128783069, 12581.0, 12594.307313097685, 14156.221407822668, 14672.779908301383, 14732.410703571952, 14758.188299643623, 14815.851841481663, 5229.843104706865, 6081.563916387316, 6181.8454538636, 6184.319724830265, 6190.7523699051535, 864.7362554420836, 967.1827305926481, 979.7256768104942, 1000.8348622477209, 1045.2369770067894, 27852.442951141267, 28953.565696514568, 29002.27494312659, 29714.0, 29726.554101688493, 973.352720440913, 973.4597298499259, 1036.5024788101753, 1066.36018388966, 1088.820344643125, 13321.866781332063, 14618.122912625277, 15202.543923682308, 15233.6191595211, 15262.007969481949, 616560.9171954112, 618701.0, 620557.0, 620613.0, 621995.0, 55747.442525574224, 55902.0, 55917.0, 55932.16101758477, 56035.0, 1231.119749379198, 1271.8982481401652, 1329.056369977327, 1366.1052010932856, 1378.689794796163, 24361.634575481738, 29164.70835291705, 29897.0, 30522.84738576293, 30681.53977690381, 46248.07503849837, 46758.53241467542, 46937.76531117323, 46938.29592556046, 46951.0, 498892.0, 498954.0, 501186.0, 503277.0, 810200.0, 23706.0, 23797.52404951926, 24145.51708965846, 24331.148409805573, 24385.0, 43851.0, 43856.78071609622, 44037.559624403344, 44503.55496444994, 44814.77592612016, 36845.44731828971, 37543.112497375456, 37566.812165938994, 38087.61912380951, 39589.0, 37401.4389784148, 37583.81208093942, 37816.43275350927, 38801.223975520894, 39035.6096439032, 37383.81308093442, 37671.0, 38272.0, 38307.425388618634, 39641.0, 30156.09531714052, 30684.386312273182, 33976.0, 34101.31797363989, 34120.48819267663, 24406.87796561006, 24853.378665533506, 24907.626385603868, 25535.0, 25670.973161073347], "value": 19082.33954441618, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2778304475824, 363.92903383840155, 367.6801182970817, 371.901446116779, 392.2938710321421, 14113.389023030733, 15033.548993530198, 20088.89955550222, 21147.365579032616, 21515.784842151574, 20428.795712042876, 20501.589968200627, 20642.0, 21129.577408451823, 21327.25354612585, 5669.376368599461, 5959.612625179371, 5978.581499295029, 6003.459688628022, 6008.866852267448, 5737.913931291013, 6014.037753959367, 6044.576879618428, 6075.088736689488, 6096.878062438748, 5908.911366329487, 6030.396960303979, 6090.177825993501, 6095.634261944276, 6096.268447786249, 6026.548008899328, 6109.205803245594, 6113.847153821145, 6115.3884611538715, 6115.724792384353, 5106.08090543702, 5358.0, 5394.8921021579745, 5870.97064514679, 5903.704814759245, 13167.407466663928, 13234.933825330812, 13247.271400072992, 13418.329083545783, 13431.932840335834, 2127.95744085119, 2180.291405293286, 2254.875981820999, 2260.9321720348416, 2360.280114565057, 9742.366746161477, 9964.003599639978, 9967.202623790152, 10204.132648724868, 14575.562733118024, 1775.1834156288123, 1782.8484578810817, 1807.5390775352332, 1849.1401498303353, 1857.19212142717, 112172.31741523884, 117807.0, 118550.0, 119387.403062985, 122888.77111228862, 10605.522751476203, 10736.677899663022, 11553.422328883522, 11556.768864622829, 11783.941080294544, 10787.0, 12886.871131288755, 13441.260730659713, 13446.93276533611, 14375.496857609933, 8461.830763384822, 8591.742247732578, 8623.827523449496, 8745.976850648773, 8782.253508451726, 6988.336108069725, 8650.610722517502, 8679.218870301704, 8786.16531429513, 8794.560271986375, 3592.497050412944, 3719.795411252407, 4153.691587150038, 4358.694891357574, 4438.689291749611, 1829.0049200431013, 1841.8028281617055, 1921.3755529452703, 1934.1973081171157, 1937.2928880958348, 729.4638440746047, 826.4793180296375, 870.3385427075342, 914.4513292024732, 939.3049143633798, 21517.78482215189, 21947.561048778934, 22220.666689999664, 22297.554048919254, 22361.776382236294, 898.7753061734567, 949.2216382566368, 979.3438396274371, 980.7695191629962, 1042.2339580408393, 5171.7672704728375, 5544.750486228129, 6005.498625343664, 6032.1856549365275, 10910.290831095954, 556270.0, 569165.0, 571556.0, 586766.0, 587797.0, 123292.5891949506, 131414.68585314215, 132458.0, 134291.0, 134617.0, 438.32279128746165, 454.9567791059844, 456.1333466413774, 457.3094627113083, 458.50939494740976, 11287.20989530725, 11396.430178490877, 11618.360990145286, 11667.59163429276, 11752.353620550952, 53160.0, 53316.73341633267, 54399.0, 54478.0, 55177.172342414095, 76214.0, 77240.5389478737, 78744.0, 80100.0, 81040.59479702564, 8040.035195776544, 8119.4722343047515, 8155.143709910374, 8324.958375208085, 8476.364272679697, 11910.0, 12054.337011464102, 12137.393130343271, 12745.872541274839, 13395.531156409479, 11109.0, 11461.713457163303, 11598.478068487108, 11719.531218751154, 11725.530978760755, 10875.293105948089, 11045.558177672803, 11149.0, 11572.421378931189, 11605.245659032136, 11443.0, 11485.942570287096, 11714.648560543197, 11824.0, 11875.168738188244, 8134.75595732129, 8262.297704695167, 8264.545450000307, 8329.54187519668, 8387.119352467904, 10905.727356816144, 11360.431978400882, 11498.77002459963, 11561.017313528444, 11681.897258493213], "value": 8937.741681300578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1545.9922700386496, 1574.283700916083, 1809.5928416106378, 1917.6356492266477, 1964.2437661500328, 7890.132085470594, 8209.589520523965, 8465.873011904818, 8893.0, 8926.732198034062, 8050.95974520128, 8126.796830079251, 8146.348292136615, 8147.837043259146, 8353.248207661325, 1978.8614796964146, 2307.9884600576975, 2366.7396586375485, 2371.6561098640686, 2372.9406764830933, 2315.0392587076344, 2331.63859601762, 2353.646952957062, 2366.1954935321987, 2366.7751563601514, 2332.3586013846157, 2345.847519911209, 2353.1293421434093, 2360.232924299601, 2372.110458578033, 2303.1478353009325, 2319.559283736093, 2325.4651430170984, 2327.2552783109413, 2329.5457385809773, 2333.1484008337006, 2340.414896275931, 2340.7776261255153, 2340.97659023411, 2345.5074434368803, 8567.657293708244, 8719.869201961976, 8727.781805454852, 8740.08229135938, 8753.343499237582, 5191.974040129813, 5333.653312534673, 5334.093204155303, 5335.759890804923, 5338.546223571001, 3418.4872269159578, 3508.3158784037123, 3646.106703857545, 3652.3243200008083, 3656.8902932911788, 1053.9262251642388, 1060.8355704865758, 1064.4518073192312, 1081.453865797775, 1082.0207712020556, 11259.718507037307, 11353.602623908206, 11510.194286399956, 11519.251248668726, 11533.250338727956, 4543.432070991126, 4550.340200670884, 4762.857114286577, 4848.466668666444, 4854.368932038812, 9910.10809027191, 9916.107550320507, 9916.80166396668, 9917.355371900803, 9932.155766759763, 4537.977310113428, 5313.760880760375, 5315.840524784263, 5322.121849894801, 5333.866653333697, 4356.803943822536, 4363.890902727458, 4790.688605240648, 4824.565789079, 4877.073356062337, 3543.2204914918675, 3695.6858667013066, 3879.7109705274024, 3985.222881538072, 4016.457778199964, 1270.8093785931999, 1273.38877338876, 1281.3401098434315, 1289.1105137455127, 1297.3253907967992, 843.7595285343771, 863.4171933944688, 904.5838914099588, 913.5067063785482, 950.5722424908819, 4375.934360984587, 5568.6101972862325, 5775.826725198251, 5777.162311464814, 6013.338532761392, 920.8664743612272, 943.6602822983721, 954.179405711088, 976.1605019683067, 1011.1102230037667, 3709.406494960793, 3741.8129093545213, 3875.2830726315724, 3942.758031220214, 4000.0199951012187, 10370.0, 10547.84178237327, 10701.732456688489, 10708.78582428347, 10722.356658600509, 10159.695209143738, 10355.844662330072, 10547.630832920964, 10574.471276436301, 10651.627193048205, 7972.880406793903, 8117.512949223184, 8118.75643730689, 8123.593820309079, 8132.146124656944, 5588.217649529151, 5614.410486898817, 5714.685692286964, 5749.770009199585, 5841.970790146022, 9785.0, 9907.900920990698, 9923.156531694598, 9944.801103978025, 9952.751181220527, 8549.0, 9505.192058674813, 10188.796224075626, 10202.030807073315, 10205.0, 6440.6135631862235, 6676.799696009128, 6682.031105489774, 6977.7208911642965, 7121.501494895515, 8030.83938321242, 8154.796130096795, 8289.834203315779, 8357.66569337244, 8422.494650321001, 7303.561786292839, 7408.6666100026705, 7429.368503677032, 7493.250674932681, 7574.772756817304, 7076.858462830612, 7259.963700181465, 7282.817929551804, 7284.271572842674, 7387.9261207387235, 6812.693428795816, 6822.11312529368, 6902.620355880475, 6926.06498122747, 6930.896036559557, 4909.042736666459, 4948.183549714401, 4974.37820272466, 4997.525235102659, 5070.138076526926, 4904.7302398367, 4934.432540257916, 4988.376452943382, 5001.574866136273, 5208.723862653674], "value": 4534.8116976650945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9375840731771, 303.1557113439073, 312.3908378661609, 317.3795230324715, 320.0414757800388, 5034.7986080556775, 5040.36188238822, 5200.4019537753165, 5310.814121505743, 5356.27690261815, 4669.836555720551, 5194.8701282467955, 5273.419923808378, 5276.472352764731, 5284.920726189101, 4053.9391909121387, 4058.208649313385, 4062.02511397264, 4074.3888416737577, 4076.7350122242105, 4087.89780255493, 4088.1619268049976, 4088.5911408859174, 4099.405586190001, 4106.466159399289, 3044.4672182368, 3378.645242249553, 3826.8469261229516, 3895.8441662333616, 3914.8042597869994, 3978.1049263915675, 3982.8605998790194, 4001.0, 4002.699797515198, 4036.6770658347264, 3166.9208269793207, 3395.5246265522846, 3478.826058697055, 3490.6334834842482, 3495.5281037059926, 4494.550544945512, 5028.547430731252, 5117.283580298761, 5131.666441681279, 5193.584513238932, 4565.497795242521, 4580.198465268565, 4600.308819340689, 4610.308453731934, 4616.484016211173, 5493.335732169894, 5496.395396506381, 5520.908291356813, 5546.140348245988, 5558.221848941152, 3227.144391974624, 3353.597568291796, 3584.964150358489, 3774.3960966245545, 3882.417637354391, 4566.949601591619, 4918.336024636664, 5094.643374963791, 5803.100519419497, 5892.351841297454, 3624.3113808376324, 3706.944395834065, 3707.629237076271, 3845.3270677631863, 3865.8840234793, 3744.307303148926, 3910.1397692507603, 3911.3155197840265, 3926.9018274542796, 3933.4099885017476, 3887.727859049896, 4369.257226271541, 4552.816267770338, 4595.149897268949, 4599.919019030525, 5443.156310771837, 5621.578381621394, 5662.943370566324, 5719.3422756382715, 5728.513076388554, 1131.903788178014, 1303.9608811735663, 1328.7873940169527, 1331.660426591213, 1335.4057444437133, 658.1575583253443, 745.8955746195537, 803.7186984555359, 807.4105902690951, 820.8835983063029, 3666.5416822897137, 3861.706328379968, 3962.7622342659533, 4372.584604462571, 4410.867673969786, 4430.490493593214, 4467.553244675506, 4786.787626888316, 4819.0002298092495, 4826.372571565674, 3839.9040023999623, 3963.4451176835264, 4082.4896887889013, 4185.455890734246, 4373.825046998085, 2332.405236664674, 2533.5305522796734, 2545.325488745484, 2546.910858119957, 2554.846709197417, 3987.7407968481957, 4119.8970025749595, 4726.810927562928, 4989.675671081368, 4997.650164488451, 3867.207222519377, 4499.595036446735, 4846.636502262344, 4918.286693546421, 4935.901281974412, 4457.554244575516, 4567.520410356931, 4641.443026836801, 4988.308651597864, 5041.437154482122, 3993.8049560352183, 4240.703150779415, 4459.866204013885, 4542.5249683991115, 4849.466558678613, 3916.804159792056, 4725.314829349656, 4791.0, 4796.904061918812, 4812.903741925212, 4442.225107360354, 4517.864464066083, 4587.793549290357, 4716.834910778106, 4973.378327709036, 2954.084233887502, 3342.8997130086136, 3352.401888536404, 3358.177246574507, 3376.831158442117, 4018.805049985327, 4126.690498212586, 4468.078726147658, 4556.362109304766, 4789.0, 4009.8997525062105, 4411.404460397934, 4686.250199967989, 4711.021371024247, 4734.834280800155, 4263.126059157928, 4671.509491503479, 4672.0, 4679.227927391942, 4712.764361781966, 3796.5064541609413, 4242.533321334712, 4548.88627784308, 4596.540345965511, 4608.516105808976, 4141.254574176677, 4142.91714165709, 4395.582419670126, 4688.6483513737285, 4743.644226682944, 4267.061246525759, 4337.154254920387, 4555.772211389483, 4619.88450288732, 4620.561046700558], "value": 3694.6586437360284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.5714314268297, 712.8807771798278, 725.300085417572, 734.1007266099026, 766.6588368176164, 15125.924370378147, 15956.441524546643, 15982.520524384287, 15993.76009359859, 16311.918440407811, 14272.4291028359, 14397.568072957802, 14405.13569185847, 14416.639584010405, 14426.927865360685, 707.3563057617569, 727.2218725963221, 881.4050515901756, 883.0595415882098, 908.7955210077713, 898.0435835834847, 904.0191392339319, 911.079809392515, 913.8903331600218, 913.949732764701, 933.2300851797295, 935.2938531408777, 971.6696323250094, 977.2231076294363, 988.5106872098321, 749.6514120933792, 776.5185584937375, 981.2885657897967, 983.2527279267737, 983.7393090830935, 694.7464175575928, 716.2729829223342, 720.2689270390558, 721.3399739238642, 722.8445884134936, 15033.0, 15084.094954302667, 15097.698046039017, 15099.698006039927, 15117.168555729431, 13403.396847141901, 13672.93163534186, 13861.514846980308, 13870.0, 14297.571072867726, 12345.814812777815, 12502.937485312606, 12508.687282817911, 12549.937250313782, 12887.935560322232, 4433.7118087324225, 4435.135148646015, 4529.275315949432, 4641.628669706415, 4645.187092258875, 114377.42811285974, 115417.99999999916, 115680.0, 116103.0, 118426.0, 10742.462876856125, 10883.455827208609, 10908.563657453613, 10993.945030274797, 11012.50443730034, 17953.820461795476, 22101.447463813533, 22184.667229991563, 22207.22274720377, 22239.55520889573, 7679.500832445873, 7729.149793522708, 7926.009248843895, 7983.161768014391, 7999.0801057877925, 4141.772202528829, 4220.451341325608, 4316.374125751811, 4409.845655402046, 4410.757408342508, 3489.5986961499752, 3560.7507474477056, 3597.442396428558, 3605.369060414417, 3609.314230296235, 529.7986765029265, 611.9877602448015, 620.0048921481048, 622.0948519903529, 642.8714257148589, 554.9112142057332, 584.0742423259181, 612.5099920063931, 626.295417655138, 629.276332217953, 8863.911360886308, 8904.8664270036, 8984.55077246135, 9054.954725226331, 9071.501067441222, 594.8126340202822, 628.355935166458, 630.6346759266138, 634.8793729191439, 644.8645784385238, 3694.5935947045805, 4295.591918767712, 4468.195724769573, 4488.820447182142, 4494.910101797946, 128019.07732917399, 141124.88312675318, 147432.26283868725, 156245.2187739054, 157501.0, 82126.0, 86389.70415443773, 98223.0, 120287.0, 121323.0, 90824.63763043427, 95207.52396238114, 96327.51836240773, 105529.0, 115008.3996640125, 9198.256085328736, 9337.439753614804, 9570.377925434825, 9758.658446954323, 9845.803083938137, 51063.234051488515, 55997.44002559922, 59613.442521323486, 60179.0, 62728.0, 86185.56907215675, 92220.0, 92467.53766231125, 92831.0, 95981.0, 12686.238825670489, 12844.678883027998, 12947.5468358607, 13019.869801301866, 13269.137506062076, 14246.786298205743, 14447.638809029859, 14650.780238296222, 14736.189509577076, 15286.082835029934, 13532.985026123277, 13564.38960246811, 13860.06324321944, 13920.373583188579, 14026.298685065502, 13358.0, 13779.311034448037, 13792.379342929793, 14135.222562759147, 14327.498537551135, 13102.148360356547, 13432.261225632294, 13433.261170635318, 13496.0, 13603.79594306106, 11188.216824822184, 11253.7749245013, 11330.886691132982, 11331.716707082389, 11735.295882247092, 10570.682879513626, 10573.312734672221, 11278.436078196222, 11571.5949941755, 11588.6523404298], "value": 7786.700740583919, "unit": "score"}], "name": "dromaeo_css", "value": 7056.372246557624, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 112.0, 113.0, 112.0, 114.0, 112.0, 113.0, 116.0, 161.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 112.0, 151.0, 112.0, 113.0, 113.0, 110.0, 144.0, 112.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 195.0, 220.0, 184.0, 185.0, 183.0, 179.0, 184.0, 186.0], "value": 188.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 60.0, 58.0, 76.0, 78.0, 84.0, 82.0, 81.0, 84.0, 59.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 96.0, 70.0, 68.0, 69.0, 91.0, 67.0, 68.0, 89.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 110.0, 113.0, 135.0, 90.0, 88.0, 84.0, 87.0, 85.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 95.0, 94.0, 93.0, 95.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 67.0, 127.0, 122.0, 134.0, 82.0, 84.0, 83.0, 81.0, 81.0], "value": 99.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 54.0, 51.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 76.0, 73.0, 72.0, 68.0, 70.0, 69.0, 69.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 86.0, 87.0, 84.0, 87.0, 85.0, 87.0, 89.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 173.0, 159.0, 147.0, 146.0, 147.0, 142.0, 168.0, 143.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 171.0, 168.0, 172.0, 171.0, 170.0, 170.0, 171.0, 171.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 70.0, 67.0, 68.0, 65.0, 68.0, 69.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1474.9, "alertThreshold": 2.0}]} 05:22:13 INFO - Return code: 0 05:22:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:22:13 INFO - # TBPL SUCCESS # 05:22:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:22:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:22:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:22:13 INFO - 2016-10-17 05:22:13.617 screenresolution[1666:9858] starting screenresolution argv=screenresolution get 05:22:13 INFO - 2016-10-17 05:22:13.620 screenresolution[1666:9858] Display 0: 1600x1200x32@60 05:22:13 INFO - 2016-10-17 05:22:13.626 screenresolution[1667:9861] starting screenresolution argv=screenresolution list 05:22:13 INFO - Available Modes on Display 0 05:22:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:22:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:22:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:22:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:22:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:22:13 INFO - Intel Iris: 05:22:13 INFO - Chipset Model: Intel Iris 05:22:13 INFO - Type: GPU 05:22:13 INFO - Bus: Built-In 05:22:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:22:13 INFO - Vendor: Intel (0x8086) 05:22:13 INFO - Device ID: 0x0a2e 05:22:13 INFO - Revision ID: 0x0009 05:22:13 INFO - Displays: 05:22:13 INFO - Display: 05:22:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:22:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:22:13 INFO - Display Serial Number: 1600x1200 60 05:22:13 INFO - Main Display: Yes 05:22:13 INFO - Mirror: Off 05:22:13 INFO - Online: Yes 05:22:13 INFO - Rotation: Supported 05:22:13 INFO - Return code: 0 05:22:13 INFO - Running post-action listener: _resource_record_post_action 05:22:13 INFO - [mozharness: 2016-10-17 12:22:13.860686Z] Finished run-tests step (success) 05:22:13 INFO - Running post-run listener: _resource_record_post_run 05:22:13 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 38450176; Write bytes: 708168192; Read time: 378; Write time: 2074 05:22:13 INFO - TinderboxPrint: CPU usage
53.9% 05:22:13 INFO - TinderboxPrint: I/O read bytes / time
38,450,176 / 378 05:22:13 INFO - TinderboxPrint: I/O write bytes / time
708,168,192 / 2,074 05:22:13 INFO - TinderboxPrint: CPU idle
2,241.4 (46.1%) 05:22:13 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 05:22:13 INFO - TinderboxPrint: CPU user
1,644.5 (33.9%) 05:22:13 INFO - TinderboxPrint: Swap in / out
444,596,224 / 0 05:22:13 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404095488; Write bytes: 395466240; Read time: 29691; Write time: 872 05:22:13 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36316160; Write bytes: 298357760; Read time: 353; Write time: 1163 05:22:14 INFO - Running post-run listener: _upload_blobber_files 05:22:14 INFO - Blob upload gear active. 05:22:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:14 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 05:22:14 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'] 05:22:14 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 05:22:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:15 INFO - (blobuploader) - INFO - Done attempting. 05:22:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:16 INFO - (blobuploader) - INFO - Done attempting. 05:22:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:19 INFO - (blobuploader) - INFO - Done attempting. 05:22:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:19 INFO - Return code: 0 05:22:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c982d646b2433a2d3f6c2a7bb5e3979bd5eca7197ff79b953600a27be3c0dfe17a20b4947d691534751ef96e67e7ab6e8b3def227ddee39c6de0a117d225775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0cc2fbf74654a6524a30552683a8ab4bf1af1fe88cc4d884fd98fbaf292285b0c075e275144a2657ddc429da23015bd5600807c767ad1299934f68fdbe4550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4870d71d88f89d9ca0bc4974df24c0f10eaf0539a5b2bb1919caa4f58efc4f911eb1ab467bcf8b69e5245a82d6cd0faccfa415c08a331e9c73cc06171b85beef"} 05:22:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:19 INFO - Contents: 05:22:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c982d646b2433a2d3f6c2a7bb5e3979bd5eca7197ff79b953600a27be3c0dfe17a20b4947d691534751ef96e67e7ab6e8b3def227ddee39c6de0a117d225775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0cc2fbf74654a6524a30552683a8ab4bf1af1fe88cc4d884fd98fbaf292285b0c075e275144a2657ddc429da23015bd5600807c767ad1299934f68fdbe4550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4870d71d88f89d9ca0bc4974df24c0f10eaf0539a5b2bb1919caa4f58efc4f911eb1ab467bcf8b69e5245a82d6cd0faccfa415c08a331e9c73cc06171b85beef"} 05:22:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:19 INFO - Copying logs to upload dir... 05:22:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.450588 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-17 05:22:19.125528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 05:22:19.128663) ========= 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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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/9c982d646b2433a2d3f6c2a7bb5e3979bd5eca7197ff79b953600a27be3c0dfe17a20b4947d691534751ef96e67e7ab6e8b3def227ddee39c6de0a117d225775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0cc2fbf74654a6524a30552683a8ab4bf1af1fe88cc4d884fd98fbaf292285b0c075e275144a2657ddc429da23015bd5600807c767ad1299934f68fdbe4550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4870d71d88f89d9ca0bc4974df24c0f10eaf0539a5b2bb1919caa4f58efc4f911eb1ab467bcf8b69e5245a82d6cd0faccfa415c08a331e9c73cc06171b85beef"} build_url:https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010927 build_url: 'https://queue.taskcluster.net/v1/task/cEXmTG9wS1qL1oQsDZ7HAg/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/9c982d646b2433a2d3f6c2a7bb5e3979bd5eca7197ff79b953600a27be3c0dfe17a20b4947d691534751ef96e67e7ab6e8b3def227ddee39c6de0a117d225775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a0cc2fbf74654a6524a30552683a8ab4bf1af1fe88cc4d884fd98fbaf292285b0c075e275144a2657ddc429da23015bd5600807c767ad1299934f68fdbe4550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4870d71d88f89d9ca0bc4974df24c0f10eaf0539a5b2bb1919caa4f58efc4f911eb1ab467bcf8b69e5245a82d6cd0faccfa415c08a331e9c73cc06171b85beef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 05:22:19.160741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:22:19.161080) ========= 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.WWs9r34WsQ/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.vT9MLT3ooK/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.004555 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:22:19.209152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 05:22:19.209479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 05:22:19.209847) ========= ========= Total master_lag: 1.05 =========