builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0135 starttime: 1485897492.59 results: success (0) buildid: 20170131111909 builduid: ef7858d93c7546618cc74a30279788e6 revision: dd9844a556dc657a878fbbc7d61fc68ec4cc5de1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.588245) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.588685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.588969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.619702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.620056) ========= 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.VGEPUD729N/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.0aGASsx1w8/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 --2017-01-31 13:18:12-- 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% 145M=0s 2017-01-31 13:18:12 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100567 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.745096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.745432) ========= 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.VGEPUD729N/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.0aGASsx1w8/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.028299 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:12.794898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 13:18:12.798253) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dd9844a556dc657a878fbbc7d61fc68ec4cc5de1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dd9844a556dc657a878fbbc7d61fc68ec4cc5de1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VGEPUD729N/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.0aGASsx1w8/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 2017-01-31 13:18:12,901 truncating revision to first 12 chars 2017-01-31 13:18:12,901 Setting DEBUG logging. 2017-01-31 13:18:12,901 attempt 1/10 2017-01-31 13:18:12,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dd9844a556dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 13:18:13,970 unpacking tar archive at: mozilla-beta-dd9844a556dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342771 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 13:18:14.167396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:14.167727) ========= script_repo_revision: dd9844a556dc657a878fbbc7d61fc68ec4cc5de1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:14.168115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:14.168417) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 13:18:14.188111) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-31 13:18:14.188510) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VGEPUD729N/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.0aGASsx1w8/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:14 INFO - MultiFileLogger online at 20170131 13:18:14 in /builds/slave/test 13:18:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:18:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:18:14 INFO - {'append_to_log': False, 13:18:14 INFO - 'base_work_dir': '/builds/slave/test', 13:18:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:18:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:18:14 INFO - 'branch': 'Mozilla-Beta', 13:18:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:18:14 INFO - 'config_files': ('talos/mac_config.py',), 13:18:14 INFO - 'default_actions': ('clobber', 13:18:14 INFO - 'read-buildbot-config', 13:18:14 INFO - 'download-and-extract', 13:18:14 INFO - 'populate-webroot', 13:18:14 INFO - 'create-virtualenv', 13:18:14 INFO - 'install', 13:18:14 INFO - 'run-tests'), 13:18:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:18:14 INFO - 'download_minidump_stackwalk': True, 13:18:14 INFO - 'download_symbols': 'ondemand', 13:18:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:18:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:18:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:18:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:18:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:18:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:18:14 INFO - 'installer_path': 'installer.exe', 13:18:14 INFO - 'log_level': 'info', 13:18:14 INFO - 'log_name': 'talos', 13:18:14 INFO - 'log_to_console': True, 13:18:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:18:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:18:14 INFO - 'opt_config_files': (), 13:18:14 INFO - 'pip_index': False, 13:18:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:18:14 INFO - 'cmd': ('bash', 13:18:14 INFO - '-c', 13:18:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:18:14 INFO - 'enabled': True, 13:18:14 INFO - 'halt_on_failure': False, 13:18:14 INFO - 'name': 'check_screen_resolution'},), 13:18:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:18:14 INFO - 'cmd': ('bash', 13:18:14 INFO - '-c', 13:18:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:18:14 INFO - 'enabled': True, 13:18:14 INFO - 'halt_on_failure': False, 13:18:14 INFO - 'name': 'check_screen_resolution'},), 13:18:14 INFO - 'run_cmd_checks_enabled': True, 13:18:14 INFO - 'sps_profile': False, 13:18:14 INFO - 'sps_profile_interval': 0, 13:18:14 INFO - 'suite': 'dromaeojs', 13:18:14 INFO - 'system_bits': '32', 13:18:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:18:14 INFO - 'title': 't-yosemite-r7-0135', 13:18:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:18:14 INFO - 'use_talos_json': True, 13:18:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:18:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:18:14 INFO - 'work_dir': 'build'} 13:18:14 INFO - [mozharness: 2017-01-31 21:18:14.404748Z] Running clobber step. 13:18:14 INFO - Running pre-action listener: _resource_record_pre_action 13:18:14 INFO - Running main action method: clobber 13:18:14 INFO - rmtree: /builds/slave/test/build 13:18:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:18:17 INFO - Running post-action listener: _resource_record_post_action 13:18:17 INFO - [mozharness: 2017-01-31 21:18:17.030661Z] Finished clobber step (success) 13:18:17 INFO - [mozharness: 2017-01-31 21:18:17.030842Z] Running read-buildbot-config step. 13:18:17 INFO - Running pre-action listener: _resource_record_pre_action 13:18:17 INFO - Running main action method: read_buildbot_config 13:18:17 INFO - Using buildbot properties: 13:18:17 INFO - { 13:18:17 INFO - "project": "", 13:18:17 INFO - "product": "firefox", 13:18:17 INFO - "script_repo_revision": "production", 13:18:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:18:17 INFO - "repository": "", 13:18:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:18:17 INFO - "buildid": "20170131111909", 13:18:17 INFO - "pgo_build": "False", 13:18:17 INFO - "basedir": "/builds/slave/test", 13:18:17 INFO - "buildnumber": 22, 13:18:17 INFO - "slavename": "t-yosemite-r7-0135", 13:18:17 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:18:17 INFO - "platform": "yosemite_r7", 13:18:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:18:17 INFO - "branch": "mozilla-beta", 13:18:17 INFO - "repo_path": "releases/mozilla-beta", 13:18:17 INFO - "revision": "dd9844a556dc657a878fbbc7d61fc68ec4cc5de1", 13:18:17 INFO - "stage_platform": "macosx64", 13:18:17 INFO - "builduid": "ef7858d93c7546618cc74a30279788e6", 13:18:17 INFO - "slavebuilddir": "test" 13:18:17 INFO - } 13:18:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:18:17 INFO - Running post-action listener: _resource_record_post_action 13:18:17 INFO - [mozharness: 2017-01-31 21:18:17.036400Z] Finished read-buildbot-config step (success) 13:18:17 INFO - [mozharness: 2017-01-31 21:18:17.036630Z] Running download-and-extract step. 13:18:17 INFO - Running pre-action listener: _resource_record_pre_action 13:18:17 INFO - Running main action method: download_and_extract 13:18:17 INFO - mkdir: /builds/slave/test/build/tests 13:18:17 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')]} 13:18:17 INFO - trying https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:18:17 INFO - Downloading https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 13:18:18 INFO - Downloaded 1165 bytes. 13:18:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:18:18 INFO - Using the following test package requirements: 13:18:18 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:18:18 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:18:18 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:18:18 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:18:18 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:18:18 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:18:18 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:18:18 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:18:18 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:18:18 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:18:18 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:18:18 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:18:18 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:18:18 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:18:18 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:18:18 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:18:18 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:18:18 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:18:18 INFO - Http code: 200 13:18:18 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 13:18:18 INFO - x-amz-cf-id: OsjtGmUCXczBx4uDvGeoo0qE-BI6YySgyR0f1o03gIo2Q8gSkNfg5g== 13:18:18 INFO - x-amz-version-id: P.0CelbF636hBN60EFicUR.MnlSOwLbg 13:18:19 INFO - Expected file size: 16089049 13:18:19 INFO - Obtained file size: 16089049 13:18:25 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:18:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:18:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:18:25 INFO - Fetch https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:18:26 INFO - Http code: 200 13:18:26 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 13:18:26 INFO - x-amz-cf-id: onaiC3m-toOmsVeV5_OFh6Ynpl05fjcWjwpjoCG0Su5GIS-I_E5I8A== 13:18:26 INFO - x-amz-version-id: P.0CelbF636hBN60EFicUR.MnlSOwLbg 13:18:26 INFO - Expected file size: 16089049 13:18:26 INFO - Obtained file size: 16089049 13:18:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:18:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:18:33 INFO - Fetch https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:18:34 INFO - Http code: 200 13:18:34 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:18:34 INFO - x-amz-cf-id: Bs9QRFJMvRd6W22AjhDdPgJK0bCXhvLwVfIc12u4X-mYG2efX1O-Uw== 13:18:34 INFO - x-amz-version-id: _yv9MtWWPEppH5Hc1Ysky7QnN_bsL5PM 13:18:34 INFO - Expected file size: 14402992 13:18:34 INFO - Obtained file size: 14402992 13:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:34 INFO - trying https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:18:34 INFO - Downloading https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 13:18:36 INFO - Downloaded 82144754 bytes. 13:18:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:18:36 INFO - mkdir: /builds/slave/test/properties 13:18:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:36 INFO - Contents: 13:18:36 INFO - build_url:https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:18:37 INFO - Running post-action listener: _resource_record_post_action 13:18:37 INFO - Running post-action listener: set_extra_try_arguments 13:18:37 INFO - [mozharness: 2017-01-31 21:18:37.651621Z] Finished download-and-extract step (success) 13:18:37 INFO - [mozharness: 2017-01-31 21:18:37.651774Z] Running populate-webroot step. 13:18:37 INFO - Running pre-action listener: _resource_record_pre_action 13:18:37 INFO - Running main action method: populate_webroot 13:18:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:18:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:18:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:18:37 INFO - '--tppagecycles', 13:18:37 INFO - '7'], 13:18:37 INFO - 'tests': ['tsvgm']}}, 13:18:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:18:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:18:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:18:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:18:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['damp', 'tps']}, 13:18:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'tests': ['damp', 'tps']}, 13:18:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['dromaeo_dom']}, 13:18:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['basic_compositor_video']}, 13:18:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:18:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['a11yr', 13:18:37 INFO - 'ts_paint', 13:18:37 INFO - 'tpaint', 13:18:37 INFO - 'sessionrestore', 13:18:37 INFO - 'sessionrestore_no_auto_restore', 13:18:37 INFO - 'tabpaint']}, 13:18:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:18:37 INFO - 'ts_paint', 13:18:37 INFO - 'tpaint', 13:18:37 INFO - 'sessionrestore', 13:18:37 INFO - 'sessionrestore_no_auto_restore', 13:18:37 INFO - 'tabpaint']}, 13:18:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:18:37 INFO - 'ts_paint', 13:18:37 INFO - 'tpaint', 13:18:37 INFO - 'sessionrestore', 13:18:37 INFO - 'sessionrestore_no_auto_restore', 13:18:37 INFO - 'tabpaint']}, 13:18:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:18:37 INFO - 'ts_paint', 13:18:37 INFO - 'tpaint', 13:18:37 INFO - 'sessionrestore', 13:18:37 INFO - 'sessionrestore_no_auto_restore', 13:18:37 INFO - 'tabpaint']}, 13:18:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['a11yr', 13:18:37 INFO - 'ts_paint', 13:18:37 INFO - 'tpaint', 13:18:37 INFO - 'sessionrestore', 13:18:37 INFO - 'sessionrestore_no_auto_restore', 13:18:37 INFO - 'tabpaint']}, 13:18:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['a11yr', 13:18:37 INFO - 'ts_paint', 13:18:37 INFO - 'tpaint', 13:18:37 INFO - 'sessionrestore', 13:18:37 INFO - 'sessionrestore_no_auto_restore', 13:18:37 INFO - 'tabpaint']}, 13:18:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['tsvgx', 13:18:37 INFO - 'tsvgr_opacity', 13:18:37 INFO - 'tart', 13:18:37 INFO - 'tscrollx', 13:18:37 INFO - 'cart']}, 13:18:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:18:37 INFO - 'tsvgr_opacity', 13:18:37 INFO - 'tart', 13:18:37 INFO - 'tscrollx', 13:18:37 INFO - 'cart']}, 13:18:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'talos_options': ['--disable-e10s'], 13:18:37 INFO - 'tests': ['tp5o']}, 13:18:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'tests': ['tp5o']}, 13:18:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'talos_options': ['--disable-e10s', 13:18:37 INFO - '--xperf_path', 13:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:37 INFO - 'tests': ['tp5n']}, 13:18:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:37 INFO - 'talos_options': ['--xperf_path', 13:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:37 INFO - 'tests': ['tp5n']}}, 13:18:37 INFO - 'talos.zip': {'path': '', 13:18:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:18:37 INFO - Running post-action listener: _resource_record_post_action 13:18:37 INFO - [mozharness: 2017-01-31 21:18:37.670627Z] Finished populate-webroot step (success) 13:18:37 INFO - [mozharness: 2017-01-31 21:18:37.670734Z] Running create-virtualenv step. 13:18:37 INFO - Running pre-action listener: _resource_record_pre_action 13:18:37 INFO - Running main action method: create_virtualenv 13:18:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:37 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 13:18:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:18:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:37 INFO - Using real prefix '/tools/python27' 13:18:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:18:41 INFO - Installing pip.................done. 13:18:41 INFO - Return code: 0 13:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:18:41 INFO - Reading from file tmpfile_stdout 13:18:41 INFO - Output received: 13:18:41 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) 13:18:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:41 INFO - 'HOME': '/Users/cltbld', 13:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:41 INFO - 'LOGNAME': 'cltbld', 13:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:41 INFO - 'MOZ_NO_REMOTE': '1', 13:18:41 INFO - 'NO_EM_RESTART': '1', 13:18:41 INFO - 'PAGER': '/bin/cat', 13:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:41 INFO - 'PWD': '/builds/slave/test', 13:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:41 INFO - 'SHELL': '/bin/bash', 13:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:18:41 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:41 INFO - 'USER': 'cltbld', 13:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:41 INFO - 'XPC_FLAGS': '0x0', 13:18:41 INFO - 'XPC_SERVICE_NAME': '0', 13:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:41 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 13:18:41 INFO - Cleaning up... 13:18:41 INFO - Return code: 0 13:18:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:41 INFO - 'HOME': '/Users/cltbld', 13:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:41 INFO - 'LOGNAME': 'cltbld', 13:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:41 INFO - 'MOZ_NO_REMOTE': '1', 13:18:41 INFO - 'NO_EM_RESTART': '1', 13:18:41 INFO - 'PAGER': '/bin/cat', 13:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:41 INFO - 'PWD': '/builds/slave/test', 13:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:41 INFO - 'SHELL': '/bin/bash', 13:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:18:41 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:41 INFO - 'USER': 'cltbld', 13:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:41 INFO - 'XPC_FLAGS': '0x0', 13:18:41 INFO - 'XPC_SERVICE_NAME': '0', 13:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:42 INFO - Downloading/unpacking psutil>=3.1.1 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:45 INFO - Installing collected packages: psutil 13:18:45 INFO - Running setup.py install for psutil 13:18:45 INFO - building 'psutil._psutil_osx' extension 13:18:45 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 13:18:46 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 13:18:46 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 13:18:46 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 13:18:46 INFO - building 'psutil._psutil_posix' extension 13:18:46 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 13:18:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:18:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:18:46 INFO - ^ 13:18:46 INFO - 1 warning generated. 13:18:46 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 13:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:46 INFO - Successfully installed psutil 13:18:46 INFO - Cleaning up... 13:18:46 INFO - Return code: 0 13:18:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:18:46 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')]} 13:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:46 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')]} 13:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:46 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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:46 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 13:18:46 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 13:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:46 INFO - 'HOME': '/Users/cltbld', 13:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:46 INFO - 'LOGNAME': 'cltbld', 13:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:46 INFO - 'MOZ_NO_REMOTE': '1', 13:18:46 INFO - 'NO_EM_RESTART': '1', 13:18:46 INFO - 'PAGER': '/bin/cat', 13:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:46 INFO - 'PWD': '/builds/slave/test', 13:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:46 INFO - 'SHELL': '/bin/bash', 13:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:18:46 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:46 INFO - 'USER': 'cltbld', 13:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:46 INFO - 'XPC_FLAGS': '0x0', 13:18:46 INFO - 'XPC_SERVICE_NAME': '0', 13:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:18:49 INFO - Installing collected packages: mozsystemmonitor 13:18:49 INFO - Running setup.py install for mozsystemmonitor 13:18:50 INFO - Successfully installed mozsystemmonitor 13:18:50 INFO - Cleaning up... 13:18:50 INFO - Return code: 0 13:18:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:50 INFO - 'HOME': '/Users/cltbld', 13:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:50 INFO - 'LOGNAME': 'cltbld', 13:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:50 INFO - 'MOZ_NO_REMOTE': '1', 13:18:50 INFO - 'NO_EM_RESTART': '1', 13:18:50 INFO - 'PAGER': '/bin/cat', 13:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:50 INFO - 'PWD': '/builds/slave/test', 13:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:50 INFO - 'SHELL': '/bin/bash', 13:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:18:50 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:50 INFO - 'USER': 'cltbld', 13:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:50 INFO - 'XPC_FLAGS': '0x0', 13:18:50 INFO - 'XPC_SERVICE_NAME': '0', 13:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:50 INFO - Downloading/unpacking jsonschema==2.5.1 13:18:50 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 13:18:50 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 13:18:50 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 13:18:50 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 13:18:50 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 13:18:50 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 13:18:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:53 INFO - warning: no files found matching '*.txt' 13:18:53 INFO - no previously-included directories found matching 'build' 13:18:53 INFO - no previously-included directories found matching 'dist' 13:18:53 INFO - no previously-included directories found matching '.git*' 13:18:53 INFO - Installing collected packages: jsonschema, functools32 13:18:53 INFO - Running setup.py install for functools32 13:18:53 INFO - warning: no files found matching '*.txt' 13:18:53 INFO - no previously-included directories found matching 'build' 13:18:53 INFO - no previously-included directories found matching 'dist' 13:18:53 INFO - no previously-included directories found matching '.git*' 13:18:53 INFO - Successfully installed jsonschema functools32 13:18:53 INFO - Cleaning up... 13:18:53 INFO - Return code: 0 13:18:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:18:53 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')]} 13:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:53 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')]} 13:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:53 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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:53 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 13:18:53 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 13:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:53 INFO - 'HOME': '/Users/cltbld', 13:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:53 INFO - 'LOGNAME': 'cltbld', 13:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:53 INFO - 'MOZ_NO_REMOTE': '1', 13:18:53 INFO - 'NO_EM_RESTART': '1', 13:18:53 INFO - 'PAGER': '/bin/cat', 13:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:53 INFO - 'PWD': '/builds/slave/test', 13:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:53 INFO - 'SHELL': '/bin/bash', 13:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:18:53 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:53 INFO - 'USER': 'cltbld', 13:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:53 INFO - 'XPC_FLAGS': '0x0', 13:18:53 INFO - 'XPC_SERVICE_NAME': '0', 13:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:18:54 INFO - Cleaning up... 13:18:54 INFO - Return code: 0 13:18:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:54 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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:54 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 13:18:54 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 13:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:54 INFO - 'HOME': '/Users/cltbld', 13:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:54 INFO - 'LOGNAME': 'cltbld', 13:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:54 INFO - 'MOZ_NO_REMOTE': '1', 13:18:54 INFO - 'NO_EM_RESTART': '1', 13:18:54 INFO - 'PAGER': '/bin/cat', 13:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:54 INFO - 'PWD': '/builds/slave/test', 13:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:54 INFO - 'SHELL': '/bin/bash', 13:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:18:54 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:54 INFO - 'USER': 'cltbld', 13:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:54 INFO - 'XPC_FLAGS': '0x0', 13:18:54 INFO - 'XPC_SERVICE_NAME': '0', 13:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:18:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:18:57 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 13:18:57 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 13:18:57 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 13:18:57 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 13:18:57 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 13:18:57 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 13:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:18:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:18:57 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 13:18:57 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 13:18:57 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 13:18:57 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 13:18:57 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 13:18:57 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 13:18:58 INFO - Downloading docopt-0.6.1.tar.gz 13:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:18:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:18:58 INFO - Running setup.py install for blobuploader 13:18:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:18:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:18:58 INFO - Running setup.py install for requests 13:18:59 INFO - Running setup.py install for docopt 13:18:59 INFO - Successfully installed blobuploader requests docopt 13:18:59 INFO - Cleaning up... 13:18:59 INFO - Return code: 0 13:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:59 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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:18:59 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 13:18:59 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 13:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:59 INFO - 'HOME': '/Users/cltbld', 13:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:59 INFO - 'LOGNAME': 'cltbld', 13:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:59 INFO - 'MOZ_NO_REMOTE': '1', 13:18:59 INFO - 'NO_EM_RESTART': '1', 13:18:59 INFO - 'PAGER': '/bin/cat', 13:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:59 INFO - 'PWD': '/builds/slave/test', 13:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:59 INFO - 'SHELL': '/bin/bash', 13:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:18:59 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:59 INFO - 'USER': 'cltbld', 13:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:59 INFO - 'XPC_FLAGS': '0x0', 13:18:59 INFO - 'XPC_SERVICE_NAME': '0', 13:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Xr4J2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-qebI6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aRLNh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-YttqVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-QaflFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-50saUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-DPyGQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-lOYv5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-JashzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-IRBeSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-V2M7xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Mbu4Ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ll7Z5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-lPhs3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-R6y_S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-PX4n0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:01 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-tXNBJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:01 INFO - Running setup.py install for manifestparser 13:19:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:01 INFO - Running setup.py install for mozcrash 13:19:01 INFO - Running setup.py install for mozdebug 13:19:01 INFO - Running setup.py install for mozdevice 13:19:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:01 INFO - Running setup.py install for mozfile 13:19:02 INFO - Running setup.py install for mozhttpd 13:19:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:02 INFO - Running setup.py install for mozinfo 13:19:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:02 INFO - Running setup.py install for mozInstall 13:19:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:02 INFO - Running setup.py install for mozleak 13:19:02 INFO - Running setup.py install for mozlog 13:19:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:02 INFO - Running setup.py install for moznetwork 13:19:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Running setup.py install for mozprocess 13:19:03 INFO - Running setup.py install for mozprofile 13:19:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Running setup.py install for mozrunner 13:19:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Running setup.py install for mozscreenshot 13:19:03 INFO - Running setup.py install for moztest 13:19:03 INFO - Running setup.py install for mozversion 13:19:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:03 INFO - Cleaning up... 13:19:03 INFO - Return code: 0 13:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:03 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')]} 13:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:04 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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:19:04 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 13:19:04 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 13:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:04 INFO - 'HOME': '/Users/cltbld', 13:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:04 INFO - 'LOGNAME': 'cltbld', 13:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:04 INFO - 'MOZ_NO_REMOTE': '1', 13:19:04 INFO - 'NO_EM_RESTART': '1', 13:19:04 INFO - 'PAGER': '/bin/cat', 13:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:04 INFO - 'PWD': '/builds/slave/test', 13:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:04 INFO - 'SHELL': '/bin/bash', 13:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:19:04 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:04 INFO - 'USER': 'cltbld', 13:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:04 INFO - 'XPC_FLAGS': '0x0', 13:19:04 INFO - 'XPC_SERVICE_NAME': '0', 13:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-cgaeV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-a8PvSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-pgeqhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Xc2_KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-c1DYaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-keZxk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-s2QGoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-PyDpfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-i5rqlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-jvoIBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:05 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)) 13:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FMEMwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:06 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-_BTluF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:06 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sbGUfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:06 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CdeykL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:06 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Y1lYUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:06 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4W5n6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:06 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-U9bgmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:06 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)) 13:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:19:06 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)) 13:19:06 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)) 13:19:06 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)) 13:19:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:06 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 13:19:06 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 13:19:06 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 13:19:06 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 13:19:06 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 13:19:06 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 13:19:09 INFO - Downloading blessings-1.6.tar.gz 13:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:09 INFO - Installing collected packages: blessings 13:19:09 INFO - Running setup.py install for blessings 13:19:10 INFO - Successfully installed blessings 13:19:10 INFO - Cleaning up... 13:19:10 INFO - Return code: 0 13:19:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:10 INFO - Reading from file tmpfile_stdout 13:19:10 INFO - Current package versions: 13:19:10 INFO - blessings == 1.6 13:19:10 INFO - blobuploader == 1.2.4 13:19:10 INFO - docopt == 0.6.1 13:19:10 INFO - functools32 == 3.2.3-2 13:19:10 INFO - jsonschema == 2.5.1 13:19:10 INFO - manifestparser == 1.1 13:19:10 INFO - mozInstall == 1.12 13:19:10 INFO - mozcrash == 1.0 13:19:10 INFO - mozdebug == 0.1 13:19:10 INFO - mozdevice == 0.48 13:19:10 INFO - mozfile == 1.2 13:19:10 INFO - mozhttpd == 0.7 13:19:10 INFO - mozinfo == 0.9 13:19:10 INFO - mozleak == 0.1 13:19:10 INFO - mozlog == 3.4 13:19:10 INFO - moznetwork == 0.27 13:19:10 INFO - mozprocess == 0.23 13:19:10 INFO - mozprofile == 0.28 13:19:10 INFO - mozrunner == 6.13 13:19:10 INFO - mozscreenshot == 0.1 13:19:10 INFO - mozsystemmonitor == 0.3 13:19:10 INFO - moztest == 0.8 13:19:10 INFO - mozversion == 1.4 13:19:10 INFO - psutil == 3.1.1 13:19:10 INFO - requests == 1.2.3 13:19:10 INFO - wsgiref == 0.1.2 13:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:10 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')]} 13:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:10 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')]} 13:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:10 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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:19:10 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 13:19:10 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 13:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:10 INFO - 'HOME': '/Users/cltbld', 13:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:10 INFO - 'LOGNAME': 'cltbld', 13:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:10 INFO - 'MOZ_NO_REMOTE': '1', 13:19:10 INFO - 'NO_EM_RESTART': '1', 13:19:10 INFO - 'PAGER': '/bin/cat', 13:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:10 INFO - 'PWD': '/builds/slave/test', 13:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:10 INFO - 'SHELL': '/bin/bash', 13:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:19:10 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:10 INFO - 'USER': 'cltbld', 13:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:10 INFO - 'XPC_FLAGS': '0x0', 13:19:10 INFO - 'XPC_SERVICE_NAME': '0', 13:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 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)) 13:19:10 INFO - Cleaning up... 13:19:10 INFO - Return code: 0 13:19:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19:10 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')]} 13:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:10 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')]} 13:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:10 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 0x109a0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109982570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe6ace0550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, '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.VGEPUD729N/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.0aGASsx1w8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 13:19:10 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 13:19:10 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 13:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:10 INFO - 'HOME': '/Users/cltbld', 13:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:10 INFO - 'LOGNAME': 'cltbld', 13:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:10 INFO - 'MOZ_NO_REMOTE': '1', 13:19:10 INFO - 'NO_EM_RESTART': '1', 13:19:10 INFO - 'PAGER': '/bin/cat', 13:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:10 INFO - 'PWD': '/builds/slave/test', 13:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:10 INFO - 'SHELL': '/bin/bash', 13:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:19:10 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:10 INFO - 'USER': 'cltbld', 13:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:10 INFO - 'XPC_FLAGS': '0x0', 13:19:10 INFO - 'XPC_SERVICE_NAME': '0', 13:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:19:10 INFO - Cleaning up... 13:19:10 INFO - Return code: 0 13:19:10 INFO - Running post-action listener: _resource_record_post_action 13:19:10 INFO - Running post-action listener: _start_resource_monitoring 13:19:10 INFO - Starting resource monitoring. 13:19:10 INFO - [mozharness: 2017-01-31 21:19:10.998992Z] Finished create-virtualenv step (success) 13:19:11 INFO - [mozharness: 2017-01-31 21:19:10.999984Z] Running install step. 13:19:11 INFO - Running pre-action listener: _resource_record_pre_action 13:19:11 INFO - Running main action method: install 13:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:11 INFO - Reading from file tmpfile_stdout 13:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 13:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:19:11 INFO - Reading from file tmpfile_stdout 13:19:11 INFO - Output received: 13:19:11 INFO - Usage: mozinstall [options] installer 13:19:11 INFO - Options: 13:19:11 INFO - -h, --help show this help message and exit 13:19:11 INFO - -d DEST, --destination=DEST 13:19:11 INFO - Directory to install application into. [default: 13:19:11 INFO - "/builds/slave/test"] 13:19:11 INFO - --app=APP Application being installed. [default: firefox] 13:19:11 INFO - mkdir: /builds/slave/test/build/application 13:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:19:32 INFO - Reading from file tmpfile_stdout 13:19:32 INFO - Output received: 13:19:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:19:32 INFO - Running post-action listener: _resource_record_post_action 13:19:32 INFO - [mozharness: 2017-01-31 21:19:32.555937Z] Finished install step (success) 13:19:32 INFO - [mozharness: 2017-01-31 21:19:32.556072Z] Running run-tests step. 13:19:32 INFO - Running pre-action listener: _resource_record_pre_action 13:19:32 INFO - Running main action method: run_tests 13:19:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:19:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:19:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:19:32 INFO - 2017-01-31 13:19:32.570 screenresolution[1622:7401] starting screenresolution argv=screenresolution get 13:19:32 INFO - 2017-01-31 13:19:32.573 screenresolution[1622:7401] Display 0: 1600x1200x32@60 13:19:32 INFO - 2017-01-31 13:19:32.579 screenresolution[1623:7404] starting screenresolution argv=screenresolution list 13:19:32 INFO - Available Modes on Display 0 13:19:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:19:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:19:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:19:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:19:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:19:32 INFO - Intel Iris: 13:19:32 INFO - Chipset Model: Intel Iris 13:19:32 INFO - Type: GPU 13:19:32 INFO - Bus: Built-In 13:19:32 INFO - VRAM (Dynamic, Max): 1536 MB 13:19:32 INFO - Vendor: Intel (0x8086) 13:19:32 INFO - Device ID: 0x0a2e 13:19:32 INFO - Revision ID: 0x0009 13:19:32 INFO - Displays: 13:19:32 INFO - Display: 13:19:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:19:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:19:32 INFO - Display Serial Number: 1600x1200 60 13:19:32 INFO - Main Display: Yes 13:19:32 INFO - Mirror: Off 13:19:32 INFO - Online: Yes 13:19:32 INFO - Rotation: Supported 13:19:32 INFO - Return code: 0 13:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:19:32 INFO - Python 2.7.3 13:19:32 INFO - Return code: 0 13:19:32 INFO - grabbing minidump binary from tooltool 13:19:32 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')]} 13:19:32 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 0x109820d30>, '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 0x109686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109818b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:19:32 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 13:19:32 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 13:19:32 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 13:19:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:19:32 INFO - Return code: 0 13:19:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:19:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:19:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:19:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:19:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 13:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --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 13:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VGEPUD729N/Render', 13:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:32 INFO - 'HOME': '/Users/cltbld', 13:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:32 INFO - 'LOGNAME': 'cltbld', 13:19:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:19:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:32 INFO - 'MOZ_NO_REMOTE': '1', 13:19:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:19:32 INFO - 'NO_EM_RESTART': '1', 13:19:32 INFO - 'PAGER': '/bin/cat', 13:19:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:32 INFO - 'PWD': '/builds/slave/test', 13:19:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:32 INFO - 'SHELL': '/bin/bash', 13:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0aGASsx1w8/Listeners', 13:19:32 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 13:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:32 INFO - 'USER': 'cltbld', 13:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:32 INFO - 'XPC_FLAGS': '0x0', 13:19:32 INFO - 'XPC_SERVICE_NAME': '0', 13:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 13:19:33 INFO - mozversion application_buildid: 20170131111909 13:19:33 INFO - mozversion application_changeset: dd9844a556dc657a878fbbc7d61fc68ec4cc5de1 13:19:33 INFO - mozversion application_display_name: Firefox 13:19:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:19:33 INFO - mozversion application_name: Firefox 13:19:33 INFO - mozversion application_remotingname: firefox 13:19:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:19:33 INFO - mozversion application_vendor: Mozilla 13:19:33 INFO - mozversion application_version: 52.0 13:19:33 INFO - mozversion platform_buildid: 20170131111909 13:19:33 INFO - mozversion platform_changeset: dd9844a556dc657a878fbbc7d61fc68ec4cc5de1 13:19:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:19:33 INFO - mozversion platform_version: 52.0 13:19:33 INFO - using testdate: 1485897573 13:19:33 INFO - actual date: 1485897573 13:19:33 INFO - starting webserver on 'localhost:49241' 13:19:33 INFO - SUITE-START | Running 2 tests 13:19:33 INFO - TEST-START | dromaeo_css 13:19:33 INFO - operating with platform_type : mac_ 13:19:33 INFO - Initialising browser for dromaeo_css test... 13:19:33 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpZ4nf6z/profile http://localhost:49241/getInfo.html) 13:19:35 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 13:19:35 INFO - PROCESS | 1633 | colorDepth:24 13:19:35 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 13:19:35 INFO - PROCESS | 1633 | __metrics 13:19:35 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:19:35 INFO - PROCESS | 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:19:36 INFO - TEST-INFO | 1633: exit 0 13:19:36 INFO - Browser initialized. 13:19:36 INFO - Running cycle 1/1 for dromaeo_css test... 13:19:36 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpZ4nf6z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:48 INFO - PROCESS | 1636 | RSS: Main: 171479040 13:19:48 INFO - PROCESS | 1636 | 13:22:51 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 13:22:53 INFO - PROCESS | 1636 | RSS: Main: 315346944 13:22:53 INFO - PROCESS | 1636 | 13:25:56 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 13:25:56 INFO - PROCESS | 1636 | RSS: Main: 299323392 13:25:56 INFO - PROCESS | 1636 | 13:28:58 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 13:28:59 INFO - PROCESS | 1636 | RSS: Main: 298762240 13:28:59 INFO - PROCESS | 1636 | 13:32:01 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 13:32:02 INFO - PROCESS | 1636 | RSS: Main: 290471936 13:32:02 INFO - PROCESS | 1636 | 13:35:05 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 13:35:06 INFO - PROCESS | 1636 | RSS: Main: 256204800 13:35:06 INFO - PROCESS | 1636 | 13:38:08 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 13:38:09 INFO - PROCESS | 1636 | RSS: Main: 321662976 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | __start_tp_report 13:38:09 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 13:38:09 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 13:38:09 INFO - PROCESS | 1636 | |i|pagename|runs| 13:38:09 INFO - PROCESS | 1636 | |0;dojo.html;3379.9831000844993;3397.116749645092;3399.7450191235657;3406.31873625275;3449.379111759884;5712.1431785232235;5721.199032135504;5753.626014309067;5757.42425757424;5766.990776614086;5728.79949201777;5822.737976791044;5844.473997340238;5858.648481091138;5871.324797648272;5179.326687530615;5213.139831927728;5217.37391513019;5280.815171468999;5298.311219541454;5176.55999240065;5190.403103643072;5204.42751297357;5321.494458026481;5323.068463018975;5280.128778751501;5281.155015197569;5292.444293349201;5298.735063246822;5311.468853114677;5049.2678561608545;5200.6619569727845;5275.129603615399;5275.287836142129;5285.973570132163;5140.203268493389;5181.5854731621375;5183.740812959337;5194.68831870089;5271.762770675329;5843.5325173985975;5872.17789509469;5910.97044514779;5915.231019967377;5929.792457263975;6055.212822333068;6139.693015349215;6176.135341052256;6203.131561581382;6254.8123556293385;6207.658578778165;6241.375862413768;6253.968095264276;6278.466330361879;6292.748290068392;5806.187133801272;5822.621529600647;5825.0679891217205;5842.59101862874;5879.882402352015;6176.042713379434;6200.3179650238435;6236.314005459396;6250.312465628777;6255.030470277115;6104.572679912363;6108.755649774048;6110.877782444415;6115.143879856823;6124.479419249325;6190.604670683775;6234;6253.78111766086;6263.060540918807;6274.529410294155;6049.153118563405;6077.513798896078;6135.754569817246;6141.140240366352;6167.784127555514;6165.414285642857;6235.345288744707;6253.6873156342;6256.562040657111;6263.217097862767;4955.554000140005;4955.752212389366;4959.925601115986;4972.403311602631;4988.4263309719845;4401.6698747594055;4436.844710435119;4493.618042466427;4494.5730155635165;4497.280435130363;4837.782299796518;5659.094544872801;5743.741531631086;5747.568932330092;5821.650700957956;6240.7503699852405;6247.344028876993;6255.624662520263;6258.123862659231;6274.937250627527;5658.886822263532;5821.243238378984;5824.825255242349;5844.795432159854;5865.384134665884;5391.514763671288;5393.298871146726;5446.291982042389;5447.182922561568;5487.012337779238;6282.874342513032;6315.084312774714;6333.145025421509;6361.90457143134;6366.681665916778;6197;6270.184875966095;6282.560220784501;6287.528435367274;6312.936870631235;4877.414710234794;6186.350433204629;6248.906266406098;6298.338674439118;6306.779262725966;6262.15460912771;6264.21697287839;6269.905951410824;6274.592151510137;6278.529110316653;6265.624062556261;6280.497560195265;6300.369963003663;6305.590136641287;6309.1167236587835;5377.408485066561;5908.350081490947;6085.208922840003;6101.328853826164;6122.571420000557;6110.602810817282;6135.386461353829;6139.508839292936;6154.046122850787;6158.291796443466;5927.585069045298;6006.849828754316;6011.849703757441;6018.8796224074395;6049.304330002106;5917.763289468545;5996.280446346466;6077.20996270482;6145.508359331154;6159.84600384994;5943.494802941798;6012.849678758066;6021.036634138517;6038.577299589162;6056.485198758155 13:38:09 INFO - PROCESS | 1636 | |1;ext.html;470.78108679464054;473.98104075836966;534.2663058375571;556.4074260912129;559.8600349912522;31047.844760776192;32865;32873.34253314932;32922.68309267626;32975.83512082442;33252;33971.660283397156;33982.150446238855;34145.65854341456;41526.37710434338;9109.453432794036;9440.339176257665;9487;9495.050494950485;9497.145256926875;9263.536823158849;9373.906260937372;9375.81248375032;9388.812223755522;9395.76510587234;8831;9044.638214471446;9357;9415.764605884873;9422.717318480456;11318;11571.594994175164;11604.013658839009;11775.175737698364;11793.705157371049;11534.250273732265;11629.302241865515;11631.825522617168;11633.94183029088;11636.825447618208;39379.60620393788;39683.40474892879;39793.20413591741;39803.8009809952;39831.60168398337;2836.964507954602;3346.0798280472823;3368;3613.6928361089076;3639.2175682228185;29648.70351296481;30094.699053009408;30447.847760761277;30558.54162187569;30841.383172336653;3250.138713240993;3259.722923551501;3293.8682452701864;3301.042697617712;3307.5038744188323;493659;495620;495642;496672;496869;33380.332393352;34130.65869341324;34253.657463425545;57201;57838.42161578331;34795.9561213164;34943.301133977686;34963.82518087393;34964.47553286703;35010;14742.557723268319;14918.552443426715;14918.627034324229;14924.552263432115;14947.775783363259;12588.181768185039;12651;12676.492940282285;12677.873221267853;12710.936445317715;7832.177621349791;7865.410094242955;7888.921110788933;7933.087694915043;8001.1198768135455;3167.683231676814;3278;3307;3331.6002079750583;3409.1988382730037;924.1128516623982;959.9584450870743;969.3311614985778;1002.5488530161457;1020.4591566469783;28733.85633071863;29362.853185733933;29550;30220.84889575538;30294;976.6142373762466;1045.325764881647;1064.0211005874614;1144.9427528623535;1149.6493569461227;15013.624659383384;15444.845551544566;15476.303566339317;15649.78386347154;15919.204039797964;663679;668593;670185;670335;675849;52477;56084.15873761897;56875;57313.14030289549;57435.71282143563;1300;1311.895048396126;1312.7308901675324;1313.2973858985397;1314.17207159487;23796.286111416684;30299.091027269216;30474.542881857233;30551.388972219986;32085.839570801996;51832.48167518277;52438.95122097613;52465.475345247585;52469;52617.47382526126;566776;571822;571848;573005;573322;22168.778312216673;23493.295201143992;24076.277711668678;25413.61879571771;26240.08159714401;44897.55102448934;45018.549814502745;45225.869353265116;45445.54554454413;45510.772446137555;32988.50517242195;37514.07720509836;40381.798091009354;41273.79363103165;41834;37376.62623373731;37498.625013749515;37920.051998700255;39047.63333283321;39062.2187556253;37580.06049848776;38072;38485.615143849325;38561.8431447057;38593.45626174921;32000;34289.828550857084;34353;34444.31111377708;34541.48187777135;24685.38286542779;25173.74826251714;25596.360090997874;25648.717564122093;25862.316650897334 13:38:09 INFO - PROCESS | 1636 | |2;jquery.html;358.1601145314238;388.33206884159256;394.34571970583414;402.8851777243485;419.57413225576045;20264;20359.69460458094;21349.146034158613;21655.45861353467;21656.2420315289;20456.181752729874;21132.260370887023;21147.365579032616;21149.365519034414;21500.56998860022;5818.214541036969;6069;6088.056351265539;6090.23872015998;6091.42131497507;5077.33994580704;5741.339745929209;5988.101784732303;6023.156758053876;6046;5998.8800223995495;5999.160117583542;6003.369646187153;6005;6006.519478441736;5703.201551782754;5878.794242201502;5947.37552556984;5966.552508561854;5978.641281523122;5229.50319719626;5236.8690782730355;5237.502437268454;5241.50205730455;5250.606204534675;21740.130394784188;23291.88354058236;25516.234512964642;26051.869740651175;26234;2371.324172610815;2396.892139853711;2474.6782918220697;2528.8609126498036;3116.3923035008183;15277.847221527754;15675.216239187996;15882;16579.17104144788;16597.917010414993;1855.6010457751513;1949.7376689516143;1975.93299618206;2008;2014.979850201494;83077;106479.93520064777;106787.46606266996;115712.42143789228;116409.41795290969;9871.160951319074;11282.097432205404;11691.356975366267;11801.586944456903;11838.171328006956;15170.24148792578;15178.620534486505;15214.467493637669;15230.619234519005;15261.542153735405;8574;8808.163224493663;8850.070742572067;8852.911470885338;8921.732348029569;7375.225601311785;8710.428724223038;8841.823163536694;8853.380263381501;9021.729348119567;4507.301368287921;4629.814807407666;4637;4670.346151538787;4712.59942904857;1683.7137686593308;1954.2378472395776;1965.3416105604497;1976.4268362175096;1982.2665613723016;698.9440844732511;944.7118628818139;950.5057370167474;981.7054883534911;1019.2559431614815;21397.893010535157;22494.100235990376;22595.322140335815;22601.208957686402;22800.885995569915;946.7301818981557;950.9809803804023;967.874176357069;976.6044751875502;994.2543092680489;10804.945975270231;11592.246503977214;11634.94182529082;11657.475413606408;11667.708307292385;524005;526917;528891;603575;640688;137784;143058;143256;144556;148201;950.6340059077305;957.2772556719772;997.3467378866853;997.5211898288862;1018.8471729240673;19555.51111222231;20012;20477.283295084602;20526.178952842318;20540.794592054484;34311.65688343085;46187.538124618324;52235.43293701195;55081;55958;78998;79287.60356198413;80660.59669701614;82443;84277.57861210655;7828.5694286812495;8000.03999520038;8128.634211460617;8302.294304984143;8371.288440482627;9917.355371900803;12606.55877044299;12698.555550555686;12700.174488658207;12794.552190673281;10690.305130166515;11048.116150707763;11241.325520468798;11277.379744114152;11409.771804563696;5096.031753966883;8125.959370203112;10652.733681658021;11401.543938242377;11729.648110556696;11503.827442588201;11538;11633.825492617787;11754.659464397462;11806.46870890829;8156.429049966683;8246.257836794717;8416.621252043795;8539;8668.739937801876;8931.419457735226;11344;11413.372264525531;11413.429328533706;11750.23623464472 13:38:09 INFO - PROCESS | 1636 | |3;mootools.html;1372.3275594958473;1507.3141720517165;1533.1414407931557;1733.835285647863;1907.4277716684992;7458.701651933923;7961.124276329607;8230.95884520578;8465.873011904827;8500.829983400328;8305.83388332233;8396.706115285966;8403.41176117672;8437;8451.02813176485;2364.869932153735;2405.037984806083;2405.783479486846;2407.07327678844;2408.7832095111435;1955.5208973801439;2407.9759202407927;2418.5525677749583;2420.9152679656218;2426.987865060681;2322.918697845576;2365.6451532270125;2400.2079313826484;2403.6514705367713;2409.2531315292317;2310.9884450577806;2339.298210536849;2375.524895020994;2376.2158487699016;2384.6423036544484;2346.577616029114;2369.620860662303;2393.6888204533298;2394.568977584034;2394.916177933764;8383.16168383163;8411.45325553837;8482.024567174793;8485.278751306147;8500.234978851933;5110.5400513953555;5306.442823503554;5308.946910530923;5322.733863306819;5334.893302133974;3420.709239714627;3531.94702079469;3579.982100089509;3594.8382322795537;3606.0263728793343;1064.834950582661;1084.8101582223157;1087.6030248959153;1099.115212254135;1117.4692021289823;10795;10808.081313088396;10892.074173695246;10904.291221070684;10910.563577456893;4314.633256173198;4451.465824101064;4535.591796738244;4545.431821022372;4549.226631472658;8689.131086891386;8692.261157801659;8702.434341767765;8710.21608055278;8718.47689138641;5143.3570803649545;5148.124818780816;5155.716435596079;5159.329287192641;5162.1224391853475;3843.9615603844163;4390.846320378771;4511.729296242236;4798.088363210979;4859.392575928009;3522.330757156132;3866.478025466582;3901.3367727486398;3996.4604778355133;4037.1320166164414;1290.316132449803;1317.8418589769096;1325.5691900132495;1332.2015279372963;1334.6196334044944;836.2097817562467;885.3802338363172;896.1038961038961;914.9588268527932;936.166811537732;4756.5956893664425;5546.639468434539;5601.691906945076;5616.803411880646;5831.79588714393;451.77185521312185;469.03847113417356;471.83957454465644;478.6673262082819;779.5283853268804;3665.7983810890655;3683.778973261613;3705.7220708446976;3842.769433833979;3850.998740327479;9962.800743985079;10304.896951030543;10308.639197628047;10314.742131446774;10314.948425257826;10129.189664826796;10272.948635256776;10277;10297.330673506198;10306.742331441774;7750.108737495148;7837.216278372117;7843.921560784319;7995.840083198304;7997.960010199912;5413.945860541344;5485.561155107502;5540.612157148961;5550.52820510245;5744.109663002241;9291.67479138227;9322.347435679438;9365.203957663674;9372.765680858032;9492.145706886413;9390.154886060287;9522.190613797904;9550.283728720513;9567.665131720356;9619.807603848023;6301.6219026858535;6482.837929051811;6683.832904177434;6709.127813384229;6840.41856442208;7930.167332430243;8119.959400202961;8127.3091787198755;8130.87803682957;8142.307903828241;7113.893291600527;7249.093863267091;7255.927440725525;7271.527350722186;7355.264473552602;7030.859382812418;7043.330883566053;7074.080369551925;7185.892211616725;7186.928130718626;6727.159105111861;6732.394084532416;6806.76176333826;6820;6823.1812182538415;4101.343784994387;4129.772862492592;4715.3869996900185;4785.282207668877;4871.707697538159;4835.709857408567;4892.90214195707;4972.627052971114;4978.054169707744;4989.101961646793 13:38:09 INFO - PROCESS | 1636 | |4;prototype.html;311.16297160637896;315.73478278246273;321.2482790270766;323.4307618591279;323.6326769117051;5198.220266959953;5209.843704688856;5217.03484855302;5222.242774797652;5230.581553475722;4470.664700147486;5051.0553436926775;5057.078310242112;5135.743212839362;5168.457311982244;3973.3046716824583;3981.5222173339166;4015.9799201003952;4031.6371526562602;4035.2534781065597;3309.6855798699085;3327.317899830529;3666.3400587894166;3967.1750994542545;4002.6997975151835;3325.1687078230443;3705.3145168143847;3965.325894597925;3976.2842688316236;3996.900077498057;3733.5893051764283;3890.5878355419536;3982.9203415931665;3993.5407428145554;4020.618041286073;2877.2662970942274;3396.558447401822;3454.9827250863837;3471.7916924984584;3484.4773284007347;4287.399764033038;5024.221245706921;5117.1556693145585;5120.977214000486;5165;4393.7363758174615;4468.815763822589;4486.55134486552;4584.593088628463;4585.541445855421;4905.626424601118;4985.576226020793;5494.5054945054735;5497.257870187554;5498.835034948918;2966.6291713535807;3603.765755225902;3796.54441467023;3803.5245594300713;3819;5567.415421380737;5709.77160913563;5726.883257764737;5747;5771.624844385102;3849.7690138591774;3858.0354911272184;3863.2273545291055;3877.903052423712;3881.243157584244;3917.6474117329576;3930.3121953657997;3940.7438516496336;3944.6252606002386;3953.5058117735284;4069.2878746219885;4136.793160341971;4200.432941552913;4394.274944634163;4584.472785629629;4828.551434569615;5539.25220095282;5558.110242517563;5572.693501857437;5615.578831587647;1246.6660673079718;1263.6714454241962;1265.4558539827963;1278.4502663854446;1286.5497076023316;683.3474032299142;796.8884356190138;801.8997625296838;863.3869952333788;866.9089745576624;4366.388705581221;4528.388667529907;4825.975870120697;4858.82994095205;4894.902101957941;4778.5699287063635;5314.415414304423;5339.626226164131;5422.457754224546;5449.99175152598;4302.139572085595;4543.183226399653;4646.907061858744;4817.445993710769;4825.420949486014;2614.8692565371657;2695.595660650918;2754.820936639112;2772.8613569321856;2792.7067657896037;5456.563474921997;5463.754131064112;5491.560675146058;5493.560515158778;5504.614676972574;4250.681198910094;5307.761150748225;5424.7016414096815;5761.070041536049;5815.302163740378;5817.941820581825;5825.912611310834;5832.416758324133;5868.354481007086;5878.676672783038;4256.25515534774;5352.545033672026;5667.546596272371;5694.886102278014;5699.658020518782;4989.426215985063;5375.946240537544;5734.254546908875;5741.182113894213;5748.872917020729;4962.975185124052;5220.634555581073;5904;5967.850803729768;6020.969895150672;3638.836252368703;3865.2269546091457;3868.5937976513187;3909.804509774443;3913.373860182357;5091.312672789274;5477.397486276586;5693.5160511357;5720.856978575569;5748.6838223898085;4709.940263440699;4821.783019764049;5519.061759500814;5531.612787105025;5540.63985840919;5182.740862956913;5240.816571419982;5474.644148130359;5531.308586426697;5550.976366388425;4916;5133.922991155061;5402.405735369028;5449.482299181572;5450.836474905759;4876.878078048077;5146.4338922717725;5427.592930530305;5574.888502230014;5579.8884022320135;4832.395950506187;4857.101436234308;4966.577840883565;5473.562115030868;5527.50252477279 13:38:09 INFO - PROCESS | 1636 | |5;yui.html;705.2031204738648;740.3115102954253;773.6711897443585;822.5887056471762;834.6520369603093;14417.855821441783;15456.459023934165;15503;15522.30149643266;15548.922255388721;14013.299335033258;14111.788323175135;14127.858721412782;14136.22250776207;14142.363593638285;719.2914978745931;743.6207534157564;863.4646519158131;883.703959173676;892.2282225874604;893.7095443980733;902.5622573052065;904.3082042237694;907.8093600343935;909.8771665825128;942.0391200975001;944.3153713557684;944.5607792376544;946.6686659669095;947.1286416496805;881.6209030117047;935.4574346878794;938.0478814003792;939.4410325856105;947.4836214263244;697.6616341074575;701.3687681087063;704.8766465868453;705.696550483292;707.2821086597108;14416.567502974927;14550.345234464474;14563.344649490693;14564.126152430888;15201.239938003055;13810.93094534531;14213.147211167363;14267.78598321026;14292.213928233943;14529.636759081002;11223;11563.826542601868;11689.883101168965;11736.53053877844;11754.706132346675;3453.4474484082425;3722.274156539476;3752.831122599462;3756.868509602151;3760.0599850037493;89004;91716.62425063629;92809.60785588222;94176.52911735466;97605.93368586186;10260.692179234635;10522.210834187466;10561.841572376421;10674.89325106739;10754.569817207224;21861;22178.778212217992;22286.774227417325;22532.21137260188;22571.774282256967;7619.809504762426;7755.650995705207;7858.2141785822105;7885.408594355446;8050.758477245692;4336.479622445327;4367.475902891673;4437.378766972626;4479.17135329965;4526.79629416677;3496.493008513751;3601.603823579404;3606.441001644749;3613.837377318027;3627.056965189017;548.5611510791351;559.3986464550625;637.6333608175318;643.6290700807344;647.4270270810273;590.6603702870866;644.9742010319535;687.1273482676972;695.7112798188796;705.0833915909298;8856.335774816785;9197.862032069525;9211.032841551674;9316.48759318244;9570.712878613653;652.7552167937024;682.6996121706533;685.2188505104185;688.8932215506604;695.58265040975;4107.774072425986;4436.534163912807;4497.572730590654;4557.339185818038;4563.589276965089;50652.49347506478;62038;64565.35434645593;71215.72705637678;107512;62574;89268.5536572326;91997.54001230084;94052;98460;58233;59990;60217.69891150516;73564.63217683877;75246;9375.812483750424;9924.503774811086;9931;9985.850212246967;10021.599136034478;47022;50802;51096;53303.46696532985;53722.57248433731;70745.29254707387;72569.27430725624;73187.63406182935;73652.63173684098;77982;10927.45362731876;12473.812892806796;12577.93711031439;12591.181573198079;12935.353232338533;11937.403129843648;12506.124571279923;13897.791533127214;14216.71566568642;14330.713385732019;11315.603953861575;11797.941010294893;11954.282743035446;12085.39573021363;12514.061445391813;11848.70378240551;12116.333601651993;12431.875681243071;13429;13432.261225632294;11421.743608203256;12620.810687839874;12958.481660733842;13089.738205235652;13423.731525369632;10947.83578246311;10961.890381096087;11351.772964540829;11518.308901465938;11667;11320.433978301216;11494.310341379543;11532.365719885487;11622.6513204604;11875.228110172811 13:38:09 INFO - PROCESS | 1636 | __end_tp_report 13:38:09 INFO - PROCESS | 1636 | __start_cc_report 13:38:09 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1561 13:38:09 INFO - PROCESS | 1636 | __end_cc_report 13:38:09 INFO - PROCESS | 1636 | __startTimestamp1485898689157__endTimestamp 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | ------- Summary: start ------- 13:38:09 INFO - PROCESS | 1636 | Number of tests: 6 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5757.75 Median:6006.85 stddev:632.27 (10.5%) stddev-sans-first:606.07 13:38:09 INFO - PROCESS | 1636 | Values: 3380.0 3397.1 3399.7 3406.3 3449.4 5712.1 5721.2 5753.6 5757.4 5767.0 5728.8 5822.7 5844.5 5858.6 5871.3 5179.3 5213.1 5217.4 5280.8 5298.3 5176.6 5190.4 5204.4 5321.5 5323.1 5280.1 5281.2 5292.4 5298.7 5311.5 5049.3 5200.7 5275.1 5275.3 5286.0 5140.2 5181.6 5183.7 5194.7 5271.8 5843.5 5872.2 5911.0 5915.2 5929.8 6055.2 6139.7 6176.1 6203.1 6254.8 6207.7 6241.4 6254.0 6278.5 6292.7 5806.2 5822.6 5825.1 5842.6 5879.9 6176.0 6200.3 6236.3 6250.3 6255.0 6104.6 6108.8 6110.9 6115.1 6124.5 6190.6 6234.0 6253.8 6263.1 6274.5 6049.2 6077.5 6135.8 6141.1 6167.8 6165.4 6235.3 6253.7 6256.6 6263.2 4955.6 4955.8 4959.9 4972.4 4988.4 4401.7 4436.8 4493.6 4494.6 4497.3 4837.8 5659.1 5743.7 5747.6 5821.7 6240.8 6247.3 6255.6 6258.1 6274.9 5658.9 5821.2 5824.8 5844.8 5865.4 5391.5 5393.3 5446.3 5447.2 5487.0 6282.9 6315.1 6333.1 6361.9 6366.7 6197.0 6270.2 6282.6 6287.5 6312.9 4877.4 6186.4 6248.9 6298.3 6306.8 6262.2 6264.2 6269.9 6274.6 6278.5 6265.6 6280.5 6300.4 6305.6 6309.1 5377.4 5908.4 6085.2 6101.3 6122.6 6110.6 6135.4 6139.5 6154.0 6158.3 5927.6 6006.8 6011.8 6018.9 6049.3 5917.8 5996.3 6077.2 6145.5 6159.8 5943.5 6012.8 6021.0 6038.6 6056.5 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:68903.21 Median:34492.90 stddev:156392.02 (453.4%) stddev-sans-first:156746.34 13:38:09 INFO - PROCESS | 1636 | Values: 470.8 474.0 534.3 556.4 559.9 31047.8 32865.0 32873.3 32922.7 32975.8 33252.0 33971.7 33982.2 34145.7 41526.4 9109.5 9440.3 9487.0 9495.1 9497.1 9263.5 9373.9 9375.8 9388.8 9395.8 8831.0 9044.6 9357.0 9415.8 9422.7 11318.0 11571.6 11604.0 11775.2 11793.7 11534.3 11629.3 11631.8 11633.9 11636.8 39379.6 39683.4 39793.2 39803.8 39831.6 2837.0 3346.1 3368.0 3613.7 3639.2 29648.7 30094.7 30447.8 30558.5 30841.4 3250.1 3259.7 3293.9 3301.0 3307.5 493659.0 495620.0 495642.0 496672.0 496869.0 33380.3 34130.7 34253.7 57201.0 57838.4 34796.0 34943.3 34963.8 34964.5 35010.0 14742.6 14918.6 14918.6 14924.6 14947.8 12588.2 12651.0 12676.5 12677.9 12710.9 7832.2 7865.4 7888.9 7933.1 8001.1 3167.7 3278.0 3307.0 3331.6 3409.2 924.1 960.0 969.3 1002.5 1020.5 28733.9 29362.9 29550.0 30220.8 30294.0 976.6 1045.3 1064.0 1144.9 1149.6 15013.6 15444.8 15476.3 15649.8 15919.2 663679.0 668593.0 670185.0 670335.0 675849.0 52477.0 56084.2 56875.0 57313.1 57435.7 1300.0 1311.9 1312.7 1313.3 1314.2 23796.3 30299.1 30474.5 30551.4 32085.8 51832.5 52439.0 52465.5 52469.0 52617.5 566776.0 571822.0 571848.0 573005.0 573322.0 22168.8 23493.3 24076.3 25413.6 26240.1 44897.6 45018.5 45225.9 45445.5 45510.8 32988.5 37514.1 40381.8 41273.8 41834.0 37376.6 37498.6 37920.1 39047.6 39062.2 37580.1 38072.0 38485.6 38561.8 38593.5 32000.0 34289.8 34353.0 34444.3 34541.5 24685.4 25173.7 25596.4 25648.7 25862.3 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:34431.35 Median:18714.02 stddev:95110.93 (508.2%) stddev-sans-first:95343.33 13:38:09 INFO - PROCESS | 1636 | Values: 358.2 388.3 394.3 402.9 419.6 20264.0 20359.7 21349.1 21655.5 21656.2 20456.2 21132.3 21147.4 21149.4 21500.6 5818.2 6069.0 6088.1 6090.2 6091.4 5077.3 5741.3 5988.1 6023.2 6046.0 5998.9 5999.2 6003.4 6005.0 6006.5 5703.2 5878.8 5947.4 5966.6 5978.6 5229.5 5236.9 5237.5 5241.5 5250.6 21740.1 23291.9 25516.2 26051.9 26234.0 2371.3 2396.9 2474.7 2528.9 3116.4 15277.8 15675.2 15882.0 16579.2 16597.9 1855.6 1949.7 1975.9 2008.0 2015.0 83077.0 106479.9 106787.5 115712.4 116409.4 9871.2 11282.1 11691.4 11801.6 11838.2 15170.2 15178.6 15214.5 15230.6 15261.5 8574.0 8808.2 8850.1 8852.9 8921.7 7375.2 8710.4 8841.8 8853.4 9021.7 4507.3 4629.8 4637.0 4670.3 4712.6 1683.7 1954.2 1965.3 1976.4 1982.3 698.9 944.7 950.5 981.7 1019.3 21397.9 22494.1 22595.3 22601.2 22800.9 946.7 951.0 967.9 976.6 994.3 10804.9 11592.2 11634.9 11657.5 11667.7 524005.0 526917.0 528891.0 603575.0 640688.0 137784.0 143058.0 143256.0 144556.0 148201.0 950.6 957.3 997.3 997.5 1018.8 19555.5 20012.0 20477.3 20526.2 20540.8 34311.7 46187.5 52235.4 55081.0 55958.0 78998.0 79287.6 80660.6 82443.0 84277.6 7828.6 8000.0 8128.6 8302.3 8371.3 9917.4 12606.6 12698.6 12700.2 12794.6 10690.3 11048.1 11241.3 11277.4 11409.8 5096.0 8126.0 10652.7 11401.5 11729.6 11503.8 11538.0 11633.8 11754.7 11806.5 8156.4 8246.3 8416.6 8539.0 8668.7 8931.4 11344.0 11413.4 11413.4 11750.2 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5443.37 Median:4932.76 stddev:2994.30 (60.7%) stddev-sans-first:2987.07 13:38:09 INFO - PROCESS | 1636 | Values: 1372.3 1507.3 1533.1 1733.8 1907.4 7458.7 7961.1 8231.0 8465.9 8500.8 8305.8 8396.7 8403.4 8437.0 8451.0 2364.9 2405.0 2405.8 2407.1 2408.8 1955.5 2408.0 2418.6 2420.9 2427.0 2322.9 2365.6 2400.2 2403.7 2409.3 2311.0 2339.3 2375.5 2376.2 2384.6 2346.6 2369.6 2393.7 2394.6 2394.9 8383.2 8411.5 8482.0 8485.3 8500.2 5110.5 5306.4 5308.9 5322.7 5334.9 3420.7 3531.9 3580.0 3594.8 3606.0 1064.8 1084.8 1087.6 1099.1 1117.5 10795.0 10808.1 10892.1 10904.3 10910.6 4314.6 4451.5 4535.6 4545.4 4549.2 8689.1 8692.3 8702.4 8710.2 8718.5 5143.4 5148.1 5155.7 5159.3 5162.1 3844.0 4390.8 4511.7 4798.1 4859.4 3522.3 3866.5 3901.3 3996.5 4037.1 1290.3 1317.8 1325.6 1332.2 1334.6 836.2 885.4 896.1 915.0 936.2 4756.6 5546.6 5601.7 5616.8 5831.8 451.8 469.0 471.8 478.7 779.5 3665.8 3683.8 3705.7 3842.8 3851.0 9962.8 10304.9 10308.6 10314.7 10314.9 10129.2 10272.9 10277.0 10297.3 10306.7 7750.1 7837.2 7843.9 7995.8 7998.0 5413.9 5485.6 5540.6 5550.5 5744.1 9291.7 9322.3 9365.2 9372.8 9492.1 9390.2 9522.2 9550.3 9567.7 9619.8 6301.6 6482.8 6683.8 6709.1 6840.4 7930.2 8120.0 8127.3 8130.9 8142.3 7113.9 7249.1 7255.9 7271.5 7355.3 7030.9 7043.3 7074.1 7185.9 7186.9 6727.2 6732.4 6806.8 6820.0 6823.2 4101.3 4129.8 4715.4 4785.3 4871.7 4835.7 4892.9 4972.6 4978.1 4989.1 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4415.90 Median:4900.26 stddev:1366.37 (27.9%) stddev-sans-first:1335.02 13:38:09 INFO - PROCESS | 1636 | Values: 311.2 315.7 321.2 323.4 323.6 5198.2 5209.8 5217.0 5222.2 5230.6 4470.7 5051.1 5057.1 5135.7 5168.5 3973.3 3981.5 4016.0 4031.6 4035.3 3309.7 3327.3 3666.3 3967.2 4002.7 3325.2 3705.3 3965.3 3976.3 3996.9 3733.6 3890.6 3982.9 3993.5 4020.6 2877.3 3396.6 3455.0 3471.8 3484.5 4287.4 5024.2 5117.2 5121.0 5165.0 4393.7 4468.8 4486.6 4584.6 4585.5 4905.6 4985.6 5494.5 5497.3 5498.8 2966.6 3603.8 3796.5 3803.5 3819.0 5567.4 5709.8 5726.9 5747.0 5771.6 3849.8 3858.0 3863.2 3877.9 3881.2 3917.6 3930.3 3940.7 3944.6 3953.5 4069.3 4136.8 4200.4 4394.3 4584.5 4828.6 5539.3 5558.1 5572.7 5615.6 1246.7 1263.7 1265.5 1278.5 1286.5 683.3 796.9 801.9 863.4 866.9 4366.4 4528.4 4826.0 4858.8 4894.9 4778.6 5314.4 5339.6 5422.5 5450.0 4302.1 4543.2 4646.9 4817.4 4825.4 2614.9 2695.6 2754.8 2772.9 2792.7 5456.6 5463.8 5491.6 5493.6 5504.6 4250.7 5307.8 5424.7 5761.1 5815.3 5817.9 5825.9 5832.4 5868.4 5878.7 4256.3 5352.5 5667.5 5694.9 5699.7 4989.4 5375.9 5734.3 5741.2 5748.9 4963.0 5220.6 5904.0 5967.9 6021.0 3638.8 3865.2 3868.6 3909.8 3913.4 5091.3 5477.4 5693.5 5720.9 5748.7 4709.9 4821.8 5519.1 5531.6 5540.6 5182.7 5240.8 5474.6 5531.3 5551.0 4916.0 5133.9 5402.4 5449.5 5450.8 4876.9 5146.4 5427.6 5574.9 5579.9 4832.4 4857.1 4966.6 5473.6 5527.5 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:18900.44 Median:4560.46 stddev:26099.06 (572.3%) stddev-sans-first:26136.52 13:38:09 INFO - PROCESS | 1636 | Values: 705.2 740.3 773.7 822.6 834.7 14417.9 15456.5 15503.0 15522.3 15548.9 14013.3 14111.8 14127.9 14136.2 14142.4 719.3 743.6 863.5 883.7 892.2 893.7 902.6 904.3 907.8 909.9 942.0 944.3 944.6 946.7 947.1 881.6 935.5 938.0 939.4 947.5 697.7 701.4 704.9 705.7 707.3 14416.6 14550.3 14563.3 14564.1 15201.2 13810.9 14213.1 14267.8 14292.2 14529.6 11223.0 11563.8 11689.9 11736.5 11754.7 3453.4 3722.3 3752.8 3756.9 3760.1 89004.0 91716.6 92809.6 94176.5 97605.9 10260.7 10522.2 10561.8 10674.9 10754.6 21861.0 22178.8 22286.8 22532.2 22571.8 7619.8 7755.7 7858.2 7885.4 8050.8 4336.5 4367.5 4437.4 4479.2 4526.8 3496.5 3601.6 3606.4 3613.8 3627.1 548.6 559.4 637.6 643.6 647.4 590.7 645.0 687.1 695.7 705.1 8856.3 9197.9 9211.0 9316.5 9570.7 652.8 682.7 685.2 688.9 695.6 4107.8 4436.5 4497.6 4557.3 4563.6 50652.5 62038.0 64565.4 71215.7 107512.0 62574.0 89268.6 91997.5 94052.0 98460.0 58233.0 59990.0 60217.7 73564.6 75246.0 9375.8 9924.5 9931.0 9985.9 10021.6 47022.0 50802.0 51096.0 53303.5 53722.6 70745.3 72569.3 73187.6 73652.6 77982.0 10927.5 12473.8 12577.9 12591.2 12935.4 11937.4 12506.1 13897.8 14216.7 14330.7 11315.6 11797.9 11954.3 12085.4 12514.1 11848.7 12116.3 12431.9 13429.0 13432.3 11421.7 12620.8 12958.5 13089.7 13423.7 10947.8 10961.9 11351.8 11518.3 11667.0 11320.4 11494.3 11532.4 11622.7 11875.2 13:38:09 INFO - PROCESS | 1636 | -------- Summary: end -------- 13:38:09 INFO - PROCESS | 1636 | 13:38:09 INFO - TEST-INFO | 1636: exit 0 13:38:09 INFO - TEST-OK | dromaeo_css | took 1116576ms 13:38:09 INFO - TEST-START | kraken 13:38:09 INFO - operating with platform_type : mac_ 13:38:09 INFO - Initialising browser for kraken test... 13:38:09 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp_PRk91/profile http://localhost:49241/getInfo.html) 13:38:12 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 13:38:12 INFO - PROCESS | 1646 | colorDepth:24 13:38:12 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 13:38:12 INFO - PROCESS | 1646 | __metrics 13:38:12 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:38:12 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:38:13 INFO - TEST-INFO | 1646: exit 0 13:38:13 INFO - Browser initialized. 13:38:13 INFO - Running cycle 1/1 for kraken test... 13:38:13 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp_PRk91/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:25 INFO - PROCESS | 1648 | RSS: Main: 167829504 13:38:25 INFO - PROCESS | 1648 | 13:38:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:28 INFO - PROCESS | 1648 | RSS: Main: 217395200 13:38:28 INFO - PROCESS | 1648 | 13:38:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 13:38:31 INFO - PROCESS | 1648 | RSS: Main: 230932480 13:38:31 INFO - PROCESS | 1648 | 13:38:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 13:38:35 INFO - PROCESS | 1648 | RSS: Main: 328081408 13:38:35 INFO - PROCESS | 1648 | 13:38:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 13:38:38 INFO - PROCESS | 1648 | RSS: Main: 231288832 13:38:38 INFO - PROCESS | 1648 | 13:38:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:38:40 INFO - PROCESS | 1648 | RSS: Main: 233451520 13:38:40 INFO - PROCESS | 1648 | 13:38:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 13:38:44 INFO - PROCESS | 1648 | RSS: Main: 273412096 13:38:44 INFO - PROCESS | 1648 | 13:38:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 13:38:47 INFO - PROCESS | 1648 | RSS: Main: 272568320 13:38:47 INFO - PROCESS | 1648 | 13:38:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 13:38:51 INFO - PROCESS | 1648 | RSS: Main: 270397440 13:38:51 INFO - PROCESS | 1648 | 13:38:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:38:53 INFO - PROCESS | 1648 | RSS: Main: 247787520 13:38:53 INFO - PROCESS | 1648 | 13:38:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:38:55 INFO - PROCESS | 1648 | RSS: Main: 247988224 13:38:55 INFO - PROCESS | 1648 | 13:38:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:38:58 INFO - PROCESS | 1648 | RSS: Main: 258850816 13:38:58 INFO - PROCESS | 1648 | 13:39:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:39:01 INFO - PROCESS | 1648 | RSS: Main: 272240640 13:39:01 INFO - PROCESS | 1648 | 13:39:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:39:05 INFO - PROCESS | 1648 | RSS: Main: 266207232 13:39:05 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 13:39:07 INFO - PROCESS | 1648 | RSS: Main: 310263808 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | __start_tp_report 13:39:07 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 13:39:07 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 13:39:07 INFO - PROCESS | 1648 | |i|pagename|runs| 13:39:07 INFO - PROCESS | 1648 | |0;ai-astar;104;114;114;113;113;116;114;113;114;113 13:39:07 INFO - PROCESS | 1648 | |1;audio-beat-detection;141;109;97;162;139;138;112;108;138;105 13:39:07 INFO - PROCESS | 1648 | |2;audio-dft;184;184;186;183;184;185;184;194;261;207 13:39:07 INFO - PROCESS | 1648 | |3;audio-fft;82;58;58;87;59;57;58;57;79;57 13:39:07 INFO - PROCESS | 1648 | |4;audio-oscillator;85;70;93;70;68;68;88;68;69;91 13:39:07 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;86;83;86;83;87;91;135;82;85;83 13:39:07 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;94;95;93;113;160;94;94;94;92 13:39:07 INFO - PROCESS | 1648 | |7;imaging-desaturate;83;88;121;80;82;84;85;83;81;84 13:39:07 INFO - PROCESS | 1648 | |8;json-parse-financial;55;52;53;52;59;56;58;57;55;57 13:39:07 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;63;69;72;78;70;68;68;69;68;69 13:39:07 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;85;80;84;85;84;81;80;82;82;88 13:39:07 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;140;136;137;134;136;133;136;143;196;149 13:39:07 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;160;216;221;160;160;164;218;193;160;158 13:39:07 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;65;64;66;66;66;66;66;63;66;64 13:39:07 INFO - PROCESS | 1648 | __end_tp_report 13:39:07 INFO - PROCESS | 1648 | __start_cc_report 13:39:07 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1809 13:39:07 INFO - PROCESS | 1648 | __end_cc_report 13:39:07 INFO - PROCESS | 1648 | __startTimestamp1485898747519__endTimestamp 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | ------- Summary: start ------- 13:39:07 INFO - PROCESS | 1648 | Number of tests: 14 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.22 (2.8%) stddev-sans-first:0.97 13:39:07 INFO - PROCESS | 1648 | Values: 104.0 114.0 114.0 113.0 113.0 116.0 114.0 113.0 114.0 113.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:124.90 Median:138.50 stddev:21.23 (15.3%) stddev-sans-first:21.71 13:39:07 INFO - PROCESS | 1648 | Values: 141.0 109.0 97.0 162.0 139.0 138.0 112.0 108.0 138.0 105.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:195.20 Median:185.50 stddev:24.29 (13.1%) stddev-sans-first:25.42 13:39:07 INFO - PROCESS | 1648 | Values: 184.0 184.0 186.0 183.0 184.0 185.0 184.0 194.0 261.0 207.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:65.20 Median:58.50 stddev:12.22 (20.9%) stddev-sans-first:11.35 13:39:07 INFO - PROCESS | 1648 | Values: 82.0 58.0 58.0 87.0 59.0 57.0 58.0 57.0 79.0 57.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.50 stddev:10.76 (13.9%) stddev-sans-first:11.02 13:39:07 INFO - PROCESS | 1648 | Values: 85.0 70.0 93.0 70.0 68.0 68.0 88.0 68.0 69.0 91.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:85.50 stddev:16.00 (18.7%) stddev-sans-first:16.90 13:39:07 INFO - PROCESS | 1648 | Values: 86.0 83.0 86.0 83.0 87.0 91.0 135.0 82.0 85.0 83.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:94.00 stddev:21.22 (22.6%) stddev-sans-first:22.24 13:39:07 INFO - PROCESS | 1648 | Values: 93.0 94.0 95.0 93.0 113.0 160.0 94.0 94.0 94.0 92.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:83.50 stddev:12.11 (14.5%) stddev-sans-first:12.76 13:39:07 INFO - PROCESS | 1648 | Values: 83.0 88.0 121.0 80.0 82.0 84.0 85.0 83.0 81.0 84.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.50 stddev:2.46 (4.4%) stddev-sans-first:2.60 13:39:07 INFO - PROCESS | 1648 | Values: 55.0 52.0 53.0 52.0 59.0 56.0 58.0 57.0 55.0 57.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:3.78 (5.5%) stddev-sans-first:3.22 13:39:07 INFO - PROCESS | 1648 | Values: 63.0 69.0 72.0 78.0 70.0 68.0 68.0 69.0 68.0 69.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.00 stddev:2.56 (3.0%) stddev-sans-first:2.62 13:39:07 INFO - PROCESS | 1648 | Values: 85.0 80.0 84.0 85.0 84.0 81.0 80.0 82.0 82.0 88.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:138.50 stddev:18.88 (13.6%) stddev-sans-first:19.97 13:39:07 INFO - PROCESS | 1648 | Values: 140.0 136.0 137.0 134.0 136.0 133.0 136.0 143.0 196.0 149.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:178.50 stddev:27.73 (15.5%) stddev-sans-first:28.35 13:39:07 INFO - PROCESS | 1648 | Values: 160.0 216.0 221.0 160.0 160.0 164.0 218.0 193.0 160.0 158.0 13:39:07 INFO - PROCESS | 1648 | 13:39:07 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 13:39:07 INFO - PROCESS | 1648 | Values: 65.0 64.0 66.0 66.0 66.0 66.0 66.0 63.0 66.0 64.0 13:39:07 INFO - PROCESS | 1648 | -------- Summary: end -------- 13:39:07 INFO - PROCESS | 1648 | 13:39:08 INFO - TEST-INFO | 1648: exit 0 13:39:08 INFO - TEST-OK | kraken | took 58787ms 13:39:08 INFO - SUITE-END | took 1175s 13:39:08 INFO - Completed test suite (00:19:35) 13:39:08 INFO - javascript benchmark 13:39:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3379.9831000844993, 3397.116749645092, 3399.7450191235657, 3406.31873625275, 3449.379111759884, 5712.1431785232235, 5721.199032135504, 5753.626014309067, 5757.42425757424, 5766.990776614086, 5728.79949201777, 5822.737976791044, 5844.473997340238, 5858.648481091138, 5871.324797648272, 5179.326687530615, 5213.139831927728, 5217.37391513019, 5280.815171468999, 5298.311219541454, 5176.55999240065, 5190.403103643072, 5204.42751297357, 5321.494458026481, 5323.068463018975, 5280.128778751501, 5281.155015197569, 5292.444293349201, 5298.735063246822, 5311.468853114677, 5049.2678561608545, 5200.6619569727845, 5275.129603615399, 5275.287836142129, 5285.973570132163, 5140.203268493389, 5181.5854731621375, 5183.740812959337, 5194.68831870089, 5271.762770675329, 5843.5325173985975, 5872.17789509469, 5910.97044514779, 5915.231019967377, 5929.792457263975, 6055.212822333068, 6139.693015349215, 6176.135341052256, 6203.131561581382, 6254.8123556293385, 6207.658578778165, 6241.375862413768, 6253.968095264276, 6278.466330361879, 6292.748290068392, 5806.187133801272, 5822.621529600647, 5825.0679891217205, 5842.59101862874, 5879.882402352015, 6176.042713379434, 6200.3179650238435, 6236.314005459396, 6250.312465628777, 6255.030470277115, 6104.572679912363, 6108.755649774048, 6110.877782444415, 6115.143879856823, 6124.479419249325, 6190.604670683775, 6234.0, 6253.78111766086, 6263.060540918807, 6274.529410294155, 6049.153118563405, 6077.513798896078, 6135.754569817246, 6141.140240366352, 6167.784127555514, 6165.414285642857, 6235.345288744707, 6253.6873156342, 6256.562040657111, 6263.217097862767, 4955.554000140005, 4955.752212389366, 4959.925601115986, 4972.403311602631, 4988.4263309719845, 4401.6698747594055, 4436.844710435119, 4493.618042466427, 4494.5730155635165, 4497.280435130363, 4837.782299796518, 5659.094544872801, 5743.741531631086, 5747.568932330092, 5821.650700957956, 6240.7503699852405, 6247.344028876993, 6255.624662520263, 6258.123862659231, 6274.937250627527, 5658.886822263532, 5821.243238378984, 5824.825255242349, 5844.795432159854, 5865.384134665884, 5391.514763671288, 5393.298871146726, 5446.291982042389, 5447.182922561568, 5487.012337779238, 6282.874342513032, 6315.084312774714, 6333.145025421509, 6361.90457143134, 6366.681665916778, 6197.0, 6270.184875966095, 6282.560220784501, 6287.528435367274, 6312.936870631235, 4877.414710234794, 6186.350433204629, 6248.906266406098, 6298.338674439118, 6306.779262725966, 6262.15460912771, 6264.21697287839, 6269.905951410824, 6274.592151510137, 6278.529110316653, 6265.624062556261, 6280.497560195265, 6300.369963003663, 6305.590136641287, 6309.1167236587835, 5377.408485066561, 5908.350081490947, 6085.208922840003, 6101.328853826164, 6122.571420000557, 6110.602810817282, 6135.386461353829, 6139.508839292936, 6154.046122850787, 6158.291796443466, 5927.585069045298, 6006.849828754316, 6011.849703757441, 6018.8796224074395, 6049.304330002106, 5917.763289468545, 5996.280446346466, 6077.20996270482, 6145.508359331154, 6159.84600384994, 5943.494802941798, 6012.849678758066, 6021.036634138517, 6038.577299589162, 6056.485198758155], "value": 5718.341556155664, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.78108679464054, 473.98104075836966, 534.2663058375571, 556.4074260912129, 559.8600349912522, 31047.844760776192, 32865.0, 32873.34253314932, 32922.68309267626, 32975.83512082442, 33252.0, 33971.660283397156, 33982.150446238855, 34145.65854341456, 41526.37710434338, 9109.453432794036, 9440.339176257665, 9487.0, 9495.050494950485, 9497.145256926875, 9263.536823158849, 9373.906260937372, 9375.81248375032, 9388.812223755522, 9395.76510587234, 8831.0, 9044.638214471446, 9357.0, 9415.764605884873, 9422.717318480456, 11318.0, 11571.594994175164, 11604.013658839009, 11775.175737698364, 11793.705157371049, 11534.250273732265, 11629.302241865515, 11631.825522617168, 11633.94183029088, 11636.825447618208, 39379.60620393788, 39683.40474892879, 39793.20413591741, 39803.8009809952, 39831.60168398337, 2836.964507954602, 3346.0798280472823, 3368.0, 3613.6928361089076, 3639.2175682228185, 29648.70351296481, 30094.699053009408, 30447.847760761277, 30558.54162187569, 30841.383172336653, 3250.138713240993, 3259.722923551501, 3293.8682452701864, 3301.042697617712, 3307.5038744188323, 493659.0, 495620.0, 495642.0, 496672.0, 496869.0, 33380.332393352, 34130.65869341324, 34253.657463425545, 57201.0, 57838.42161578331, 34795.9561213164, 34943.301133977686, 34963.82518087393, 34964.47553286703, 35010.0, 14742.557723268319, 14918.552443426715, 14918.627034324229, 14924.552263432115, 14947.775783363259, 12588.181768185039, 12651.0, 12676.492940282285, 12677.873221267853, 12710.936445317715, 7832.177621349791, 7865.410094242955, 7888.921110788933, 7933.087694915043, 8001.1198768135455, 3167.683231676814, 3278.0, 3307.0, 3331.6002079750583, 3409.1988382730037, 924.1128516623982, 959.9584450870743, 969.3311614985778, 1002.5488530161457, 1020.4591566469783, 28733.85633071863, 29362.853185733933, 29550.0, 30220.84889575538, 30294.0, 976.6142373762466, 1045.325764881647, 1064.0211005874614, 1144.9427528623535, 1149.6493569461227, 15013.624659383384, 15444.845551544566, 15476.303566339317, 15649.78386347154, 15919.204039797964, 663679.0, 668593.0, 670185.0, 670335.0, 675849.0, 52477.0, 56084.15873761897, 56875.0, 57313.14030289549, 57435.71282143563, 1300.0, 1311.895048396126, 1312.7308901675324, 1313.2973858985397, 1314.17207159487, 23796.286111416684, 30299.091027269216, 30474.542881857233, 30551.388972219986, 32085.839570801996, 51832.48167518277, 52438.95122097613, 52465.475345247585, 52469.0, 52617.47382526126, 566776.0, 571822.0, 571848.0, 573005.0, 573322.0, 22168.778312216673, 23493.295201143992, 24076.277711668678, 25413.61879571771, 26240.08159714401, 44897.55102448934, 45018.549814502745, 45225.869353265116, 45445.54554454413, 45510.772446137555, 32988.50517242195, 37514.07720509836, 40381.798091009354, 41273.79363103165, 41834.0, 37376.62623373731, 37498.625013749515, 37920.051998700255, 39047.63333283321, 39062.2187556253, 37580.06049848776, 38072.0, 38485.615143849325, 38561.8431447057, 38593.45626174921, 32000.0, 34289.828550857084, 34353.0, 34444.31111377708, 34541.48187777135, 24685.38286542779, 25173.74826251714, 25596.360090997874, 25648.717564122093, 25862.316650897334], "value": 18427.34547450973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.1601145314238, 388.33206884159256, 394.34571970583414, 402.8851777243485, 419.57413225576045, 20264.0, 20359.69460458094, 21349.146034158613, 21655.45861353467, 21656.2420315289, 20456.181752729874, 21132.260370887023, 21147.365579032616, 21149.365519034414, 21500.56998860022, 5818.214541036969, 6069.0, 6088.056351265539, 6090.23872015998, 6091.42131497507, 5077.33994580704, 5741.339745929209, 5988.101784732303, 6023.156758053876, 6046.0, 5998.8800223995495, 5999.160117583542, 6003.369646187153, 6005.0, 6006.519478441736, 5703.201551782754, 5878.794242201502, 5947.37552556984, 5966.552508561854, 5978.641281523122, 5229.50319719626, 5236.8690782730355, 5237.502437268454, 5241.50205730455, 5250.606204534675, 21740.130394784188, 23291.88354058236, 25516.234512964642, 26051.869740651175, 26234.0, 2371.324172610815, 2396.892139853711, 2474.6782918220697, 2528.8609126498036, 3116.3923035008183, 15277.847221527754, 15675.216239187996, 15882.0, 16579.17104144788, 16597.917010414993, 1855.6010457751513, 1949.7376689516143, 1975.93299618206, 2008.0, 2014.979850201494, 83077.0, 106479.93520064777, 106787.46606266996, 115712.42143789228, 116409.41795290969, 9871.160951319074, 11282.097432205404, 11691.356975366267, 11801.586944456903, 11838.171328006956, 15170.24148792578, 15178.620534486505, 15214.467493637669, 15230.619234519005, 15261.542153735405, 8574.0, 8808.163224493663, 8850.070742572067, 8852.911470885338, 8921.732348029569, 7375.225601311785, 8710.428724223038, 8841.823163536694, 8853.380263381501, 9021.729348119567, 4507.301368287921, 4629.814807407666, 4637.0, 4670.346151538787, 4712.59942904857, 1683.7137686593308, 1954.2378472395776, 1965.3416105604497, 1976.4268362175096, 1982.2665613723016, 698.9440844732511, 944.7118628818139, 950.5057370167474, 981.7054883534911, 1019.2559431614815, 21397.893010535157, 22494.100235990376, 22595.322140335815, 22601.208957686402, 22800.885995569915, 946.7301818981557, 950.9809803804023, 967.874176357069, 976.6044751875502, 994.2543092680489, 10804.945975270231, 11592.246503977214, 11634.94182529082, 11657.475413606408, 11667.708307292385, 524005.0, 526917.0, 528891.0, 603575.0, 640688.0, 137784.0, 143058.0, 143256.0, 144556.0, 148201.0, 950.6340059077305, 957.2772556719772, 997.3467378866853, 997.5211898288862, 1018.8471729240673, 19555.51111222231, 20012.0, 20477.283295084602, 20526.178952842318, 20540.794592054484, 34311.65688343085, 46187.538124618324, 52235.43293701195, 55081.0, 55958.0, 78998.0, 79287.60356198413, 80660.59669701614, 82443.0, 84277.57861210655, 7828.5694286812495, 8000.03999520038, 8128.634211460617, 8302.294304984143, 8371.288440482627, 9917.355371900803, 12606.55877044299, 12698.555550555686, 12700.174488658207, 12794.552190673281, 10690.305130166515, 11048.116150707763, 11241.325520468798, 11277.379744114152, 11409.771804563696, 5096.031753966883, 8125.959370203112, 10652.733681658021, 11401.543938242377, 11729.648110556696, 11503.827442588201, 11538.0, 11633.825492617787, 11754.659464397462, 11806.46870890829, 8156.429049966683, 8246.257836794717, 8416.621252043795, 8539.0, 8668.739937801876, 8931.419457735226, 11344.0, 11413.372264525531, 11413.429328533706, 11750.23623464472], "value": 9774.578802522467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.3275594958473, 1507.3141720517165, 1533.1414407931557, 1733.835285647863, 1907.4277716684992, 7458.701651933923, 7961.124276329607, 8230.95884520578, 8465.873011904827, 8500.829983400328, 8305.83388332233, 8396.706115285966, 8403.41176117672, 8437.0, 8451.02813176485, 2364.869932153735, 2405.037984806083, 2405.783479486846, 2407.07327678844, 2408.7832095111435, 1955.5208973801439, 2407.9759202407927, 2418.5525677749583, 2420.9152679656218, 2426.987865060681, 2322.918697845576, 2365.6451532270125, 2400.2079313826484, 2403.6514705367713, 2409.2531315292317, 2310.9884450577806, 2339.298210536849, 2375.524895020994, 2376.2158487699016, 2384.6423036544484, 2346.577616029114, 2369.620860662303, 2393.6888204533298, 2394.568977584034, 2394.916177933764, 8383.16168383163, 8411.45325553837, 8482.024567174793, 8485.278751306147, 8500.234978851933, 5110.5400513953555, 5306.442823503554, 5308.946910530923, 5322.733863306819, 5334.893302133974, 3420.709239714627, 3531.94702079469, 3579.982100089509, 3594.8382322795537, 3606.0263728793343, 1064.834950582661, 1084.8101582223157, 1087.6030248959153, 1099.115212254135, 1117.4692021289823, 10795.0, 10808.081313088396, 10892.074173695246, 10904.291221070684, 10910.563577456893, 4314.633256173198, 4451.465824101064, 4535.591796738244, 4545.431821022372, 4549.226631472658, 8689.131086891386, 8692.261157801659, 8702.434341767765, 8710.21608055278, 8718.47689138641, 5143.3570803649545, 5148.124818780816, 5155.716435596079, 5159.329287192641, 5162.1224391853475, 3843.9615603844163, 4390.846320378771, 4511.729296242236, 4798.088363210979, 4859.392575928009, 3522.330757156132, 3866.478025466582, 3901.3367727486398, 3996.4604778355133, 4037.1320166164414, 1290.316132449803, 1317.8418589769096, 1325.5691900132495, 1332.2015279372963, 1334.6196334044944, 836.2097817562467, 885.3802338363172, 896.1038961038961, 914.9588268527932, 936.166811537732, 4756.5956893664425, 5546.639468434539, 5601.691906945076, 5616.803411880646, 5831.79588714393, 451.77185521312185, 469.03847113417356, 471.83957454465644, 478.6673262082819, 779.5283853268804, 3665.7983810890655, 3683.778973261613, 3705.7220708446976, 3842.769433833979, 3850.998740327479, 9962.800743985079, 10304.896951030543, 10308.639197628047, 10314.742131446774, 10314.948425257826, 10129.189664826796, 10272.948635256776, 10277.0, 10297.330673506198, 10306.742331441774, 7750.108737495148, 7837.216278372117, 7843.921560784319, 7995.840083198304, 7997.960010199912, 5413.945860541344, 5485.561155107502, 5540.612157148961, 5550.52820510245, 5744.109663002241, 9291.67479138227, 9322.347435679438, 9365.203957663674, 9372.765680858032, 9492.145706886413, 9390.154886060287, 9522.190613797904, 9550.283728720513, 9567.665131720356, 9619.807603848023, 6301.6219026858535, 6482.837929051811, 6683.832904177434, 6709.127813384229, 6840.41856442208, 7930.167332430243, 8119.959400202961, 8127.3091787198755, 8130.87803682957, 8142.307903828241, 7113.893291600527, 7249.093863267091, 7255.927440725525, 7271.527350722186, 7355.264473552602, 7030.859382812418, 7043.330883566053, 7074.080369551925, 7185.892211616725, 7186.928130718626, 6727.159105111861, 6732.394084532416, 6806.76176333826, 6820.0, 6823.1812182538415, 4101.343784994387, 4129.772862492592, 4715.3869996900185, 4785.282207668877, 4871.707697538159, 4835.709857408567, 4892.90214195707, 4972.627052971114, 4978.054169707744, 4989.101961646793], "value": 4373.381957638851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.16297160637896, 315.73478278246273, 321.2482790270766, 323.4307618591279, 323.6326769117051, 5198.220266959953, 5209.843704688856, 5217.03484855302, 5222.242774797652, 5230.581553475722, 4470.664700147486, 5051.0553436926775, 5057.078310242112, 5135.743212839362, 5168.457311982244, 3973.3046716824583, 3981.5222173339166, 4015.9799201003952, 4031.6371526562602, 4035.2534781065597, 3309.6855798699085, 3327.317899830529, 3666.3400587894166, 3967.1750994542545, 4002.6997975151835, 3325.1687078230443, 3705.3145168143847, 3965.325894597925, 3976.2842688316236, 3996.900077498057, 3733.5893051764283, 3890.5878355419536, 3982.9203415931665, 3993.5407428145554, 4020.618041286073, 2877.2662970942274, 3396.558447401822, 3454.9827250863837, 3471.7916924984584, 3484.4773284007347, 4287.399764033038, 5024.221245706921, 5117.1556693145585, 5120.977214000486, 5165.0, 4393.7363758174615, 4468.815763822589, 4486.55134486552, 4584.593088628463, 4585.541445855421, 4905.626424601118, 4985.576226020793, 5494.5054945054735, 5497.257870187554, 5498.835034948918, 2966.6291713535807, 3603.765755225902, 3796.54441467023, 3803.5245594300713, 3819.0, 5567.415421380737, 5709.77160913563, 5726.883257764737, 5747.0, 5771.624844385102, 3849.7690138591774, 3858.0354911272184, 3863.2273545291055, 3877.903052423712, 3881.243157584244, 3917.6474117329576, 3930.3121953657997, 3940.7438516496336, 3944.6252606002386, 3953.5058117735284, 4069.2878746219885, 4136.793160341971, 4200.432941552913, 4394.274944634163, 4584.472785629629, 4828.551434569615, 5539.25220095282, 5558.110242517563, 5572.693501857437, 5615.578831587647, 1246.6660673079718, 1263.6714454241962, 1265.4558539827963, 1278.4502663854446, 1286.5497076023316, 683.3474032299142, 796.8884356190138, 801.8997625296838, 863.3869952333788, 866.9089745576624, 4366.388705581221, 4528.388667529907, 4825.975870120697, 4858.82994095205, 4894.902101957941, 4778.5699287063635, 5314.415414304423, 5339.626226164131, 5422.457754224546, 5449.99175152598, 4302.139572085595, 4543.183226399653, 4646.907061858744, 4817.445993710769, 4825.420949486014, 2614.8692565371657, 2695.595660650918, 2754.820936639112, 2772.8613569321856, 2792.7067657896037, 5456.563474921997, 5463.754131064112, 5491.560675146058, 5493.560515158778, 5504.614676972574, 4250.681198910094, 5307.761150748225, 5424.7016414096815, 5761.070041536049, 5815.302163740378, 5817.941820581825, 5825.912611310834, 5832.416758324133, 5868.354481007086, 5878.676672783038, 4256.25515534774, 5352.545033672026, 5667.546596272371, 5694.886102278014, 5699.658020518782, 4989.426215985063, 5375.946240537544, 5734.254546908875, 5741.182113894213, 5748.872917020729, 4962.975185124052, 5220.634555581073, 5904.0, 5967.850803729768, 6020.969895150672, 3638.836252368703, 3865.2269546091457, 3868.5937976513187, 3909.804509774443, 3913.373860182357, 5091.312672789274, 5477.397486276586, 5693.5160511357, 5720.856978575569, 5748.6838223898085, 4709.940263440699, 4821.783019764049, 5519.061759500814, 5531.612787105025, 5540.63985840919, 5182.740862956913, 5240.816571419982, 5474.644148130359, 5531.308586426697, 5550.976366388425, 4916.0, 5133.922991155061, 5402.405735369028, 5449.482299181572, 5450.836474905759, 4876.878078048077, 5146.4338922717725, 5427.592930530305, 5574.888502230014, 5579.8884022320135, 4832.395950506187, 4857.101436234308, 4966.577840883565, 5473.562115030868, 5527.50252477279], "value": 3980.62689838988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.2031204738648, 740.3115102954253, 773.6711897443585, 822.5887056471762, 834.6520369603093, 14417.855821441783, 15456.459023934165, 15503.0, 15522.30149643266, 15548.922255388721, 14013.299335033258, 14111.788323175135, 14127.858721412782, 14136.22250776207, 14142.363593638285, 719.2914978745931, 743.6207534157564, 863.4646519158131, 883.703959173676, 892.2282225874604, 893.7095443980733, 902.5622573052065, 904.3082042237694, 907.8093600343935, 909.8771665825128, 942.0391200975001, 944.3153713557684, 944.5607792376544, 946.6686659669095, 947.1286416496805, 881.6209030117047, 935.4574346878794, 938.0478814003792, 939.4410325856105, 947.4836214263244, 697.6616341074575, 701.3687681087063, 704.8766465868453, 705.696550483292, 707.2821086597108, 14416.567502974927, 14550.345234464474, 14563.344649490693, 14564.126152430888, 15201.239938003055, 13810.93094534531, 14213.147211167363, 14267.78598321026, 14292.213928233943, 14529.636759081002, 11223.0, 11563.826542601868, 11689.883101168965, 11736.53053877844, 11754.706132346675, 3453.4474484082425, 3722.274156539476, 3752.831122599462, 3756.868509602151, 3760.0599850037493, 89004.0, 91716.62425063629, 92809.60785588222, 94176.52911735466, 97605.93368586186, 10260.692179234635, 10522.210834187466, 10561.841572376421, 10674.89325106739, 10754.569817207224, 21861.0, 22178.778212217992, 22286.774227417325, 22532.21137260188, 22571.774282256967, 7619.809504762426, 7755.650995705207, 7858.2141785822105, 7885.408594355446, 8050.758477245692, 4336.479622445327, 4367.475902891673, 4437.378766972626, 4479.17135329965, 4526.79629416677, 3496.493008513751, 3601.603823579404, 3606.441001644749, 3613.837377318027, 3627.056965189017, 548.5611510791351, 559.3986464550625, 637.6333608175318, 643.6290700807344, 647.4270270810273, 590.6603702870866, 644.9742010319535, 687.1273482676972, 695.7112798188796, 705.0833915909298, 8856.335774816785, 9197.862032069525, 9211.032841551674, 9316.48759318244, 9570.712878613653, 652.7552167937024, 682.6996121706533, 685.2188505104185, 688.8932215506604, 695.58265040975, 4107.774072425986, 4436.534163912807, 4497.572730590654, 4557.339185818038, 4563.589276965089, 50652.49347506478, 62038.0, 64565.35434645593, 71215.72705637678, 107512.0, 62574.0, 89268.5536572326, 91997.54001230084, 94052.0, 98460.0, 58233.0, 59990.0, 60217.69891150516, 73564.63217683877, 75246.0, 9375.812483750424, 9924.503774811086, 9931.0, 9985.850212246967, 10021.599136034478, 47022.0, 50802.0, 51096.0, 53303.46696532985, 53722.57248433731, 70745.29254707387, 72569.27430725624, 73187.63406182935, 73652.63173684098, 77982.0, 10927.45362731876, 12473.812892806796, 12577.93711031439, 12591.181573198079, 12935.353232338533, 11937.403129843648, 12506.124571279923, 13897.791533127214, 14216.71566568642, 14330.713385732019, 11315.603953861575, 11797.941010294893, 11954.282743035446, 12085.39573021363, 12514.061445391813, 11848.70378240551, 12116.333601651993, 12431.875681243071, 13429.0, 13432.261225632294, 11421.743608203256, 12620.810687839874, 12958.481660733842, 13089.738205235652, 13423.731525369632, 10947.83578246311, 10961.890381096087, 11351.772964540829, 11518.308901465938, 11667.0, 11320.433978301216, 11494.310341379543, 11532.365719885487, 11622.6513204604, 11875.228110172811], "value": 7318.196424327423, "unit": "score"}], "name": "dromaeo_css", "value": 7128.667133651414, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 113.0, 116.0, 114.0, 113.0, 114.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 97.0, 162.0, 139.0, 138.0, 112.0, 108.0, 138.0, 105.0], "value": 124.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 183.0, 184.0, 185.0, 184.0, 194.0, 261.0, 207.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 87.0, 59.0, 57.0, 58.0, 57.0, 79.0, 57.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 93.0, 70.0, 68.0, 68.0, 88.0, 68.0, 69.0, 91.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 87.0, 91.0, 135.0, 82.0, 85.0, 83.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 93.0, 113.0, 160.0, 94.0, 94.0, 94.0, 92.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 121.0, 80.0, 82.0, 84.0, 85.0, 83.0, 81.0, 84.0], "value": 87.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 52.0, 59.0, 56.0, 58.0, 57.0, 55.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 72.0, 78.0, 70.0, 68.0, 68.0, 69.0, 68.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 84.0, 85.0, 84.0, 81.0, 80.0, 82.0, 82.0, 88.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 137.0, 134.0, 136.0, 133.0, 136.0, 143.0, 196.0, 149.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 216.0, 221.0, 160.0, 160.0, 164.0, 218.0, 193.0, 160.0, 158.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 66.0, 66.0, 66.0, 66.0, 63.0, 66.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1452.6, "alertThreshold": 2.0}]} 13:39:08 INFO - Return code: 0 13:39:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:39:08 INFO - # TBPL SUCCESS # 13:39:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:39:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:39:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:39:08 INFO - 2017-01-31 13:39:08.833 screenresolution[1652:9763] starting screenresolution argv=screenresolution get 13:39:08 INFO - 2017-01-31 13:39:08.836 screenresolution[1652:9763] Display 0: 1600x1200x32@60 13:39:08 INFO - 2017-01-31 13:39:08.842 screenresolution[1653:9766] starting screenresolution argv=screenresolution list 13:39:08 INFO - Available Modes on Display 0 13:39:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:39:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:39:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:39:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:39:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:39:09 INFO - Intel Iris: 13:39:09 INFO - Chipset Model: Intel Iris 13:39:09 INFO - Type: GPU 13:39:09 INFO - Bus: Built-In 13:39:09 INFO - VRAM (Dynamic, Max): 1536 MB 13:39:09 INFO - Vendor: Intel (0x8086) 13:39:09 INFO - Device ID: 0x0a2e 13:39:09 INFO - Revision ID: 0x0009 13:39:09 INFO - Displays: 13:39:09 INFO - Display: 13:39:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:39:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:39:09 INFO - Display Serial Number: 1600x1200 60 13:39:09 INFO - Main Display: Yes 13:39:09 INFO - Mirror: Off 13:39:09 INFO - Online: Yes 13:39:09 INFO - Rotation: Supported 13:39:09 INFO - Return code: 0 13:39:09 INFO - Running post-action listener: _resource_record_post_action 13:39:09 INFO - [mozharness: 2017-01-31 21:39:09.084919Z] Finished run-tests step (success) 13:39:09 INFO - Running post-run listener: _resource_record_post_run 13:39:09 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38867968; Write bytes: 499806720; Read time: 383; Write time: 1899 13:39:09 INFO - TinderboxPrint: CPU usage
53.6% 13:39:09 INFO - TinderboxPrint: I/O read bytes / time
38,867,968 / 383 13:39:09 INFO - TinderboxPrint: I/O write bytes / time
499,806,720 / 1,899 13:39:09 INFO - TinderboxPrint: CPU idle
2,223.1 (46.4%) 13:39:09 INFO - TinderboxPrint: CPU system
962.0 (20.1%) 13:39:09 INFO - TinderboxPrint: CPU user
1,604.6 (33.5%) 13:39:09 INFO - TinderboxPrint: Swap in / out
230,191,104 / 0 13:39:09 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186661376; Write bytes: 186126336; Read time: 16893; Write time: 338 13:39:09 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36938752; Write bytes: 306778624; Read time: 359; Write time: 1534 13:39:09 INFO - Running post-run listener: _upload_blobber_files 13:39:09 INFO - Blob upload gear active. 13:39:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:39:09 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 13:39:09 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:39:09 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:39:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:39:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:11 INFO - (blobuploader) - INFO - Done attempting. 13:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:12 INFO - (blobuploader) - INFO - Done attempting. 13:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:14 INFO - (blobuploader) - INFO - Done attempting. 13:39:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:14 INFO - Return code: 0 13:39:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f242d63dc2e2577665f2f4f37d534a71fdea5b76614b49eb9e49bb312e56dfceb9b273b6a09ea3120f6baf8e6b58ebfd39a7304137abb8a8e04bdb0b16f13ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584de70cd2781d599aa23ef81ce5b702a680ad84b5672f8cb0ec67948c03f85012d98137dd42844d1c419511a937c7573c79bf04f37b2dce49c844bc61bad211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377949ca6e5407fa607282d4a676aed05560ae5eb8c9a1bbfd7d78a25797d021105f2c4e5d692359f17abf21d20e76c71a122c88d298249e9ef6af5dc61013f0"} 13:39:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:14 INFO - Contents: 13:39:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f242d63dc2e2577665f2f4f37d534a71fdea5b76614b49eb9e49bb312e56dfceb9b273b6a09ea3120f6baf8e6b58ebfd39a7304137abb8a8e04bdb0b16f13ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584de70cd2781d599aa23ef81ce5b702a680ad84b5672f8cb0ec67948c03f85012d98137dd42844d1c419511a937c7573c79bf04f37b2dce49c844bc61bad211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377949ca6e5407fa607282d4a676aed05560ae5eb8c9a1bbfd7d78a25797d021105f2c4e5d692359f17abf21d20e76c71a122c88d298249e9ef6af5dc61013f0"} 13:39:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:14 INFO - Copying logs to upload dir... 13:39:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.594009 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-31 13:39:14.833741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 13:39:14.838617) ========= 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.VGEPUD729N/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.0aGASsx1w8/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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/Mozilla-Beta/sha512/1f242d63dc2e2577665f2f4f37d534a71fdea5b76614b49eb9e49bb312e56dfceb9b273b6a09ea3120f6baf8e6b58ebfd39a7304137abb8a8e04bdb0b16f13ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584de70cd2781d599aa23ef81ce5b702a680ad84b5672f8cb0ec67948c03f85012d98137dd42844d1c419511a937c7573c79bf04f37b2dce49c844bc61bad211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377949ca6e5407fa607282d4a676aed05560ae5eb8c9a1bbfd7d78a25797d021105f2c4e5d692359f17abf21d20e76c71a122c88d298249e9ef6af5dc61013f0"} build_url:https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/e4jpciQNQmiQKPldowM-sw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f242d63dc2e2577665f2f4f37d534a71fdea5b76614b49eb9e49bb312e56dfceb9b273b6a09ea3120f6baf8e6b58ebfd39a7304137abb8a8e04bdb0b16f13ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/584de70cd2781d599aa23ef81ce5b702a680ad84b5672f8cb0ec67948c03f85012d98137dd42844d1c419511a937c7573c79bf04f37b2dce49c844bc61bad211", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377949ca6e5407fa607282d4a676aed05560ae5eb8c9a1bbfd7d78a25797d021105f2c4e5d692359f17abf21d20e76c71a122c88d298249e9ef6af5dc61013f0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 13:39:14.875817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:39:14.876120) ========= 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.VGEPUD729N/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.0aGASsx1w8/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005083 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 13:39:14.924918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 13:39:14.928258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 13:39:14.928576) ========= ========= Total master_lag: 0.19 =========