builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0142 starttime: 1479352639.61 results: success (0) buildid: 20161116164323 builduid: a9da5904779446f6b2ef0c3aa2649b68 revision: 830ce59e0a13e1e0544a1d36bff5f053ac315c21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:19.615041) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:19.615485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:19.615787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:19.639084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:19.639470) ========= 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.jlIhiciYrw/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.ECMQZNVEOW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-16 19:17:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.1M=0.001s 2016-11-16 19:17:20 (10.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.465310 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.126503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.126844) ========= 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.jlIhiciYrw/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.ECMQZNVEOW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.020102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.175739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.176123) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 830ce59e0a13e1e0544a1d36bff5f053ac315c21 --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 830ce59e0a13e1e0544a1d36bff5f053ac315c21 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jlIhiciYrw/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.ECMQZNVEOW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-16 19:17:20,256 truncating revision to first 12 chars 2016-11-16 19:17:20,256 Setting DEBUG logging. 2016-11-16 19:17:20,256 attempt 1/10 2016-11-16 19:17:20,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/830ce59e0a13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 19:17:20,572 unpacking tar archive at: mozilla-central-830ce59e0a13/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.771030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.771358) ========= script_repo_revision: 830ce59e0a13e1e0544a1d36bff5f053ac315c21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.771778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.772052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 19:17:20.790464) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-16 19:17:20.790877) ========= /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.jlIhiciYrw/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.ECMQZNVEOW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:17:20 INFO - MultiFileLogger online at 20161116 19:17:20 in /builds/slave/test 19:17:20 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 19:17:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:17:20 INFO - {'append_to_log': False, 19:17:20 INFO - 'base_work_dir': '/builds/slave/test', 19:17:20 INFO - 'blob_upload_branch': 'Firefox', 19:17:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:17:20 INFO - 'branch': 'Firefox', 19:17:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:20 INFO - 'config_files': ('talos/mac_config.py',), 19:17:20 INFO - 'default_actions': ('clobber', 19:17:20 INFO - 'read-buildbot-config', 19:17:20 INFO - 'download-and-extract', 19:17:20 INFO - 'populate-webroot', 19:17:20 INFO - 'create-virtualenv', 19:17:20 INFO - 'install', 19:17:20 INFO - 'run-tests'), 19:17:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:20 INFO - 'download_minidump_stackwalk': True, 19:17:20 INFO - 'download_symbols': 'ondemand', 19:17:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:20 INFO - 'installer_path': 'installer.exe', 19:17:20 INFO - 'log_level': 'info', 19:17:20 INFO - 'log_name': 'talos', 19:17:20 INFO - 'log_to_console': True, 19:17:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:17:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:17:20 INFO - 'opt_config_files': (), 19:17:20 INFO - 'pip_index': False, 19:17:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:17:20 INFO - 'cmd': ('bash', 19:17:20 INFO - '-c', 19:17:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:17:20 INFO - 'enabled': True, 19:17:20 INFO - 'halt_on_failure': False, 19:17:20 INFO - 'name': 'check_screen_resolution'},), 19:17:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:17:20 INFO - 'cmd': ('bash', 19:17:20 INFO - '-c', 19:17:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:17:20 INFO - 'enabled': True, 19:17:20 INFO - 'halt_on_failure': False, 19:17:20 INFO - 'name': 'check_screen_resolution'},), 19:17:20 INFO - 'run_cmd_checks_enabled': True, 19:17:20 INFO - 'sps_profile': False, 19:17:20 INFO - 'sps_profile_interval': 0, 19:17:20 INFO - 'suite': 'dromaeojs', 19:17:20 INFO - 'system_bits': '32', 19:17:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:20 INFO - 'title': 't-yosemite-r7-0142', 19:17:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:20 INFO - 'use_talos_json': True, 19:17:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:17:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:20 INFO - 'work_dir': 'build'} 19:17:20 INFO - [mozharness: 2016-11-17 03:17:20.994741Z] Running clobber step. 19:17:20 INFO - Running pre-action listener: _resource_record_pre_action 19:17:20 INFO - Running main action method: clobber 19:17:20 INFO - rmtree: /builds/slave/test/build 19:17:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:17:21 INFO - Running post-action listener: _resource_record_post_action 19:17:21 INFO - [mozharness: 2016-11-17 03:17:21.913647Z] Finished clobber step (success) 19:17:21 INFO - [mozharness: 2016-11-17 03:17:21.913810Z] Running read-buildbot-config step. 19:17:21 INFO - Running pre-action listener: _resource_record_pre_action 19:17:21 INFO - Running main action method: read_buildbot_config 19:17:21 INFO - Using buildbot properties: 19:17:21 INFO - { 19:17:21 INFO - "project": "", 19:17:21 INFO - "product": "firefox", 19:17:21 INFO - "script_repo_revision": "production", 19:17:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:17:21 INFO - "repository": "", 19:17:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:17:21 INFO - "buildid": "20161116164323", 19:17:21 INFO - "pgo_build": "False", 19:17:21 INFO - "basedir": "/builds/slave/test", 19:17:21 INFO - "buildnumber": 78, 19:17:21 INFO - "slavename": "t-yosemite-r7-0142", 19:17:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:17:21 INFO - "platform": "yosemite_r7", 19:17:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:17:21 INFO - "branch": "mozilla-central", 19:17:21 INFO - "repo_path": "mozilla-central", 19:17:21 INFO - "revision": "830ce59e0a13e1e0544a1d36bff5f053ac315c21", 19:17:21 INFO - "stage_platform": "macosx64", 19:17:21 INFO - "builduid": "a9da5904779446f6b2ef0c3aa2649b68", 19:17:21 INFO - "slavebuilddir": "test" 19:17:21 INFO - } 19:17:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:17:21 INFO - Running post-action listener: _resource_record_post_action 19:17:21 INFO - [mozharness: 2016-11-17 03:17:21.917328Z] Finished read-buildbot-config step (success) 19:17:21 INFO - [mozharness: 2016-11-17 03:17:21.917471Z] Running download-and-extract step. 19:17:21 INFO - Running pre-action listener: _resource_record_pre_action 19:17:21 INFO - Running main action method: download_and_extract 19:17:21 INFO - mkdir: /builds/slave/test/build/tests 19:17: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')]} 19:17:21 INFO - trying https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:17:21 INFO - Downloading https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/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 19:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/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 19:17:22 INFO - Downloaded 1199 bytes. 19:17:22 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:17:22 INFO - Using the following test package requirements: 19:17:22 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:17:22 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:17:22 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:17:22 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'jsshell-mac.zip'], 19:17:22 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:17:22 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:17:22 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:17:22 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:17:22 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:17:22 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:17:22 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:17:22 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:17:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:17:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:17:22 INFO - Fetch https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:17:23 INFO - Http code: 200 19:17:23 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 19:17:23 INFO - x-amz-cf-id: Tm3jpqBzTTbC-PurEhAOd9GAO36D7D8RXdpEBt2BtJ9EpTLq8dQ5ew== 19:17:23 INFO - x-amz-version-id: EN1xXXA4wazkLAkjdXFPUldyGHyo8vA1 19:17:23 INFO - Expected file size: 16267567 19:17:23 INFO - Obtained file size: 16267567 19:17:30 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 19:17:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:17:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:17:30 INFO - Fetch https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:17:31 INFO - Http code: 200 19:17:31 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 19:17:31 INFO - x-amz-cf-id: ntz20CQdL48qSn4sz37jlj5UIjVsnPry6Yb57t_vh8bXKDlRmh8pkQ== 19:17:31 INFO - x-amz-version-id: EN1xXXA4wazkLAkjdXFPUldyGHyo8vA1 19:17:31 INFO - Expected file size: 16267567 19:17:31 INFO - Obtained file size: 16267567 19:17:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:17:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:17:37 INFO - Fetch https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:17:38 INFO - Http code: 200 19:17:38 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 19:17:38 INFO - x-amz-cf-id: TR8pk7KlJ9TtaTgbic-yA3sLX7KcMr6rbgtrfHHccSt_a9oMgkuyCA== 19:17:38 INFO - x-amz-version-id: LIqs3NpgVSxMG65QLqubdV6UqbYx8hBT 19:17:39 INFO - Expected file size: 14409389 19:17:39 INFO - Obtained file size: 14409389 19:17:39 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')]} 19:17:39 INFO - trying https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:17:39 INFO - Downloading https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/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 19:17:42 INFO - Downloaded 111006050 bytes. 19:17:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:17:42 INFO - mkdir: /builds/slave/test/properties 19:17:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:17:42 INFO - Writing to file /builds/slave/test/properties/build_url 19:17:42 INFO - Contents: 19:17:42 INFO - build_url:https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:17:43 INFO - Running post-action listener: _resource_record_post_action 19:17:43 INFO - Running post-action listener: set_extra_try_arguments 19:17:43 INFO - [mozharness: 2016-11-17 03:17:43.073559Z] Finished download-and-extract step (success) 19:17:43 INFO - [mozharness: 2016-11-17 03:17:43.073683Z] Running populate-webroot step. 19:17:43 INFO - Running pre-action listener: _resource_record_pre_action 19:17:43 INFO - Running main action method: populate_webroot 19:17:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:43 INFO - '--tppagecycles', 19:17:43 INFO - '7'], 19:17:43 INFO - 'tests': ['tsvgm']}}, 19:17:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:17:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:17:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:17:43 INFO - 'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:17:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:17:43 INFO - 'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['damp', 'tps']}, 19:17:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:17:43 INFO - 'tests': ['damp', 'tps']}, 19:17:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['dromaeo_dom']}, 19:17:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['basic_compositor_video']}, 19:17:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:17:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other-e10s': {'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['a11yr', 19:17:43 INFO - 'ts_paint', 19:17:43 INFO - 'tpaint', 19:17:43 INFO - 'sessionrestore', 19:17:43 INFO - 'sessionrestore_no_auto_restore', 19:17:43 INFO - 'tabpaint']}, 19:17:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['tsvgx', 19:17:43 INFO - 'tsvgr_opacity', 19:17:43 INFO - 'tart', 19:17:43 INFO - 'tscrollx', 19:17:43 INFO - 'cart']}, 19:17:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:17:43 INFO - 'tsvgr_opacity', 19:17:43 INFO - 'tart', 19:17:43 INFO - 'tscrollx', 19:17:43 INFO - 'cart']}, 19:17:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:17:43 INFO - 'talos_options': ['--disable-e10s'], 19:17:43 INFO - 'tests': ['tp5o']}, 19:17:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:17:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:17:43 INFO - 'talos_options': ['--disable-e10s', 19:17:43 INFO - '--xperf_path', 19:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:43 INFO - 'tests': ['tp5n']}, 19:17:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:17:43 INFO - 'talos_options': ['--xperf_path', 19:17:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:43 INFO - 'tests': ['tp5n']}}, 19:17:43 INFO - 'talos.zip': {'path': '', 19:17:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:43 INFO - Running post-action listener: _resource_record_post_action 19:17:43 INFO - [mozharness: 2016-11-17 03:17:43.091869Z] Finished populate-webroot step (success) 19:17:43 INFO - [mozharness: 2016-11-17 03:17:43.092013Z] Running create-virtualenv step. 19:17:43 INFO - Running pre-action listener: _resource_record_pre_action 19:17:43 INFO - Running main action method: create_virtualenv 19:17:43 INFO - Creating virtualenv /builds/slave/test/build/venv 19:17:43 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 19:17:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:17:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:43 INFO - Using real prefix '/tools/python27' 19:17:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:17:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:46 INFO - Installing pip.................done. 19:17:46 INFO - Return code: 0 19:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:17:47 INFO - Reading from file tmpfile_stdout 19:17:47 INFO - Output received: 19:17:47 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) 19:17:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:17:47 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 19:17:47 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 19:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:47 INFO - 'HOME': '/Users/cltbld', 19:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:47 INFO - 'LOGNAME': 'cltbld', 19:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:47 INFO - 'MOZ_NO_REMOTE': '1', 19:17:47 INFO - 'NO_EM_RESTART': '1', 19:17:47 INFO - 'PAGER': '/bin/cat', 19:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:47 INFO - 'PWD': '/builds/slave/test', 19:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:47 INFO - 'SHELL': '/bin/bash', 19:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:17:47 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:47 INFO - 'USER': 'cltbld', 19:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:47 INFO - 'XPC_FLAGS': '0x0', 19:17:47 INFO - 'XPC_SERVICE_NAME': '0', 19:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:47 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 19:17:47 INFO - Cleaning up... 19:17:47 INFO - Return code: 0 19:17:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:17:47 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 19:17:47 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 19:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:47 INFO - 'HOME': '/Users/cltbld', 19:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:47 INFO - 'LOGNAME': 'cltbld', 19:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:47 INFO - 'MOZ_NO_REMOTE': '1', 19:17:47 INFO - 'NO_EM_RESTART': '1', 19:17:47 INFO - 'PAGER': '/bin/cat', 19:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:47 INFO - 'PWD': '/builds/slave/test', 19:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:47 INFO - 'SHELL': '/bin/bash', 19:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:17:47 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:47 INFO - 'USER': 'cltbld', 19:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:47 INFO - 'XPC_FLAGS': '0x0', 19:17:47 INFO - 'XPC_SERVICE_NAME': '0', 19:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:47 INFO - Downloading/unpacking psutil>=3.1.1 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:50 INFO - Installing collected packages: psutil 19:17:50 INFO - Running setup.py install for psutil 19:17:51 INFO - building 'psutil._psutil_osx' extension 19:17:51 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 19:17:51 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 19:17:51 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 19:17:51 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 19:17:51 INFO - building 'psutil._psutil_posix' extension 19:17:51 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 19:17:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:17:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:17:51 INFO - ^ 19:17:51 INFO - 1 warning generated. 19:17:51 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 19:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:51 INFO - Successfully installed psutil 19:17:51 INFO - Cleaning up... 19:17:51 INFO - Return code: 0 19:17:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:17: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')]} 19:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:51 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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:17:51 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 19:17:51 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 19:17:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:17:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:51 INFO - 'HOME': '/Users/cltbld', 19:17:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:51 INFO - 'LOGNAME': 'cltbld', 19:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:51 INFO - 'MOZ_NO_REMOTE': '1', 19:17:51 INFO - 'NO_EM_RESTART': '1', 19:17:51 INFO - 'PAGER': '/bin/cat', 19:17:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:51 INFO - 'PWD': '/builds/slave/test', 19:17:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:51 INFO - 'SHELL': '/bin/bash', 19:17:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:17:51 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:17:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:51 INFO - 'USER': 'cltbld', 19:17:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:51 INFO - 'XPC_FLAGS': '0x0', 19:17:51 INFO - 'XPC_SERVICE_NAME': '0', 19:17:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:17:52 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 19:17:52 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 19:17:52 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 19:17:52 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 19:17:52 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 19:17:52 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 19:17:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:17:54 INFO - Installing collected packages: mozsystemmonitor 19:17:54 INFO - Running setup.py install for mozsystemmonitor 19:17:54 INFO - Successfully installed mozsystemmonitor 19:17:54 INFO - Cleaning up... 19:17:54 INFO - Return code: 0 19:17:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:17:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:17:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:54 INFO - 'HOME': '/Users/cltbld', 19:17:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:54 INFO - 'LOGNAME': 'cltbld', 19:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:54 INFO - 'MOZ_NO_REMOTE': '1', 19:17:54 INFO - 'NO_EM_RESTART': '1', 19:17:54 INFO - 'PAGER': '/bin/cat', 19:17:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:54 INFO - 'PWD': '/builds/slave/test', 19:17:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:54 INFO - 'SHELL': '/bin/bash', 19:17:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:17:54 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:17:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:54 INFO - 'USER': 'cltbld', 19:17:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:54 INFO - 'XPC_FLAGS': '0x0', 19:17:54 INFO - 'XPC_SERVICE_NAME': '0', 19:17:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:55 INFO - Downloading/unpacking jsonschema==2.5.1 19:17:55 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 19:17:55 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 19:17:55 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 19:17:55 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 19:17:55 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 19:17:55 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 19:17:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:58 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:58 INFO - warning: no files found matching '*.txt' 19:17:58 INFO - no previously-included directories found matching 'build' 19:17:58 INFO - no previously-included directories found matching 'dist' 19:17:58 INFO - no previously-included directories found matching '.git*' 19:17:58 INFO - Installing collected packages: jsonschema, functools32 19:17:58 INFO - Running setup.py install for functools32 19:17:58 INFO - warning: no files found matching '*.txt' 19:17:58 INFO - no previously-included directories found matching 'build' 19:17:58 INFO - no previously-included directories found matching 'dist' 19:17:58 INFO - no previously-included directories found matching '.git*' 19:17:58 INFO - Successfully installed jsonschema functools32 19:17:58 INFO - Cleaning up... 19:17:58 INFO - Return code: 0 19:17:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:58 INFO - 'HOME': '/Users/cltbld', 19:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:58 INFO - 'LOGNAME': 'cltbld', 19:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:58 INFO - 'MOZ_NO_REMOTE': '1', 19:17:58 INFO - 'NO_EM_RESTART': '1', 19:17:58 INFO - 'PAGER': '/bin/cat', 19:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:58 INFO - 'PWD': '/builds/slave/test', 19:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:58 INFO - 'SHELL': '/bin/bash', 19:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:17:58 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:58 INFO - 'USER': 'cltbld', 19:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:58 INFO - 'XPC_FLAGS': '0x0', 19:17:58 INFO - 'XPC_SERVICE_NAME': '0', 19:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:17:58 INFO - Cleaning up... 19:17:58 INFO - Return code: 0 19:17:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:58 INFO - 'HOME': '/Users/cltbld', 19:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:58 INFO - 'LOGNAME': 'cltbld', 19:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:58 INFO - 'MOZ_NO_REMOTE': '1', 19:17:58 INFO - 'NO_EM_RESTART': '1', 19:17:58 INFO - 'PAGER': '/bin/cat', 19:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:58 INFO - 'PWD': '/builds/slave/test', 19:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:58 INFO - 'SHELL': '/bin/bash', 19:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:17:58 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:58 INFO - 'USER': 'cltbld', 19:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:58 INFO - 'XPC_FLAGS': '0x0', 19:17:58 INFO - 'XPC_SERVICE_NAME': '0', 19:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:58 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 19:17:58 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 19:17:58 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 19:17:58 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 19:17:58 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 19:17:58 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 19:18:01 INFO - Downloading blobuploader-1.2.4.tar.gz 19:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:18:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:18:01 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 19:18:01 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 19:18:01 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 19:18:01 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 19:18:01 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 19:18:01 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 19:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:18:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:18:02 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 19:18:02 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 19:18:02 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 19:18:02 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 19:18:02 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 19:18:02 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 19:18:02 INFO - Downloading docopt-0.6.1.tar.gz 19:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:18:02 INFO - Installing collected packages: blobuploader, requests, docopt 19:18:02 INFO - Running setup.py install for blobuploader 19:18:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:02 INFO - Running setup.py install for requests 19:18:03 INFO - Running setup.py install for docopt 19:18:03 INFO - Successfully installed blobuploader requests docopt 19:18:03 INFO - Cleaning up... 19:18:03 INFO - Return code: 0 19:18:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:03 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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:18:03 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 19:18:03 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 19:18:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:18:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:03 INFO - 'HOME': '/Users/cltbld', 19:18:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:03 INFO - 'LOGNAME': 'cltbld', 19:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:03 INFO - 'MOZ_NO_REMOTE': '1', 19:18:03 INFO - 'NO_EM_RESTART': '1', 19:18:03 INFO - 'PAGER': '/bin/cat', 19:18:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:03 INFO - 'PWD': '/builds/slave/test', 19:18:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:03 INFO - 'SHELL': '/bin/bash', 19:18:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:18:03 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:18:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:03 INFO - 'USER': 'cltbld', 19:18:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:03 INFO - 'XPC_FLAGS': '0x0', 19:18:03 INFO - 'XPC_SERVICE_NAME': '0', 19:18:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-NdH0Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-WmbTod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-pY1rQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-JG228O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Rt140R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-1bP29A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-rJjSR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-PFHaPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-XODxNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ViPDZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-R5CezG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-g3g1ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-HM7BHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-zI0Kce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-rnwT4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-QzgBOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:05 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-eDcm9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:05 INFO - Running setup.py install for manifestparser 19:18:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:05 INFO - Running setup.py install for mozcrash 19:18:05 INFO - Running setup.py install for mozdebug 19:18:06 INFO - Running setup.py install for mozdevice 19:18:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Running setup.py install for mozfile 19:18:06 INFO - Running setup.py install for mozhttpd 19:18:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Running setup.py install for mozinfo 19:18:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Running setup.py install for mozInstall 19:18:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:06 INFO - Running setup.py install for mozleak 19:18:06 INFO - Running setup.py install for mozlog 19:18:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:07 INFO - Running setup.py install for moznetwork 19:18:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:07 INFO - Running setup.py install for mozprocess 19:18:07 INFO - Running setup.py install for mozprofile 19:18:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:07 INFO - Running setup.py install for mozrunner 19:18:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:07 INFO - Running setup.py install for mozscreenshot 19:18:07 INFO - Running setup.py install for moztest 19:18:08 INFO - Running setup.py install for mozversion 19:18:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:08 INFO - Cleaning up... 19:18:08 INFO - Return code: 0 19:18:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:08 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')]} 19:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:08 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')]} 19:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:08 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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:18:08 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 19:18:08 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 19:18:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:18:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:08 INFO - 'HOME': '/Users/cltbld', 19:18:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:08 INFO - 'LOGNAME': 'cltbld', 19:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:08 INFO - 'MOZ_NO_REMOTE': '1', 19:18:08 INFO - 'NO_EM_RESTART': '1', 19:18:08 INFO - 'PAGER': '/bin/cat', 19:18:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:08 INFO - 'PWD': '/builds/slave/test', 19:18:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:08 INFO - 'SHELL': '/bin/bash', 19:18:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:18:08 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:18:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:08 INFO - 'USER': 'cltbld', 19:18:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:08 INFO - 'XPC_FLAGS': '0x0', 19:18:08 INFO - 'XPC_SERVICE_NAME': '0', 19:18:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:08 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-8eSZjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:08 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)) 19:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:08 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-uyW5y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:08 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)) 19:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:08 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ivhw7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:08 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)) 19:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:08 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-CU8_U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:08 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Xpcs0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-kuB30t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-8t3M6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-5m2qQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-0KBfHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-lR30p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-tjiteg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-V8goOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-z7GHLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-f3itnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:09 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)) 19:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-keDKqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:10 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)) 19:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-sQ6z95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:10 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)) 19:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-YoGbdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:10 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)) 19:18:10 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)) 19:18:10 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)) 19:18:10 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)) 19:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:10 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 19:18:10 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 19:18:10 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 19:18:10 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 19:18:10 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 19:18:10 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 19:18:12 INFO - Downloading blessings-1.6.tar.gz 19:18:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:12 INFO - Installing collected packages: blessings 19:18:12 INFO - Running setup.py install for blessings 19:18:13 INFO - Successfully installed blessings 19:18:13 INFO - Cleaning up... 19:18:13 INFO - Return code: 0 19:18:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:13 INFO - Reading from file tmpfile_stdout 19:18:13 INFO - Current package versions: 19:18:13 INFO - blessings == 1.6 19:18:13 INFO - blobuploader == 1.2.4 19:18:13 INFO - docopt == 0.6.1 19:18:13 INFO - functools32 == 3.2.3-2 19:18:13 INFO - jsonschema == 2.5.1 19:18:13 INFO - manifestparser == 1.1 19:18:13 INFO - mozInstall == 1.12 19:18:13 INFO - mozcrash == 1.0 19:18:13 INFO - mozdebug == 0.1 19:18:13 INFO - mozdevice == 0.48 19:18:13 INFO - mozfile == 1.2 19:18:13 INFO - mozhttpd == 0.7 19:18:13 INFO - mozinfo == 0.9 19:18:13 INFO - mozleak == 0.1 19:18:13 INFO - mozlog == 3.4 19:18:13 INFO - moznetwork == 0.27 19:18:13 INFO - mozprocess == 0.23 19:18:13 INFO - mozprofile == 0.28 19:18:13 INFO - mozrunner == 6.13 19:18:13 INFO - mozscreenshot == 0.1 19:18:13 INFO - mozsystemmonitor == 0.3 19:18:13 INFO - moztest == 0.7 19:18:13 INFO - mozversion == 1.4 19:18:13 INFO - psutil == 3.1.1 19:18:13 INFO - requests == 1.2.3 19:18:13 INFO - wsgiref == 0.1.2 19:18:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:13 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')]} 19:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:13 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')]} 19:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:13 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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:18:13 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 19:18:13 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 19:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:13 INFO - 'HOME': '/Users/cltbld', 19:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:13 INFO - 'LOGNAME': 'cltbld', 19:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:13 INFO - 'MOZ_NO_REMOTE': '1', 19:18:13 INFO - 'NO_EM_RESTART': '1', 19:18:13 INFO - 'PAGER': '/bin/cat', 19:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:13 INFO - 'PWD': '/builds/slave/test', 19:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:13 INFO - 'SHELL': '/bin/bash', 19:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:18:13 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:13 INFO - 'USER': 'cltbld', 19:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:13 INFO - 'XPC_FLAGS': '0x0', 19:18:13 INFO - 'XPC_SERVICE_NAME': '0', 19:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 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)) 19:18:13 INFO - Cleaning up... 19:18:13 INFO - Return code: 0 19:18:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:13 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')]} 19:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:13 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')]} 19:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:13 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 0x10e6293f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e59f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5e0d8a510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, '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.jlIhiciYrw/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.ECMQZNVEOW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 19:18:13 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 19:18:13 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 19:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:13 INFO - 'HOME': '/Users/cltbld', 19:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:13 INFO - 'LOGNAME': 'cltbld', 19:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:13 INFO - 'MOZ_NO_REMOTE': '1', 19:18:13 INFO - 'NO_EM_RESTART': '1', 19:18:13 INFO - 'PAGER': '/bin/cat', 19:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:13 INFO - 'PWD': '/builds/slave/test', 19:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:13 INFO - 'SHELL': '/bin/bash', 19:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:18:13 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:13 INFO - 'USER': 'cltbld', 19:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:13 INFO - 'XPC_FLAGS': '0x0', 19:18:13 INFO - 'XPC_SERVICE_NAME': '0', 19:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:18:14 INFO - Cleaning up... 19:18:14 INFO - Return code: 0 19:18:14 INFO - Running post-action listener: _resource_record_post_action 19:18:14 INFO - Running post-action listener: _start_resource_monitoring 19:18:14 INFO - Starting resource monitoring. 19:18:14 INFO - [mozharness: 2016-11-17 03:18:14.067280Z] Finished create-virtualenv step (success) 19:18:14 INFO - [mozharness: 2016-11-17 03:18:14.068353Z] Running install step. 19:18:14 INFO - Running pre-action listener: _resource_record_pre_action 19:18:14 INFO - Running main action method: install 19:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:14 INFO - Reading from file tmpfile_stdout 19:18:14 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:14 INFO - Reading from file tmpfile_stdout 19:18:14 INFO - Output received: 19:18:14 INFO - Usage: mozinstall [options] installer 19:18:14 INFO - Options: 19:18:14 INFO - -h, --help show this help message and exit 19:18:14 INFO - -d DEST, --destination=DEST 19:18:14 INFO - Directory to install application into. [default: 19:18:14 INFO - "/builds/slave/test"] 19:18:14 INFO - --app=APP Application being installed. [default: firefox] 19:18:14 INFO - mkdir: /builds/slave/test/build/application 19:18:14 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'] 19:18:14 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 19:18:48 INFO - Reading from file tmpfile_stdout 19:18:48 INFO - Output received: 19:18:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:18:48 INFO - Running post-action listener: _resource_record_post_action 19:18:48 INFO - [mozharness: 2016-11-17 03:18:48.020463Z] Finished install step (success) 19:18:48 INFO - [mozharness: 2016-11-17 03:18:48.020605Z] Running run-tests step. 19:18:48 INFO - Running pre-action listener: _resource_record_pre_action 19:18:48 INFO - Running main action method: run_tests 19:18:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:18:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:18:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:18:48 INFO - 2016-11-16 19:18:48.035 screenresolution[1939:13375] starting screenresolution argv=screenresolution get 19:18:48 INFO - 2016-11-16 19:18:48.037 screenresolution[1939:13375] Display 0: 1600x1200x32@60 19:18:48 INFO - 2016-11-16 19:18:48.044 screenresolution[1940:13377] starting screenresolution argv=screenresolution list 19:18:48 INFO - Available Modes on Display 0 19:18:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:18:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:18:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:18:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:18:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:18:48 INFO - Intel Iris: 19:18:48 INFO - Chipset Model: Intel Iris 19:18:48 INFO - Type: GPU 19:18:48 INFO - Bus: Built-In 19:18:48 INFO - VRAM (Dynamic, Max): 1536 MB 19:18:48 INFO - Vendor: Intel (0x8086) 19:18:48 INFO - Device ID: 0x0a2e 19:18:48 INFO - Revision ID: 0x0009 19:18:48 INFO - Displays: 19:18:48 INFO - Display: 19:18:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:18:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:18:48 INFO - Display Serial Number: 1600x1200 60 19:18:48 INFO - Main Display: Yes 19:18:48 INFO - Mirror: Off 19:18:48 INFO - Online: Yes 19:18:48 INFO - Rotation: Supported 19:18:48 INFO - Return code: 0 19:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:18:48 INFO - Python 2.7.3 19:18:48 INFO - Return code: 0 19:18:48 INFO - grabbing minidump binary from tooltool 19:18:48 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')]} 19:18:48 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 0x10e43fd30>, '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 0x10e2a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e437b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:18:48 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 19:18:48 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 19:18:48 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 19:18:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:18:48 INFO - Return code: 0 19:18:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:18:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:18:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:18:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:18:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:18:48 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/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 19:18:48 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/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0142 --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 19:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jlIhiciYrw/Render', 19:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:48 INFO - 'HOME': '/Users/cltbld', 19:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:48 INFO - 'LOGNAME': 'cltbld', 19:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:48 INFO - 'MOZ_NO_REMOTE': '1', 19:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:18:48 INFO - 'NO_EM_RESTART': '1', 19:18:48 INFO - 'PAGER': '/bin/cat', 19:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:48 INFO - 'PWD': '/builds/slave/test', 19:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:48 INFO - 'SHELL': '/bin/bash', 19:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ECMQZNVEOW/Listeners', 19:18:48 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 19:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:48 INFO - 'USER': 'cltbld', 19:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:48 INFO - 'XPC_FLAGS': '0x0', 19:18:48 INFO - 'XPC_SERVICE_NAME': '0', 19:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:48 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/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 19:18:48 INFO - mozversion application_buildid: 20161116164323 19:18:48 INFO - mozversion application_changeset: 830ce59e0a13e1e0544a1d36bff5f053ac315c21 19:18:48 INFO - mozversion application_display_name: Nightly 19:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:18:48 INFO - mozversion application_name: Firefox 19:18:48 INFO - mozversion application_remotingname: firefox 19:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:18:48 INFO - mozversion application_vendor: Mozilla 19:18:48 INFO - mozversion application_version: 53.0a1 19:18:48 INFO - mozversion platform_buildid: 20161116164323 19:18:48 INFO - mozversion platform_changeset: 830ce59e0a13e1e0544a1d36bff5f053ac315c21 19:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:18:48 INFO - mozversion platform_version: 53.0a1 19:18:48 INFO - using testdate: 1479352728 19:18:48 INFO - actual date: 1479352728 19:18:48 INFO - starting webserver on 'localhost:51295' 19:18:48 INFO - SUITE-START | Running 2 tests 19:18:48 INFO - TEST-START | dromaeo_css 19:18:48 INFO - operating with platform_type : mac_ 19:18:48 INFO - Initialising browser for dromaeo_css test... 19:18:48 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp3Mso5f/profile http://localhost:51295/getInfo.html) 19:18:50 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 19:18:50 INFO - PROCESS | 1950 | colorDepth:24 19:18:50 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 19:18:50 INFO - PROCESS | 1950 | __metrics 19:18:51 INFO - PROCESS | 1950 | 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" 19:18:51 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:18:51 INFO - TEST-INFO | 1950: exit 0 19:18:51 INFO - Browser initialized. 19:18:51 INFO - Running cycle 1/1 for dromaeo_css test... 19:18:51 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp3Mso5f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:03 INFO - PROCESS | 1952 | RSS: Main: 238690304 19:19:03 INFO - PROCESS | 1952 | 19:19:55 INFO - PROCESS | 1952 | 1479352795484 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] 19:22:08 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51295/tests/dromaeo/cssquery-ext.html) 19:22:10 INFO - PROCESS | 1952 | RSS: Main: 414621696 19:22:10 INFO - PROCESS | 1952 | 19:25:13 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-ext.html (next: http://localhost:51295/tests/dromaeo/cssquery-jquery.html) 19:25:13 INFO - PROCESS | 1952 | RSS: Main: 375230464 19:25:13 INFO - PROCESS | 1952 | 19:28:16 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51295/tests/dromaeo/cssquery-mootools.html) 19:28:16 INFO - PROCESS | 1952 | RSS: Main: 361349120 19:28:16 INFO - PROCESS | 1952 | 19:31:19 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51295/tests/dromaeo/cssquery-prototype.html) 19:31:19 INFO - PROCESS | 1952 | RSS: Main: 344383488 19:31:19 INFO - PROCESS | 1952 | 19:34:23 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51295/tests/dromaeo/cssquery-yui.html) 19:34:23 INFO - PROCESS | 1952 | RSS: Main: 335409152 19:34:23 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51295/tests/dromaeo/cssquery-yui.html (next: http://localhost:51295/tests/dromaeo/cssquery-dojo.html) 19:37:27 INFO - PROCESS | 1952 | RSS: Main: 496865280 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | __start_tp_report 19:37:27 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 19:37:27 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 19:37:27 INFO - PROCESS | 1952 | |i|pagename|runs| 19:37:27 INFO - PROCESS | 1952 | |0;dojo.html;3268.7058164765167;3269.444194486937;3276.574045374102;3305.8512366943487;3338.415777238984;4571.839985600504;5596.972015139929;5662.915056274154;5681.403452637471;5690.06113991192;5601.103823388259;5654.717264136787;5674.375818659954;5681.005823980797;5705.572082093839;5082.51716086973;5103.821366252182;5119.308893299412;5157.48425157485;5161;5158.638895277332;5249.868753281179;5266.631335806495;5268.710220937847;5290.418054014055;5078.111330517182;5118.436971933084;5228.096804115021;5256.237845512417;5279.287296215039;5146.253793200002;5164.612654050961;5170.948290517084;5175.068487672217;5175.611829112794;5072.873178170538;5111.1566591512355;5121.28302037715;5141.383034035902;5145.279660847485;5609.074502707089;5613.775448982035;5618.662880227159;5629.8592535186945;5654.010548154057;6090.756369745205;6092.421219984094;6096.664683442409;6101.816945491642;6116;6109.3585173556585;6148.354422785588;6180.103884936704;6186.319504854462;6228.065790131472;5669.688167150805;5729;5732.914006289909;5743.4543718346695;5762.078067509262;6144.846378840475;6216.782412615627;6269.749210031548;6269.843253918597;6281.560290779602;5171.991461664939;6004.639721616717;6034.5172386209;6051.969740151271;6091.543134264948;6183.443490085914;6198.039303907812;6217.626942383471;6219.968900155561;6248.31268560458;5972.193753843176;6033.306169790442;6147.938520614736;6153.8461538461;6170.228721409824;6082.209312789398;6104.732011601605;6110.627719080174;6115.097174815069;6134.263888333428;4826.758662066883;4859.003904199631;4867.196912509467;4870.805167793319;4871.8294859679745;4303.182395344875;4336.544662810423;4350.108227813291;4360.520342762294;4382.517923028464;5613.073842815889;5673.886522269531;5678.68767217807;5694.288213973254;5733.827985160452;6062.818115456544;6115.666295175977;6119.746288422706;6121.727351053096;6161.6611086389785;5717.113847353667;5727.140928860705;5728.484436400744;5734.885302293931;5773.711314434261;5322.494363035506;5343.225232341289;5349.705766182819;5355.062863998784;5365.7585408656705;6177.84555386119;6240.4071613196675;6252.624842509464;6274.843128921905;6284.277308109626;6132.814448934826;6171.753129874754;6176.289726681489;6254.749810007549;6259.186305780219;6260.092286618506;6264.31092579825;6275.152854364603;6281.874362512815;6305.117283580211;5963.612365196248;6037.18498002764;6045.6070355426755;6124.38756124384;6124.448799608057;6048.637081775108;6108.524204008529;6123.84690382744;6134.2835184798605;6147.170132032118;5867.618604790846;6038;6049.697515124314;6057.697115144313;6096.542759293159;5963.970180149072;5996.940030599638;5999.700014999145;6015.548833837567;6022.698865056817;5691.345495268097;5789.2763404574425;5790.85522861915;5820.243368362086;5856.092305692625;6036.486898613492;6041.2750469943885;6042.788502402394;6066.7269972850445;6098.176746139215;5700.885982280414;5768.769249230152;5771.971140144273;5776.220210271727;5826.592138550261 19:37:27 INFO - PROCESS | 1952 | |1;ext.html;499.2212149047485;506.56182402222066;511.29186077282975;515.1654320001601;540.6918056707678;29566.704332956662;31309.060728178163;31313.530297045534;39321.01697457565;40549;41492.37761433581;41881.58118418815;41886.16227675445;42011.57988420115;42015.78992105035;9218.723438296862;9231.446113233194;9236.3996340238;9325.114114159178;9392.060793920622;9331.580078896466;9420.199283060949;9425.717228483121;9426.622935082623;9434.245260379188;9362.110599493037;9411.482368469766;9433.009533998935;9438.81122377552;9446.480443575601;9381.061893810633;9399.71800845969;9404.965453800076;9411.152996230372;9415.199708024791;9201.401908875901;9283.814323713555;9288.349815512916;9292.488913109777;9305.069493050709;38283.80858095719;38563.42154867679;38581;38627.61372386268;38644.227115457536;3273.770836041478;3333.5499707539416;3351.899443016689;3448.603410607762;3645.8906232813056;29498.55752163719;29840.806367745263;30000.24999375033;30012.399752004836;30068.24829379283;3115.704008119225;3196.4406228909847;3225.516172574109;3309.834508274577;3333.916652083693;434338;436118;436624;436762;437381;32781.836090819874;58705.41294587;59049.70475147597;59059;59327;33784.32431351359;34612.65387346094;34832.82583587066;34843.65156348455;34980.47529287063;14092.013559050973;14235.430582776573;14244.501442449464;14256.42974281017;14265.857341426452;11816.704582385337;11925.642230733092;11930.22453540517;11939.283642981449;11945.522179112912;7735.574543400167;7744.845103097907;7799.3760499159935;7815.6482958267015;7819.022622172229;2805.733455321741;3186.4901615741833;3228.9192770180935;3231.092017184553;3266.591676040495;875.912408759119;890.7129198308382;932.664240873285;977.4233202410612;1014.9441780702132;24900.37749056288;29166.854165729037;29292.414151716846;30000.249993749894;30043.69956300409;845.5180547088223;1003.7791685829106;1023.8720159980003;1046.3826342457987;1060.2154405739698;12363;14342.713145737027;14530;15033.924830375998;15557;624753;628230;628508;629235;629608;56327;56826.71586642123;56907.43092569021;57004;57069;1204.3616883051996;1239.6157191270736;1308.3458270864378;1323.245749922535;1356.5523377285274;27046.647667616933;27695.861520692266;30163.547546786376;30421.847890760404;30985.535216972214;47626.76186619045;48206;48255.517444825105;48264.758676206395;48322.033559327916;465497;467142;467552;467664;468698;25856.22431327063;26224.344391389604;26543.7345626549;26820.731792681825;27062.458750825266;44697.55302447064;45111.774441127585;45169.32246016378;45405.31892021689;46054;37142.62857371392;37404.81297593495;37645.04727003735;38351;38810.8356749298;33160.66839331672;33741.65033398636;36601.81699091488;38472.80763596164;38537.80731096439;36123.55505779739;36275.09312267109;36486;37245.813770930974;37327.81336093302;32501;32715.672843271263;32857.77291040051;33338.33323333471;33609.495857562644;23926.880365598758;24295.51408971775;24417.877910610332;24793.88427520802;25288.988440462177 19:37:27 INFO - PROCESS | 1952 | |2;jquery.html;320.7914855344027;323.466280636949;349.34497816593887;374.9887503374899;376.4447440025962;14914;15846.128462934534;19540.609187816237;19969.60060798783;20862.582748345023;16398.7540186897;19120.235190592393;19725.704114438297;20664.07011684474;20695.482612934647;5276.630635855482;5790.623609465392;5865.970670146665;5867.853303667421;5877.970610146944;3420.2817408344276;4201.495820501544;5702.230198923134;5826.242588463494;5828.154917536955;6315.621062736251;6351.110844481753;6401.935980640181;6407.391297826699;6413.230412350501;6123.540734444934;6334.588251763666;6376.936230637681;6386.457151142158;6388.39310265524;5575.804846830341;5583.246261754652;5587.469190426903;5591.161325801162;5595.524380427669;24387.26838194857;25345.873270633714;25357.492850142895;25438.36404089894;25673.35816604581;2253.019936327703;2345.917892873741;2351.8824058797163;2356.104680221505;2394.8114073610896;10354.223433242461;11873.228240164362;12432.627021189379;14225.928870355581;16061.919690401473;1572.4024870549233;1709.0856391830434;1768.9911550442166;1822.772153480815;1887.584731359099;92527;105101;119113;119591.4020429901;120387.79612203853;11279.718007049889;11396.772064558663;11405.14461415397;11428.94285528567;11571.132165087483;14433;14449.422023119168;14455.927720361542;14468.782968255484;14486.565403037926;8145.104038555754;8281.089080201173;8290.958545207235;8338.166183381612;8443.451175673561;6719.899201511981;8074.940890073111;8084.231997960184;8280.461769984931;8369.079401265855;4407.625351845065;4492.460904691393;4537.863864084083;4557.475890272594;4625.884352891205;1725.7066298729246;1902.6289873474539;1903.4765439504247;1907.6661584222984;1911.2259534888392;806.8341246898293;814.5886327404622;872.7818045488627;928.8142371525722;938.5119737736339;19311.725046689033;19592.11835467379;20700.378988630364;20805;21246.893765531382;782.72213364256;791.8416316736676;877.8850859408516;916.8899732032065;939.7180845746249;10366.740831479123;11098.833517497244;11121.05471034971;11130.443477826238;11156.274842135235;233070.66929330828;577290;584998;591147;591572;110014;138262;138365;139109;141053;862.8791969124328;926.1849572376266;943.8631398447187;1011.4487604255698;1011.5043628621922;17087.743683845;19191.32830350931;19451.416457506297;19513.43892488569;19731.80268197357;41896.95257618584;55779;55978.44021559732;57323.14015289857;57576;73590;75812;78406.4318713634;80135;83659;6966.756163534252;7356.337929586363;7370.262973702587;7419.258074192753;7541.585212813348;10094.949525252621;11477;12529.624111276677;12920.418581163682;13132.212067275994;10903.727406814893;11133.343645681;11215.102791776475;11380.43097845121;11414.94292528532;10772.192085593455;10890.074343680875;11163.274387164809;11265.831012534654;11479;11270.549178033114;11416.885831141582;11490.425478725863;11528.711782205512;11606.620642768043;7201.927980720126;7395.593242371721;7419.554826710415;7490.925090749241;7611.086669599462;9968.55141518619;10703.785924281627;10704.357738535713;10925.344479331265;11365.943170284096 19:37:27 INFO - PROCESS | 1952 | |3;mootools.html;1320.9009324300669;1457.5554455890956;1477.6084337650523;1635.7382818749002;1825.8995755233457;7382;7764.650590723417;7948.125706172316;8264.876026859602;8265.710700125483;8118.634661440235;8206.097329293772;8212.260896519312;8217.46586471879;8220.506769593829;2255.3797705631;2287.5996700577416;2288.4278930267433;2289.942751431211;2292.1289909834322;2264.9886750566225;2310.2722642367685;2323.0707716913203;2323.372689373868;2325.3721495196287;2258.1644791427193;2268.7312687312688;2287.9885600571974;2290.530441259546;2294.3919861236786;1896.6301571193624;2223.399682085836;2288.6338185890345;2291.656251562279;2295.3917211938765;2266.648669456237;2282.885855707208;2287.965680514794;2289.107248173214;2289.439087423575;8181.140980197053;8348.41561090724;8354.415190936637;8355.1227121152;8376.162383761635;4953.306537084811;4993.625478089121;5122.257272695476;5177.249298851645;5185.066687996159;3152.952705709416;3443.3974054540604;3535.381308271042;3543.0433782878736;3553.8223088845452;1016.2733645443469;1041.1826716027958;1083.9241253112286;1086.4296244471636;1089.3844977587637;10201.744956376077;10516.474176291154;10645.361278323326;10794.02853743159;10794.73013174669;4167.270727622654;4254.744715317029;4359.258925982527;4372.759498227564;4392.714473559208;8520.360972927056;8529.360297977677;8529.658813647384;8534.317254619615;8534.914650853412;4983.975080124576;4986.501349865057;4991;4991.950080499221;4996.025774973918;3981.1639555693628;4202.0040480772;4355.998120432255;4359.12557600235;4676.883077923079;3135.2475405902874;3572.339117263263;3616.0598244456633;3618.3125206210734;3627.3470775260707;1123.0510218865045;1132.17351333527;1136.4204255829586;1150.505282728418;1155.7110722319421;767.5279702982737;799.1010113622175;853.8292341531718;854.0221446443911;870.3646338173169;5362.927414517112;5485.50630443262;5513.7794488220825;5528.944710552843;5737.397573254748;358.4766241287749;406.5081251685435;421.85656876661466;430.30076126294773;430.5307215135517;3746.2320224353944;3788.6400791924725;3818.59904710007;3912.197999410114;3922.5489068757456;9576;10091.142252908585;10092.848607270897;10104.69685909424;10137.087662110445;8428.8314233715;10023.899761002442;10041.397516149054;10042.0460056296;10047.145992590566;7492.925070749332;7625.885611715828;7628.69485220596;7810.804729881685;7829.099653539802;5387.542058924879;5473.151661492475;5491.890162196653;5590.720463976703;5711.457411545896;9202.907970920205;9249.953750231205;9280.58237379333;9293.67472138472;9443.244540436612;9188.678396256098;9280.675176368795;9384.765380865532;9387.061293870558;9387.483688397204;6615.4046135848;6684.598924064571;6702.698378572878;6706.295838936841;6710.496712746466;7260.745873894389;7561.7731468056045;7623.809404764926;7690.346320562815;7807.453478256468;6732.663366831541;6873.347032031949;7040.507164498641;7085.858282834418;7108.537945033556;6847.109875716125;6948.791536253921;6964.164300283998;6984.685689143899;7015.614141222281;6550.574212676161;6678.49911256648;6701.497387695845;6701.765438209639;6712.093867328043;4616.653750968623;4810.374651295449;4810.687305325143;4886.096072226649;4969.503049695001;4722.433308003062;4731.739754313408;4900;4933.9506604933495;5032.27032080339 19:37:27 INFO - PROCESS | 1952 | |4;prototype.html;268.0938428112978;280.54271537394044;295.0852357691157;300.2314075965527;310.44275525431846;4823.807047718092;4905.362302900622;5001.899962000763;5017.272495488152;5135.948640513594;4553.88615284618;5063.898722025558;5076.695398276106;5090.236464530322;5095.566876815476;3338.4825352070466;3478.330401407326;3621.837017334213;3883.3786594144945;3956.3274243378696;3446.5691788526433;3754.962450375502;3916.784576848272;3923.312975420568;3946.605339466045;3076.8307743074233;3889.747166434187;3892.47451594034;3894.8636797712084;3922.195949830278;3896.941545876814;3919.196564704229;3927.509061367329;3937.330653788863;3941.881743547698;2686.838789672626;3140.5289206618963;3378.9155271118175;3379.9015320020844;3429.416999110132;4721.952780472186;5003.674761140514;5040.36995375578;5092.821751238689;5110.28456016158;4432.911341773147;4440.977795111004;4462.4645042594775;4479;4494.73031618104;4660.790264438108;4759.619710284013;5211.820789318513;5337.70642614656;5389.440015992412;3146.6695996920453;3583.802890841003;3710.703143748494;3710.831088207206;3732.9440058399146;5575.637583557096;5622.943770562283;5631.465010823965;5653.632513886584;5713.400092990218;3304.8678052877617;3639.7270204734223;3772.9245415091546;3788.583255841855;3788.6400791924725;3557.7331700122595;3763.0592351912023;3773.716971227169;3791.469194312798;3816.866409675648;3503.4219353806848;4219.472565929259;4317.633001194934;4322.827086916488;4433.556644335606;5314.386217372224;5396.78412863481;5400.864978375572;5456.454354564512;5477.424870388551;1096.1176253116319;1193.928364298145;1219.2379762648345;1225.6078055022485;1244.3342811595753;742.361569050616;754.5925200391837;800.4917306345358;800.9479383840031;839.4879123734516;4600.332951721982;4606.032733126081;4705.411823522059;4733.810647574127;4748.243150034509;4630.814767409266;5213.452587478336;5251.2123181523075;5255.6321057526375;5277.577793776489;3910.7066969977363;4166.770802613237;4702.482726900038;4748.4539277982785;4770.833020844254;2110.504031552584;2310.7920287173897;2353.9995501911962;2561.3596600849787;2584.1988983415204;4709.458412282563;5280.471952804689;5346.4653534647005;5469.535089517435;5470.073510671771;4890.414471997038;4903.6847574135245;5250.7637156328055;5256.2904007959205;5365.466181076984;4530.84142055033;4744;5003.774075351562;5479.630027533118;5481.561475081904;4682.929756053593;5138.511841375063;5212.661177023481;5228.241904923841;5242.633015689018;4395.626371758436;4443.577860103285;4726.645501587326;5167.61242906776;5176.456472070378;4613.400257966578;5335.279737235579;5421.891562168814;5425.294711687456;5494.81861399801;3047.5733397323947;3493.8078405686915;3554.413521768879;3556.5732112146707;3574.857005719742;4361.694681372273;5154.922676159786;5163.134460374378;5164.431912489698;5216.504432078947;4346.630536404441;4440.4671439427475;5085.847424577269;5096;5149.845504634867;4204.873853784391;4923.8276660316715;4938.802447902043;4960.8759781005765;4977.825776097964;4256.446661933929;4350;4663.543653924984;4870.78081486341;4909.4354149273295;4263.3818096375235;4619.93070103942;4966.751662416937;4969.527894849984;5054.19132938728;4189.853355132677;4254.617084462413;4836.661433699607;4866.902661946812;4870.975645121752 19:37:27 INFO - PROCESS | 1952 | |5;yui.html;633.762339122829;671.958171597839;751.6204316820005;767.286423626028;797.3222760653443;12930;14458.566243012714;14793;15103.093814371145;15118.39526418942;13140.948724102072;13290.867091329084;13659;13669.589912302647;13691.383887725051;785.3991696352281;806.8709006558952;806.9273765361116;807.9515229086244;809.3282575462352;644.336333576417;658.5061204096927;796.1004065406083;803.116571771053;823.1398188892591;857.2499063319596;858.8883445152153;859.0936561927165;860.3504354212561;860.802015536427;851.5571902610639;855.110684887716;855.1192271959891;855.495257797896;856.3748463621529;500.9474005229435;508.438175815722;511.69298420947507;517.9792808287701;632.4529282170935;11941.522339106425;13341.599752007456;13817.101888377223;13840.23878686682;14170.574882753534;13314.267715275655;13433.596992090253;13466.865331346658;13604.727905441934;13672.589822305346;10853.186011049203;10886.292390994638;10909.83635245472;10951.890481095166;11161;3612.3678356287546;3613.421852503613;3627.4740162676526;3678.8712395066314;3751.3060083884297;86999;88135.79660508475;88287.55856220741;88877;89257;8348.66605335792;10304.845427318596;10620.150387969099;10705.83941240882;10732.463376831127;20111.597768044558;20179.697304540445;20319.288824891057;20417.2853950114;20474.692879606817;7608.391328693691;7627.809304767426;7639.388848892076;7681.807954801175;7797.649105790253;3745.269672413853;4171.749695018309;4199.265128602544;4226.218149642326;4252.659787217015;3341.515480255398;3496.3356962177104;3527.1005893496995;3528.647135286451;3540.5574303212097;460.63149480415535;534.3774502704383;536.6029138437606;540.9377921539074;542.4060653584397;482.08068403876956;625.2059883947361;627.4478458956089;632.2160520953984;635.4757325206723;7355.889661655079;8228.25945664893;8628;8686.261667758312;8875.511846848356;547.8657728856456;595.9046552551571;608.3490664988508;640.4620119099885;641.8074577626787;4295.29127693927;4335.956640433618;4349;4408.404865343137;4427.845025424094;111117.44441277742;114467;115253;116488.25267620993;120554.3972280133;90880;99945;104806.42790358151;104935;105990;92387;93060;93541.5322923381;93846;95777.04222957681;8213.7555665513;8459.492430454193;8481.533515656698;8537.359698022548;8617.569121543773;41455;52290.67536932344;55329;55614.88770224654;58340.708296458244;54000.729996349764;54255.45744542504;70656.94014589682;74815.62592187004;79236.81144782949;12335.568255111028;12364.1963272387;12503.499860005863;12549.749005019667;12755.426005829946;12770.68073298175;13235;13410;13463.932680336535;14282.500112496013;12890.35548222604;13576.59270221895;13740.793888091886;13797.931010344884;13898.51355202563;12693.174943628635;13250.933745331597;13347.332633368487;13760.518381856587;13876.514321999086;13038.869611303766;13526;13808.17150970945;14017.649558761113;14019.929900350433;10772.384142378705;10909.945450272699;11184.608538701106;11218.83171752408;11578.652640420802;8665.913340866511;9010.954945225232;10630.415327157081;10862.185336099667;10867.456627168767 19:37:27 INFO - PROCESS | 1952 | __end_tp_report 19:37:27 INFO - PROCESS | 1952 | __start_cc_report 19:37:27 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,2014 19:37:27 INFO - PROCESS | 1952 | __end_cc_report 19:37:27 INFO - PROCESS | 1952 | __startTimestamp1479353847337__endTimestamp 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | ------- Summary: start ------- 19:37:27 INFO - PROCESS | 1952 | Number of tests: 6 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5666.91 Median:5790.86 stddev:635.70 (11.0%) stddev-sans-first:609.17 19:37:27 INFO - PROCESS | 1952 | Values: 3268.7 3269.4 3276.6 3305.9 3338.4 4571.8 5597.0 5662.9 5681.4 5690.1 5601.1 5654.7 5674.4 5681.0 5705.6 5082.5 5103.8 5119.3 5157.5 5161.0 5158.6 5249.9 5266.6 5268.7 5290.4 5078.1 5118.4 5228.1 5256.2 5279.3 5146.3 5164.6 5170.9 5175.1 5175.6 5072.9 5111.2 5121.3 5141.4 5145.3 5609.1 5613.8 5618.7 5629.9 5654.0 6090.8 6092.4 6096.7 6101.8 6116.0 6109.4 6148.4 6180.1 6186.3 6228.1 5669.7 5729.0 5732.9 5743.5 5762.1 6144.8 6216.8 6269.7 6269.8 6281.6 5172.0 6004.6 6034.5 6052.0 6091.5 6183.4 6198.0 6217.6 6220.0 6248.3 5972.2 6033.3 6147.9 6153.8 6170.2 6082.2 6104.7 6110.6 6115.1 6134.3 4826.8 4859.0 4867.2 4870.8 4871.8 4303.2 4336.5 4350.1 4360.5 4382.5 5613.1 5673.9 5678.7 5694.3 5733.8 6062.8 6115.7 6119.7 6121.7 6161.7 5717.1 5727.1 5728.5 5734.9 5773.7 5322.5 5343.2 5349.7 5355.1 5365.8 6177.8 6240.4 6252.6 6274.8 6284.3 6132.8 6171.8 6176.3 6254.7 6259.2 6260.1 6264.3 6275.2 6281.9 6305.1 5963.6 6037.2 6045.6 6124.4 6124.4 6048.6 6108.5 6123.8 6134.3 6147.2 5867.6 6038.0 6049.7 6057.7 6096.5 5964.0 5996.9 5999.7 6015.5 6022.7 5691.3 5789.3 5790.9 5820.2 5856.1 6036.5 6041.3 6042.8 6066.7 6098.2 5700.9 5768.8 5772.0 5776.2 5826.6 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:63227.99 Median:38317.40 stddev:138389.70 (361.2%) stddev-sans-first:138697.77 19:37:27 INFO - PROCESS | 1952 | Values: 499.2 506.6 511.3 515.2 540.7 29566.7 31309.1 31313.5 39321.0 40549.0 41492.4 41881.6 41886.2 42011.6 42015.8 9218.7 9231.4 9236.4 9325.1 9392.1 9331.6 9420.2 9425.7 9426.6 9434.2 9362.1 9411.5 9433.0 9438.8 9446.5 9381.1 9399.7 9405.0 9411.2 9415.2 9201.4 9283.8 9288.3 9292.5 9305.1 38283.8 38563.4 38581.0 38627.6 38644.2 3273.8 3333.5 3351.9 3448.6 3645.9 29498.6 29840.8 30000.2 30012.4 30068.2 3115.7 3196.4 3225.5 3309.8 3333.9 434338.0 436118.0 436624.0 436762.0 437381.0 32781.8 58705.4 59049.7 59059.0 59327.0 33784.3 34612.7 34832.8 34843.7 34980.5 14092.0 14235.4 14244.5 14256.4 14265.9 11816.7 11925.6 11930.2 11939.3 11945.5 7735.6 7744.8 7799.4 7815.6 7819.0 2805.7 3186.5 3228.9 3231.1 3266.6 875.9 890.7 932.7 977.4 1014.9 24900.4 29166.9 29292.4 30000.2 30043.7 845.5 1003.8 1023.9 1046.4 1060.2 12363.0 14342.7 14530.0 15033.9 15557.0 624753.0 628230.0 628508.0 629235.0 629608.0 56327.0 56826.7 56907.4 57004.0 57069.0 1204.4 1239.6 1308.3 1323.2 1356.6 27046.6 27695.9 30163.5 30421.8 30985.5 47626.8 48206.0 48255.5 48264.8 48322.0 465497.0 467142.0 467552.0 467664.0 468698.0 25856.2 26224.3 26543.7 26820.7 27062.5 44697.6 45111.8 45169.3 45405.3 46054.0 37142.6 37404.8 37645.0 38351.0 38810.8 33160.7 33741.7 36601.8 38472.8 38537.8 36123.6 36275.1 36486.0 37245.8 37327.8 32501.0 32715.7 32857.8 33338.3 33609.5 23926.9 24295.5 24417.9 24793.9 25289.0 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:32620.97 Median:13391.04 stddev:90141.13 (673.1%) stddev-sans-first:90361.38 19:37:27 INFO - PROCESS | 1952 | Values: 320.8 323.5 349.3 375.0 376.4 14914.0 15846.1 19540.6 19969.6 20862.6 16398.8 19120.2 19725.7 20664.1 20695.5 5276.6 5790.6 5866.0 5867.9 5878.0 3420.3 4201.5 5702.2 5826.2 5828.2 6315.6 6351.1 6401.9 6407.4 6413.2 6123.5 6334.6 6376.9 6386.5 6388.4 5575.8 5583.2 5587.5 5591.2 5595.5 24387.3 25345.9 25357.5 25438.4 25673.4 2253.0 2345.9 2351.9 2356.1 2394.8 10354.2 11873.2 12432.6 14225.9 16061.9 1572.4 1709.1 1769.0 1822.8 1887.6 92527.0 105101.0 119113.0 119591.4 120387.8 11279.7 11396.8 11405.1 11428.9 11571.1 14433.0 14449.4 14455.9 14468.8 14486.6 8145.1 8281.1 8291.0 8338.2 8443.5 6719.9 8074.9 8084.2 8280.5 8369.1 4407.6 4492.5 4537.9 4557.5 4625.9 1725.7 1902.6 1903.5 1907.7 1911.2 806.8 814.6 872.8 928.8 938.5 19311.7 19592.1 20700.4 20805.0 21246.9 782.7 791.8 877.9 916.9 939.7 10366.7 11098.8 11121.1 11130.4 11156.3 233070.7 577290.0 584998.0 591147.0 591572.0 110014.0 138262.0 138365.0 139109.0 141053.0 862.9 926.2 943.9 1011.4 1011.5 17087.7 19191.3 19451.4 19513.4 19731.8 41897.0 55779.0 55978.4 57323.1 57576.0 73590.0 75812.0 78406.4 80135.0 83659.0 6966.8 7356.3 7370.3 7419.3 7541.6 10094.9 11477.0 12529.6 12920.4 13132.2 10903.7 11133.3 11215.1 11380.4 11414.9 10772.2 10890.1 11163.3 11265.8 11479.0 11270.5 11416.9 11490.4 11528.7 11606.6 7201.9 7395.6 7419.6 7490.9 7611.1 9968.6 10703.8 10704.4 10925.3 11365.9 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:5306.00 Median:4943.63 stddev:2934.53 (59.4%) stddev-sans-first:2927.47 19:37:27 INFO - PROCESS | 1952 | Values: 1320.9 1457.6 1477.6 1635.7 1825.9 7382.0 7764.7 7948.1 8264.9 8265.7 8118.6 8206.1 8212.3 8217.5 8220.5 2255.4 2287.6 2288.4 2289.9 2292.1 2265.0 2310.3 2323.1 2323.4 2325.4 2258.2 2268.7 2288.0 2290.5 2294.4 1896.6 2223.4 2288.6 2291.7 2295.4 2266.6 2282.9 2288.0 2289.1 2289.4 8181.1 8348.4 8354.4 8355.1 8376.2 4953.3 4993.6 5122.3 5177.2 5185.1 3153.0 3443.4 3535.4 3543.0 3553.8 1016.3 1041.2 1083.9 1086.4 1089.4 10201.7 10516.5 10645.4 10794.0 10794.7 4167.3 4254.7 4359.3 4372.8 4392.7 8520.4 8529.4 8529.7 8534.3 8534.9 4984.0 4986.5 4991.0 4992.0 4996.0 3981.2 4202.0 4356.0 4359.1 4676.9 3135.2 3572.3 3616.1 3618.3 3627.3 1123.1 1132.2 1136.4 1150.5 1155.7 767.5 799.1 853.8 854.0 870.4 5362.9 5485.5 5513.8 5528.9 5737.4 358.5 406.5 421.9 430.3 430.5 3746.2 3788.6 3818.6 3912.2 3922.5 9576.0 10091.1 10092.8 10104.7 10137.1 8428.8 10023.9 10041.4 10042.0 10047.1 7492.9 7625.9 7628.7 7810.8 7829.1 5387.5 5473.2 5491.9 5590.7 5711.5 9202.9 9250.0 9280.6 9293.7 9443.2 9188.7 9280.7 9384.8 9387.1 9387.5 6615.4 6684.6 6702.7 6706.3 6710.5 7260.7 7561.8 7623.8 7690.3 7807.5 6732.7 6873.3 7040.5 7085.9 7108.5 6847.1 6948.8 6964.2 6984.7 7015.6 6550.6 6678.5 6701.5 6701.8 6712.1 4616.7 4810.4 4810.7 4886.1 4969.5 4722.4 4731.7 4900.0 4934.0 5032.3 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:4182.03 Median:4662.17 stddev:1282.33 (27.5%) stddev-sans-first:1251.82 19:37:27 INFO - PROCESS | 1952 | Values: 268.1 280.5 295.1 300.2 310.4 4823.8 4905.4 5001.9 5017.3 5135.9 4553.9 5063.9 5076.7 5090.2 5095.6 3338.5 3478.3 3621.8 3883.4 3956.3 3446.6 3755.0 3916.8 3923.3 3946.6 3076.8 3889.7 3892.5 3894.9 3922.2 3896.9 3919.2 3927.5 3937.3 3941.9 2686.8 3140.5 3378.9 3379.9 3429.4 4722.0 5003.7 5040.4 5092.8 5110.3 4432.9 4441.0 4462.5 4479.0 4494.7 4660.8 4759.6 5211.8 5337.7 5389.4 3146.7 3583.8 3710.7 3710.8 3732.9 5575.6 5622.9 5631.5 5653.6 5713.4 3304.9 3639.7 3772.9 3788.6 3788.6 3557.7 3763.1 3773.7 3791.5 3816.9 3503.4 4219.5 4317.6 4322.8 4433.6 5314.4 5396.8 5400.9 5456.5 5477.4 1096.1 1193.9 1219.2 1225.6 1244.3 742.4 754.6 800.5 800.9 839.5 4600.3 4606.0 4705.4 4733.8 4748.2 4630.8 5213.5 5251.2 5255.6 5277.6 3910.7 4166.8 4702.5 4748.5 4770.8 2110.5 2310.8 2354.0 2561.4 2584.2 4709.5 5280.5 5346.5 5469.5 5470.1 4890.4 4903.7 5250.8 5256.3 5365.5 4530.8 4744.0 5003.8 5479.6 5481.6 4682.9 5138.5 5212.7 5228.2 5242.6 4395.6 4443.6 4726.6 5167.6 5176.5 4613.4 5335.3 5421.9 5425.3 5494.8 3047.6 3493.8 3554.4 3556.6 3574.9 4361.7 5154.9 5163.1 5164.4 5216.5 4346.6 4440.5 5085.8 5096.0 5149.8 4204.9 4923.8 4938.8 4960.9 4977.8 4256.4 4350.0 4663.5 4870.8 4909.4 4263.4 4619.9 4966.8 4969.5 5054.2 4189.9 4254.6 4836.7 4866.9 4871.0 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:20791.53 Median:4273.98 stddev:31179.76 (729.5%) stddev-sans-first:31230.49 19:37:27 INFO - PROCESS | 1952 | Values: 633.8 672.0 751.6 767.3 797.3 12930.0 14458.6 14793.0 15103.1 15118.4 13140.9 13290.9 13659.0 13669.6 13691.4 785.4 806.9 806.9 808.0 809.3 644.3 658.5 796.1 803.1 823.1 857.2 858.9 859.1 860.4 860.8 851.6 855.1 855.1 855.5 856.4 500.9 508.4 511.7 518.0 632.5 11941.5 13341.6 13817.1 13840.2 14170.6 13314.3 13433.6 13466.9 13604.7 13672.6 10853.2 10886.3 10909.8 10951.9 11161.0 3612.4 3613.4 3627.5 3678.9 3751.3 86999.0 88135.8 88287.6 88877.0 89257.0 8348.7 10304.8 10620.2 10705.8 10732.5 20111.6 20179.7 20319.3 20417.3 20474.7 7608.4 7627.8 7639.4 7681.8 7797.6 3745.3 4171.7 4199.3 4226.2 4252.7 3341.5 3496.3 3527.1 3528.6 3540.6 460.6 534.4 536.6 540.9 542.4 482.1 625.2 627.4 632.2 635.5 7355.9 8228.3 8628.0 8686.3 8875.5 547.9 595.9 608.3 640.5 641.8 4295.3 4336.0 4349.0 4408.4 4427.8 111117.4 114467.0 115253.0 116488.3 120554.4 90880.0 99945.0 104806.4 104935.0 105990.0 92387.0 93060.0 93541.5 93846.0 95777.0 8213.8 8459.5 8481.5 8537.4 8617.6 41455.0 52290.7 55329.0 55614.9 58340.7 54000.7 54255.5 70656.9 74815.6 79236.8 12335.6 12364.2 12503.5 12549.7 12755.4 12770.7 13235.0 13410.0 13463.9 14282.5 12890.4 13576.6 13740.8 13797.9 13898.5 12693.2 13250.9 13347.3 13760.5 13876.5 13038.9 13526.0 13808.2 14017.6 14019.9 10772.4 10909.9 11184.6 11218.8 11578.7 8665.9 9011.0 10630.4 10862.2 10867.5 19:37:27 INFO - PROCESS | 1952 | -------- Summary: end -------- 19:37:27 INFO - PROCESS | 1952 | 19:37:27 INFO - TEST-INFO | 1952: exit 0 19:37:27 INFO - TEST-OK | dromaeo_css | took 1119371ms 19:37:27 INFO - TEST-START | kraken 19:37:27 INFO - operating with platform_type : mac_ 19:37:27 INFO - Initialising browser for kraken test... 19:37:28 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmphxI92d/profile http://localhost:51295/getInfo.html) 19:37:30 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 19:37:30 INFO - PROCESS | 1956 | colorDepth:24 19:37:30 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 19:37:30 INFO - PROCESS | 1956 | __metrics 19:37:30 INFO - PROCESS | 1956 | 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" 19:37:30 INFO - PROCESS | 1956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:31 INFO - TEST-INFO | 1956: exit 0 19:37:31 INFO - Browser initialized. 19:37:31 INFO - Running cycle 1/1 for kraken test... 19:37:31 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmphxI92d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:43 INFO - PROCESS | 1957 | RSS: Main: 237977600 19:37:43 INFO - PROCESS | 1957 | 19:37:45 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-beat-detection) 19:37:46 INFO - PROCESS | 1957 | RSS: Main: 288882688 19:37:46 INFO - PROCESS | 1957 | 19:37:49 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-dft) 19:37:50 INFO - PROCESS | 1957 | RSS: Main: 289574912 19:37:50 INFO - PROCESS | 1957 | 19:37:53 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-fft) 19:37:54 INFO - PROCESS | 1957 | RSS: Main: 380166144 19:37:54 INFO - PROCESS | 1957 | 19:37:56 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51295/tests/kraken/driver.html?testName=audio-oscillator) 19:37:56 INFO - PROCESS | 1957 | RSS: Main: 283983872 19:37:56 INFO - PROCESS | 1957 | 19:37:59 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:37:59 INFO - PROCESS | 1957 | RSS: Main: 286253056 19:37:59 INFO - PROCESS | 1957 | 19:38:02 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51295/tests/kraken/driver.html?testName=imaging-darkroom) 19:38:03 INFO - PROCESS | 1957 | RSS: Main: 329547776 19:38:03 INFO - PROCESS | 1957 | 19:38:06 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51295/tests/kraken/driver.html?testName=imaging-desaturate) 19:38:06 INFO - PROCESS | 1957 | RSS: Main: 330473472 19:38:06 INFO - PROCESS | 1957 | 19:38:09 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51295/tests/kraken/driver.html?testName=json-parse-financial) 19:38:10 INFO - PROCESS | 1957 | RSS: Main: 328216576 19:38:10 INFO - PROCESS | 1957 | 19:38:11 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:38:12 INFO - PROCESS | 1957 | RSS: Main: 304025600 19:38:12 INFO - PROCESS | 1957 | 19:38:14 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:38:14 INFO - PROCESS | 1957 | RSS: Main: 306237440 19:38:14 INFO - PROCESS | 1957 | 19:38:17 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:38:17 INFO - PROCESS | 1957 | RSS: Main: 314552320 19:38:17 INFO - PROCESS | 1957 | 19:38:20 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:38:21 INFO - PROCESS | 1957 | RSS: Main: 328478720 19:38:21 INFO - PROCESS | 1957 | 19:38:24 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:38:25 INFO - PROCESS | 1957 | RSS: Main: 321490944 19:38:25 INFO - PROCESS | 1957 | 19:38:26 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51295/tests/kraken/driver.html?testName=ai-astar) 19:38:27 INFO - PROCESS | 1957 | RSS: Main: 365350912 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | __start_tp_report 19:38:27 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 19:38:27 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 19:38:27 INFO - PROCESS | 1957 | |i|pagename|runs| 19:38:27 INFO - PROCESS | 1957 | |0;ai-astar;113;113;114;114;114;114;113;114;114;113 19:38:27 INFO - PROCESS | 1957 | |1;audio-beat-detection;151;113;115;146;115;115;110;113;144;98 19:38:27 INFO - PROCESS | 1957 | |2;audio-dft;184;189;185;187;184;187;184;184;183;186 19:38:27 INFO - PROCESS | 1957 | |3;audio-fft;80;58;58;85;62;58;58;59;85;58 19:38:27 INFO - PROCESS | 1957 | |4;audio-oscillator;94;91;106;62;90;96;127;98;85;94 19:38:27 INFO - PROCESS | 1957 | |5;imaging-gaussian-blur;88;85;89;86;88;85;88;85;88;85 19:38:27 INFO - PROCESS | 1957 | |6;imaging-darkroom;106;153;123;93;93;93;93;94;93;93 19:38:27 INFO - PROCESS | 1957 | |7;imaging-desaturate;86;85;84;89;70;120;127;95;84;88 19:38:27 INFO - PROCESS | 1957 | |8;json-parse-financial;58;55;54;55;56;55;54;55;54;54 19:38:27 INFO - PROCESS | 1957 | |9;json-stringify-tinderbox;66;66;77;77;73;71;70;71;72;72 19:38:27 INFO - PROCESS | 1957 | |10;stanford-crypto-aes;85;87;87;89;89;87;87;91;93;92 19:38:27 INFO - PROCESS | 1957 | |11;stanford-crypto-ccm;145;151;163;149;148;139;137;154;215;184 19:38:27 INFO - PROCESS | 1957 | |12;stanford-crypto-pbkdf2;174;173;173;175;175;173;174;173;173;173 19:38:27 INFO - PROCESS | 1957 | |13;stanford-crypto-sha256-iterative;68;67;68;67;67;69;66;66;67;65 19:38:27 INFO - PROCESS | 1957 | __end_tp_report 19:38:27 INFO - PROCESS | 1957 | __start_cc_report 19:38:27 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,2038 19:38:27 INFO - PROCESS | 1957 | __end_cc_report 19:38:27 INFO - PROCESS | 1957 | __startTimestamp1479353907165__endTimestamp 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | ------- Summary: start ------- 19:38:27 INFO - PROCESS | 1957 | Number of tests: 14 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:38:27 INFO - PROCESS | 1957 | Values: 113.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 113.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:129.50 stddev:18.04 (13.9%) stddev-sans-first:15.79 19:38:27 INFO - PROCESS | 1957 | Values: 151.0 113.0 115.0 146.0 115.0 115.0 110.0 113.0 144.0 98.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#2] audio-dft Cycles:10 Average:185.30 Median:185.50 stddev:1.89 (1.0%) stddev-sans-first:1.94 19:38:27 INFO - PROCESS | 1957 | Values: 184.0 189.0 185.0 187.0 184.0 187.0 184.0 184.0 183.0 186.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:12.03 (19.9%) stddev-sans-first:11.66 19:38:27 INFO - PROCESS | 1957 | Values: 80.0 58.0 58.0 85.0 62.0 58.0 58.0 59.0 85.0 58.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:92.50 stddev:16.27 (17.6%) stddev-sans-first:17.26 19:38:27 INFO - PROCESS | 1957 | Values: 94.0 91.0 106.0 62.0 90.0 96.0 127.0 98.0 85.0 94.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:1.64 (1.9%) stddev-sans-first:1.67 19:38:27 INFO - PROCESS | 1957 | Values: 88.0 85.0 89.0 86.0 88.0 85.0 88.0 85.0 88.0 85.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:93.00 stddev:19.97 (21.5%) stddev-sans-first:21.16 19:38:27 INFO - PROCESS | 1957 | Values: 106.0 153.0 123.0 93.0 93.0 93.0 93.0 94.0 93.0 93.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:85.50 stddev:17.43 (20.4%) stddev-sans-first:18.31 19:38:27 INFO - PROCESS | 1957 | Values: 86.0 85.0 84.0 89.0 70.0 120.0 127.0 95.0 84.0 88.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:0.71 19:38:27 INFO - PROCESS | 1957 | Values: 58.0 55.0 54.0 55.0 56.0 55.0 54.0 55.0 54.0 54.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.00 stddev:3.75 (5.2%) stddev-sans-first:3.41 19:38:27 INFO - PROCESS | 1957 | Values: 66.0 66.0 77.0 77.0 73.0 71.0 70.0 71.0 72.0 72.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:89.00 stddev:2.58 (2.9%) stddev-sans-first:2.37 19:38:27 INFO - PROCESS | 1957 | Values: 85.0 87.0 87.0 89.0 89.0 87.0 87.0 91.0 93.0 92.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:152.50 stddev:23.95 (15.7%) stddev-sans-first:24.90 19:38:27 INFO - PROCESS | 1957 | Values: 145.0 151.0 163.0 149.0 148.0 139.0 137.0 154.0 215.0 184.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 19:38:27 INFO - PROCESS | 1957 | Values: 174.0 173.0 173.0 175.0 175.0 173.0 174.0 173.0 173.0 173.0 19:38:27 INFO - PROCESS | 1957 | 19:38:27 INFO - PROCESS | 1957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 19:38:27 INFO - PROCESS | 1957 | Values: 68.0 67.0 68.0 67.0 67.0 69.0 66.0 66.0 67.0 65.0 19:38:27 INFO - PROCESS | 1957 | -------- Summary: end -------- 19:38:27 INFO - PROCESS | 1957 | 19:38:28 INFO - TEST-INFO | 1957: exit 0 19:38:28 INFO - TEST-OK | kraken | took 60066ms 19:38:28 INFO - SUITE-END | took 1179s 19:38:28 INFO - Completed test suite (00:19:39) 19:38:28 INFO - javascript benchmark 19:38:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.7058164765167, 3269.444194486937, 3276.574045374102, 3305.8512366943487, 3338.415777238984, 4571.839985600504, 5596.972015139929, 5662.915056274154, 5681.403452637471, 5690.06113991192, 5601.103823388259, 5654.717264136787, 5674.375818659954, 5681.005823980797, 5705.572082093839, 5082.51716086973, 5103.821366252182, 5119.308893299412, 5157.48425157485, 5161.0, 5158.638895277332, 5249.868753281179, 5266.631335806495, 5268.710220937847, 5290.418054014055, 5078.111330517182, 5118.436971933084, 5228.096804115021, 5256.237845512417, 5279.287296215039, 5146.253793200002, 5164.612654050961, 5170.948290517084, 5175.068487672217, 5175.611829112794, 5072.873178170538, 5111.1566591512355, 5121.28302037715, 5141.383034035902, 5145.279660847485, 5609.074502707089, 5613.775448982035, 5618.662880227159, 5629.8592535186945, 5654.010548154057, 6090.756369745205, 6092.421219984094, 6096.664683442409, 6101.816945491642, 6116.0, 6109.3585173556585, 6148.354422785588, 6180.103884936704, 6186.319504854462, 6228.065790131472, 5669.688167150805, 5729.0, 5732.914006289909, 5743.4543718346695, 5762.078067509262, 6144.846378840475, 6216.782412615627, 6269.749210031548, 6269.843253918597, 6281.560290779602, 5171.991461664939, 6004.639721616717, 6034.5172386209, 6051.969740151271, 6091.543134264948, 6183.443490085914, 6198.039303907812, 6217.626942383471, 6219.968900155561, 6248.31268560458, 5972.193753843176, 6033.306169790442, 6147.938520614736, 6153.8461538461, 6170.228721409824, 6082.209312789398, 6104.732011601605, 6110.627719080174, 6115.097174815069, 6134.263888333428, 4826.758662066883, 4859.003904199631, 4867.196912509467, 4870.805167793319, 4871.8294859679745, 4303.182395344875, 4336.544662810423, 4350.108227813291, 4360.520342762294, 4382.517923028464, 5613.073842815889, 5673.886522269531, 5678.68767217807, 5694.288213973254, 5733.827985160452, 6062.818115456544, 6115.666295175977, 6119.746288422706, 6121.727351053096, 6161.6611086389785, 5717.113847353667, 5727.140928860705, 5728.484436400744, 5734.885302293931, 5773.711314434261, 5322.494363035506, 5343.225232341289, 5349.705766182819, 5355.062863998784, 5365.7585408656705, 6177.84555386119, 6240.4071613196675, 6252.624842509464, 6274.843128921905, 6284.277308109626, 6132.814448934826, 6171.753129874754, 6176.289726681489, 6254.749810007549, 6259.186305780219, 6260.092286618506, 6264.31092579825, 6275.152854364603, 6281.874362512815, 6305.117283580211, 5963.612365196248, 6037.18498002764, 6045.6070355426755, 6124.38756124384, 6124.448799608057, 6048.637081775108, 6108.524204008529, 6123.84690382744, 6134.2835184798605, 6147.170132032118, 5867.618604790846, 6038.0, 6049.697515124314, 6057.697115144313, 6096.542759293159, 5963.970180149072, 5996.940030599638, 5999.700014999145, 6015.548833837567, 6022.698865056817, 5691.345495268097, 5789.2763404574425, 5790.85522861915, 5820.243368362086, 5856.092305692625, 6036.486898613492, 6041.2750469943885, 6042.788502402394, 6066.7269972850445, 6098.176746139215, 5700.885982280414, 5768.769249230152, 5771.971140144273, 5776.220210271727, 5826.592138550261], "value": 5625.578019301597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.2212149047485, 506.56182402222066, 511.29186077282975, 515.1654320001601, 540.6918056707678, 29566.704332956662, 31309.060728178163, 31313.530297045534, 39321.01697457565, 40549.0, 41492.37761433581, 41881.58118418815, 41886.16227675445, 42011.57988420115, 42015.78992105035, 9218.723438296862, 9231.446113233194, 9236.3996340238, 9325.114114159178, 9392.060793920622, 9331.580078896466, 9420.199283060949, 9425.717228483121, 9426.622935082623, 9434.245260379188, 9362.110599493037, 9411.482368469766, 9433.009533998935, 9438.81122377552, 9446.480443575601, 9381.061893810633, 9399.71800845969, 9404.965453800076, 9411.152996230372, 9415.199708024791, 9201.401908875901, 9283.814323713555, 9288.349815512916, 9292.488913109777, 9305.069493050709, 38283.80858095719, 38563.42154867679, 38581.0, 38627.61372386268, 38644.227115457536, 3273.770836041478, 3333.5499707539416, 3351.899443016689, 3448.603410607762, 3645.8906232813056, 29498.55752163719, 29840.806367745263, 30000.24999375033, 30012.399752004836, 30068.24829379283, 3115.704008119225, 3196.4406228909847, 3225.516172574109, 3309.834508274577, 3333.916652083693, 434338.0, 436118.0, 436624.0, 436762.0, 437381.0, 32781.836090819874, 58705.41294587, 59049.70475147597, 59059.0, 59327.0, 33784.32431351359, 34612.65387346094, 34832.82583587066, 34843.65156348455, 34980.47529287063, 14092.013559050973, 14235.430582776573, 14244.501442449464, 14256.42974281017, 14265.857341426452, 11816.704582385337, 11925.642230733092, 11930.22453540517, 11939.283642981449, 11945.522179112912, 7735.574543400167, 7744.845103097907, 7799.3760499159935, 7815.6482958267015, 7819.022622172229, 2805.733455321741, 3186.4901615741833, 3228.9192770180935, 3231.092017184553, 3266.591676040495, 875.912408759119, 890.7129198308382, 932.664240873285, 977.4233202410612, 1014.9441780702132, 24900.37749056288, 29166.854165729037, 29292.414151716846, 30000.249993749894, 30043.69956300409, 845.5180547088223, 1003.7791685829106, 1023.8720159980003, 1046.3826342457987, 1060.2154405739698, 12363.0, 14342.713145737027, 14530.0, 15033.924830375998, 15557.0, 624753.0, 628230.0, 628508.0, 629235.0, 629608.0, 56327.0, 56826.71586642123, 56907.43092569021, 57004.0, 57069.0, 1204.3616883051996, 1239.6157191270736, 1308.3458270864378, 1323.245749922535, 1356.5523377285274, 27046.647667616933, 27695.861520692266, 30163.547546786376, 30421.847890760404, 30985.535216972214, 47626.76186619045, 48206.0, 48255.517444825105, 48264.758676206395, 48322.033559327916, 465497.0, 467142.0, 467552.0, 467664.0, 468698.0, 25856.22431327063, 26224.344391389604, 26543.7345626549, 26820.731792681825, 27062.458750825266, 44697.55302447064, 45111.774441127585, 45169.32246016378, 45405.31892021689, 46054.0, 37142.62857371392, 37404.81297593495, 37645.04727003735, 38351.0, 38810.8356749298, 33160.66839331672, 33741.65033398636, 36601.81699091488, 38472.80763596164, 38537.80731096439, 36123.55505779739, 36275.09312267109, 36486.0, 37245.813770930974, 37327.81336093302, 32501.0, 32715.672843271263, 32857.77291040051, 33338.33323333471, 33609.495857562644, 23926.880365598758, 24295.51408971775, 24417.877910610332, 24793.88427520802, 25288.988440462177], "value": 17911.770627070553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.7914855344027, 323.466280636949, 349.34497816593887, 374.9887503374899, 376.4447440025962, 14914.0, 15846.128462934534, 19540.609187816237, 19969.60060798783, 20862.582748345023, 16398.7540186897, 19120.235190592393, 19725.704114438297, 20664.07011684474, 20695.482612934647, 5276.630635855482, 5790.623609465392, 5865.970670146665, 5867.853303667421, 5877.970610146944, 3420.2817408344276, 4201.495820501544, 5702.230198923134, 5826.242588463494, 5828.154917536955, 6315.621062736251, 6351.110844481753, 6401.935980640181, 6407.391297826699, 6413.230412350501, 6123.540734444934, 6334.588251763666, 6376.936230637681, 6386.457151142158, 6388.39310265524, 5575.804846830341, 5583.246261754652, 5587.469190426903, 5591.161325801162, 5595.524380427669, 24387.26838194857, 25345.873270633714, 25357.492850142895, 25438.36404089894, 25673.35816604581, 2253.019936327703, 2345.917892873741, 2351.8824058797163, 2356.104680221505, 2394.8114073610896, 10354.223433242461, 11873.228240164362, 12432.627021189379, 14225.928870355581, 16061.919690401473, 1572.4024870549233, 1709.0856391830434, 1768.9911550442166, 1822.772153480815, 1887.584731359099, 92527.0, 105101.0, 119113.0, 119591.4020429901, 120387.79612203853, 11279.718007049889, 11396.772064558663, 11405.14461415397, 11428.94285528567, 11571.132165087483, 14433.0, 14449.422023119168, 14455.927720361542, 14468.782968255484, 14486.565403037926, 8145.104038555754, 8281.089080201173, 8290.958545207235, 8338.166183381612, 8443.451175673561, 6719.899201511981, 8074.940890073111, 8084.231997960184, 8280.461769984931, 8369.079401265855, 4407.625351845065, 4492.460904691393, 4537.863864084083, 4557.475890272594, 4625.884352891205, 1725.7066298729246, 1902.6289873474539, 1903.4765439504247, 1907.6661584222984, 1911.2259534888392, 806.8341246898293, 814.5886327404622, 872.7818045488627, 928.8142371525722, 938.5119737736339, 19311.725046689033, 19592.11835467379, 20700.378988630364, 20805.0, 21246.893765531382, 782.72213364256, 791.8416316736676, 877.8850859408516, 916.8899732032065, 939.7180845746249, 10366.740831479123, 11098.833517497244, 11121.05471034971, 11130.443477826238, 11156.274842135235, 233070.66929330828, 577290.0, 584998.0, 591147.0, 591572.0, 110014.0, 138262.0, 138365.0, 139109.0, 141053.0, 862.8791969124328, 926.1849572376266, 943.8631398447187, 1011.4487604255698, 1011.5043628621922, 17087.743683845, 19191.32830350931, 19451.416457506297, 19513.43892488569, 19731.80268197357, 41896.95257618584, 55779.0, 55978.44021559732, 57323.14015289857, 57576.0, 73590.0, 75812.0, 78406.4318713634, 80135.0, 83659.0, 6966.756163534252, 7356.337929586363, 7370.262973702587, 7419.258074192753, 7541.585212813348, 10094.949525252621, 11477.0, 12529.624111276677, 12920.418581163682, 13132.212067275994, 10903.727406814893, 11133.343645681, 11215.102791776475, 11380.43097845121, 11414.94292528532, 10772.192085593455, 10890.074343680875, 11163.274387164809, 11265.831012534654, 11479.0, 11270.549178033114, 11416.885831141582, 11490.425478725863, 11528.711782205512, 11606.620642768043, 7201.927980720126, 7395.593242371721, 7419.554826710415, 7490.925090749241, 7611.086669599462, 9968.55141518619, 10703.785924281627, 10704.357738535713, 10925.344479331265, 11365.943170284096], "value": 9370.818259222791, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.9009324300669, 1457.5554455890956, 1477.6084337650523, 1635.7382818749002, 1825.8995755233457, 7382.0, 7764.650590723417, 7948.125706172316, 8264.876026859602, 8265.710700125483, 8118.634661440235, 8206.097329293772, 8212.260896519312, 8217.46586471879, 8220.506769593829, 2255.3797705631, 2287.5996700577416, 2288.4278930267433, 2289.942751431211, 2292.1289909834322, 2264.9886750566225, 2310.2722642367685, 2323.0707716913203, 2323.372689373868, 2325.3721495196287, 2258.1644791427193, 2268.7312687312688, 2287.9885600571974, 2290.530441259546, 2294.3919861236786, 1896.6301571193624, 2223.399682085836, 2288.6338185890345, 2291.656251562279, 2295.3917211938765, 2266.648669456237, 2282.885855707208, 2287.965680514794, 2289.107248173214, 2289.439087423575, 8181.140980197053, 8348.41561090724, 8354.415190936637, 8355.1227121152, 8376.162383761635, 4953.306537084811, 4993.625478089121, 5122.257272695476, 5177.249298851645, 5185.066687996159, 3152.952705709416, 3443.3974054540604, 3535.381308271042, 3543.0433782878736, 3553.8223088845452, 1016.2733645443469, 1041.1826716027958, 1083.9241253112286, 1086.4296244471636, 1089.3844977587637, 10201.744956376077, 10516.474176291154, 10645.361278323326, 10794.02853743159, 10794.73013174669, 4167.270727622654, 4254.744715317029, 4359.258925982527, 4372.759498227564, 4392.714473559208, 8520.360972927056, 8529.360297977677, 8529.658813647384, 8534.317254619615, 8534.914650853412, 4983.975080124576, 4986.501349865057, 4991.0, 4991.950080499221, 4996.025774973918, 3981.1639555693628, 4202.0040480772, 4355.998120432255, 4359.12557600235, 4676.883077923079, 3135.2475405902874, 3572.339117263263, 3616.0598244456633, 3618.3125206210734, 3627.3470775260707, 1123.0510218865045, 1132.17351333527, 1136.4204255829586, 1150.505282728418, 1155.7110722319421, 767.5279702982737, 799.1010113622175, 853.8292341531718, 854.0221446443911, 870.3646338173169, 5362.927414517112, 5485.50630443262, 5513.7794488220825, 5528.944710552843, 5737.397573254748, 358.4766241287749, 406.5081251685435, 421.85656876661466, 430.30076126294773, 430.5307215135517, 3746.2320224353944, 3788.6400791924725, 3818.59904710007, 3912.197999410114, 3922.5489068757456, 9576.0, 10091.142252908585, 10092.848607270897, 10104.69685909424, 10137.087662110445, 8428.8314233715, 10023.899761002442, 10041.397516149054, 10042.0460056296, 10047.145992590566, 7492.925070749332, 7625.885611715828, 7628.69485220596, 7810.804729881685, 7829.099653539802, 5387.542058924879, 5473.151661492475, 5491.890162196653, 5590.720463976703, 5711.457411545896, 9202.907970920205, 9249.953750231205, 9280.58237379333, 9293.67472138472, 9443.244540436612, 9188.678396256098, 9280.675176368795, 9384.765380865532, 9387.061293870558, 9387.483688397204, 6615.4046135848, 6684.598924064571, 6702.698378572878, 6706.295838936841, 6710.496712746466, 7260.745873894389, 7561.7731468056045, 7623.809404764926, 7690.346320562815, 7807.453478256468, 6732.663366831541, 6873.347032031949, 7040.507164498641, 7085.858282834418, 7108.537945033556, 6847.109875716125, 6948.791536253921, 6964.164300283998, 6984.685689143899, 7015.614141222281, 6550.574212676161, 6678.49911256648, 6701.497387695845, 6701.765438209639, 6712.093867328043, 4616.653750968623, 4810.374651295449, 4810.687305325143, 4886.096072226649, 4969.503049695001, 4722.433308003062, 4731.739754313408, 4900.0, 4933.9506604933495, 5032.27032080339], "value": 4215.671694568761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.0938428112978, 280.54271537394044, 295.0852357691157, 300.2314075965527, 310.44275525431846, 4823.807047718092, 4905.362302900622, 5001.899962000763, 5017.272495488152, 5135.948640513594, 4553.88615284618, 5063.898722025558, 5076.695398276106, 5090.236464530322, 5095.566876815476, 3338.4825352070466, 3478.330401407326, 3621.837017334213, 3883.3786594144945, 3956.3274243378696, 3446.5691788526433, 3754.962450375502, 3916.784576848272, 3923.312975420568, 3946.605339466045, 3076.8307743074233, 3889.747166434187, 3892.47451594034, 3894.8636797712084, 3922.195949830278, 3896.941545876814, 3919.196564704229, 3927.509061367329, 3937.330653788863, 3941.881743547698, 2686.838789672626, 3140.5289206618963, 3378.9155271118175, 3379.9015320020844, 3429.416999110132, 4721.952780472186, 5003.674761140514, 5040.36995375578, 5092.821751238689, 5110.28456016158, 4432.911341773147, 4440.977795111004, 4462.4645042594775, 4479.0, 4494.73031618104, 4660.790264438108, 4759.619710284013, 5211.820789318513, 5337.70642614656, 5389.440015992412, 3146.6695996920453, 3583.802890841003, 3710.703143748494, 3710.831088207206, 3732.9440058399146, 5575.637583557096, 5622.943770562283, 5631.465010823965, 5653.632513886584, 5713.400092990218, 3304.8678052877617, 3639.7270204734223, 3772.9245415091546, 3788.583255841855, 3788.6400791924725, 3557.7331700122595, 3763.0592351912023, 3773.716971227169, 3791.469194312798, 3816.866409675648, 3503.4219353806848, 4219.472565929259, 4317.633001194934, 4322.827086916488, 4433.556644335606, 5314.386217372224, 5396.78412863481, 5400.864978375572, 5456.454354564512, 5477.424870388551, 1096.1176253116319, 1193.928364298145, 1219.2379762648345, 1225.6078055022485, 1244.3342811595753, 742.361569050616, 754.5925200391837, 800.4917306345358, 800.9479383840031, 839.4879123734516, 4600.332951721982, 4606.032733126081, 4705.411823522059, 4733.810647574127, 4748.243150034509, 4630.814767409266, 5213.452587478336, 5251.2123181523075, 5255.6321057526375, 5277.577793776489, 3910.7066969977363, 4166.770802613237, 4702.482726900038, 4748.4539277982785, 4770.833020844254, 2110.504031552584, 2310.7920287173897, 2353.9995501911962, 2561.3596600849787, 2584.1988983415204, 4709.458412282563, 5280.471952804689, 5346.4653534647005, 5469.535089517435, 5470.073510671771, 4890.414471997038, 4903.6847574135245, 5250.7637156328055, 5256.2904007959205, 5365.466181076984, 4530.84142055033, 4744.0, 5003.774075351562, 5479.630027533118, 5481.561475081904, 4682.929756053593, 5138.511841375063, 5212.661177023481, 5228.241904923841, 5242.633015689018, 4395.626371758436, 4443.577860103285, 4726.645501587326, 5167.61242906776, 5176.456472070378, 4613.400257966578, 5335.279737235579, 5421.891562168814, 5425.294711687456, 5494.81861399801, 3047.5733397323947, 3493.8078405686915, 3554.413521768879, 3556.5732112146707, 3574.857005719742, 4361.694681372273, 5154.922676159786, 5163.134460374378, 5164.431912489698, 5216.504432078947, 4346.630536404441, 4440.4671439427475, 5085.847424577269, 5096.0, 5149.845504634867, 4204.873853784391, 4923.8276660316715, 4938.802447902043, 4960.8759781005765, 4977.825776097964, 4256.446661933929, 4350.0, 4663.543653924984, 4870.78081486341, 4909.4354149273295, 4263.3818096375235, 4619.93070103942, 4966.751662416937, 4969.527894849984, 5054.19132938728, 4189.853355132677, 4254.617084462413, 4836.661433699607, 4866.902661946812, 4870.975645121752], "value": 3770.4381914208134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.762339122829, 671.958171597839, 751.6204316820005, 767.286423626028, 797.3222760653443, 12930.0, 14458.566243012714, 14793.0, 15103.093814371145, 15118.39526418942, 13140.948724102072, 13290.867091329084, 13659.0, 13669.589912302647, 13691.383887725051, 785.3991696352281, 806.8709006558952, 806.9273765361116, 807.9515229086244, 809.3282575462352, 644.336333576417, 658.5061204096927, 796.1004065406083, 803.116571771053, 823.1398188892591, 857.2499063319596, 858.8883445152153, 859.0936561927165, 860.3504354212561, 860.802015536427, 851.5571902610639, 855.110684887716, 855.1192271959891, 855.495257797896, 856.3748463621529, 500.9474005229435, 508.438175815722, 511.69298420947507, 517.9792808287701, 632.4529282170935, 11941.522339106425, 13341.599752007456, 13817.101888377223, 13840.23878686682, 14170.574882753534, 13314.267715275655, 13433.596992090253, 13466.865331346658, 13604.727905441934, 13672.589822305346, 10853.186011049203, 10886.292390994638, 10909.83635245472, 10951.890481095166, 11161.0, 3612.3678356287546, 3613.421852503613, 3627.4740162676526, 3678.8712395066314, 3751.3060083884297, 86999.0, 88135.79660508475, 88287.55856220741, 88877.0, 89257.0, 8348.66605335792, 10304.845427318596, 10620.150387969099, 10705.83941240882, 10732.463376831127, 20111.597768044558, 20179.697304540445, 20319.288824891057, 20417.2853950114, 20474.692879606817, 7608.391328693691, 7627.809304767426, 7639.388848892076, 7681.807954801175, 7797.649105790253, 3745.269672413853, 4171.749695018309, 4199.265128602544, 4226.218149642326, 4252.659787217015, 3341.515480255398, 3496.3356962177104, 3527.1005893496995, 3528.647135286451, 3540.5574303212097, 460.63149480415535, 534.3774502704383, 536.6029138437606, 540.9377921539074, 542.4060653584397, 482.08068403876956, 625.2059883947361, 627.4478458956089, 632.2160520953984, 635.4757325206723, 7355.889661655079, 8228.25945664893, 8628.0, 8686.261667758312, 8875.511846848356, 547.8657728856456, 595.9046552551571, 608.3490664988508, 640.4620119099885, 641.8074577626787, 4295.29127693927, 4335.956640433618, 4349.0, 4408.404865343137, 4427.845025424094, 111117.44441277742, 114467.0, 115253.0, 116488.25267620993, 120554.3972280133, 90880.0, 99945.0, 104806.42790358151, 104935.0, 105990.0, 92387.0, 93060.0, 93541.5322923381, 93846.0, 95777.04222957681, 8213.7555665513, 8459.492430454193, 8481.533515656698, 8537.359698022548, 8617.569121543773, 41455.0, 52290.67536932344, 55329.0, 55614.88770224654, 58340.708296458244, 54000.729996349764, 54255.45744542504, 70656.94014589682, 74815.62592187004, 79236.81144782949, 12335.568255111028, 12364.1963272387, 12503.499860005863, 12549.749005019667, 12755.426005829946, 12770.68073298175, 13235.0, 13410.0, 13463.932680336535, 14282.500112496013, 12890.35548222604, 13576.59270221895, 13740.793888091886, 13797.931010344884, 13898.51355202563, 12693.174943628635, 13250.933745331597, 13347.332633368487, 13760.518381856587, 13876.514321999086, 13038.869611303766, 13526.0, 13808.17150970945, 14017.649558761113, 14019.929900350433, 10772.384142378705, 10909.945450272699, 11184.608538701106, 11218.83171752408, 11578.652640420802, 8665.913340866511, 9010.954945225232, 10630.415327157081, 10862.185336099667, 10867.456627168767], "value": 7129.760252269561, "unit": "score"}], "name": "dromaeo_css", "value": 6890.396919113061, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 113.0, 115.0, 146.0, 115.0, 115.0, 110.0, 113.0, 144.0, 98.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 189.0, 185.0, 187.0, 184.0, 187.0, 184.0, 184.0, 183.0, 186.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 85.0, 62.0, 58.0, 58.0, 59.0, 85.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 106.0, 62.0, 90.0, 96.0, 127.0, 98.0, 85.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 88.0, 85.0, 88.0, 85.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 153.0, 123.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 89.0, 70.0, 120.0, 127.0, 95.0, 84.0, 88.0], "value": 92.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 54.0, 55.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 77.0, 77.0, 73.0, 71.0, 70.0, 71.0, 72.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 89.0, 89.0, 87.0, 87.0, 91.0, 93.0, 92.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 151.0, 163.0, 149.0, 148.0, 139.0, 137.0, 154.0, 215.0, 184.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 173.0, 175.0, 175.0, 173.0, 174.0, 173.0, 173.0, 173.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 69.0, 66.0, 66.0, 67.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1478.4999999999998, "alertThreshold": 2.0}]} 19:38:28 INFO - Return code: 0 19:38:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:38:28 INFO - # TBPL SUCCESS # 19:38:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:38:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:38:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:38:28 INFO - 2016-11-16 19:38:28.509 screenresolution[1961:15383] starting screenresolution argv=screenresolution get 19:38:28 INFO - 2016-11-16 19:38:28.511 screenresolution[1961:15383] Display 0: 1600x1200x32@60 19:38:28 INFO - 2016-11-16 19:38:28.517 screenresolution[1962:15386] starting screenresolution argv=screenresolution list 19:38:28 INFO - Available Modes on Display 0 19:38:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:38:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:38:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:38:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:38:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:38:28 INFO - Intel Iris: 19:38:28 INFO - Chipset Model: Intel Iris 19:38:28 INFO - Type: GPU 19:38:28 INFO - Bus: Built-In 19:38:28 INFO - VRAM (Dynamic, Max): 1536 MB 19:38:28 INFO - Vendor: Intel (0x8086) 19:38:28 INFO - Device ID: 0x0a2e 19:38:28 INFO - Revision ID: 0x0009 19:38:28 INFO - Displays: 19:38:28 INFO - Display: 19:38:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:38:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:38:28 INFO - Display Serial Number: 1600x1200 60 19:38:28 INFO - Main Display: Yes 19:38:28 INFO - Mirror: Off 19:38:28 INFO - Online: Yes 19:38:28 INFO - Rotation: Supported 19:38:28 INFO - Return code: 0 19:38:28 INFO - Running post-action listener: _resource_record_post_action 19:38:28 INFO - [mozharness: 2016-11-17 03:38:28.754937Z] Finished run-tests step (success) 19:38:28 INFO - Running post-run listener: _resource_record_post_run 19:38:28 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 774144; Write bytes: 701517824; Read time: 10; Write time: 2001 19:38:28 INFO - TinderboxPrint: CPU usage
53.8% 19:38:28 INFO - TinderboxPrint: I/O read bytes / time
774,144 / 10 19:38:28 INFO - TinderboxPrint: I/O write bytes / time
701,517,824 / 2,001 19:38:28 INFO - TinderboxPrint: CPU idle
2,243.1 (46.2%) 19:38:28 INFO - TinderboxPrint: CPU system
975.1 (20.1%) 19:38:28 INFO - TinderboxPrint: CPU user
1,639.6 (33.8%) 19:38:28 INFO - TinderboxPrint: Swap in / out
399,454,208 / 0 19:38:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379091456; Write bytes: 374204416; Read time: 28207; Write time: 761 19:38:28 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 774144; Write bytes: 299440128; Read time: 10; Write time: 1179 19:38:29 INFO - Running post-run listener: _upload_blobber_files 19:38:29 INFO - Blob upload gear active. 19:38:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:38:29 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 19:38:29 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'] 19:38:29 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 19:38:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:38:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:30 INFO - (blobuploader) - INFO - Done attempting. 19:38:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:38:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:38:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:31 INFO - (blobuploader) - INFO - Done attempting. 19:38:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:38:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:33 INFO - (blobuploader) - INFO - Done attempting. 19:38:33 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:33 INFO - Return code: 0 19:38:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:38:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd3c81414f289b3e3e07e574d82d891a60ebf270a6dcfffa18a1010e034984efc3dadc2c8ec69ce08e61fb0214d10ddd242d1b3106b9c40badd30114c303aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/155a8547c1a0a7883d8066d100286e31e6344835a48570a8f302369ad0fccb9aab8fe0ac35e2491c767da0ebffbb66e6e27f8bd14006ce38dfb303777c5dcb0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f8f53d4792cfb5d7876f111a7365e194beb67d60b8c54259185ac84001abca79b1f84bede6af61f636ca7a2dff48ff82ec12c4ee3b69f696e6552d78a299708"} 19:38:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:38:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:38:33 INFO - Contents: 19:38:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd3c81414f289b3e3e07e574d82d891a60ebf270a6dcfffa18a1010e034984efc3dadc2c8ec69ce08e61fb0214d10ddd242d1b3106b9c40badd30114c303aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/155a8547c1a0a7883d8066d100286e31e6344835a48570a8f302369ad0fccb9aab8fe0ac35e2491c767da0ebffbb66e6e27f8bd14006ce38dfb303777c5dcb0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f8f53d4792cfb5d7876f111a7365e194beb67d60b8c54259185ac84001abca79b1f84bede6af61f636ca7a2dff48ff82ec12c4ee3b69f696e6552d78a299708"} 19:38:33 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:33 INFO - Copying logs to upload dir... 19:38:33 INFO - mkdir: /builds/slave/test/build/upload/logs 19:38:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.173858 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-16 19:38:34.014786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 19:38:34.018473) ========= 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.jlIhiciYrw/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.ECMQZNVEOW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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/cd3c81414f289b3e3e07e574d82d891a60ebf270a6dcfffa18a1010e034984efc3dadc2c8ec69ce08e61fb0214d10ddd242d1b3106b9c40badd30114c303aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/155a8547c1a0a7883d8066d100286e31e6344835a48570a8f302369ad0fccb9aab8fe0ac35e2491c767da0ebffbb66e6e27f8bd14006ce38dfb303777c5dcb0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f8f53d4792cfb5d7876f111a7365e194beb67d60b8c54259185ac84001abca79b1f84bede6af61f636ca7a2dff48ff82ec12c4ee3b69f696e6552d78a299708"} build_url:https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010810 build_url: 'https://queue.taskcluster.net/v1/task/FFXuJHSLT7KzHvjgXuXV7w/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/cd3c81414f289b3e3e07e574d82d891a60ebf270a6dcfffa18a1010e034984efc3dadc2c8ec69ce08e61fb0214d10ddd242d1b3106b9c40badd30114c303aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/155a8547c1a0a7883d8066d100286e31e6344835a48570a8f302369ad0fccb9aab8fe0ac35e2491c767da0ebffbb66e6e27f8bd14006ce38dfb303777c5dcb0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f8f53d4792cfb5d7876f111a7365e194beb67d60b8c54259185ac84001abca79b1f84bede6af61f636ca7a2dff48ff82ec12c4ee3b69f696e6552d78a299708"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 19:38:34.054468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:38:34.054798) ========= 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.jlIhiciYrw/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.ECMQZNVEOW/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 19:38:34.103621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 19:38:34.103944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 19:38:34.104265) ========= ========= Total master_lag: 0.19 =========