builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0343 starttime: 1480174439.46 results: success (0) buildid: 20161126062719 builduid: 5d3d39b523f54d7f9797175ae2a702ec revision: 26773c7afa55b6f8ad725d5a00850b379eb0a10f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 07:33:59.456508) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 07:33:59.457095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 07:33:59.457394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 07:33:59.482335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 07:33:59.482649) ========= 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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-26 07:33:59-- 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% 8.79M=0.001s 2016-11-26 07:34:00 (8.79 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.516785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 07:34:00.023740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 07:34:00.024079) ========= 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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.020069 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 07:34:00.073890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 07:34:00.074551) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 26773c7afa55b6f8ad725d5a00850b379eb0a10f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 26773c7afa55b6f8ad725d5a00850b379eb0a10f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-26 07:34:00,160 truncating revision to first 12 chars 2016-11-26 07:34:00,160 Setting DEBUG logging. 2016-11-26 07:34:00,160 attempt 1/10 2016-11-26 07:34:00,160 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/26773c7afa55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 07:34:01,139 unpacking tar archive at: mozilla-central-26773c7afa55/testing/mozharness/ program finished with exit code 0 elapsedTime=1.252489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 07:34:01.351566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 07:34:01.351871) ========= script_repo_revision: 26773c7afa55b6f8ad725d5a00850b379eb0a10f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 07:34:01.352322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 07:34:01.352592) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 07:34:01.372219) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-26 07:34:01.372490) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:01 INFO - MultiFileLogger online at 20161126 07:34:01 in /builds/slave/test 07:34:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:34:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:01 INFO - {'append_to_log': False, 07:34:01 INFO - 'base_work_dir': '/builds/slave/test', 07:34:01 INFO - 'blob_upload_branch': 'Firefox', 07:34:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:01 INFO - 'branch': 'Firefox', 07:34:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:01 INFO - 'config_files': ('talos/mac_config.py',), 07:34:01 INFO - 'default_actions': ('clobber', 07:34:01 INFO - 'read-buildbot-config', 07:34:01 INFO - 'download-and-extract', 07:34:01 INFO - 'populate-webroot', 07:34:01 INFO - 'create-virtualenv', 07:34:01 INFO - 'install', 07:34:01 INFO - 'run-tests'), 07:34:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:01 INFO - 'download_minidump_stackwalk': True, 07:34:01 INFO - 'download_symbols': 'ondemand', 07:34:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:01 INFO - 'installer_path': 'installer.exe', 07:34:01 INFO - 'log_level': 'info', 07:34:01 INFO - 'log_name': 'talos', 07:34:01 INFO - 'log_to_console': True, 07:34:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:34:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:34:01 INFO - 'opt_config_files': (), 07:34:01 INFO - 'pip_index': False, 07:34:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:01 INFO - 'cmd': ('bash', 07:34:01 INFO - '-c', 07:34:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:01 INFO - 'enabled': True, 07:34:01 INFO - 'halt_on_failure': False, 07:34:01 INFO - 'name': 'check_screen_resolution'},), 07:34:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:01 INFO - 'cmd': ('bash', 07:34:01 INFO - '-c', 07:34:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:01 INFO - 'enabled': True, 07:34:01 INFO - 'halt_on_failure': False, 07:34:01 INFO - 'name': 'check_screen_resolution'},), 07:34:01 INFO - 'run_cmd_checks_enabled': True, 07:34:01 INFO - 'sps_profile': False, 07:34:01 INFO - 'sps_profile_interval': 0, 07:34:01 INFO - 'suite': 'dromaeojs', 07:34:01 INFO - 'system_bits': '32', 07:34:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:01 INFO - 'title': 't-yosemite-r7-0343', 07:34:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:01 INFO - 'use_talos_json': True, 07:34:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:01 INFO - 'work_dir': 'build'} 07:34:01 INFO - [mozharness: 2016-11-26 15:34:01.579081Z] Running clobber step. 07:34:01 INFO - Running pre-action listener: _resource_record_pre_action 07:34:01 INFO - Running main action method: clobber 07:34:01 INFO - rmtree: /builds/slave/test/build 07:34:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:03 INFO - Running post-action listener: _resource_record_post_action 07:34:03 INFO - [mozharness: 2016-11-26 15:34:03.107781Z] Finished clobber step (success) 07:34:03 INFO - [mozharness: 2016-11-26 15:34:03.107908Z] Running read-buildbot-config step. 07:34:03 INFO - Running pre-action listener: _resource_record_pre_action 07:34:03 INFO - Running main action method: read_buildbot_config 07:34:03 INFO - Using buildbot properties: 07:34:03 INFO - { 07:34:03 INFO - "project": "", 07:34:03 INFO - "product": "firefox", 07:34:03 INFO - "script_repo_revision": "production", 07:34:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:34:03 INFO - "repository": "", 07:34:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:34:03 INFO - "buildid": "20161126062719", 07:34:03 INFO - "pgo_build": "False", 07:34:03 INFO - "basedir": "/builds/slave/test", 07:34:03 INFO - "buildnumber": 31, 07:34:03 INFO - "slavename": "t-yosemite-r7-0343", 07:34:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:34:03 INFO - "platform": "yosemite_r7", 07:34:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:34:03 INFO - "branch": "mozilla-central", 07:34:03 INFO - "repo_path": "mozilla-central", 07:34:03 INFO - "revision": "26773c7afa55b6f8ad725d5a00850b379eb0a10f", 07:34:03 INFO - "stage_platform": "macosx64", 07:34:03 INFO - "builduid": "5d3d39b523f54d7f9797175ae2a702ec", 07:34:03 INFO - "slavebuilddir": "test" 07:34:03 INFO - } 07:34:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:34:03 INFO - Running post-action listener: _resource_record_post_action 07:34:03 INFO - [mozharness: 2016-11-26 15:34:03.111100Z] Finished read-buildbot-config step (success) 07:34:03 INFO - [mozharness: 2016-11-26 15:34:03.111216Z] Running download-and-extract step. 07:34:03 INFO - Running pre-action listener: _resource_record_pre_action 07:34:03 INFO - Running main action method: download_and_extract 07:34:03 INFO - mkdir: /builds/slave/test/build/tests 07:34: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')]} 07:34:03 INFO - trying https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:34:03 INFO - Downloading https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:34:03 INFO - Downloaded 1199 bytes. 07:34:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:34:03 INFO - Using the following test package requirements: 07:34:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:34:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:34:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:34:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'jsshell-mac.zip'], 07:34:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:34:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:34:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:34:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:34:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:34:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:34:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:34:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:34:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:34:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:34:03 INFO - Fetch https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:34:04 INFO - Http code: 200 07:34:04 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 07:34:04 INFO - x-amz-cf-id: zY3yQv4RfuPqn_jAaeZrxEFp1iantL1aodqI0VZIHg1wiHZk1FW4zA== 07:34:04 INFO - x-amz-version-id: 8WqrB6R19huopjdy4uewFxcJi31iMgef 07:34:05 INFO - Expected file size: 16273291 07:34:05 INFO - Obtained file size: 16273291 07:34:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:34:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:34:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:34:12 INFO - Fetch https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:34:12 INFO - Http code: 200 07:34:12 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 07:34:12 INFO - x-amz-cf-id: wu6U7-Dc3osgeU1Lqp7GKcwCQu60BawezAl5h9Uj1nwCPoOYDMA9sA== 07:34:12 INFO - x-amz-version-id: 8WqrB6R19huopjdy4uewFxcJi31iMgef 07:34:12 INFO - Expected file size: 16273291 07:34:12 INFO - Obtained file size: 16273291 07:34:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:34:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:34:19 INFO - Fetch https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:34:20 INFO - Http code: 200 07:34:20 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 07:34:20 INFO - x-amz-cf-id: PNVdeJyAwupe47UkrF9PhVpOT_Eu98RmK7G-KH9Jerxre36nc8maGA== 07:34:20 INFO - x-amz-version-id: .aiwO1rPZ_YU.FczFcfneauZ6TnnqqwF 07:34:21 INFO - Expected file size: 14409702 07:34:21 INFO - Obtained file size: 14409702 07:34:21 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')]} 07:34:21 INFO - trying https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:34:21 INFO - Downloading https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:34:24 INFO - Downloaded 107599035 bytes. 07:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:34:24 INFO - mkdir: /builds/slave/test/properties 07:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:24 INFO - Contents: 07:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:34:25 INFO - Running post-action listener: _resource_record_post_action 07:34:25 INFO - Running post-action listener: set_extra_try_arguments 07:34:25 INFO - [mozharness: 2016-11-26 15:34:25.228949Z] Finished download-and-extract step (success) 07:34:25 INFO - [mozharness: 2016-11-26 15:34:25.229078Z] Running populate-webroot step. 07:34:25 INFO - Running pre-action listener: _resource_record_pre_action 07:34:25 INFO - Running main action method: populate_webroot 07:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:25 INFO - '--tppagecycles', 07:34:25 INFO - '7'], 07:34:25 INFO - 'tests': ['tsvgm']}}, 07:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['damp', 'tps']}, 07:34:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:34:25 INFO - 'tests': ['damp', 'tps']}, 07:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['dromaeo_dom']}, 07:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['basic_compositor_video']}, 07:34:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['a11yr', 07:34:25 INFO - 'ts_paint', 07:34:25 INFO - 'tpaint', 07:34:25 INFO - 'sessionrestore', 07:34:25 INFO - 'sessionrestore_no_auto_restore', 07:34:25 INFO - 'tabpaint']}, 07:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tsvgx', 07:34:25 INFO - 'tsvgr_opacity', 07:34:25 INFO - 'tart', 07:34:25 INFO - 'tscrollx', 07:34:25 INFO - 'cart', 07:34:25 INFO - 'tsvg_static']}, 07:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:25 INFO - 'tsvgr_opacity', 07:34:25 INFO - 'tart', 07:34:25 INFO - 'tscrollx', 07:34:25 INFO - 'cart', 07:34:25 INFO - 'tsvg_static']}, 07:34:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s'], 07:34:25 INFO - 'tests': ['tp5o']}, 07:34:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:34:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:34:25 INFO - 'talos_options': ['--disable-e10s', 07:34:25 INFO - '--xperf_path', 07:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:25 INFO - 'tests': ['tp5n']}, 07:34:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:34:25 INFO - 'talos_options': ['--xperf_path', 07:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:25 INFO - 'tests': ['tp5n']}}, 07:34:25 INFO - 'talos.zip': {'path': '', 07:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:25 INFO - Running post-action listener: _resource_record_post_action 07:34:25 INFO - [mozharness: 2016-11-26 15:34:25.247474Z] Finished populate-webroot step (success) 07:34:25 INFO - [mozharness: 2016-11-26 15:34:25.247560Z] Running create-virtualenv step. 07:34:25 INFO - Running pre-action listener: _resource_record_pre_action 07:34:25 INFO - Running main action method: create_virtualenv 07:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:25 INFO - Using real prefix '/tools/python27' 07:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:28 INFO - Installing pip.................done. 07:34:28 INFO - Return code: 0 07:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:34:29 INFO - Reading from file tmpfile_stdout 07:34:29 INFO - Output received: 07:34:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:34:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:29 INFO - 'HOME': '/Users/cltbld', 07:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:29 INFO - 'LOGNAME': 'cltbld', 07:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:29 INFO - 'MOZ_NO_REMOTE': '1', 07:34:29 INFO - 'NO_EM_RESTART': '1', 07:34:29 INFO - 'PAGER': '/bin/cat', 07:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:29 INFO - 'PWD': '/builds/slave/test', 07:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:29 INFO - 'SHELL': '/bin/bash', 07:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:29 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:29 INFO - 'USER': 'cltbld', 07:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:29 INFO - 'XPC_FLAGS': '0x0', 07:34:29 INFO - 'XPC_SERVICE_NAME': '0', 07:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:29 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 07:34:29 INFO - Cleaning up... 07:34:29 INFO - Return code: 0 07:34:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:29 INFO - 'HOME': '/Users/cltbld', 07:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:29 INFO - 'LOGNAME': 'cltbld', 07:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:29 INFO - 'MOZ_NO_REMOTE': '1', 07:34:29 INFO - 'NO_EM_RESTART': '1', 07:34:29 INFO - 'PAGER': '/bin/cat', 07:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:29 INFO - 'PWD': '/builds/slave/test', 07:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:29 INFO - 'SHELL': '/bin/bash', 07:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:29 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:29 INFO - 'USER': 'cltbld', 07:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:29 INFO - 'XPC_FLAGS': '0x0', 07:34:29 INFO - 'XPC_SERVICE_NAME': '0', 07:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:29 INFO - Downloading/unpacking psutil>=3.1.1 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:33 INFO - Installing collected packages: psutil 07:34:33 INFO - Running setup.py install for psutil 07:34:33 INFO - building 'psutil._psutil_osx' extension 07:34:33 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 07:34:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:34:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:34:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:34:34 INFO - building 'psutil._psutil_posix' extension 07:34:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:34:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:34:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:34:34 INFO - ^ 07:34:34 INFO - 1 warning generated. 07:34:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:34 INFO - Successfully installed psutil 07:34:34 INFO - Cleaning up... 07:34:34 INFO - Return code: 0 07:34:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:34 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 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:34 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 07:34:34 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 07:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:34 INFO - 'HOME': '/Users/cltbld', 07:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:34 INFO - 'LOGNAME': 'cltbld', 07:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:34 INFO - 'MOZ_NO_REMOTE': '1', 07:34:34 INFO - 'NO_EM_RESTART': '1', 07:34:34 INFO - 'PAGER': '/bin/cat', 07:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:34 INFO - 'PWD': '/builds/slave/test', 07:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:34 INFO - 'SHELL': '/bin/bash', 07:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:34 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:34 INFO - 'USER': 'cltbld', 07:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:34 INFO - 'XPC_FLAGS': '0x0', 07:34:34 INFO - 'XPC_SERVICE_NAME': '0', 07:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:34:34 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 07:34:34 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 07:34:34 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 07:34:34 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 07:34:34 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 07:34:34 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 07:34:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:34:37 INFO - Installing collected packages: mozsystemmonitor 07:34:37 INFO - Running setup.py install for mozsystemmonitor 07:34:37 INFO - Successfully installed mozsystemmonitor 07:34:37 INFO - Cleaning up... 07:34:37 INFO - Return code: 0 07:34:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:34:37 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')]} 07:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:37 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')]} 07:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:37 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 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:37 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 07:34:37 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 07:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:37 INFO - 'HOME': '/Users/cltbld', 07:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:37 INFO - 'LOGNAME': 'cltbld', 07:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:37 INFO - 'MOZ_NO_REMOTE': '1', 07:34:37 INFO - 'NO_EM_RESTART': '1', 07:34:37 INFO - 'PAGER': '/bin/cat', 07:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:37 INFO - 'PWD': '/builds/slave/test', 07:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:37 INFO - 'SHELL': '/bin/bash', 07:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:37 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:37 INFO - 'USER': 'cltbld', 07:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:37 INFO - 'XPC_FLAGS': '0x0', 07:34:37 INFO - 'XPC_SERVICE_NAME': '0', 07:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:34:37 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 07:34:37 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 07:34:37 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 07:34:37 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 07:34:37 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 07:34:37 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 07:34:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:34:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:34:40 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 07:34:40 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 07:34:40 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 07:34:40 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 07:34:40 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 07:34:40 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 07:34:40 INFO - Downloading functools32-3.2.3-2.tar.gz 07:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:34:41 INFO - warning: no files found matching '*.txt' 07:34:41 INFO - no previously-included directories found matching 'build' 07:34:41 INFO - no previously-included directories found matching 'dist' 07:34:41 INFO - no previously-included directories found matching '.git*' 07:34:41 INFO - Installing collected packages: jsonschema, functools32 07:34:41 INFO - Running setup.py install for functools32 07:34:41 INFO - warning: no files found matching '*.txt' 07:34:41 INFO - no previously-included directories found matching 'build' 07:34:41 INFO - no previously-included directories found matching 'dist' 07:34:41 INFO - no previously-included directories found matching '.git*' 07:34:41 INFO - Successfully installed jsonschema functools32 07:34:41 INFO - Cleaning up... 07:34:41 INFO - Return code: 0 07:34:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:41 INFO - 'HOME': '/Users/cltbld', 07:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:41 INFO - 'LOGNAME': 'cltbld', 07:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:41 INFO - 'MOZ_NO_REMOTE': '1', 07:34:41 INFO - 'NO_EM_RESTART': '1', 07:34:41 INFO - 'PAGER': '/bin/cat', 07:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:41 INFO - 'PWD': '/builds/slave/test', 07:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:41 INFO - 'SHELL': '/bin/bash', 07:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:41 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:41 INFO - 'USER': 'cltbld', 07:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:41 INFO - 'XPC_FLAGS': '0x0', 07:34:41 INFO - 'XPC_SERVICE_NAME': '0', 07:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:34:41 INFO - Cleaning up... 07:34:41 INFO - Return code: 0 07:34:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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', '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 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:34: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 blobuploader==1.2.4 07:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:41 INFO - 'HOME': '/Users/cltbld', 07:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:41 INFO - 'LOGNAME': 'cltbld', 07:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:41 INFO - 'MOZ_NO_REMOTE': '1', 07:34:41 INFO - 'NO_EM_RESTART': '1', 07:34:41 INFO - 'PAGER': '/bin/cat', 07:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:41 INFO - 'PWD': '/builds/slave/test', 07:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:41 INFO - 'SHELL': '/bin/bash', 07:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:41 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:41 INFO - 'USER': 'cltbld', 07:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:41 INFO - 'XPC_FLAGS': '0x0', 07:34:41 INFO - 'XPC_SERVICE_NAME': '0', 07:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:41 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:45 INFO - Downloading docopt-0.6.1.tar.gz 07:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:45 INFO - Running setup.py install for blobuploader 07:34:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:45 INFO - Running setup.py install for requests 07:34:46 INFO - Running setup.py install for docopt 07:34:46 INFO - Successfully installed blobuploader requests docopt 07:34:46 INFO - Cleaning up... 07:34:46 INFO - Return code: 0 07:34:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:46 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 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:46 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 07:34:46 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 07:34:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:46 INFO - 'HOME': '/Users/cltbld', 07:34:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:46 INFO - 'LOGNAME': 'cltbld', 07:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:46 INFO - 'MOZ_NO_REMOTE': '1', 07:34:46 INFO - 'NO_EM_RESTART': '1', 07:34:46 INFO - 'PAGER': '/bin/cat', 07:34:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:46 INFO - 'PWD': '/builds/slave/test', 07:34:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:46 INFO - 'SHELL': '/bin/bash', 07:34:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:46 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:46 INFO - 'USER': 'cltbld', 07:34:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:46 INFO - 'XPC_FLAGS': '0x0', 07:34:46 INFO - 'XPC_SERVICE_NAME': '0', 07:34:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:46 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-65ugiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:46 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-_ZJ13B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-66xBJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-1wNRiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-S_P7EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-evCSjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-qTGZop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-ivh7Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-KTe02w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-HwYtCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:47 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-k5M63I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-0TWW0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-AEMfxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-QPHQEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-sKRstq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-5lzF_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:48 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-tudlXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:48 INFO - Running setup.py install for manifestparser 07:34:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:48 INFO - Running setup.py install for mozcrash 07:34:48 INFO - Running setup.py install for mozdebug 07:34:49 INFO - Running setup.py install for mozdevice 07:34:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Running setup.py install for mozfile 07:34:49 INFO - Running setup.py install for mozhttpd 07:34:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Running setup.py install for mozinfo 07:34:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Running setup.py install for mozInstall 07:34:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:49 INFO - Running setup.py install for mozleak 07:34:49 INFO - Running setup.py install for mozlog 07:34:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:50 INFO - Running setup.py install for moznetwork 07:34:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:50 INFO - Running setup.py install for mozprocess 07:34:50 INFO - Running setup.py install for mozprofile 07:34:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:50 INFO - Running setup.py install for mozrunner 07:34:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:50 INFO - Running setup.py install for mozscreenshot 07:34:50 INFO - Running setup.py install for moztest 07:34:51 INFO - Running setup.py install for mozversion 07:34:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:51 INFO - Cleaning up... 07:34:51 INFO - Return code: 0 07:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:51 INFO - 'HOME': '/Users/cltbld', 07:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:51 INFO - 'LOGNAME': 'cltbld', 07:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:51 INFO - 'MOZ_NO_REMOTE': '1', 07:34:51 INFO - 'NO_EM_RESTART': '1', 07:34:51 INFO - 'PAGER': '/bin/cat', 07:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:51 INFO - 'PWD': '/builds/slave/test', 07:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:51 INFO - 'SHELL': '/bin/bash', 07:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:51 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:51 INFO - 'USER': 'cltbld', 07:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:51 INFO - 'XPC_FLAGS': '0x0', 07:34:51 INFO - 'XPC_SERVICE_NAME': '0', 07:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:51 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-GHlJy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:51 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)) 07:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:51 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-pftY9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:51 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)) 07:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:51 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-btrCIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:51 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)) 07:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:51 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-oAIXyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:51 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-FcKuvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-KEmg_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Z7rscm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-VMRSxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-Vv5Ar8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-aj_9Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:52 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)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zrhIg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:52 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)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-XPpkJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:52 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)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-ttZY3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:52 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)) 07:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:52 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-wjQaBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:53 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)) 07:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:53 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zi3KMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:53 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-PBGl8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:53 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-SDgwtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34:55 INFO - Downloading blessings-1.6.tar.gz 07:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:55 INFO - Installing collected packages: blessings 07:34:55 INFO - Running setup.py install for blessings 07:34:56 INFO - Successfully installed blessings 07:34:56 INFO - Cleaning up... 07:34:56 INFO - Return code: 0 07:34:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:56 INFO - Reading from file tmpfile_stdout 07:34:56 INFO - Current package versions: 07:34:56 INFO - blessings == 1.6 07:34:56 INFO - blobuploader == 1.2.4 07:34:56 INFO - docopt == 0.6.1 07:34:56 INFO - functools32 == 3.2.3-2 07:34:56 INFO - jsonschema == 2.5.1 07:34:56 INFO - manifestparser == 1.1 07:34:56 INFO - mozInstall == 1.12 07:34:56 INFO - mozcrash == 1.0 07:34:56 INFO - mozdebug == 0.1 07:34:56 INFO - mozdevice == 0.49 07:34:56 INFO - mozfile == 1.2 07:34:56 INFO - mozhttpd == 0.7 07:34:56 INFO - mozinfo == 0.9 07:34:56 INFO - mozleak == 0.1 07:34:56 INFO - mozlog == 3.4 07:34:56 INFO - moznetwork == 0.27 07:34:56 INFO - mozprocess == 0.23 07:34:56 INFO - mozprofile == 0.28 07:34:56 INFO - mozrunner == 6.13 07:34:56 INFO - mozscreenshot == 0.1 07:34:56 INFO - mozsystemmonitor == 0.3 07:34:56 INFO - moztest == 0.7 07:34:56 INFO - mozversion == 1.4 07:34:56 INFO - psutil == 3.1.1 07:34:56 INFO - requests == 1.2.3 07:34:56 INFO - wsgiref == 0.1.2 07:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 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 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:56 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 07:34:56 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 07:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:56 INFO - 'HOME': '/Users/cltbld', 07:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:56 INFO - 'LOGNAME': 'cltbld', 07:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:56 INFO - 'MOZ_NO_REMOTE': '1', 07:34:56 INFO - 'NO_EM_RESTART': '1', 07:34:56 INFO - 'PAGER': '/bin/cat', 07:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:56 INFO - 'PWD': '/builds/slave/test', 07:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:56 INFO - 'SHELL': '/bin/bash', 07:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:56 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:56 INFO - 'USER': 'cltbld', 07:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:56 INFO - 'XPC_FLAGS': '0x0', 07:34:56 INFO - 'XPC_SERVICE_NAME': '0', 07:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 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)) 07:34:56 INFO - Cleaning up... 07:34:56 INFO - Return code: 0 07:34:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 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 0x106c793f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bef570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff50346ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, '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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 07:34:56 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 07:34:56 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 07:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:56 INFO - 'HOME': '/Users/cltbld', 07:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:56 INFO - 'LOGNAME': 'cltbld', 07:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:56 INFO - 'MOZ_NO_REMOTE': '1', 07:34:56 INFO - 'NO_EM_RESTART': '1', 07:34:56 INFO - 'PAGER': '/bin/cat', 07:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:56 INFO - 'PWD': '/builds/slave/test', 07:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:56 INFO - 'SHELL': '/bin/bash', 07:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:34:56 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:56 INFO - 'USER': 'cltbld', 07:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:56 INFO - 'XPC_FLAGS': '0x0', 07:34:56 INFO - 'XPC_SERVICE_NAME': '0', 07:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:34:57 INFO - Cleaning up... 07:34:57 INFO - Return code: 0 07:34:57 INFO - Running post-action listener: _resource_record_post_action 07:34:57 INFO - Running post-action listener: _start_resource_monitoring 07:34:57 INFO - Starting resource monitoring. 07:34:57 INFO - [mozharness: 2016-11-26 15:34:57.079835Z] Finished create-virtualenv step (success) 07:34:57 INFO - [mozharness: 2016-11-26 15:34:57.080884Z] Running install step. 07:34:57 INFO - Running pre-action listener: _resource_record_pre_action 07:34:57 INFO - Running main action method: install 07:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:57 INFO - Reading from file tmpfile_stdout 07:34:57 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:57 INFO - Reading from file tmpfile_stdout 07:34:57 INFO - Output received: 07:34:57 INFO - Usage: mozinstall [options] installer 07:34:57 INFO - Options: 07:34:57 INFO - -h, --help show this help message and exit 07:34:57 INFO - -d DEST, --destination=DEST 07:34:57 INFO - Directory to install application into. [default: 07:34:57 INFO - "/builds/slave/test"] 07:34:57 INFO - --app=APP Application being installed. [default: firefox] 07:34:57 INFO - mkdir: /builds/slave/test/build/application 07:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:35:30 INFO - Reading from file tmpfile_stdout 07:35:30 INFO - Output received: 07:35:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:35:30 INFO - Running post-action listener: _resource_record_post_action 07:35:30 INFO - [mozharness: 2016-11-26 15:35:30.257031Z] Finished install step (success) 07:35:30 INFO - [mozharness: 2016-11-26 15:35:30.257168Z] Running run-tests step. 07:35:30 INFO - Running pre-action listener: _resource_record_pre_action 07:35:30 INFO - Running main action method: run_tests 07:35:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:30 INFO - 2016-11-26 07:35:30.271 screenresolution[2512:33685] starting screenresolution argv=screenresolution get 07:35:30 INFO - 2016-11-26 07:35:30.274 screenresolution[2512:33685] Display 0: 1600x1200x32@60 07:35:30 INFO - 2016-11-26 07:35:30.280 screenresolution[2513:33688] starting screenresolution argv=screenresolution list 07:35:30 INFO - Available Modes on Display 0 07:35:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:30 INFO - Intel Iris: 07:35:30 INFO - Chipset Model: Intel Iris 07:35:30 INFO - Type: GPU 07:35:30 INFO - Bus: Built-In 07:35:30 INFO - VRAM (Dynamic, Max): 1536 MB 07:35:30 INFO - Vendor: Intel (0x8086) 07:35:30 INFO - Device ID: 0x0a2e 07:35:30 INFO - Revision ID: 0x0009 07:35:30 INFO - Displays: 07:35:30 INFO - Display: 07:35:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:30 INFO - Display Serial Number: 1600x1200 60 07:35:30 INFO - Main Display: Yes 07:35:30 INFO - Mirror: Off 07:35:30 INFO - Online: Yes 07:35:30 INFO - Rotation: Supported 07:35:30 INFO - Return code: 0 07:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:30 INFO - Python 2.7.3 07:35:30 INFO - Return code: 0 07:35:30 INFO - grabbing minidump binary from tooltool 07:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:30 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 0x106a8fd30>, '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 0x1068f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a87b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:30 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 07:35:30 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 07:35:30 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 07:35:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:30 INFO - Return code: 0 07:35:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:35:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:35:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 07:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0343 --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 07:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hb4YNxBXA0/Render', 07:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:30 INFO - 'HOME': '/Users/cltbld', 07:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:30 INFO - 'LOGNAME': 'cltbld', 07:35:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:30 INFO - 'MOZ_NO_REMOTE': '1', 07:35:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:30 INFO - 'NO_EM_RESTART': '1', 07:35:30 INFO - 'PAGER': '/bin/cat', 07:35:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:30 INFO - 'PWD': '/builds/slave/test', 07:35:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:30 INFO - 'SHELL': '/bin/bash', 07:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ICU4TnXp8w/Listeners', 07:35:30 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 07:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:30 INFO - 'USER': 'cltbld', 07:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:30 INFO - 'XPC_FLAGS': '0x0', 07:35:30 INFO - 'XPC_SERVICE_NAME': '0', 07:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 07:35:30 INFO - mozversion application_buildid: 20161126062719 07:35:30 INFO - mozversion application_changeset: 26773c7afa55b6f8ad725d5a00850b379eb0a10f 07:35:30 INFO - mozversion application_display_name: Nightly 07:35:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:30 INFO - mozversion application_name: Firefox 07:35:30 INFO - mozversion application_remotingname: firefox 07:35:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:35:30 INFO - mozversion application_vendor: Mozilla 07:35:30 INFO - mozversion application_version: 53.0a1 07:35:30 INFO - mozversion platform_buildid: 20161126062719 07:35:30 INFO - mozversion platform_changeset: 26773c7afa55b6f8ad725d5a00850b379eb0a10f 07:35:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:35:30 INFO - mozversion platform_version: 53.0a1 07:35:30 INFO - using testdate: 1480174530 07:35:30 INFO - actual date: 1480174530 07:35:30 INFO - starting webserver on 'localhost:56619' 07:35:30 INFO - SUITE-START | Running 2 tests 07:35:30 INFO - TEST-START | dromaeo_css 07:35:30 INFO - operating with platform_type : mac_ 07:35:30 INFO - Initialising browser for dromaeo_css test... 07:35:30 INFO - TEST-INFO | started process 2523 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpzPZMEP/profile http://localhost:56619/getInfo.html) 07:35:33 INFO - PROCESS | 2523 | __metrics Screen width/height:1600/1200 07:35:33 INFO - PROCESS | 2523 | colorDepth:24 07:35:33 INFO - PROCESS | 2523 | Browser inner width/height: 1024/689 07:35:33 INFO - PROCESS | 2523 | __metrics 07:35:33 INFO - PROCESS | 2523 | 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" 07:35:33 INFO - PROCESS | 2523 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:34 INFO - TEST-INFO | 2523: exit 0 07:35:34 INFO - Browser initialized. 07:35:34 INFO - Running cycle 1/1 for dromaeo_css test... 07:35:34 INFO - TEST-INFO | started process 2525 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpzPZMEP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:46 INFO - PROCESS | 2525 | RSS: Main: 245362688 07:35:46 INFO - PROCESS | 2525 | 07:36:38 INFO - PROCESS | 2525 | 1480174598355 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:38:49 INFO - PROCESS | 2525 | Cycle 1(1): loaded http://localhost:56619/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56619/tests/dromaeo/cssquery-ext.html) 07:38:53 INFO - PROCESS | 2525 | RSS: Main: 471834624 07:38:53 INFO - PROCESS | 2525 | 07:41:56 INFO - PROCESS | 2525 | Cycle 1(1): loaded http://localhost:56619/tests/dromaeo/cssquery-ext.html (next: http://localhost:56619/tests/dromaeo/cssquery-jquery.html) 07:41:56 INFO - PROCESS | 2525 | RSS: Main: 361828352 07:41:56 INFO - PROCESS | 2525 | 07:44:58 INFO - PROCESS | 2525 | Cycle 1(1): loaded http://localhost:56619/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56619/tests/dromaeo/cssquery-mootools.html) 07:44:59 INFO - PROCESS | 2525 | RSS: Main: 359936000 07:44:59 INFO - PROCESS | 2525 | 07:48:01 INFO - PROCESS | 2525 | Cycle 1(1): loaded http://localhost:56619/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56619/tests/dromaeo/cssquery-prototype.html) 07:48:02 INFO - PROCESS | 2525 | RSS: Main: 351887360 07:48:02 INFO - PROCESS | 2525 | 07:51:05 INFO - PROCESS | 2525 | Cycle 1(1): loaded http://localhost:56619/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56619/tests/dromaeo/cssquery-yui.html) 07:51:06 INFO - PROCESS | 2525 | RSS: Main: 336650240 07:51:06 INFO - PROCESS | 2525 | 07:54:09 INFO - PROCESS | 2525 | Cycle 1(1): loaded http://localhost:56619/tests/dromaeo/cssquery-yui.html (next: http://localhost:56619/tests/dromaeo/cssquery-dojo.html) 07:54:10 INFO - PROCESS | 2525 | RSS: Main: 474750976 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | __start_tp_report 07:54:10 INFO - PROCESS | 2525 | _x_x_mozilla_page_load 07:54:10 INFO - PROCESS | 2525 | _x_x_mozilla_page_load_details 07:54:10 INFO - PROCESS | 2525 | |i|pagename|runs| 07:54:10 INFO - PROCESS | 2525 | |0;dojo.html;2737.575675770255;3257.267114899147;3280.0487858521014;3285.342931413718;3337.6315710558674;5466.125419932811;5486.6707997520125;5534.391216966131;5604.355499117598;5609.35492418372;5542.314360949974;5577.358603760569;5624.29696287964;5638.210650508932;5698.031334673115;5023.874403139914;5063.873403164914;5068.670536415139;5122.564582010534;5150.227465880111;5124.359455068116;5219.765110570033;5224.3730752309775;5224.45143259958;5261.368635763713;5024.522670346311;5146.819861304836;5171.663841850286;5174.844754657329;5238.633295669305;5051.393832740095;5078.873028174288;5092.10888094582;5136.717480538568;5137.74311284438;5054.393472783253;5104.566111880495;5114.565261952738;5114.746887012706;5155.71643559604;5582.190582365534;5584.748686309085;5584.944150558524;5613.045782217033;5615.129654903497;5913.379095194986;5949.8215053548465;5974.8506287342725;6063.272407311107;6121.9081713773885;6161.045038019114;6208.037754148069;6212.347703491158;6214.720337584819;6224.253089629274;5669.121286200645;5677.829665110054;5679.062954612443;5685.1756495307945;5714.542836573064;6090.786822461281;6107.401224262618;6186.350433204539;6277.591956522811;6291.905621415683;5845.210896528999;5883.588148829541;5921.644701317935;5961.463468287875;6103.816885493442;6149.200603921461;6181.752729890754;6193.721282542207;6203.4416902479;6211.782587609412;6022.728977196037;6094.2077529920825;6103.6948152592195;6126.27339965311;6127.938720612826;5884.941150588525;5968.970155149196;5979.312379076462;6131.724815773889;6151.169592105098;4844.0554091951735;4846.684965477232;4852.708837469692;4855.295982082578;4858.125537403231;4313.61177494027;4343.261645520269;4377.124575084996;4388.385626012361;4424.6239069678795;4957.677750946177;5318.361796584435;5604.32748070226;5604.971975140098;5647.209390685307;6158.630482171084;6167.907481387782;6187.659678717624;6195.132681424604;6201.937980620226;5452.563794896399;5521.503064724194;5532.170174473861;5548.112302031655;5615.466530679579;5276.709780962084;5333.946660533345;5362.302900622894;5368.436314187033;5376.435474275223;6228.439440450381;6272.905906411499;6275.843103922439;6277.686115694197;6309.33751956038;5925.9407405925385;5978.372270911492;6171.074338849208;6191.040388739752;6197.96901015492;6182.938170618237;6187.443130118311;6209.875802484015;6233.968830156002;6274.843128921813;6051.425114614105;6057.896723689206;6064.151018857276;6075.119107729266;6116.785912493041;6092.299385570716;6099.432368409277;6119.571629985859;6136;6141.955867502446;5637.689927053887;5717.9993501136305;5787.045137552425;5847;5868.853278668067;5694.861027794541;5831.504322132497;5838.883222335445;5840;5842.561807864342;4926.507349265188;5734.22587950638;5735.426457354231;5743.195952566561;5748.827535173951;5781.913271300849;5813.651180929158;5832.212651292021;5839.036558967723;5850.12248162779;5705.515031222227;5734.885302293847;5735;5735.512481439125;5745.1382292656435 07:54:10 INFO - PROCESS | 2525 | |1;ext.html;467.99848324585395;492.2591499792811;501.0605115408611;507.83241530295004;513.0790231534396;37295.62704372955;38401;38766.8061659692;38810.80594597023;40029.39955900664;39189;39608.20783584326;39644.40533392001;39765.60234397662;39856.40215396771;8366.406414011646;8590;9133.223675987549;9264.536773161348;9336.673216437426;10852.891471085306;11088.667339979813;11165;11300.265482743636;11308.321500709942;11013;11065.723356916062;11066.170037247199;11112.388818614972;11145.72135696606;10954.178436617245;10995.835062474069;11009.61466348674;11017.394043327613;11029.558817647285;10859.945700271526;10908.945455272753;10920.781584368347;10929.398883061429;10946.507407166697;37262.88211353664;37566.812165938994;37573;37573.81213093917;37598.81200594007;3223.597050368704;3406.812625305607;3581.4627805829073;3787.110029143149;3877.3214687429586;22259.44351391212;29002.27494312638;29209;29226.707732922612;29515.852420737974;3134.4828103362915;3135.843207839599;3151.543026261202;3258.3809076275434;3299.1257316811066;475315.246847534;476722.61638691934;477763;478271;481468;56449;56783.71608141933;56920;56968.715156423954;57070;59563;59609.701951489966;59705.701471492364;59743.701281494185;59774.70112649496;14736.010638563872;15176.848231517544;15196;15217.010894291836;15227.467038653594;10692.62575809843;10947.014768670859;10991.670249892515;11707.941460292814;11769.764604707858;14352.842374677553;14500.129992200502;14533.709325813425;15600.765988510182;15847.603809904844;6162.859870923893;6229.501639868799;6275.52933529978;6300.487882908161;6309.684515774285;831.9708810191614;935.6491315756591;1040.776233109885;1046.6284469013542;1106.7343837478948;27756.30609234785;28422;28672;29238;29348.706512934597;1036.8237399642078;1061.9256652034437;1108.146727020206;1108.4623957380663;1135.2961164078324;11718.941405292919;14542.272886355851;14673.192974386511;14929.253537323091;14984.775228371584;630646;637884;638023;638376;639476;53830.7308463463;54019.45980540223;54038;54252.728736356854;54320.72839635856;1327.6614463311987;1352.8782409583184;1361.9931900340632;1365.3992243412868;1367.0840536840142;27914.74383652781;28387.858060709565;29036.854815725786;29080.56379154272;29131;47666;50040;52205.7389713049;52398.95202096013;55040.44959550353;498091;502841;503586;504855;504945;24224.757752422956;24564.263072107864;24637;24654.260372188863;24705.87647061753;25033.87483062573;39131.80434097811;41807.11867965888;43013.92465188395;45128.77435612801;30402.543961840147;35410;36783.44824827576;36997.890063298146;38029;35910.82044589865;36358;37195;37442;37718.2456350877;35684;35986.64013359833;36324;38491.23017539577;39490.01274968034;36551.26897462089;38487.6151238484;38844.80577597207;39421;39705.41178352833;30281.69718302789;30292.84853575718;30429.239269017566;30872.476514091366;31093 07:54:10 INFO - PROCESS | 2525 | |2;jquery.html;343.17295318282913;370.1357330632972;370.7478914338249;379.8803376936265;398.3268276612525;12912.418941147647;14300.070495417804;15619.609509762247;19620.705689414634;20261.797382026212;19004;19907;20135.590508664398;20253.696194557095;20536;5472.50747432731;5849.2980842298775;5850.4734573888345;5850.64896106235;5853.824385268449;4664.323673067403;5332.386775520807;5667.4049224831415;5723.2559767230205;5730.398308177644;5690.57320700947;5695.601307908448;5697.430256974311;5699.971500142494;5702.372738998728;5390.326209223847;5616.691081990489;5695;5698.287714035746;5710;4812.590929770939;5021.196608542652;5034.0686972910125;5035.320231768701;5038.672486288379;24529.386765331008;24679;25110.49779004428;25122.748772512223;25453.61819572708;2310.514791893704;2343.27358518858;2346.6949296591333;2373.299876536426;2379.512199998996;14607.342669579895;15227.238638068053;15400.998935069296;15468.845311546853;15500.844991550053;1808.620189760152;1820.7086866101492;1866.4773863318292;1872.2739276212335;1918.0409795102448;117489;121804;122144;122765;123352;8750.256228220545;10499.632512862014;11080.390578518098;11125.72185695348;11253.099752019818;13799.585072612253;13816.585502434944;13840.031197816057;13854.376553055137;13878.861211387959;7985.800354991172;8329.583520824055;8342.124076971952;8442.113578074213;8445.619947102396;8193.385496087818;8203.630836612367;8210.753677389688;8356.791080223044;8393.496390216607;6566.80299591013;6687.230968438595;6706.228783689938;6752.257251702407;6856.931430685729;1525.5499627609881;1678.479671301876;1766.2493440287826;1803.107461806388;1803.449947765944;866.3935245328296;920.1902325953118;978.9951050244846;981.4503877828439;984.3404918704342;20397.79602203959;22063.786491742787;22142.667859982113;22165.445863853533;22196.334109976728;952.7332346942867;953.4803532074897;961.8457850579333;1015.94920253987;1065.1851333729703;10799.192210025292;11126.109911207084;11173.273737207055;11699.76600467986;11714.648560543197;485268;534967;572320;587673;589712.7201095968;90009.09990900138;109784.4510777441;112633;122442.38778806049;131356;916.8074704312036;943.7216021273741;996.1333639733479;996.1980605612407;1000.3597697473623;18808.905955470134;18841.24635014639;19266.518337041125;19300;19372.8062719371;51130;53512.25414220967;53650.46349536454;54282.64293392539;54527.90944181174;71103;77418.6129069351;79043;79052;79303.60348198222;6541.34586541342;7919.683212671659;7952.403569732409;8177.182281771775;8400.747977560683;9452.669156579486;12207.694807629525;12471.939885109867;13017.804732928824;13132.212067275994;10780.730481738019;10788.892111079103;10806.973337532922;11012.724681883017;11113.499892505019;10570.788584228427;10639.787204255717;11054.00513953748;11074.224804263624;11240.718982025515;11015.559377624806;11193.328400296008;11321.7735645285;11403.574553180852;11538.76922461563;7039.612821294878;7901.525908445512;8114.188581141839;8145.79635509117;8180.9590952044855;7950.24472675095;9520.761980950254;10473.947630262104;10761.677149685522;10891.0742586881 07:54:10 INFO - PROCESS | 2525 | |3;mootools.html;1304.6562041097668;1433.5269361110834;1588.9920550397246;1767.8674099442544;1825.3337531800896;7370.373518250942;7652.158262591124;7832.295093441589;8266.173382661731;8277.91722082779;7526.849463010736;7835.412344074189;8045.477043992137;8055.31529819966;8147.429679922408;2276.3398614401844;2312.780285872848;2314.5833749925005;2316.6293393057113;2319.373769082347;2061.917523299066;2305.227748704186;2326.255598208574;2351.694279743631;2353.8469999450067;2078.418042947977;2215.1582398688474;2298.5058212484314;2307.1809507624803;2307.607706689867;2278.020451205981;2296.850704704189;2316.0851463671925;2319.930402087923;2334.7665233476687;1944.2903340280836;1955.7750858651295;2328.394617399488;2328.429534763977;2334.3580515358244;7163.31948464895;7786.7663970080985;7998.960005199995;8082.1513741057515;8106.47307924983;4737.786799594027;5103.744812759347;5109.770060347293;5111.872203194913;5119.206522988943;3230.353929214167;3439.8796042138406;3460.4290292101773;3529.1530032791943;3540.964590354089;1027.0756319312604;1055.4828134214256;1069.7860427914447;1078.229066217658;1097.8572785537829;10457.111145552637;10566.260361774679;10706.571737130584;10707.946460267727;10723.14214862809;3840.1935593525113;3859.7684138951754;4247.830086796494;4514.6614003949835;4584.235069498267;9241.676541321156;9244.168024877794;9251.44491330509;9252.67615633463;9256.305777066747;5110.310108135429;5114.974425127851;5118.411382690963;5118.74406279692;5122.359705036871;4266.402703621496;4610.654200934943;4639.164950308977;4705.200115980291;4707.552782485658;3558.0749005258817;3594.6225646307284;3620.5836328822525;3637.254362855608;3674.246779410268;909.9954500227589;1096.2381145104075;1148.26511032939;1152.4410660829492;1153.0544953138515;679.5141473846124;811.5860910935465;823.2097186700714;836.6653338664582;897.9595918183697;5095.0828850806465;5207.010667973073;5520.447955204528;5525.502704756511;5666.4050274721385;896.3501461440403;925.8842644669417;932.9346945713735;938;959.7187754347884;3551.9289614208087;3681.834317455721;3724.273766615484;3787.3561494545993;3787.5644300905196;9531.66474213822;9819.558119884623;9916.652917148009;9924.80150396988;9951.452670103214;9887.950560247153;9897.60409583623;9900.207983361313;9903.405795652285;9946.850797238047;7523.962380188064;7547.320741133324;7565.394768418513;7614.96192519045;7701.614919254015;5403.486668766461;5416.052190866504;5447.591430642638;5487.396386397413;5521.503064724194;9149.908500915171;9201.355905086579;9292.62829486813;9294.070592940652;9301.906980930104;8903.465792052497;9134.634614615341;9285.303602229726;9308.627654893728;9361.625534978797;7009.053777740144;7181.712731490682;7184.820379490555;7187.31720486553;7208.747693830691;7596.582187979714;7694.615269236628;7761.301482866344;7771.92228077712;7775.494592851446;6850.554713943578;6904.827379315558;6922.411595014481;6958.617276049866;7061.187963384276;6801.863962720817;6878.415334696407;6900.551464154814;6947.826304342229;6969.0940177776565;6460.612363258219;6521.9673901630185;6598.307177746267;6602.7689030883685;6603.042558828847;3690.4833323335292;4306.913861722685;4589.426321709786;4645.721256724607;4717.716936983792;4641.721496710074;4749.857504274877;4753.358296629911;4759.571638552547;4915.877103072452 07:54:10 INFO - PROCESS | 2525 | |4;prototype.html;278.457008832776;279.5499246213596;287.3477206740698;288.8252607172661;291.7520107908277;3823.8661646842297;5166.560842328402;5236.947630523694;5237.014901506143;5256.395514515827;4369.956300436995;5014.2979982802435;5092.541671249587;5093.5925125989925;5104.668196567221;3129.890453834116;3163.3515129398534;3659.579148397935;3943.6450719435247;3946.855411930551;3390.86436542538;3471.6701913318193;3911;3933.4296527003567;3937.5078115235597;3203.5423882133573;3554.413521768905;3734.3838266685966;3786.413105968579;3901.4733011043572;3210.4221240176757;3563.875264365761;3736.3648179809225;3895.3900886406177;3902.2195560887794;2986.268364250751;3152.7793054486197;3193.9779270633408;3377.831108444568;3378;4703.95296047042;4956.3804524434445;4970.850874473772;4990.451050384455;4997.600191984632;3434.8797792077157;3714.201446688975;4023.7988100594853;4429.357743127229;4465.642748580106;4742.573168414825;5116.590672746172;5370.489803468664;5390.649607775482;5405.837824865261;3701.592824789271;3713.5729391119826;3714.885534339687;3714.9071273218387;3718.888433347004;4845.491223421561;5300.337457817773;5427.9185812212845;5628.887422251532;5644.927463781909;3764.5294338207723;3769.1707824278615;3779.4519794629623;3784.6783023442763;3793.108619474421;3296.220041177737;3362.680545348188;3836.8848934532007;3842.9039274018373;3843.6540711336115;3603.8558457661925;3867.3425517662067;4260.68044896634;4451.755153466591;4459.509453960061;4513;5076.568491678248;5445.863853403696;5463.453654634504;5463.453654634584;1047.3611097230682;1162.5349860056044;1189.5301355964345;1241.6523373455448;1246.9812952805714;675.8544267466696;681.2880539835884;742.3504433620582;746.8244962433823;816.8978877640295;4179.561146079679;4506.662000349987;4724.622030237641;4893.681910675795;4895.290182923456;4505.707129036602;4797.592204662573;5125.615578831603;5323.866903327448;5347.81282655113;4389;4813.518648135228;4888.486708895586;5235.853300146921;5331.58778381836;2418.33495788656;2828.779408164581;2845.4593627210766;2855.257633015431;2864.8567571621334;5229.9801538699585;5251.264822924793;5638.267025286768;5702.429757024264;5747.540196784247;4393.890932352489;5538.9169162462595;5547.195656629847;5564.054110801174;5587.636803607834;4980.726060066731;5036.798528058836;5603.469814017306;5617.887642247132;5622.811005800623;4282.207791558571;4994.525520075587;5159.561437277724;5332.253484512249;5455.263539422286;5597.524210442158;5645.826356852559;5693.459121383462;5694.437503123528;5699.287589051369;5944.4352786485215;5953.7023148843255;5986.2217911671205;5997.670128142994;6059.969700151647;3633.9273214535033;3737.4954381158195;3737.570179429292;3773.415120656303;3782.5650050244576;5160.638755287094;5385.791825351587;5745.3105627324985;5748.120018987083;5776.480116789509;4389.495208051115;5179.808644011974;5534.544691523201;5579.804706835242;5611.8877622448135;4778.665493415428;5270.367555893317;5514.36584792754;5522.392536821027;5580.330360356783;4425.048614547888;5101.699066737958;5187.870303242298;5464.26232458613;5472.699001554953;4331.387072767492;5228;5405.216243644728;5421.7770714007065;5591.440855914376;4749.643776716691;5296.576273898156;5438.592105592017;5440.292761940922;5474.835754927359 07:54:10 INFO - PROCESS | 2525 | |5;yui.html;708.783820934615;715.4920006795178;731.4660297982474;746.734909107267;760.1752098972614;14154.150750954937;14650.413983440676;14691.632709182275;14692.706145877102;14700.852991470096;13173.670658233548;13292.202467851936;13297.933510332436;13304;13340.132891362055;645.1033064040987;667.4993754683987;671.4259308291414;808.2079562029215;824.5506199121463;794.7854079398588;813.8657121574932;814.9225823546753;833.5165603949725;838.3502785341378;872.7556284240391;873.6811063961671;876.7983363826323;878.7188099808064;878.8505953987806;682.3313153109931;870.8301881133182;871.3682580129356;871.5685735560938;872.7032808844991;467.13113608687814;505.5904717179097;519.8102692517242;522.6210997027163;524.5462674786321;13668.794968075486;14085.64785880351;14100.506482273071;14114.012019158663;14143.222122783243;12991.350432478339;13059;13118.016148788878;13146.342682865818;13294.3352832358;11952.521899124025;11994.70013249667;11998.760024799543;12002.819957700642;12366.04771902661;4331.696781225315;4408.426904502394;4415.646748260131;4436.645068394553;4534.9319760203625;81811;82385;87525.24949501039;87613.56193219057;87817.5609121963;10037;10191.490425478696;10504.632337868137;10628.309159904582;10762.300450470695;20294.898525507277;20307.086181121886;20321.390358289274;20325;20335.389938301876;7519.323260906435;7536.284053014955;7595.126560445509;7619.161892191854;7707.845843083107;4145.958540414617;4215.325547912319;4225.2817021105875;4226.197022565702;4233.872983810491;3165.4776961801504;3275.4759238522197;3281.819499927527;3283.6387997320276;3285.5564498792837;627.8085184018918;628.0767272109991;638.4828289085856;640.7725257533508;641.9711112999926;585.1544518171202;601.4436646102338;601.7322291580292;607.9513638908877;609.6444565405628;7727.729529466442;8053.436259461781;8090.738364113014;8619.6983105591;8627.568621568897;576.2940398012402;603.5202014398564;604.3563604760916;609.8018144103096;614.9200603921462;3058.4461974251303;4261.488621365456;4264.424302719155;4281.77343812021;4395.099004704028;60758;93231;116457.41771291259;119391.20913186308;123284;79001.60499197467;105134.84595461996;109311.45344273228;109937.45031274793;112443;59565;75561.6221918898;78167.4366512678;96400.55399169018;97453.5381969271;9337.346385752931;9569.234461243223;9692.893477109657;9712.514374281116;9729.318947673595;42857;42942.78528607337;50328.24507632315;53081.93836123333;56158.87682246414;59474.70262648659;75112.62443687746;75255;77075;79234.6038269805;11641.825372619249;11971.880281197076;12029.639110826689;12145.817812732992;12669.239845608925;13697.041207115406;13854.722905542034;13896.791548126585;14171.787423188867;14192.92903535517;12707.174033687781;12738;12871.613851584467;13018.739625207632;13460.394282257517;12751.61745147647;13026.762977715549;13056.412461439068;13165.407556659782;13414.061015728805;11189.48941892834;12392.442340094538;12908.290044047668;13102.279374634487;13128.60614181576;10557.735286814006;10559.678877661518;10717.249792514449;10876.347419154876;11263;10612.681619551426;11067.264129923693;11077.446127693422;11184.776304474028;11265.042471390023 07:54:10 INFO - PROCESS | 2525 | __end_tp_report 07:54:10 INFO - PROCESS | 2525 | __start_cc_report 07:54:10 INFO - PROCESS | 2525 | _x_x_mozilla_cycle_collect,3091 07:54:10 INFO - PROCESS | 2525 | __end_cc_report 07:54:10 INFO - PROCESS | 2525 | __startTimestamp1480175650219__endTimestamp 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | ------- Summary: start ------- 07:54:10 INFO - PROCESS | 2525 | Number of tests: 6 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | [#0] dojo.html Cycles:165 Average:5609.61 Median:5735.00 stddev:636.17 (11.1%) stddev-sans-first:596.89 07:54:10 INFO - PROCESS | 2525 | Values: 2737.6 3257.3 3280.0 3285.3 3337.6 5466.1 5486.7 5534.4 5604.4 5609.4 5542.3 5577.4 5624.3 5638.2 5698.0 5023.9 5063.9 5068.7 5122.6 5150.2 5124.4 5219.8 5224.4 5224.5 5261.4 5024.5 5146.8 5171.7 5174.8 5238.6 5051.4 5078.9 5092.1 5136.7 5137.7 5054.4 5104.6 5114.6 5114.7 5155.7 5582.2 5584.7 5584.9 5613.0 5615.1 5913.4 5949.8 5974.9 6063.3 6121.9 6161.0 6208.0 6212.3 6214.7 6224.3 5669.1 5677.8 5679.1 5685.2 5714.5 6090.8 6107.4 6186.4 6277.6 6291.9 5845.2 5883.6 5921.6 5961.5 6103.8 6149.2 6181.8 6193.7 6203.4 6211.8 6022.7 6094.2 6103.7 6126.3 6127.9 5884.9 5969.0 5979.3 6131.7 6151.2 4844.1 4846.7 4852.7 4855.3 4858.1 4313.6 4343.3 4377.1 4388.4 4424.6 4957.7 5318.4 5604.3 5605.0 5647.2 6158.6 6167.9 6187.7 6195.1 6201.9 5452.6 5521.5 5532.2 5548.1 5615.5 5276.7 5333.9 5362.3 5368.4 5376.4 6228.4 6272.9 6275.8 6277.7 6309.3 5925.9 5978.4 6171.1 6191.0 6198.0 6182.9 6187.4 6209.9 6234.0 6274.8 6051.4 6057.9 6064.2 6075.1 6116.8 6092.3 6099.4 6119.6 6136.0 6142.0 5637.7 5718.0 5787.0 5847.0 5868.9 5694.9 5831.5 5838.9 5840.0 5842.6 4926.5 5734.2 5735.4 5743.2 5748.8 5781.9 5813.7 5832.2 5839.0 5850.1 5705.5 5734.9 5735.0 5735.5 5745.1 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | [#1] ext.html Cycles:180 Average:66902.46 Median:35948.73 stddev:145228.70 (404.0%) stddev-sans-first:145550.45 07:54:10 INFO - PROCESS | 2525 | Values: 468.0 492.3 501.1 507.8 513.1 37295.6 38401.0 38766.8 38810.8 40029.4 39189.0 39608.2 39644.4 39765.6 39856.4 8366.4 8590.0 9133.2 9264.5 9336.7 10852.9 11088.7 11165.0 11300.3 11308.3 11013.0 11065.7 11066.2 11112.4 11145.7 10954.2 10995.8 11009.6 11017.4 11029.6 10859.9 10908.9 10920.8 10929.4 10946.5 37262.9 37566.8 37573.0 37573.8 37598.8 3223.6 3406.8 3581.5 3787.1 3877.3 22259.4 29002.3 29209.0 29226.7 29515.9 3134.5 3135.8 3151.5 3258.4 3299.1 475315.2 476722.6 477763.0 478271.0 481468.0 56449.0 56783.7 56920.0 56968.7 57070.0 59563.0 59609.7 59705.7 59743.7 59774.7 14736.0 15176.8 15196.0 15217.0 15227.5 10692.6 10947.0 10991.7 11707.9 11769.8 14352.8 14500.1 14533.7 15600.8 15847.6 6162.9 6229.5 6275.5 6300.5 6309.7 832.0 935.6 1040.8 1046.6 1106.7 27756.3 28422.0 28672.0 29238.0 29348.7 1036.8 1061.9 1108.1 1108.5 1135.3 11718.9 14542.3 14673.2 14929.3 14984.8 630646.0 637884.0 638023.0 638376.0 639476.0 53830.7 54019.5 54038.0 54252.7 54320.7 1327.7 1352.9 1362.0 1365.4 1367.1 27914.7 28387.9 29036.9 29080.6 29131.0 47666.0 50040.0 52205.7 52399.0 55040.4 498091.0 502841.0 503586.0 504855.0 504945.0 24224.8 24564.3 24637.0 24654.3 24705.9 25033.9 39131.8 41807.1 43013.9 45128.8 30402.5 35410.0 36783.4 36997.9 38029.0 35910.8 36358.0 37195.0 37442.0 37718.2 35684.0 35986.6 36324.0 38491.2 39490.0 36551.3 38487.6 38844.8 39421.0 39705.4 30281.7 30292.8 30429.2 30872.5 31093.0 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | [#2] jquery.html Cycles:180 Average:33428.82 Median:25116.62 stddev:92866.17 (369.7%) stddev-sans-first:93093.46 07:54:10 INFO - PROCESS | 2525 | Values: 343.2 370.1 370.7 379.9 398.3 12912.4 14300.1 15619.6 19620.7 20261.8 19004.0 19907.0 20135.6 20253.7 20536.0 5472.5 5849.3 5850.5 5850.6 5853.8 4664.3 5332.4 5667.4 5723.3 5730.4 5690.6 5695.6 5697.4 5700.0 5702.4 5390.3 5616.7 5695.0 5698.3 5710.0 4812.6 5021.2 5034.1 5035.3 5038.7 24529.4 24679.0 25110.5 25122.7 25453.6 2310.5 2343.3 2346.7 2373.3 2379.5 14607.3 15227.2 15401.0 15468.8 15500.8 1808.6 1820.7 1866.5 1872.3 1918.0 117489.0 121804.0 122144.0 122765.0 123352.0 8750.3 10499.6 11080.4 11125.7 11253.1 13799.6 13816.6 13840.0 13854.4 13878.9 7985.8 8329.6 8342.1 8442.1 8445.6 8193.4 8203.6 8210.8 8356.8 8393.5 6566.8 6687.2 6706.2 6752.3 6856.9 1525.5 1678.5 1766.2 1803.1 1803.4 866.4 920.2 979.0 981.5 984.3 20397.8 22063.8 22142.7 22165.4 22196.3 952.7 953.5 961.8 1015.9 1065.2 10799.2 11126.1 11173.3 11699.8 11714.6 485268.0 534967.0 572320.0 587673.0 589712.7 90009.1 109784.5 112633.0 122442.4 131356.0 916.8 943.7 996.1 996.2 1000.4 18808.9 18841.2 19266.5 19300.0 19372.8 51130.0 53512.3 53650.5 54282.6 54527.9 71103.0 77418.6 79043.0 79052.0 79303.6 6541.3 7919.7 7952.4 8177.2 8400.7 9452.7 12207.7 12471.9 13017.8 13132.2 10780.7 10788.9 10807.0 11012.7 11113.5 10570.8 10639.8 11054.0 11074.2 11240.7 11015.6 11193.3 11321.8 11403.6 11538.8 7039.6 7901.5 8114.2 8145.8 8181.0 7950.2 9520.8 10473.9 10761.7 10891.1 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | [#3] mootools.html Cycles:180 Average:5307.72 Median:5305.25 stddev:2920.29 (55.0%) stddev-sans-first:2912.98 07:54:10 INFO - PROCESS | 2525 | Values: 1304.7 1433.5 1589.0 1767.9 1825.3 7370.4 7652.2 7832.3 8266.2 8277.9 7526.8 7835.4 8045.5 8055.3 8147.4 2276.3 2312.8 2314.6 2316.6 2319.4 2061.9 2305.2 2326.3 2351.7 2353.8 2078.4 2215.2 2298.5 2307.2 2307.6 2278.0 2296.9 2316.1 2319.9 2334.8 1944.3 1955.8 2328.4 2328.4 2334.4 7163.3 7786.8 7999.0 8082.2 8106.5 4737.8 5103.7 5109.8 5111.9 5119.2 3230.4 3439.9 3460.4 3529.2 3541.0 1027.1 1055.5 1069.8 1078.2 1097.9 10457.1 10566.3 10706.6 10707.9 10723.1 3840.2 3859.8 4247.8 4514.7 4584.2 9241.7 9244.2 9251.4 9252.7 9256.3 5110.3 5115.0 5118.4 5118.7 5122.4 4266.4 4610.7 4639.2 4705.2 4707.6 3558.1 3594.6 3620.6 3637.3 3674.2 910.0 1096.2 1148.3 1152.4 1153.1 679.5 811.6 823.2 836.7 898.0 5095.1 5207.0 5520.4 5525.5 5666.4 896.4 925.9 932.9 938.0 959.7 3551.9 3681.8 3724.3 3787.4 3787.6 9531.7 9819.6 9916.7 9924.8 9951.5 9888.0 9897.6 9900.2 9903.4 9946.9 7524.0 7547.3 7565.4 7615.0 7701.6 5403.5 5416.1 5447.6 5487.4 5521.5 9149.9 9201.4 9292.6 9294.1 9301.9 8903.5 9134.6 9285.3 9308.6 9361.6 7009.1 7181.7 7184.8 7187.3 7208.7 7596.6 7694.6 7761.3 7771.9 7775.5 6850.6 6904.8 6922.4 6958.6 7061.2 6801.9 6878.4 6900.6 6947.8 6969.1 6460.6 6522.0 6598.3 6602.8 6603.0 3690.5 4306.9 4589.4 4645.7 4717.7 4641.7 4749.9 4753.4 4759.6 4915.9 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | [#4] prototype.html Cycles:180 Average:4322.47 Median:4891.08 stddev:1381.33 (28.2%) stddev-sans-first:1351.45 07:54:10 INFO - PROCESS | 2525 | Values: 278.5 279.5 287.3 288.8 291.8 3823.9 5166.6 5236.9 5237.0 5256.4 4370.0 5014.3 5092.5 5093.6 5104.7 3129.9 3163.4 3659.6 3943.6 3946.9 3390.9 3471.7 3911.0 3933.4 3937.5 3203.5 3554.4 3734.4 3786.4 3901.5 3210.4 3563.9 3736.4 3895.4 3902.2 2986.3 3152.8 3194.0 3377.8 3378.0 4704.0 4956.4 4970.9 4990.5 4997.6 3434.9 3714.2 4023.8 4429.4 4465.6 4742.6 5116.6 5370.5 5390.6 5405.8 3701.6 3713.6 3714.9 3714.9 3718.9 4845.5 5300.3 5427.9 5628.9 5644.9 3764.5 3769.2 3779.5 3784.7 3793.1 3296.2 3362.7 3836.9 3842.9 3843.7 3603.9 3867.3 4260.7 4451.8 4459.5 4513.0 5076.6 5445.9 5463.5 5463.5 1047.4 1162.5 1189.5 1241.7 1247.0 675.9 681.3 742.4 746.8 816.9 4179.6 4506.7 4724.6 4893.7 4895.3 4505.7 4797.6 5125.6 5323.9 5347.8 4389.0 4813.5 4888.5 5235.9 5331.6 2418.3 2828.8 2845.5 2855.3 2864.9 5230.0 5251.3 5638.3 5702.4 5747.5 4393.9 5538.9 5547.2 5564.1 5587.6 4980.7 5036.8 5603.5 5617.9 5622.8 4282.2 4994.5 5159.6 5332.3 5455.3 5597.5 5645.8 5693.5 5694.4 5699.3 5944.4 5953.7 5986.2 5997.7 6060.0 3633.9 3737.5 3737.6 3773.4 3782.6 5160.6 5385.8 5745.3 5748.1 5776.5 4389.5 5179.8 5534.5 5579.8 5611.9 4778.7 5270.4 5514.4 5522.4 5580.3 4425.0 5101.7 5187.9 5464.3 5472.7 4331.4 5228.0 5405.2 5421.8 5591.4 4749.6 5296.6 5438.6 5440.3 5474.8 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - PROCESS | 2525 | [#5] yui.html Cycles:180 Average:20192.88 Median:23569.39 stddev:29883.81 (126.8%) stddev-sans-first:29931.83 07:54:10 INFO - PROCESS | 2525 | Values: 708.8 715.5 731.5 746.7 760.2 14154.2 14650.4 14691.6 14692.7 14700.9 13173.7 13292.2 13297.9 13304.0 13340.1 645.1 667.5 671.4 808.2 824.6 794.8 813.9 814.9 833.5 838.4 872.8 873.7 876.8 878.7 878.9 682.3 870.8 871.4 871.6 872.7 467.1 505.6 519.8 522.6 524.5 13668.8 14085.6 14100.5 14114.0 14143.2 12991.4 13059.0 13118.0 13146.3 13294.3 11952.5 11994.7 11998.8 12002.8 12366.0 4331.7 4408.4 4415.6 4436.6 4534.9 81811.0 82385.0 87525.2 87613.6 87817.6 10037.0 10191.5 10504.6 10628.3 10762.3 20294.9 20307.1 20321.4 20325.0 20335.4 7519.3 7536.3 7595.1 7619.2 7707.8 4146.0 4215.3 4225.3 4226.2 4233.9 3165.5 3275.5 3281.8 3283.6 3285.6 627.8 628.1 638.5 640.8 642.0 585.2 601.4 601.7 608.0 609.6 7727.7 8053.4 8090.7 8619.7 8627.6 576.3 603.5 604.4 609.8 614.9 3058.4 4261.5 4264.4 4281.8 4395.1 60758.0 93231.0 116457.4 119391.2 123284.0 79001.6 105134.8 109311.5 109937.5 112443.0 59565.0 75561.6 78167.4 96400.6 97453.5 9337.3 9569.2 9692.9 9712.5 9729.3 42857.0 42942.8 50328.2 53081.9 56158.9 59474.7 75112.6 75255.0 77075.0 79234.6 11641.8 11971.9 12029.6 12145.8 12669.2 13697.0 13854.7 13896.8 14171.8 14192.9 12707.2 12738.0 12871.6 13018.7 13460.4 12751.6 13026.8 13056.4 13165.4 13414.1 11189.5 12392.4 12908.3 13102.3 13128.6 10557.7 10559.7 10717.2 10876.3 11263.0 10612.7 11067.3 11077.4 11184.8 11265.0 07:54:10 INFO - PROCESS | 2525 | -------- Summary: end -------- 07:54:10 INFO - PROCESS | 2525 | 07:54:10 INFO - TEST-INFO | 2525: exit 0 07:54:10 INFO - TEST-OK | dromaeo_css | took 1120024ms 07:54:10 INFO - TEST-START | kraken 07:54:10 INFO - operating with platform_type : mac_ 07:54:10 INFO - Initialising browser for kraken test... 07:54:10 INFO - TEST-INFO | started process 2527 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpYsozz0/profile http://localhost:56619/getInfo.html) 07:54:13 INFO - PROCESS | 2527 | __metrics Screen width/height:1600/1200 07:54:13 INFO - PROCESS | 2527 | colorDepth:24 07:54:13 INFO - PROCESS | 2527 | Browser inner width/height: 1024/689 07:54:13 INFO - PROCESS | 2527 | __metrics 07:54:13 INFO - PROCESS | 2527 | 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" 07:54:13 INFO - PROCESS | 2527 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:14 INFO - TEST-INFO | 2527: exit 0 07:54:14 INFO - Browser initialized. 07:54:14 INFO - Running cycle 1/1 for kraken test... 07:54:14 INFO - TEST-INFO | started process 2528 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpYsozz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:26 INFO - PROCESS | 2528 | RSS: Main: 237015040 07:54:26 INFO - PROCESS | 2528 | 07:54:29 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56619/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:30 INFO - PROCESS | 2528 | RSS: Main: 295067648 07:54:30 INFO - PROCESS | 2528 | 07:54:33 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56619/tests/kraken/driver.html?testName=audio-dft) 07:54:33 INFO - PROCESS | 2528 | RSS: Main: 297324544 07:54:33 INFO - PROCESS | 2528 | 07:54:37 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56619/tests/kraken/driver.html?testName=audio-fft) 07:54:38 INFO - PROCESS | 2528 | RSS: Main: 389529600 07:54:38 INFO - PROCESS | 2528 | 07:54:40 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56619/tests/kraken/driver.html?testName=audio-oscillator) 07:54:40 INFO - PROCESS | 2528 | RSS: Main: 292683776 07:54:40 INFO - PROCESS | 2528 | 07:54:42 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56619/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:43 INFO - PROCESS | 2528 | RSS: Main: 296980480 07:54:43 INFO - PROCESS | 2528 | 07:54:46 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56619/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:46 INFO - PROCESS | 2528 | RSS: Main: 337887232 07:54:46 INFO - PROCESS | 2528 | 07:54:49 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56619/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:50 INFO - PROCESS | 2528 | RSS: Main: 337092608 07:54:50 INFO - PROCESS | 2528 | 07:54:52 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56619/tests/kraken/driver.html?testName=json-parse-financial) 07:54:53 INFO - PROCESS | 2528 | RSS: Main: 337182720 07:54:53 INFO - PROCESS | 2528 | 07:54:55 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56619/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:55 INFO - PROCESS | 2528 | RSS: Main: 309989376 07:54:55 INFO - PROCESS | 2528 | 07:54:57 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:58 INFO - PROCESS | 2528 | RSS: Main: 313499648 07:54:58 INFO - PROCESS | 2528 | 07:55:00 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:01 INFO - PROCESS | 2528 | RSS: Main: 315346944 07:55:01 INFO - PROCESS | 2528 | 07:55:04 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:05 INFO - PROCESS | 2528 | RSS: Main: 334163968 07:55:05 INFO - PROCESS | 2528 | 07:55:07 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:08 INFO - PROCESS | 2528 | RSS: Main: 328261632 07:55:08 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | Cycle 1(1): loaded http://localhost:56619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56619/tests/kraken/driver.html?testName=ai-astar) 07:55:10 INFO - PROCESS | 2528 | RSS: Main: 372326400 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | __start_tp_report 07:55:10 INFO - PROCESS | 2528 | _x_x_mozilla_page_load 07:55:10 INFO - PROCESS | 2528 | _x_x_mozilla_page_load_details 07:55:10 INFO - PROCESS | 2528 | |i|pagename|runs| 07:55:10 INFO - PROCESS | 2528 | |0;ai-astar;103;113;113;114;115;113;113;113;114;114 07:55:10 INFO - PROCESS | 2528 | |1;audio-beat-detection;176;141;141;152;117;116;119;117;132;115 07:55:10 INFO - PROCESS | 2528 | |2;audio-dft;196;255;184;186;185;185;181;225;257;183 07:55:10 INFO - PROCESS | 2528 | |3;audio-fft;79;59;62;76;66;82;81;81;79;59 07:55:10 INFO - PROCESS | 2528 | |4;audio-oscillator;90;70;85;69;68;68;83;67;69;83 07:55:10 INFO - PROCESS | 2528 | |5;imaging-gaussian-blur;87;86;87;83;87;84;87;86;86;83 07:55:10 INFO - PROCESS | 2528 | |6;imaging-darkroom;94;93;94;95;93;94;94;94;94;93 07:55:10 INFO - PROCESS | 2528 | |7;imaging-desaturate;88;86;87;87;86;87;85;89;87;86 07:55:10 INFO - PROCESS | 2528 | |8;json-parse-financial;59;58;58;58;58;56;57;55;55;56 07:55:10 INFO - PROCESS | 2528 | |9;json-stringify-tinderbox;65;68;78;78;76;72;72;71;72;73 07:55:10 INFO - PROCESS | 2528 | |10;stanford-crypto-aes;88;87;87;88;87;88;88;85;89;81 07:55:10 INFO - PROCESS | 2528 | |11;stanford-crypto-ccm;152;154;157;160;152;152;173;157;203;148 07:55:10 INFO - PROCESS | 2528 | |12;stanford-crypto-pbkdf2;176;171;179;177;175;175;172;173;174;174 07:55:10 INFO - PROCESS | 2528 | |13;stanford-crypto-sha256-iterative;70;70;69;67;68;70;69;69;68;68 07:55:10 INFO - PROCESS | 2528 | __end_tp_report 07:55:10 INFO - PROCESS | 2528 | __start_cc_report 07:55:10 INFO - PROCESS | 2528 | _x_x_mozilla_cycle_collect,2022 07:55:10 INFO - PROCESS | 2528 | __end_cc_report 07:55:10 INFO - PROCESS | 2528 | __startTimestamp1480175710528__endTimestamp 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | ------- Summary: start ------- 07:55:10 INFO - PROCESS | 2528 | Number of tests: 14 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:3.41 (3.0%) stddev-sans-first:0.73 07:55:10 INFO - PROCESS | 2528 | Values: 103.0 113.0 113.0 114.0 115.0 113.0 113.0 113.0 114.0 114.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:136.50 stddev:20.16 (14.8%) stddev-sans-first:13.99 07:55:10 INFO - PROCESS | 2528 | Values: 176.0 141.0 141.0 152.0 117.0 116.0 119.0 117.0 132.0 115.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#2] audio-dft Cycles:10 Average:203.70 Median:191.00 stddev:30.42 (15.9%) stddev-sans-first:32.14 07:55:10 INFO - PROCESS | 2528 | Values: 196.0 255.0 184.0 186.0 185.0 185.0 181.0 225.0 257.0 183.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#3] audio-fft Cycles:10 Average:72.40 Median:79.00 stddev:9.71 (12.3%) stddev-sans-first:10.00 07:55:10 INFO - PROCESS | 2528 | Values: 79.0 59.0 62.0 76.0 66.0 82.0 81.0 81.0 79.0 59.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.50 stddev:8.89 (11.6%) stddev-sans-first:7.65 07:55:10 INFO - PROCESS | 2528 | Values: 90.0 70.0 85.0 69.0 68.0 68.0 83.0 67.0 69.0 83.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:1.65 (1.9%) stddev-sans-first:1.67 07:55:10 INFO - PROCESS | 2528 | Values: 87.0 86.0 87.0 83.0 87.0 84.0 87.0 86.0 86.0 83.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:55:10 INFO - PROCESS | 2528 | Values: 94.0 93.0 94.0 95.0 93.0 94.0 94.0 94.0 94.0 93.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:1.14 (1.3%) stddev-sans-first:1.12 07:55:10 INFO - PROCESS | 2528 | Values: 88.0 86.0 87.0 87.0 86.0 87.0 85.0 89.0 87.0 86.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:58.00 stddev:1.41 (2.4%) stddev-sans-first:1.30 07:55:10 INFO - PROCESS | 2528 | Values: 59.0 58.0 58.0 58.0 58.0 56.0 57.0 55.0 55.0 56.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.50 stddev:4.12 (5.7%) stddev-sans-first:3.35 07:55:10 INFO - PROCESS | 2528 | Values: 65.0 68.0 78.0 78.0 76.0 72.0 72.0 71.0 72.0 73.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:88.00 stddev:2.30 (2.6%) stddev-sans-first:2.40 07:55:10 INFO - PROCESS | 2528 | Values: 88.0 87.0 87.0 88.0 87.0 88.0 88.0 85.0 89.0 81.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:157.00 stddev:16.34 (10.4%) stddev-sans-first:17.01 07:55:10 INFO - PROCESS | 2528 | Values: 152.0 154.0 157.0 160.0 152.0 152.0 173.0 157.0 203.0 148.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.00 stddev:2.37 (1.4%) stddev-sans-first:2.46 07:55:10 INFO - PROCESS | 2528 | Values: 176.0 171.0 179.0 177.0 175.0 175.0 172.0 173.0 174.0 174.0 07:55:10 INFO - PROCESS | 2528 | 07:55:10 INFO - PROCESS | 2528 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 07:55:10 INFO - PROCESS | 2528 | Values: 70.0 70.0 69.0 67.0 68.0 70.0 69.0 69.0 68.0 68.0 07:55:10 INFO - PROCESS | 2528 | -------- Summary: end -------- 07:55:10 INFO - PROCESS | 2528 | 07:55:11 INFO - TEST-INFO | 2528: exit 0 07:55:11 INFO - TEST-OK | kraken | took 60684ms 07:55:11 INFO - SUITE-END | took 1180s 07:55:11 INFO - Completed test suite (00:19:40) 07:55:11 INFO - javascript benchmark 07:55:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2737.575675770255, 3257.267114899147, 3280.0487858521014, 3285.342931413718, 3337.6315710558674, 5466.125419932811, 5486.6707997520125, 5534.391216966131, 5604.355499117598, 5609.35492418372, 5542.314360949974, 5577.358603760569, 5624.29696287964, 5638.210650508932, 5698.031334673115, 5023.874403139914, 5063.873403164914, 5068.670536415139, 5122.564582010534, 5150.227465880111, 5124.359455068116, 5219.765110570033, 5224.3730752309775, 5224.45143259958, 5261.368635763713, 5024.522670346311, 5146.819861304836, 5171.663841850286, 5174.844754657329, 5238.633295669305, 5051.393832740095, 5078.873028174288, 5092.10888094582, 5136.717480538568, 5137.74311284438, 5054.393472783253, 5104.566111880495, 5114.565261952738, 5114.746887012706, 5155.71643559604, 5582.190582365534, 5584.748686309085, 5584.944150558524, 5613.045782217033, 5615.129654903497, 5913.379095194986, 5949.8215053548465, 5974.8506287342725, 6063.272407311107, 6121.9081713773885, 6161.045038019114, 6208.037754148069, 6212.347703491158, 6214.720337584819, 6224.253089629274, 5669.121286200645, 5677.829665110054, 5679.062954612443, 5685.1756495307945, 5714.542836573064, 6090.786822461281, 6107.401224262618, 6186.350433204539, 6277.591956522811, 6291.905621415683, 5845.210896528999, 5883.588148829541, 5921.644701317935, 5961.463468287875, 6103.816885493442, 6149.200603921461, 6181.752729890754, 6193.721282542207, 6203.4416902479, 6211.782587609412, 6022.728977196037, 6094.2077529920825, 6103.6948152592195, 6126.27339965311, 6127.938720612826, 5884.941150588525, 5968.970155149196, 5979.312379076462, 6131.724815773889, 6151.169592105098, 4844.0554091951735, 4846.684965477232, 4852.708837469692, 4855.295982082578, 4858.125537403231, 4313.61177494027, 4343.261645520269, 4377.124575084996, 4388.385626012361, 4424.6239069678795, 4957.677750946177, 5318.361796584435, 5604.32748070226, 5604.971975140098, 5647.209390685307, 6158.630482171084, 6167.907481387782, 6187.659678717624, 6195.132681424604, 6201.937980620226, 5452.563794896399, 5521.503064724194, 5532.170174473861, 5548.112302031655, 5615.466530679579, 5276.709780962084, 5333.946660533345, 5362.302900622894, 5368.436314187033, 5376.435474275223, 6228.439440450381, 6272.905906411499, 6275.843103922439, 6277.686115694197, 6309.33751956038, 5925.9407405925385, 5978.372270911492, 6171.074338849208, 6191.040388739752, 6197.96901015492, 6182.938170618237, 6187.443130118311, 6209.875802484015, 6233.968830156002, 6274.843128921813, 6051.425114614105, 6057.896723689206, 6064.151018857276, 6075.119107729266, 6116.785912493041, 6092.299385570716, 6099.432368409277, 6119.571629985859, 6136.0, 6141.955867502446, 5637.689927053887, 5717.9993501136305, 5787.045137552425, 5847.0, 5868.853278668067, 5694.861027794541, 5831.504322132497, 5838.883222335445, 5840.0, 5842.561807864342, 4926.507349265188, 5734.22587950638, 5735.426457354231, 5743.195952566561, 5748.827535173951, 5781.913271300849, 5813.651180929158, 5832.212651292021, 5839.036558967723, 5850.12248162779, 5705.515031222227, 5734.885302293847, 5735.0, 5735.512481439125, 5745.1382292656435], "value": 5567.327839830945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.99848324585395, 492.2591499792811, 501.0605115408611, 507.83241530295004, 513.0790231534396, 37295.62704372955, 38401.0, 38766.8061659692, 38810.80594597023, 40029.39955900664, 39189.0, 39608.20783584326, 39644.40533392001, 39765.60234397662, 39856.40215396771, 8366.406414011646, 8590.0, 9133.223675987549, 9264.536773161348, 9336.673216437426, 10852.891471085306, 11088.667339979813, 11165.0, 11300.265482743636, 11308.321500709942, 11013.0, 11065.723356916062, 11066.170037247199, 11112.388818614972, 11145.72135696606, 10954.178436617245, 10995.835062474069, 11009.61466348674, 11017.394043327613, 11029.558817647285, 10859.945700271526, 10908.945455272753, 10920.781584368347, 10929.398883061429, 10946.507407166697, 37262.88211353664, 37566.812165938994, 37573.0, 37573.81213093917, 37598.81200594007, 3223.597050368704, 3406.812625305607, 3581.4627805829073, 3787.110029143149, 3877.3214687429586, 22259.44351391212, 29002.27494312638, 29209.0, 29226.707732922612, 29515.852420737974, 3134.4828103362915, 3135.843207839599, 3151.543026261202, 3258.3809076275434, 3299.1257316811066, 475315.246847534, 476722.61638691934, 477763.0, 478271.0, 481468.0, 56449.0, 56783.71608141933, 56920.0, 56968.715156423954, 57070.0, 59563.0, 59609.701951489966, 59705.701471492364, 59743.701281494185, 59774.70112649496, 14736.010638563872, 15176.848231517544, 15196.0, 15217.010894291836, 15227.467038653594, 10692.62575809843, 10947.014768670859, 10991.670249892515, 11707.941460292814, 11769.764604707858, 14352.842374677553, 14500.129992200502, 14533.709325813425, 15600.765988510182, 15847.603809904844, 6162.859870923893, 6229.501639868799, 6275.52933529978, 6300.487882908161, 6309.684515774285, 831.9708810191614, 935.6491315756591, 1040.776233109885, 1046.6284469013542, 1106.7343837478948, 27756.30609234785, 28422.0, 28672.0, 29238.0, 29348.706512934597, 1036.8237399642078, 1061.9256652034437, 1108.146727020206, 1108.4623957380663, 1135.2961164078324, 11718.941405292919, 14542.272886355851, 14673.192974386511, 14929.253537323091, 14984.775228371584, 630646.0, 637884.0, 638023.0, 638376.0, 639476.0, 53830.7308463463, 54019.45980540223, 54038.0, 54252.728736356854, 54320.72839635856, 1327.6614463311987, 1352.8782409583184, 1361.9931900340632, 1365.3992243412868, 1367.0840536840142, 27914.74383652781, 28387.858060709565, 29036.854815725786, 29080.56379154272, 29131.0, 47666.0, 50040.0, 52205.7389713049, 52398.95202096013, 55040.44959550353, 498091.0, 502841.0, 503586.0, 504855.0, 504945.0, 24224.757752422956, 24564.263072107864, 24637.0, 24654.260372188863, 24705.87647061753, 25033.87483062573, 39131.80434097811, 41807.11867965888, 43013.92465188395, 45128.77435612801, 30402.543961840147, 35410.0, 36783.44824827576, 36997.890063298146, 38029.0, 35910.82044589865, 36358.0, 37195.0, 37442.0, 37718.2456350877, 35684.0, 35986.64013359833, 36324.0, 38491.23017539577, 39490.01274968034, 36551.26897462089, 38487.6151238484, 38844.80577597207, 39421.0, 39705.41178352833, 30281.69718302789, 30292.84853575718, 30429.239269017566, 30872.476514091366, 31093.0], "value": 19468.376148634772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.17295318282913, 370.1357330632972, 370.7478914338249, 379.8803376936265, 398.3268276612525, 12912.418941147647, 14300.070495417804, 15619.609509762247, 19620.705689414634, 20261.797382026212, 19004.0, 19907.0, 20135.590508664398, 20253.696194557095, 20536.0, 5472.50747432731, 5849.2980842298775, 5850.4734573888345, 5850.64896106235, 5853.824385268449, 4664.323673067403, 5332.386775520807, 5667.4049224831415, 5723.2559767230205, 5730.398308177644, 5690.57320700947, 5695.601307908448, 5697.430256974311, 5699.971500142494, 5702.372738998728, 5390.326209223847, 5616.691081990489, 5695.0, 5698.287714035746, 5710.0, 4812.590929770939, 5021.196608542652, 5034.0686972910125, 5035.320231768701, 5038.672486288379, 24529.386765331008, 24679.0, 25110.49779004428, 25122.748772512223, 25453.61819572708, 2310.514791893704, 2343.27358518858, 2346.6949296591333, 2373.299876536426, 2379.512199998996, 14607.342669579895, 15227.238638068053, 15400.998935069296, 15468.845311546853, 15500.844991550053, 1808.620189760152, 1820.7086866101492, 1866.4773863318292, 1872.2739276212335, 1918.0409795102448, 117489.0, 121804.0, 122144.0, 122765.0, 123352.0, 8750.256228220545, 10499.632512862014, 11080.390578518098, 11125.72185695348, 11253.099752019818, 13799.585072612253, 13816.585502434944, 13840.031197816057, 13854.376553055137, 13878.861211387959, 7985.800354991172, 8329.583520824055, 8342.124076971952, 8442.113578074213, 8445.619947102396, 8193.385496087818, 8203.630836612367, 8210.753677389688, 8356.791080223044, 8393.496390216607, 6566.80299591013, 6687.230968438595, 6706.228783689938, 6752.257251702407, 6856.931430685729, 1525.5499627609881, 1678.479671301876, 1766.2493440287826, 1803.107461806388, 1803.449947765944, 866.3935245328296, 920.1902325953118, 978.9951050244846, 981.4503877828439, 984.3404918704342, 20397.79602203959, 22063.786491742787, 22142.667859982113, 22165.445863853533, 22196.334109976728, 952.7332346942867, 953.4803532074897, 961.8457850579333, 1015.94920253987, 1065.1851333729703, 10799.192210025292, 11126.109911207084, 11173.273737207055, 11699.76600467986, 11714.648560543197, 485268.0, 534967.0, 572320.0, 587673.0, 589712.7201095968, 90009.09990900138, 109784.4510777441, 112633.0, 122442.38778806049, 131356.0, 916.8074704312036, 943.7216021273741, 996.1333639733479, 996.1980605612407, 1000.3597697473623, 18808.905955470134, 18841.24635014639, 19266.518337041125, 19300.0, 19372.8062719371, 51130.0, 53512.25414220967, 53650.46349536454, 54282.64293392539, 54527.90944181174, 71103.0, 77418.6129069351, 79043.0, 79052.0, 79303.60348198222, 6541.34586541342, 7919.683212671659, 7952.403569732409, 8177.182281771775, 8400.747977560683, 9452.669156579486, 12207.694807629525, 12471.939885109867, 13017.804732928824, 13132.212067275994, 10780.730481738019, 10788.892111079103, 10806.973337532922, 11012.724681883017, 11113.499892505019, 10570.788584228427, 10639.787204255717, 11054.00513953748, 11074.224804263624, 11240.718982025515, 11015.559377624806, 11193.328400296008, 11321.7735645285, 11403.574553180852, 11538.76922461563, 7039.612821294878, 7901.525908445512, 8114.188581141839, 8145.79635509117, 8180.9590952044855, 7950.24472675095, 9520.761980950254, 10473.947630262104, 10761.677149685522, 10891.0742586881], "value": 9500.292094260514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.6562041097668, 1433.5269361110834, 1588.9920550397246, 1767.8674099442544, 1825.3337531800896, 7370.373518250942, 7652.158262591124, 7832.295093441589, 8266.173382661731, 8277.91722082779, 7526.849463010736, 7835.412344074189, 8045.477043992137, 8055.31529819966, 8147.429679922408, 2276.3398614401844, 2312.780285872848, 2314.5833749925005, 2316.6293393057113, 2319.373769082347, 2061.917523299066, 2305.227748704186, 2326.255598208574, 2351.694279743631, 2353.8469999450067, 2078.418042947977, 2215.1582398688474, 2298.5058212484314, 2307.1809507624803, 2307.607706689867, 2278.020451205981, 2296.850704704189, 2316.0851463671925, 2319.930402087923, 2334.7665233476687, 1944.2903340280836, 1955.7750858651295, 2328.394617399488, 2328.429534763977, 2334.3580515358244, 7163.31948464895, 7786.7663970080985, 7998.960005199995, 8082.1513741057515, 8106.47307924983, 4737.786799594027, 5103.744812759347, 5109.770060347293, 5111.872203194913, 5119.206522988943, 3230.353929214167, 3439.8796042138406, 3460.4290292101773, 3529.1530032791943, 3540.964590354089, 1027.0756319312604, 1055.4828134214256, 1069.7860427914447, 1078.229066217658, 1097.8572785537829, 10457.111145552637, 10566.260361774679, 10706.571737130584, 10707.946460267727, 10723.14214862809, 3840.1935593525113, 3859.7684138951754, 4247.830086796494, 4514.6614003949835, 4584.235069498267, 9241.676541321156, 9244.168024877794, 9251.44491330509, 9252.67615633463, 9256.305777066747, 5110.310108135429, 5114.974425127851, 5118.411382690963, 5118.74406279692, 5122.359705036871, 4266.402703621496, 4610.654200934943, 4639.164950308977, 4705.200115980291, 4707.552782485658, 3558.0749005258817, 3594.6225646307284, 3620.5836328822525, 3637.254362855608, 3674.246779410268, 909.9954500227589, 1096.2381145104075, 1148.26511032939, 1152.4410660829492, 1153.0544953138515, 679.5141473846124, 811.5860910935465, 823.2097186700714, 836.6653338664582, 897.9595918183697, 5095.0828850806465, 5207.010667973073, 5520.447955204528, 5525.502704756511, 5666.4050274721385, 896.3501461440403, 925.8842644669417, 932.9346945713735, 938.0, 959.7187754347884, 3551.9289614208087, 3681.834317455721, 3724.273766615484, 3787.3561494545993, 3787.5644300905196, 9531.66474213822, 9819.558119884623, 9916.652917148009, 9924.80150396988, 9951.452670103214, 9887.950560247153, 9897.60409583623, 9900.207983361313, 9903.405795652285, 9946.850797238047, 7523.962380188064, 7547.320741133324, 7565.394768418513, 7614.96192519045, 7701.614919254015, 5403.486668766461, 5416.052190866504, 5447.591430642638, 5487.396386397413, 5521.503064724194, 9149.908500915171, 9201.355905086579, 9292.62829486813, 9294.070592940652, 9301.906980930104, 8903.465792052497, 9134.634614615341, 9285.303602229726, 9308.627654893728, 9361.625534978797, 7009.053777740144, 7181.712731490682, 7184.820379490555, 7187.31720486553, 7208.747693830691, 7596.582187979714, 7694.615269236628, 7761.301482866344, 7771.92228077712, 7775.494592851446, 6850.554713943578, 6904.827379315558, 6922.411595014481, 6958.617276049866, 7061.187963384276, 6801.863962720817, 6878.415334696407, 6900.551464154814, 6947.826304342229, 6969.0940177776565, 6460.612363258219, 6521.9673901630185, 6598.307177746267, 6602.7689030883685, 6603.042558828847, 3690.4833323335292, 4306.913861722685, 4589.426321709786, 4645.721256724607, 4717.716936983792, 4641.721496710074, 4749.857504274877, 4753.358296629911, 4759.571638552547, 4915.877103072452], "value": 4295.1042962443935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.457008832776, 279.5499246213596, 287.3477206740698, 288.8252607172661, 291.7520107908277, 3823.8661646842297, 5166.560842328402, 5236.947630523694, 5237.014901506143, 5256.395514515827, 4369.956300436995, 5014.2979982802435, 5092.541671249587, 5093.5925125989925, 5104.668196567221, 3129.890453834116, 3163.3515129398534, 3659.579148397935, 3943.6450719435247, 3946.855411930551, 3390.86436542538, 3471.6701913318193, 3911.0, 3933.4296527003567, 3937.5078115235597, 3203.5423882133573, 3554.413521768905, 3734.3838266685966, 3786.413105968579, 3901.4733011043572, 3210.4221240176757, 3563.875264365761, 3736.3648179809225, 3895.3900886406177, 3902.2195560887794, 2986.268364250751, 3152.7793054486197, 3193.9779270633408, 3377.831108444568, 3378.0, 4703.95296047042, 4956.3804524434445, 4970.850874473772, 4990.451050384455, 4997.600191984632, 3434.8797792077157, 3714.201446688975, 4023.7988100594853, 4429.357743127229, 4465.642748580106, 4742.573168414825, 5116.590672746172, 5370.489803468664, 5390.649607775482, 5405.837824865261, 3701.592824789271, 3713.5729391119826, 3714.885534339687, 3714.9071273218387, 3718.888433347004, 4845.491223421561, 5300.337457817773, 5427.9185812212845, 5628.887422251532, 5644.927463781909, 3764.5294338207723, 3769.1707824278615, 3779.4519794629623, 3784.6783023442763, 3793.108619474421, 3296.220041177737, 3362.680545348188, 3836.8848934532007, 3842.9039274018373, 3843.6540711336115, 3603.8558457661925, 3867.3425517662067, 4260.68044896634, 4451.755153466591, 4459.509453960061, 4513.0, 5076.568491678248, 5445.863853403696, 5463.453654634504, 5463.453654634584, 1047.3611097230682, 1162.5349860056044, 1189.5301355964345, 1241.6523373455448, 1246.9812952805714, 675.8544267466696, 681.2880539835884, 742.3504433620582, 746.8244962433823, 816.8978877640295, 4179.561146079679, 4506.662000349987, 4724.622030237641, 4893.681910675795, 4895.290182923456, 4505.707129036602, 4797.592204662573, 5125.615578831603, 5323.866903327448, 5347.81282655113, 4389.0, 4813.518648135228, 4888.486708895586, 5235.853300146921, 5331.58778381836, 2418.33495788656, 2828.779408164581, 2845.4593627210766, 2855.257633015431, 2864.8567571621334, 5229.9801538699585, 5251.264822924793, 5638.267025286768, 5702.429757024264, 5747.540196784247, 4393.890932352489, 5538.9169162462595, 5547.195656629847, 5564.054110801174, 5587.636803607834, 4980.726060066731, 5036.798528058836, 5603.469814017306, 5617.887642247132, 5622.811005800623, 4282.207791558571, 4994.525520075587, 5159.561437277724, 5332.253484512249, 5455.263539422286, 5597.524210442158, 5645.826356852559, 5693.459121383462, 5694.437503123528, 5699.287589051369, 5944.4352786485215, 5953.7023148843255, 5986.2217911671205, 5997.670128142994, 6059.969700151647, 3633.9273214535033, 3737.4954381158195, 3737.570179429292, 3773.415120656303, 3782.5650050244576, 5160.638755287094, 5385.791825351587, 5745.3105627324985, 5748.120018987083, 5776.480116789509, 4389.495208051115, 5179.808644011974, 5534.544691523201, 5579.804706835242, 5611.8877622448135, 4778.665493415428, 5270.367555893317, 5514.36584792754, 5522.392536821027, 5580.330360356783, 4425.048614547888, 5101.699066737958, 5187.870303242298, 5464.26232458613, 5472.699001554953, 4331.387072767492, 5228.0, 5405.216243644728, 5421.7770714007065, 5591.440855914376, 4749.643776716691, 5296.576273898156, 5438.592105592017, 5440.292761940922, 5474.835754927359], "value": 3871.5272065777626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.783820934615, 715.4920006795178, 731.4660297982474, 746.734909107267, 760.1752098972614, 14154.150750954937, 14650.413983440676, 14691.632709182275, 14692.706145877102, 14700.852991470096, 13173.670658233548, 13292.202467851936, 13297.933510332436, 13304.0, 13340.132891362055, 645.1033064040987, 667.4993754683987, 671.4259308291414, 808.2079562029215, 824.5506199121463, 794.7854079398588, 813.8657121574932, 814.9225823546753, 833.5165603949725, 838.3502785341378, 872.7556284240391, 873.6811063961671, 876.7983363826323, 878.7188099808064, 878.8505953987806, 682.3313153109931, 870.8301881133182, 871.3682580129356, 871.5685735560938, 872.7032808844991, 467.13113608687814, 505.5904717179097, 519.8102692517242, 522.6210997027163, 524.5462674786321, 13668.794968075486, 14085.64785880351, 14100.506482273071, 14114.012019158663, 14143.222122783243, 12991.350432478339, 13059.0, 13118.016148788878, 13146.342682865818, 13294.3352832358, 11952.521899124025, 11994.70013249667, 11998.760024799543, 12002.819957700642, 12366.04771902661, 4331.696781225315, 4408.426904502394, 4415.646748260131, 4436.645068394553, 4534.9319760203625, 81811.0, 82385.0, 87525.24949501039, 87613.56193219057, 87817.5609121963, 10037.0, 10191.490425478696, 10504.632337868137, 10628.309159904582, 10762.300450470695, 20294.898525507277, 20307.086181121886, 20321.390358289274, 20325.0, 20335.389938301876, 7519.323260906435, 7536.284053014955, 7595.126560445509, 7619.161892191854, 7707.845843083107, 4145.958540414617, 4215.325547912319, 4225.2817021105875, 4226.197022565702, 4233.872983810491, 3165.4776961801504, 3275.4759238522197, 3281.819499927527, 3283.6387997320276, 3285.5564498792837, 627.8085184018918, 628.0767272109991, 638.4828289085856, 640.7725257533508, 641.9711112999926, 585.1544518171202, 601.4436646102338, 601.7322291580292, 607.9513638908877, 609.6444565405628, 7727.729529466442, 8053.436259461781, 8090.738364113014, 8619.6983105591, 8627.568621568897, 576.2940398012402, 603.5202014398564, 604.3563604760916, 609.8018144103096, 614.9200603921462, 3058.4461974251303, 4261.488621365456, 4264.424302719155, 4281.77343812021, 4395.099004704028, 60758.0, 93231.0, 116457.41771291259, 119391.20913186308, 123284.0, 79001.60499197467, 105134.84595461996, 109311.45344273228, 109937.45031274793, 112443.0, 59565.0, 75561.6221918898, 78167.4366512678, 96400.55399169018, 97453.5381969271, 9337.346385752931, 9569.234461243223, 9692.893477109657, 9712.514374281116, 9729.318947673595, 42857.0, 42942.78528607337, 50328.24507632315, 53081.93836123333, 56158.87682246414, 59474.70262648659, 75112.62443687746, 75255.0, 77075.0, 79234.6038269805, 11641.825372619249, 11971.880281197076, 12029.639110826689, 12145.817812732992, 12669.239845608925, 13697.041207115406, 13854.722905542034, 13896.791548126585, 14171.787423188867, 14192.92903535517, 12707.174033687781, 12738.0, 12871.613851584467, 13018.739625207632, 13460.394282257517, 12751.61745147647, 13026.762977715549, 13056.412461439068, 13165.407556659782, 13414.061015728805, 11189.48941892834, 12392.442340094538, 12908.290044047668, 13102.279374634487, 13128.60614181576, 10557.735286814006, 10559.678877661518, 10717.249792514449, 10876.347419154876, 11263.0, 10612.681619551426, 11067.264129923693, 11077.446127693422, 11184.776304474028, 11265.042471390023], "value": 7150.228838814125, "unit": "score"}], "name": "dromaeo_css", "value": 7046.767661888827, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 114.0, 115.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 141.0, 141.0, 152.0, 117.0, 116.0, 119.0, 117.0, 132.0, 115.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 255.0, 184.0, 186.0, 185.0, 185.0, 181.0, 225.0, 257.0, 183.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 62.0, 76.0, 66.0, 82.0, 81.0, 81.0, 79.0, 59.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 85.0, 69.0, 68.0, 68.0, 83.0, 67.0, 69.0, 83.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 83.0, 87.0, 84.0, 87.0, 86.0, 86.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 87.0, 86.0, 87.0, 85.0, 89.0, 87.0, 86.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 58.0, 56.0, 57.0, 55.0, 55.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 78.0, 78.0, 76.0, 72.0, 72.0, 71.0, 72.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 87.0, 88.0, 88.0, 85.0, 89.0, 81.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 157.0, 160.0, 152.0, 152.0, 173.0, 157.0, 203.0, 148.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 179.0, 177.0, 175.0, 175.0, 172.0, 173.0, 174.0, 174.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 67.0, 68.0, 70.0, 69.0, 69.0, 68.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1483.0999999999997, "alertThreshold": 2.0}]} 07:55:11 INFO - Return code: 0 07:55:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:11 INFO - # TBPL SUCCESS # 07:55:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:11 INFO - 2016-11-26 07:55:11.890 screenresolution[2532:35730] starting screenresolution argv=screenresolution get 07:55:11 INFO - 2016-11-26 07:55:11.892 screenresolution[2532:35730] Display 0: 1600x1200x32@60 07:55:11 INFO - 2016-11-26 07:55:11.899 screenresolution[2533:35733] starting screenresolution argv=screenresolution list 07:55:11 INFO - Available Modes on Display 0 07:55:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:12 INFO - Intel Iris: 07:55:12 INFO - Chipset Model: Intel Iris 07:55:12 INFO - Type: GPU 07:55:12 INFO - Bus: Built-In 07:55:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:12 INFO - Vendor: Intel (0x8086) 07:55:12 INFO - Device ID: 0x0a2e 07:55:12 INFO - Revision ID: 0x0009 07:55:12 INFO - Displays: 07:55:12 INFO - Display: 07:55:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:12 INFO - Display Serial Number: 1600x1200 60 07:55:12 INFO - Main Display: Yes 07:55:12 INFO - Mirror: Off 07:55:12 INFO - Online: Yes 07:55:12 INFO - Rotation: Supported 07:55:12 INFO - Return code: 0 07:55:12 INFO - Running post-action listener: _resource_record_post_action 07:55:12 INFO - [mozharness: 2016-11-26 15:55:12.143162Z] Finished run-tests step (success) 07:55:12 INFO - Running post-run listener: _resource_record_post_run 07:55:12 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 16384; Write bytes: 696723456; Read time: 0; Write time: 2020 07:55:12 INFO - TinderboxPrint: CPU usage
53.4% 07:55:12 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 0 07:55:12 INFO - TinderboxPrint: I/O write bytes / time
696,723,456 / 2,020 07:55:12 INFO - TinderboxPrint: CPU idle
2,261.8 (46.6%) 07:55:12 INFO - TinderboxPrint: CPU system
969.5 (20.0%) 07:55:12 INFO - TinderboxPrint: CPU user
1,626.5 (33.5%) 07:55:12 INFO - TinderboxPrint: Swap in / out
382,861,312 / 0 07:55:12 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384164352; Write bytes: 387878400; Read time: 29548; Write time: 840 07:55:12 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 0; Write bytes: 307423744; Read time: 0; Write time: 1171 07:55:12 INFO - Running post-run listener: _upload_blobber_files 07:55:12 INFO - Blob upload gear active. 07:55:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55:12 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 07:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:55:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:14 INFO - (blobuploader) - INFO - Done attempting. 07:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:15 INFO - (blobuploader) - INFO - Done attempting. 07:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:17 INFO - (blobuploader) - INFO - Done attempting. 07:55:17 INFO - (blobuploader) - INFO - Iteration through files over. 07:55:17 INFO - Return code: 0 07:55:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:55:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:55:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0bbbdf406ed379b1093eedde0182f8994527dfaac209eb74d05ff4515086c60deea24a01579c52047ef2023e7ce0d275ecae2a556f058d316824d842a53c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aa06e3498c22bdaef774ddbaebf0ea970b4cdf9aa6b10adf522302aa9e5a2d3e070a4df258a4c690d33b4b78cef9ee49273a14c75d9fa1cf28448fb22c7e5d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a704276635a8c6f1df0f63a7033169030dbedd490150ad106cc6580ae309acbd467943eb2f0ccc79d41fdfdbc875a4fc039ca065d0c639c2d325cde2dd6721b"} 07:55:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:55:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:55:17 INFO - Contents: 07:55:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0bbbdf406ed379b1093eedde0182f8994527dfaac209eb74d05ff4515086c60deea24a01579c52047ef2023e7ce0d275ecae2a556f058d316824d842a53c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aa06e3498c22bdaef774ddbaebf0ea970b4cdf9aa6b10adf522302aa9e5a2d3e070a4df258a4c690d33b4b78cef9ee49273a14c75d9fa1cf28448fb22c7e5d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a704276635a8c6f1df0f63a7033169030dbedd490150ad106cc6580ae309acbd467943eb2f0ccc79d41fdfdbc875a4fc039ca065d0c639c2d325cde2dd6721b"} 07:55:17 INFO - Running post-run listener: copy_logs_to_upload_dir 07:55:17 INFO - Copying logs to upload dir... 07:55:17 INFO - mkdir: /builds/slave/test/build/upload/logs 07:55:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.151022 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-26 07:55:17.568641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 07:55:17.572405) ========= 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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0bbbdf406ed379b1093eedde0182f8994527dfaac209eb74d05ff4515086c60deea24a01579c52047ef2023e7ce0d275ecae2a556f058d316824d842a53c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aa06e3498c22bdaef774ddbaebf0ea970b4cdf9aa6b10adf522302aa9e5a2d3e070a4df258a4c690d33b4b78cef9ee49273a14c75d9fa1cf28448fb22c7e5d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a704276635a8c6f1df0f63a7033169030dbedd490150ad106cc6580ae309acbd467943eb2f0ccc79d41fdfdbc875a4fc039ca065d0c639c2d325cde2dd6721b"} build_url:https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/REacNu9cR-iC5nVVXq8Z0w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eba0bbbdf406ed379b1093eedde0182f8994527dfaac209eb74d05ff4515086c60deea24a01579c52047ef2023e7ce0d275ecae2a556f058d316824d842a53c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5aa06e3498c22bdaef774ddbaebf0ea970b4cdf9aa6b10adf522302aa9e5a2d3e070a4df258a4c690d33b4b78cef9ee49273a14c75d9fa1cf28448fb22c7e5d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a704276635a8c6f1df0f63a7033169030dbedd490150ad106cc6580ae309acbd467943eb2f0ccc79d41fdfdbc875a4fc039ca065d0c639c2d325cde2dd6721b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 07:55:17.607566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 07:55:17.607914) ========= 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.Hb4YNxBXA0/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.ICU4TnXp8w/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.005253 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 07:55:17.657296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 07:55:17.657667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 07:55:17.658058) ========= ========= Total master_lag: 0.19 =========