builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0360 starttime: 1480437600.62 results: success (0) buildid: 20161129062926 builduid: 048a0259962446d380020565c40f4e96 revision: 130bb29013a1d089dd533e50e170eabedce157d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.623217) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.623852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.624130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.650296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.650735) ========= 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.ODgOfTww7v/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.k0v8gq8pdk/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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-29 08:40:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.04M=0.001s 2016-11-29 08:40:00 (8.04 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.777846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.778315) ========= 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.ODgOfTww7v/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.k0v8gq8pdk/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.019118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:00.828065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 08:40:00.828429) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 130bb29013a1d089dd533e50e170eabedce157d8 --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 130bb29013a1d089dd533e50e170eabedce157d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ODgOfTww7v/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.k0v8gq8pdk/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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-29 08:40:00,911 truncating revision to first 12 chars 2016-11-29 08:40:00,911 Setting DEBUG logging. 2016-11-29 08:40:00,912 attempt 1/10 2016-11-29 08:40:00,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/130bb29013a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 08:40:02,473 unpacking tar archive at: mozilla-central-130bb29013a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.809058 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 08:40:02.661210) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:02.661722) ========= script_repo_revision: 130bb29013a1d089dd533e50e170eabedce157d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:02.662211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:02.662499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 08:40:02.683056) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-29 08:40:02.683412) ========= /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.ODgOfTww7v/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.k0v8gq8pdk/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:02 INFO - MultiFileLogger online at 20161129 08:40:02 in /builds/slave/test 08:40:02 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 08:40:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:02 INFO - {'append_to_log': False, 08:40:02 INFO - 'base_work_dir': '/builds/slave/test', 08:40:02 INFO - 'blob_upload_branch': 'Firefox', 08:40:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:02 INFO - 'branch': 'Firefox', 08:40:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:02 INFO - 'config_files': ('talos/mac_config.py',), 08:40:02 INFO - 'default_actions': ('clobber', 08:40:02 INFO - 'read-buildbot-config', 08:40:02 INFO - 'download-and-extract', 08:40:02 INFO - 'populate-webroot', 08:40:02 INFO - 'create-virtualenv', 08:40:02 INFO - 'install', 08:40:02 INFO - 'run-tests'), 08:40:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:02 INFO - 'download_minidump_stackwalk': True, 08:40:02 INFO - 'download_symbols': 'ondemand', 08:40:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:02 INFO - 'installer_path': 'installer.exe', 08:40:02 INFO - 'log_level': 'info', 08:40:02 INFO - 'log_name': 'talos', 08:40:02 INFO - 'log_to_console': True, 08:40:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:02 INFO - 'opt_config_files': (), 08:40:02 INFO - 'pip_index': False, 08:40:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:02 INFO - 'cmd': ('bash', 08:40:02 INFO - '-c', 08:40:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:02 INFO - 'enabled': True, 08:40:02 INFO - 'halt_on_failure': False, 08:40:02 INFO - 'name': 'check_screen_resolution'},), 08:40:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:02 INFO - 'cmd': ('bash', 08:40:02 INFO - '-c', 08:40:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:02 INFO - 'enabled': True, 08:40:02 INFO - 'halt_on_failure': False, 08:40:02 INFO - 'name': 'check_screen_resolution'},), 08:40:02 INFO - 'run_cmd_checks_enabled': True, 08:40:02 INFO - 'sps_profile': False, 08:40:02 INFO - 'sps_profile_interval': 0, 08:40:02 INFO - 'suite': 'dromaeojs', 08:40:02 INFO - 'system_bits': '32', 08:40:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:02 INFO - 'title': 't-yosemite-r7-0360', 08:40:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:02 INFO - 'use_talos_json': True, 08:40:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:02 INFO - 'work_dir': 'build'} 08:40:02 INFO - [mozharness: 2016-11-29 16:40:02.885385Z] Running clobber step. 08:40:02 INFO - Running pre-action listener: _resource_record_pre_action 08:40:02 INFO - Running main action method: clobber 08:40:02 INFO - rmtree: /builds/slave/test/build 08:40:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:04 INFO - Running post-action listener: _resource_record_post_action 08:40:04 INFO - [mozharness: 2016-11-29 16:40:04.357395Z] Finished clobber step (success) 08:40:04 INFO - [mozharness: 2016-11-29 16:40:04.357572Z] Running read-buildbot-config step. 08:40:04 INFO - Running pre-action listener: _resource_record_pre_action 08:40:04 INFO - Running main action method: read_buildbot_config 08:40:04 INFO - Using buildbot properties: 08:40:04 INFO - { 08:40:04 INFO - "project": "", 08:40:04 INFO - "product": "firefox", 08:40:04 INFO - "script_repo_revision": "production", 08:40:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:40:04 INFO - "repository": "", 08:40:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:40:04 INFO - "buildid": "20161129062926", 08:40:04 INFO - "pgo_build": "False", 08:40:04 INFO - "basedir": "/builds/slave/test", 08:40:04 INFO - "buildnumber": 4, 08:40:04 INFO - "slavename": "t-yosemite-r7-0360", 08:40:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:40:04 INFO - "platform": "yosemite_r7", 08:40:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:40:04 INFO - "branch": "mozilla-central", 08:40:04 INFO - "repo_path": "mozilla-central", 08:40:04 INFO - "revision": "130bb29013a1d089dd533e50e170eabedce157d8", 08:40:04 INFO - "stage_platform": "macosx64", 08:40:04 INFO - "builduid": "048a0259962446d380020565c40f4e96", 08:40:04 INFO - "slavebuilddir": "test" 08:40:04 INFO - } 08:40:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:40:04 INFO - Running post-action listener: _resource_record_post_action 08:40:04 INFO - [mozharness: 2016-11-29 16:40:04.360706Z] Finished read-buildbot-config step (success) 08:40:04 INFO - [mozharness: 2016-11-29 16:40:04.360792Z] Running download-and-extract step. 08:40:04 INFO - Running pre-action listener: _resource_record_pre_action 08:40:04 INFO - Running main action method: download_and_extract 08:40:04 INFO - mkdir: /builds/slave/test/build/tests 08:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:04 INFO - trying https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:40:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/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 08:40:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/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 08:40:05 INFO - Downloaded 1199 bytes. 08:40:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:40:05 INFO - Using the following test package requirements: 08:40:05 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:40:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:40:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:40:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'jsshell-mac.zip'], 08:40:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:40:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:40:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:40:05 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:40:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:40:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:40:05 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:40:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:40:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:40:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:40:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:40:06 INFO - Http code: 200 08:40:06 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 08:40:06 INFO - x-amz-cf-id: 3eDse2GMLhBnYO_Ut8XuSHEvRTfzusyo_gi5W7lf3DT63ayYQ2JCbw== 08:40:06 INFO - x-amz-version-id: XQ8UQO49jPCyrT0b.7OSYSssMyOSIkRR 08:40:06 INFO - Expected file size: 16284843 08:40:06 INFO - Obtained file size: 16284843 08:40:13 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 08:40:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:40:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:40:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:40:13 INFO - Http code: 200 08:40:13 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 08:40:13 INFO - x-amz-cf-id: jRifYYnPS5nVtrBdtHD_j75Fb0bmXZr-3Gs9gcDFFIo5XHuAXLA7eg== 08:40:13 INFO - x-amz-version-id: XQ8UQO49jPCyrT0b.7OSYSssMyOSIkRR 08:40:14 INFO - Expected file size: 16284843 08:40:14 INFO - Obtained file size: 16284843 08:40:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:40:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:40:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:40:21 INFO - Http code: 200 08:40:21 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 08:40:21 INFO - x-amz-cf-id: o_HzYRpQkM7TUsuXOJI-l-OPuZyaqte4qrLwIXLFfVdY23ipr5UZKg== 08:40:21 INFO - x-amz-version-id: 6EZEvV98gkob4GgJpfgjd6Gw.QYrkrdC 08:40:21 INFO - Expected file size: 14409702 08:40:21 INFO - Obtained file size: 14409702 08:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:22 INFO - trying https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:40:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:40:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/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 08:40:24 INFO - Downloaded 107588335 bytes. 08:40:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:40:24 INFO - mkdir: /builds/slave/test/properties 08:40:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:24 INFO - Contents: 08:40:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:40:25 INFO - Running post-action listener: _resource_record_post_action 08:40:25 INFO - Running post-action listener: set_extra_try_arguments 08:40:25 INFO - [mozharness: 2016-11-29 16:40:25.619677Z] Finished download-and-extract step (success) 08:40:25 INFO - [mozharness: 2016-11-29 16:40:25.619775Z] Running populate-webroot step. 08:40:25 INFO - Running pre-action listener: _resource_record_pre_action 08:40:25 INFO - Running main action method: populate_webroot 08:40:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:25 INFO - '--tppagecycles', 08:40:25 INFO - '7'], 08:40:25 INFO - 'tests': ['tsvgm']}}, 08:40:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:40:25 INFO - 'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:40:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:40:25 INFO - 'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['damp', 'tps']}, 08:40:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:40:25 INFO - 'tests': ['damp', 'tps']}, 08:40:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['dromaeo_dom']}, 08:40:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['basic_compositor_video']}, 08:40:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['a11yr', 08:40:25 INFO - 'ts_paint', 08:40:25 INFO - 'tpaint', 08:40:25 INFO - 'sessionrestore', 08:40:25 INFO - 'sessionrestore_no_auto_restore', 08:40:25 INFO - 'tabpaint']}, 08:40:25 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:25 INFO - 'ts_paint', 08:40:25 INFO - 'tpaint', 08:40:25 INFO - 'sessionrestore', 08:40:25 INFO - 'sessionrestore_no_auto_restore', 08:40:25 INFO - 'tabpaint']}, 08:40:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:25 INFO - 'ts_paint', 08:40:25 INFO - 'tpaint', 08:40:25 INFO - 'sessionrestore', 08:40:25 INFO - 'sessionrestore_no_auto_restore', 08:40:25 INFO - 'tabpaint']}, 08:40:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:25 INFO - 'ts_paint', 08:40:25 INFO - 'tpaint', 08:40:25 INFO - 'sessionrestore', 08:40:25 INFO - 'sessionrestore_no_auto_restore', 08:40:25 INFO - 'tabpaint']}, 08:40:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['a11yr', 08:40:25 INFO - 'ts_paint', 08:40:25 INFO - 'tpaint', 08:40:25 INFO - 'sessionrestore', 08:40:25 INFO - 'sessionrestore_no_auto_restore', 08:40:25 INFO - 'tabpaint']}, 08:40:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['a11yr', 08:40:25 INFO - 'ts_paint', 08:40:25 INFO - 'tpaint', 08:40:25 INFO - 'sessionrestore', 08:40:25 INFO - 'sessionrestore_no_auto_restore', 08:40:25 INFO - 'tabpaint']}, 08:40:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['tsvgx', 08:40:25 INFO - 'tsvgr_opacity', 08:40:25 INFO - 'tart', 08:40:25 INFO - 'tscrollx', 08:40:25 INFO - 'cart', 08:40:25 INFO - 'tsvg_static']}, 08:40:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:25 INFO - 'tsvgr_opacity', 08:40:25 INFO - 'tart', 08:40:25 INFO - 'tscrollx', 08:40:25 INFO - 'cart', 08:40:25 INFO - 'tsvg_static']}, 08:40:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:40:25 INFO - 'talos_options': ['--disable-e10s'], 08:40:25 INFO - 'tests': ['tp5o']}, 08:40:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:40:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:40:25 INFO - 'talos_options': ['--disable-e10s', 08:40:25 INFO - '--xperf_path', 08:40:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:25 INFO - 'tests': ['tp5n']}, 08:40:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:40:25 INFO - 'talos_options': ['--xperf_path', 08:40:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:25 INFO - 'tests': ['tp5n']}}, 08:40:25 INFO - 'talos.zip': {'path': '', 08:40:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:25 INFO - Running post-action listener: _resource_record_post_action 08:40:25 INFO - [mozharness: 2016-11-29 16:40:25.637541Z] Finished populate-webroot step (success) 08:40:25 INFO - [mozharness: 2016-11-29 16:40:25.637669Z] Running create-virtualenv step. 08:40:25 INFO - Running pre-action listener: _resource_record_pre_action 08:40:25 INFO - Running main action method: create_virtualenv 08:40:25 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:25 INFO - Using real prefix '/tools/python27' 08:40:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:29 INFO - Installing pip.................done. 08:40:29 INFO - Return code: 0 08:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:29 INFO - Reading from file tmpfile_stdout 08:40:29 INFO - Output received: 08:40:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:40:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:29 INFO - 'HOME': '/Users/cltbld', 08:40:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:29 INFO - 'LOGNAME': 'cltbld', 08:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:29 INFO - 'MOZ_NO_REMOTE': '1', 08:40:29 INFO - 'NO_EM_RESTART': '1', 08:40:29 INFO - 'PAGER': '/bin/cat', 08:40:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:29 INFO - 'PWD': '/builds/slave/test', 08:40:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:29 INFO - 'SHELL': '/bin/bash', 08:40:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:29 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:29 INFO - 'USER': 'cltbld', 08:40:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:29 INFO - 'XPC_FLAGS': '0x0', 08:40:29 INFO - 'XPC_SERVICE_NAME': '0', 08:40:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:30 INFO - Cleaning up... 08:40:30 INFO - Return code: 0 08:40:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:30 INFO - 'HOME': '/Users/cltbld', 08:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:30 INFO - 'LOGNAME': 'cltbld', 08:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:30 INFO - 'MOZ_NO_REMOTE': '1', 08:40:30 INFO - 'NO_EM_RESTART': '1', 08:40:30 INFO - 'PAGER': '/bin/cat', 08:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:30 INFO - 'PWD': '/builds/slave/test', 08:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:30 INFO - 'SHELL': '/bin/bash', 08:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:30 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:30 INFO - 'USER': 'cltbld', 08:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:30 INFO - 'XPC_FLAGS': '0x0', 08:40:30 INFO - 'XPC_SERVICE_NAME': '0', 08:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:30 INFO - Downloading/unpacking psutil>=3.1.1 08:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:33 INFO - Installing collected packages: psutil 08:40:33 INFO - Running setup.py install for psutil 08:40:34 INFO - building 'psutil._psutil_osx' extension 08:40:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:40:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:40:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:40:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:40:34 INFO - building 'psutil._psutil_posix' extension 08:40:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:40:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:40:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:40:34 INFO - ^ 08:40:34 INFO - 1 warning generated. 08:40:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:40:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:34 INFO - Successfully installed psutil 08:40:34 INFO - Cleaning up... 08:40:34 INFO - Return code: 0 08:40:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:34 INFO - 'HOME': '/Users/cltbld', 08:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:34 INFO - 'LOGNAME': 'cltbld', 08:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:34 INFO - 'MOZ_NO_REMOTE': '1', 08:40:34 INFO - 'NO_EM_RESTART': '1', 08:40:34 INFO - 'PAGER': '/bin/cat', 08:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:34 INFO - 'PWD': '/builds/slave/test', 08:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:34 INFO - 'SHELL': '/bin/bash', 08:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:34 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:34 INFO - 'USER': 'cltbld', 08:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:34 INFO - 'XPC_FLAGS': '0x0', 08:40:34 INFO - 'XPC_SERVICE_NAME': '0', 08:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:37 INFO - Installing collected packages: mozsystemmonitor 08:40:37 INFO - Running setup.py install for mozsystemmonitor 08:40:37 INFO - Successfully installed mozsystemmonitor 08:40:37 INFO - Cleaning up... 08:40:38 INFO - Return code: 0 08:40:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:38 INFO - 'HOME': '/Users/cltbld', 08:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:38 INFO - 'LOGNAME': 'cltbld', 08:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:38 INFO - 'MOZ_NO_REMOTE': '1', 08:40:38 INFO - 'NO_EM_RESTART': '1', 08:40:38 INFO - 'PAGER': '/bin/cat', 08:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:38 INFO - 'PWD': '/builds/slave/test', 08:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:38 INFO - 'SHELL': '/bin/bash', 08:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:38 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:38 INFO - 'USER': 'cltbld', 08:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:38 INFO - 'XPC_FLAGS': '0x0', 08:40:38 INFO - 'XPC_SERVICE_NAME': '0', 08:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:41 INFO - warning: no files found matching '*.txt' 08:40:41 INFO - no previously-included directories found matching 'build' 08:40:41 INFO - no previously-included directories found matching 'dist' 08:40:41 INFO - no previously-included directories found matching '.git*' 08:40:41 INFO - Installing collected packages: jsonschema, functools32 08:40:41 INFO - Running setup.py install for functools32 08:40:41 INFO - warning: no files found matching '*.txt' 08:40:41 INFO - no previously-included directories found matching 'build' 08:40:41 INFO - no previously-included directories found matching 'dist' 08:40:41 INFO - no previously-included directories found matching '.git*' 08:40:41 INFO - Successfully installed jsonschema functools32 08:40:41 INFO - Cleaning up... 08:40:41 INFO - Return code: 0 08:40:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:40:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:41 INFO - 'HOME': '/Users/cltbld', 08:40:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:41 INFO - 'LOGNAME': 'cltbld', 08:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:41 INFO - 'MOZ_NO_REMOTE': '1', 08:40:41 INFO - 'NO_EM_RESTART': '1', 08:40:41 INFO - 'PAGER': '/bin/cat', 08:40:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:41 INFO - 'PWD': '/builds/slave/test', 08:40:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:41 INFO - 'SHELL': '/bin/bash', 08:40:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:41 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:41 INFO - 'USER': 'cltbld', 08:40:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:41 INFO - 'XPC_FLAGS': '0x0', 08:40:41 INFO - 'XPC_SERVICE_NAME': '0', 08:40:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:41 INFO - Cleaning up... 08:40:41 INFO - Return code: 0 08:40:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:40:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:41 INFO - 'HOME': '/Users/cltbld', 08:40:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:41 INFO - 'LOGNAME': 'cltbld', 08:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:41 INFO - 'MOZ_NO_REMOTE': '1', 08:40:41 INFO - 'NO_EM_RESTART': '1', 08:40:41 INFO - 'PAGER': '/bin/cat', 08:40:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:41 INFO - 'PWD': '/builds/slave/test', 08:40:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:41 INFO - 'SHELL': '/bin/bash', 08:40:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:41 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:41 INFO - 'USER': 'cltbld', 08:40:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:41 INFO - 'XPC_FLAGS': '0x0', 08:40:41 INFO - 'XPC_SERVICE_NAME': '0', 08:40:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:45 INFO - Downloading docopt-0.6.1.tar.gz 08:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:46 INFO - Running setup.py install for blobuploader 08:40:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:46 INFO - Running setup.py install for requests 08:40:46 INFO - Running setup.py install for docopt 08:40:46 INFO - Successfully installed blobuploader requests docopt 08:40:46 INFO - Cleaning up... 08:40:46 INFO - Return code: 0 08:40:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:46 INFO - 'HOME': '/Users/cltbld', 08:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:46 INFO - 'LOGNAME': 'cltbld', 08:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:46 INFO - 'MOZ_NO_REMOTE': '1', 08:40:46 INFO - 'NO_EM_RESTART': '1', 08:40:46 INFO - 'PAGER': '/bin/cat', 08:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:46 INFO - 'PWD': '/builds/slave/test', 08:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:46 INFO - 'SHELL': '/bin/bash', 08:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:46 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:46 INFO - 'USER': 'cltbld', 08:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:46 INFO - 'XPC_FLAGS': '0x0', 08:40:46 INFO - 'XPC_SERVICE_NAME': '0', 08:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-rkvunD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-mkffWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-2WANVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-fqMkL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-POH1w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-XrQWH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-uLnL33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-ECIvIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:47 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-N4Syf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-LEM1rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-uN2N1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-i_uIOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-MwGITu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-zTukgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-JZJw3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-K3rZL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:48 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-C4squ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:48 INFO - Running setup.py install for manifestparser 08:40:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for mozcrash 08:40:49 INFO - Running setup.py install for mozdebug 08:40:49 INFO - Running setup.py install for mozdevice 08:40:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for mozfile 08:40:49 INFO - Running setup.py install for mozhttpd 08:40:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for mozinfo 08:40:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:49 INFO - Running setup.py install for mozInstall 08:40:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Running setup.py install for mozleak 08:40:50 INFO - Running setup.py install for mozlog 08:40:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Running setup.py install for moznetwork 08:40:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Running setup.py install for mozprocess 08:40:50 INFO - Running setup.py install for mozprofile 08:40:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:50 INFO - Running setup.py install for mozrunner 08:40:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Running setup.py install for mozscreenshot 08:40:51 INFO - Running setup.py install for moztest 08:40:51 INFO - Running setup.py install for mozversion 08:40:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:51 INFO - Cleaning up... 08:40:51 INFO - Return code: 0 08:40:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:52 INFO - 'HOME': '/Users/cltbld', 08:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PAGER': '/bin/cat', 08:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:52 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - 'XPC_FLAGS': '0x0', 08:40:52 INFO - 'XPC_SERVICE_NAME': '0', 08:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-mVYSml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-4VXgfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:53 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)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-tujkQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-_E3mlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-akpLg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-VmHr5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Yg3ZmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-YCIcOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:40:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:53 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-z74k1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-DlblCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-l0Yup8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-yYC84H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-JwXLVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-O0Ai8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:54 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)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Fk5TCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Mke8ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:54 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-O4W4a0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:57 INFO - Downloading blessings-1.6.tar.gz 08:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:57 INFO - Installing collected packages: blessings 08:40:57 INFO - Running setup.py install for blessings 08:40:58 INFO - Successfully installed blessings 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:58 INFO - Reading from file tmpfile_stdout 08:40:58 INFO - Current package versions: 08:40:58 INFO - blessings == 1.6 08:40:58 INFO - blobuploader == 1.2.4 08:40:58 INFO - docopt == 0.6.1 08:40:58 INFO - functools32 == 3.2.3-2 08:40:58 INFO - jsonschema == 2.5.1 08:40:58 INFO - manifestparser == 1.1 08:40:58 INFO - mozInstall == 1.12 08:40:58 INFO - mozcrash == 1.0 08:40:58 INFO - mozdebug == 0.1 08:40:58 INFO - mozdevice == 0.49 08:40:58 INFO - mozfile == 1.2 08:40:58 INFO - mozhttpd == 0.7 08:40:58 INFO - mozinfo == 0.9 08:40:58 INFO - mozleak == 0.1 08:40:58 INFO - mozlog == 3.4 08:40:58 INFO - moznetwork == 0.27 08:40:58 INFO - mozprocess == 0.23 08:40:58 INFO - mozprofile == 0.28 08:40:58 INFO - mozrunner == 6.13 08:40:58 INFO - mozscreenshot == 0.1 08:40:58 INFO - mozsystemmonitor == 0.3 08:40:58 INFO - moztest == 0.7 08:40:58 INFO - mozversion == 1.4 08:40:58 INFO - psutil == 3.1.1 08:40:58 INFO - requests == 1.2.3 08:40:58 INFO - wsgiref == 0.1.2 08:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:58 INFO - 'HOME': '/Users/cltbld', 08:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:58 INFO - 'LOGNAME': 'cltbld', 08:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:58 INFO - 'MOZ_NO_REMOTE': '1', 08:40:58 INFO - 'NO_EM_RESTART': '1', 08:40:58 INFO - 'PAGER': '/bin/cat', 08:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:58 INFO - 'PWD': '/builds/slave/test', 08:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:58 INFO - 'SHELL': '/bin/bash', 08:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:58 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:58 INFO - 'USER': 'cltbld', 08:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:58 INFO - 'XPC_FLAGS': '0x0', 08:40:58 INFO - 'XPC_SERVICE_NAME': '0', 08:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faaf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e82ca6960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, '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.ODgOfTww7v/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.k0v8gq8pdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 08:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:58 INFO - 'HOME': '/Users/cltbld', 08:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:58 INFO - 'LOGNAME': 'cltbld', 08:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:58 INFO - 'MOZ_NO_REMOTE': '1', 08:40:58 INFO - 'NO_EM_RESTART': '1', 08:40:58 INFO - 'PAGER': '/bin/cat', 08:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:58 INFO - 'PWD': '/builds/slave/test', 08:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:58 INFO - 'SHELL': '/bin/bash', 08:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:40:58 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:58 INFO - 'USER': 'cltbld', 08:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:58 INFO - 'XPC_FLAGS': '0x0', 08:40:58 INFO - 'XPC_SERVICE_NAME': '0', 08:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:58 INFO - Cleaning up... 08:40:58 INFO - Return code: 0 08:40:58 INFO - Running post-action listener: _resource_record_post_action 08:40:58 INFO - Running post-action listener: _start_resource_monitoring 08:40:59 INFO - Starting resource monitoring. 08:40:59 INFO - [mozharness: 2016-11-29 16:40:59.008896Z] Finished create-virtualenv step (success) 08:40:59 INFO - [mozharness: 2016-11-29 16:40:59.009918Z] Running install step. 08:40:59 INFO - Running pre-action listener: _resource_record_pre_action 08:40:59 INFO - Running main action method: install 08:40:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:59 INFO - Reading from file tmpfile_stdout 08:40:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:59 INFO - Reading from file tmpfile_stdout 08:40:59 INFO - Output received: 08:40:59 INFO - Usage: mozinstall [options] installer 08:40:59 INFO - Options: 08:40:59 INFO - -h, --help show this help message and exit 08:40:59 INFO - -d DEST, --destination=DEST 08:40:59 INFO - Directory to install application into. [default: 08:40:59 INFO - "/builds/slave/test"] 08:40:59 INFO - --app=APP Application being installed. [default: firefox] 08:40:59 INFO - mkdir: /builds/slave/test/build/application 08:40:59 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'] 08:40:59 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 08:41:32 INFO - Reading from file tmpfile_stdout 08:41:32 INFO - Output received: 08:41:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:41:32 INFO - Running post-action listener: _resource_record_post_action 08:41:32 INFO - [mozharness: 2016-11-29 16:41:32.767909Z] Finished install step (success) 08:41:32 INFO - [mozharness: 2016-11-29 16:41:32.768013Z] Running run-tests step. 08:41:32 INFO - Running pre-action listener: _resource_record_pre_action 08:41:32 INFO - Running main action method: run_tests 08:41:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:32 INFO - 2016-11-29 08:41:32.782 screenresolution[1906:18592] starting screenresolution argv=screenresolution get 08:41:32 INFO - 2016-11-29 08:41:32.785 screenresolution[1906:18592] Display 0: 1600x1200x32@60 08:41:32 INFO - 2016-11-29 08:41:32.791 screenresolution[1907:18594] starting screenresolution argv=screenresolution list 08:41:32 INFO - Available Modes on Display 0 08:41:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:33 INFO - Intel Iris: 08:41:33 INFO - Chipset Model: Intel Iris 08:41:33 INFO - Type: GPU 08:41:33 INFO - Bus: Built-In 08:41:33 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:33 INFO - Vendor: Intel (0x8086) 08:41:33 INFO - Device ID: 0x0a2e 08:41:33 INFO - Revision ID: 0x0009 08:41:33 INFO - Displays: 08:41:33 INFO - Display: 08:41:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:33 INFO - Display Serial Number: 1600x1200 60 08:41:33 INFO - Main Display: Yes 08:41:33 INFO - Mirror: Off 08:41:33 INFO - Online: Yes 08:41:33 INFO - Rotation: Supported 08:41:33 INFO - Return code: 0 08:41:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:33 INFO - Python 2.7.3 08:41:33 INFO - Return code: 0 08:41:33 INFO - grabbing minidump binary from tooltool 08:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5d30>, '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 0x10f72cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:41:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:41:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:33 INFO - Return code: 0 08:41:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:33 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/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 08:41:33 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/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0360 --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 08:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ODgOfTww7v/Render', 08:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:33 INFO - 'HOME': '/Users/cltbld', 08:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:33 INFO - 'LOGNAME': 'cltbld', 08:41:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:33 INFO - 'MOZ_NO_REMOTE': '1', 08:41:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:33 INFO - 'NO_EM_RESTART': '1', 08:41:33 INFO - 'PAGER': '/bin/cat', 08:41:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:33 INFO - 'PWD': '/builds/slave/test', 08:41:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:33 INFO - 'SHELL': '/bin/bash', 08:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0v8gq8pdk/Listeners', 08:41:33 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 08:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:33 INFO - 'USER': 'cltbld', 08:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:33 INFO - 'XPC_FLAGS': '0x0', 08:41:33 INFO - 'XPC_SERVICE_NAME': '0', 08:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:33 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/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 08:41:33 INFO - mozversion application_buildid: 20161129062926 08:41:33 INFO - mozversion application_changeset: 130bb29013a1d089dd533e50e170eabedce157d8 08:41:33 INFO - mozversion application_display_name: Nightly 08:41:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:33 INFO - mozversion application_name: Firefox 08:41:33 INFO - mozversion application_remotingname: firefox 08:41:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:33 INFO - mozversion application_vendor: Mozilla 08:41:33 INFO - mozversion application_version: 53.0a1 08:41:33 INFO - mozversion platform_buildid: 20161129062926 08:41:33 INFO - mozversion platform_changeset: 130bb29013a1d089dd533e50e170eabedce157d8 08:41:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:33 INFO - mozversion platform_version: 53.0a1 08:41:33 INFO - using testdate: 1480437693 08:41:33 INFO - actual date: 1480437693 08:41:33 INFO - starting webserver on 'localhost:54520' 08:41:33 INFO - SUITE-START | Running 2 tests 08:41:33 INFO - TEST-START | dromaeo_css 08:41:33 INFO - operating with platform_type : mac_ 08:41:33 INFO - Initialising browser for dromaeo_css test... 08:41:33 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmp6Q9r0u/profile http://localhost:54520/getInfo.html) 08:41:35 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 08:41:35 INFO - PROCESS | 1917 | colorDepth:24 08:41:35 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 08:41:35 INFO - PROCESS | 1917 | __metrics 08:41:35 INFO - PROCESS | 1917 | 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" 08:41:35 INFO - PROCESS | 1917 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:36 INFO - TEST-INFO | 1917: exit 0 08:41:36 INFO - Browser initialized. 08:41:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:36 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmp6Q9r0u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:49 INFO - PROCESS | 1919 | RSS: Main: 237146112 08:41:49 INFO - PROCESS | 1919 | 08:42:39 INFO - PROCESS | 1919 | 1480437759837 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] 08:44:53 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54520/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54520/tests/dromaeo/cssquery-ext.html) 08:44:55 INFO - PROCESS | 1919 | RSS: Main: 421441536 08:44:55 INFO - PROCESS | 1919 | 08:47:59 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54520/tests/dromaeo/cssquery-ext.html (next: http://localhost:54520/tests/dromaeo/cssquery-jquery.html) 08:47:59 INFO - PROCESS | 1919 | RSS: Main: 377331712 08:47:59 INFO - PROCESS | 1919 | 08:51:02 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54520/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54520/tests/dromaeo/cssquery-mootools.html) 08:51:02 INFO - PROCESS | 1919 | RSS: Main: 369426432 08:51:02 INFO - PROCESS | 1919 | 08:54:05 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54520/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54520/tests/dromaeo/cssquery-prototype.html) 08:54:05 INFO - PROCESS | 1919 | RSS: Main: 349437952 08:54:05 INFO - PROCESS | 1919 | 08:57:09 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54520/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54520/tests/dromaeo/cssquery-yui.html) 08:57:10 INFO - PROCESS | 1919 | RSS: Main: 333467648 08:57:10 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:54520/tests/dromaeo/cssquery-yui.html (next: http://localhost:54520/tests/dromaeo/cssquery-dojo.html) 09:00:13 INFO - PROCESS | 1919 | RSS: Main: 521056256 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | __start_tp_report 09:00:13 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 09:00:13 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 09:00:13 INFO - PROCESS | 1919 | |i|pagename|runs| 09:00:13 INFO - PROCESS | 1919 | |0;dojo.html;3268.4116858965385;3270.983645081773;3297.8186199759;3309.6028476582815;3320;5400.9189862152;5492.5605951523885;5518.503334699876;5571.192177134313;5591;5508.063629183039;5530.170474428838;5530.5852061095475;5541.778328866841;5545.77816887324;4109.445224894631;4979.626528010404;5028.094942910275;5041.269015992679;5103.438621751623;5069.467705890884;5150.1759718445055;5152.252923326116;5156.639035267533;5167.586593072564;3995.5205375355;5065.138926382524;5071.847844564651;5098.337216161894;5154.07226699194;5123.1546794778815;5130.820421285274;5132.127538318495;5134.794608215667;5190.377154741455;4934.728589927553;4955.776990035457;4992.276119962585;5063.569596584295;5086.160783470723;5471.972640136813;5501.642393244466;5531.115021596565;5533.170024496318;5548.278723765885;6063.787767428119;6081;6091.512678985715;6092.847678808021;6097.298810636745;6022.3074346450285;6059.727312270914;6159.106929495243;6163.383661633846;6185.969070154665;5545.390007099216;5580.91628625571;5585.553155747531;5649.096144616841;5658.321001479808;6161.96919015411;6173.876522469525;6174.9691251544355;6182.69086545671;6192.195014648157;5861.0915308127305;5887.116932460165;5909.8227053188475;5932.673702946293;5946.345901950782;5960.612560183574;5979.970100149559;6002.129691194752;6013.0980352946535;6090.147379366892;6030.819075427744;6034;6064.4845188158615;6065.4541091302;6065.999110146777;6055.909161362583;6060.909086363708;6064.423879731418;6073.423024812636;6131.478824299985;4726.621870250372;4751.667383283137;4759.50025247351;4762.333273341735;4801.01579176268;4297.3768803523935;4349.652027837766;4349.978250108792;4384.912301753947;4401.075774087478;5607.523360514402;5618.887622247532;5637.746301416446;5644.209810626516;5648.322201335866;5970.701464926737;6085.756569737161;6097.420745029215;6105.176214193607;6139.2325959255095;5472.945270547243;5551.694656793834;5597.44025597437;5613.915791263053;5616.129499927518;5272.815451459181;5273.1035723927025;5279.577633789288;5284.313039304942;5306;6112.877742445126;6138.079288106641;6152.846178845386;6160.075988601746;6162.630242185483;5993.041113421831;5999.670018149044;6024.0662697282;6042.667653279112;6107.9083813741945;6110.0424004731585;6121.209103132208;6127.662978536223;6131.049687298476;6160.260768707604;6013.849653758691;6016.42843929826;6020.066889632114;6020.247469066367;6067.514598831995;5953.880922381615;5990.921634105903;6026.698665066641;6079.240094988127;6088.330283668882;5839.532837373085;5860.443257890493;5917.082852157922;5931.822045338647;6003.729832157476;4395.7362558246605;5937.109433584997;5938.138969849261;5965;5991.131285963598;5716.342620598518;5732.627379220337;5776.653400795798;5789.015867302484;5794.594378393641;5760.740766665426;5808.94191058084;5811.070228763547;5900.557458190567;5933.465988061095;5696.287964004499;5697.259356283656;5708.457696518824;5715.028445164416;5719.599628025998 09:00:13 INFO - PROCESS | 1919 | |1;ext.html;458.8967482316479;467.77546777546775;500.8873003574194;510.06403250036203;529.8607992815447;30187.698123018792;39415.60584394155;40433.38266469341;40573.14555117267;42049.78975105128;40995.59004409955;41234.58765412345;41348.379774303336;41366.79316603413;41612.751617451446;8401.453905496153;9252.67615633453;9412.105849944244;9429.858552121723;9450.85823712645;7302.853942921165;10931.672049838478;11284.040856527165;11302.152338574599;11487.59793407231;11228;11261.155413344031;11317.377544235063;11331.433428328592;11339.319640821577;9488.525573721321;11170;11244.943775281072;11292.684999575067;11315.660530184108;11222.887771122347;11268.830967535494;11276.1542884284;11279.266847654877;11296;38774.80612596947;39611.80194099011;39769.40345894814;39837.80081099605;39915.20169596621;3229.2411283348392;3343.147497388175;3668.3030224257304;3942.64516193544;3968.206358728237;29030.41939161205;30300.939467118766;30465.781368745225;30615;30970.225744356347;3110.797798143136;3215.8070515769127;3231.272963583175;3272.8527216275324;3298.620658624241;389138;477040;480704;481904;482204.5889770599;58182.14541036991;58929.41070589325;59365.81268374608;59708.402915970284;59827;62822.685886570274;62831.203631491626;63017.05474417887;63065.36934630687;63105.36894631087;15137.848621513864;15365.308561114776;15372.231388430533;15373.154476503676;15379.461718839786;9963.302568820112;10179.931107233782;10226.693199204035;11806.52773889052;11893.583724569771;16675.666486670198;16881.07154106536;17044.659106817795;17295.74056389155;17379.47861564155;5787.565932555075;6886.208086070066;7045.753398631024;7050.224475307712;7053.647317634201;831.6340810043562;930.316217580078;939.1031564855547;963.4652767713845;966.3428868369435;24670;29015.69429375683;29184.41631167365;29535.556966645516;29813.701862981525;961.1445813226235;1003.3779056984716;1018.2871989607305;1033.844923261517;1092.4919912240846;14549.636259093608;15161.469348572968;15502.689946201013;15529.767053494206;15655.217239137997;651581;655179;655269;656260;656985;56503.71748141233;56764.43235567674;56765.43234567684;56901.430985689614;57235.42764572301;1215.9452824622913;1253.7116463213513;1339.7521458530202;1358.456617353047;1392.7284179585288;29783.702162978094;30184.54723179198;30739.9241026563;31243.906463273677;31382.843085784425;48839.5116048835;49206.75396622994;49343.7532812348;49349;49365.765855852456;481139.78290326375;492427;493951;496248;496689;22560.323190304316;25929.6110558338;26033.609495857956;26601.600975985762;26639.60040599431;45494.31758523691;45769.54230457786;46005.539944600125;46848.531514684415;47028.529714703785;37624.811875940446;37701.81149094237;37939.81030094832;39159;39162.608373917035;37830;38651;38814.80592597019;39031.02422439462;39806.20387592174;36429;36475.08812279714;37694.62305376911;37860;37893.43159852659;26764.330891727863;30510.08469745911;33644.66355336415;33736.831315843265;33939.66060339365;23493.942772574934;24477.632835507124;24556;25381.492370152864;25494.872525637995 09:00:13 INFO - PROCESS | 1919 | |2;jquery.html;321.78118879162173;347.0646607393073;361.8371732720275;370.61456085670903;399.8484365028719;14735.70528589429;14966.32651530681;15758.290876910538;19584.902075489637;20350.389488315337;16107.677846443094;18287;18992.525186870334;19310.517237069045;19572.510687232825;5559.58303127266;5786.537077033827;5822.505087067604;5939.85150371242;5948.40515948406;5619.847931174099;5768.884622307552;5776.913346299809;5806.59353845231;5923.17075609415;5774.451427114417;5774.6535207887455;5776.018076926912;5780.335261444946;5787.305523337184;5588.636738612018;5690.60165788395;5714.79998200061;5776.884462310731;5782.074868021138;4994.87512812179;5049.065922804293;5057.671251368649;5076.898462030738;5088.821891233789;24965.375865603324;25475.108371207105;25508.872455637604;25778.484430311477;26144;2277.2029789573517;2285.0288627333316;2404.6393041043984;2592.5333439980795;2763.77889768818;14695.853041469556;14951.925240373837;15167.924160379127;15703.057816531045;15846.128462934534;1758.1209395302349;1760.7270873014704;1836.7612210412694;1857.4891904726173;1891.7919028906808;108389;111657.76684466346;112006;112172.43913780378;112981;10359.792804144026;10592.470376481146;10864.456777161111;10947.671569852917;11099.889001110047;13514.662133446545;13815.792763108562;13975.580732578039;14003.299835008209;14022.298885055707;8197.71308004229;8264.917350826536;8277.751667449866;8402.747917562483;8438.071812100665;8164.183581641907;8171.06032806223;8183.95908020456;8369.414141010071;8381.455205411628;5438;6455.7740479083;6558.573692709959;6579.47364210862;6706.061151438705;1783.9464816055538;1824.6533158699804;1830.5149135478841;1832.670119378498;1834.9816501835078;829.7676650537738;835.7964531075354;877.2061284537504;907.0702529906766;922.5018490015317;21479.46301342479;22057;22113.778862211493;22124.55750884973;22188.445288867584;929.4516235421135;947.7204224753714;955.6464108279841;977.6969139566758;1025.4462590201356;10861.239713219999;11317.264377815416;11382.829257561143;11419.429028548539;11564.826527602092;567766;571946;580765;582824;582856;117183;117443.41278293554;120474;121522;122647;762.3520007993161;963.5615794813343;975.2880397310004;978.4422878959067;980.9460479673686;14933.850661493247;18980.43058708241;18996.335128270443;19218.231270749573;19244.903775481594;38122.809385952896;48678.29625963216;48806.0477580907;49092;50360;66048.79950810407;68214.65892670504;68397;68957.31042689508;70515.29484705087;6809.829754256183;7184.640767961477;7260.818479538054;7367.300106489874;7538.924610753822;11692.415379231175;11757.647270581896;11823.231489953125;12031.4585843639;12074.818877717016;10076.143527800219;10305.845412318671;10397.792044159225;10475.266731328733;10543.683689489328;9820.263480238867;9871.851922221316;9875.259355548218;10117.08946194846;10132.797344053226;8482.406231563731;8758.693445729368;10465.790684186426;10489.265751397328;10717.41054241993;7417.888731669137;7483.102027756704;7574.280443357872;7782.066152061789;7842.64708088126;8847.071057538866;9720.562574684014;9816.607335706492;10298.3820970742;10344.586216551254 09:00:13 INFO - PROCESS | 1919 | |3;mootools.html;1330.4877622115482;1459.9343029563668;1496.2219645784191;1652.3225477554206;1849.3157531713268;7458.179600243969;7803.6098195090235;7807.5315481071175;7815.960920195391;7815.960920195405;7601.125870524891;8074.192580741923;8097.757067287991;8235.423520353577;8425.536595487245;2273.920412785553;2313.3060081975423;2318.675385446039;2320.0951628864755;2325.5232677301196;2003.3989803059096;2255.4474153832334;2320.3503019154664;2321.535692861426;2328.8486248393883;2048;2071.337172104927;2072.5647614001077;2072.730545029144;2073.2121793718443;2202.581509513195;2269.7049383580193;2273.7044184256106;2277.3851060213815;2285.06312411912;2255.548890221962;2279.7036385269976;2292.5644127615865;2293.9885300573555;2296.9770302297097;8233.46482478637;8330.583470826496;8339.20777526134;8357.080721120672;8383.455075420079;4962.900741985176;5119.923201151985;5127.461616530248;5136.743162841843;5141.254518094893;3242.1732458223237;3407.880724174642;3436.914077148091;3475.4265546184847;3514.1741690702665;918.8713580098791;1016.5171543516844;1046.199657262195;1067.3542506783363;1089.6458650938478;10883.346999180074;10993.395363255018;10994.890051099546;10995.560177592966;11000.22998390113;4309.59058889405;4505;4591.1965406053805;4592.15045216636;4635.629149668019;9366.016568260371;9379.062093790566;9381.671641492516;9389.530523473799;9397.76505587352;5103.157978933508;5104.872378190575;5108.540231379194;5113.769880355393;5117.692938423632;4485.215087359699;4566.97716511422;4626.329182268552;4674.906501870011;4701.2242979908615;3654.2691461707764;3686.944695829565;3719.5536535615897;3770.1517158639085;3788.3749181385315;1238.9132760706664;1240.1009268280425;1243.776120298337;1256.3215863433827;1258.4337048328107;687.8108520156997;805.9113497515268;807.2976510435841;868.6047848229041;876.4872549558452;5516.889662206733;5764.625299355528;5852.590318677737;5939.851503712442;5960.92703313399;851.2423942691009;913.6847787513298;924.4360939826701;934.7429456899271;991.7966816802682;3676.852925882988;3869.1487872667967;3995.4006898965386;4002.5797291284;4028.778417187083;9763.511824408752;10143.442110683836;10256.28206025586;10285.33145345565;10291.43397113151;9831.459269740233;10005.949970250102;10198.133158681447;10202.438865862301;10212.131968782589;7687.769366919001;7697.191794861571;7740.574268415178;7793.571353575608;7855.84288314242;5456.127019676833;5591.580631452576;5617.606767526234;5622.690752008679;5770.913436298543;9114.635414583343;9132.589033493641;9189.310801689766;9347.252219822261;9348.485833279236;8944.552772361487;9033.367664263438;9205.953970230106;9279.72160835176;9374.95312523433;6845;7187.712491500281;7201.3518783309755;7201.747938822116;7218.855622887618;6581.473482121514;7533.7363192290195;7585.62071896414;7616.581088040211;7699.153093159636;6002.339742628395;7064;7111.111111111111;7151.392131668658;7162;5550.861228469321;6780.254172040973;6925;6954.965225173842;7041.647917604202;6494.64279464634;6547.345265473415;6554.377334153248;6565.161754708689;6627.867442651216;4593;4804.807807687654;4809.350737650372;4832.033593281288;4951.455339912679;4750.8337208197545;4868.853934381974;4889.315495830516;4917.532834380728;5039.118154323052 09:00:13 INFO - PROCESS | 1919 | |4;prototype.html;282.75117896251294;295.2456473709671;303.89667513045566;308.1203164964028;311.5529215575648;5102.3111879896205;5178.799010420575;5187.247849061884;5203.973980130104;5291.862249616342;4045.939310910339;4932.901341973158;4994.578713581191;5012.198048312271;5103.948960510394;3298.3403319336107;3480.4605286180554;3944.5858184890603;3990.3216453203027;4019.5779443158485;3175.7459403247685;3467.6358982306874;3836.1943991761764;3967.166894952049;3998.2003599280115;3032.7725420593433;3131.617852719069;3505.019663889894;3969.98015009926;3996.700247481436;3891.1050458394584;3934.370500719871;3935.173613541131;3941.4284928685465;3968.9801550992206;3406.6423025582453;3441.0709108540805;3452.8100954447495;3463.688268055862;3465.012471445626;4170.082581831992;4407.779611019469;5030.773615187325;5055.241713742968;5083.288339632454;3886.553046399672;3936.264296314063;4005.898377946059;4142.440770495975;4143.544210136883;5405.243265942771;5406.675599464005;5421.2952316199035;5433.918491222635;5446.400895901447;3682.9447558286647;3783.829727662262;3794.3359912015285;3834.0989867381145;3836.7122465814896;5297.496737809902;5582.63712858667;5652.180433837112;5665.631733937281;5691.381964296429;3827.215420838777;3835.8684188164557;3841.250956063541;3845.7115716321387;3880.941785873214;3927.3716205407;3928.2929072766606;3930.4104384342577;3937.901552461154;3938.8818335449982;3553.573571171476;3700.593774365778;4057.857974970862;4299.656027517791;4556.886077848014;5433.619646624698;5453.209284653783;5454.036546843134;5465.918011229755;5536.474034966672;1203.8314635950974;1236.8763123687559;1255.736295377981;1258.314218750783;1259.7921342978489;751.6023883810626;768.7962689887185;824.6577670266772;869.4305230074185;887.1483375959023;4448.421705178306;4504.752238626907;4782.904341913142;4819.180739274261;4861.29511220871;4343;4896.6572339935865;5248.947510524922;5289.444608316071;5365.409804921455;4576.123789246393;4664.813407463731;4784.425868895755;4806.399200099988;4820.68665536739;2413.1674572272536;2688.9916281394476;2695.339641787735;2700.784646908899;2702.3919618086165;4488.281874900001;5188.825297895492;5221.269022336875;5255.789768409298;5304.32131773452;4363.672724545671;4580.725156490621;4920.803167873245;5205.427402985669;5770;5832.270966129234;5837.211976383134;5856.355800861902;5857.824265272134;5894.410558944071;5223.895522089461;5227.686338819683;5265.6840589564745;5649.689267090185;5706;4736.194846876108;5487.640314664733;5567.860803479945;5582.246396736551;5614.6631202128;5044.1172794761505;5214.713190774392;5809.912851307149;5815.883682326415;5906.645601263938;3535.646435356444;3774.6602805747616;3777.6411240932066;3796.5064541609413;3814.2371525694416;4734.839964208791;4991.07665081961;5500.58745594074;5513.255710479034;5539.224508568885;4214.4310518079665;5434.527290083081;5511.035568775528;5535.730350556252;5539.25220095282;5139.640225184201;5406.351237851483;5444.8366549003595;5500.697461639648;5509.862253443696;4465.933011004772;5330.828157246432;5361.195820626937;5361.865953351197;5375.301210842722;5223.242629818579;5332.73336333174;5368.463153684756;5487.835364939058;5518.972405137949;4991.925121123113;5349.839504814861;5378.97310513445;5421.62048656606;5435 09:00:13 INFO - PROCESS | 1919 | |5;yui.html;631.5168895794717;761.1741260732109;766.9233076692332;780.3640033372798;788.0622059748898;14588;14893;15276.007059541122;15534.766978495332;15604.53186404407;12039.819402708967;14030.719385612281;14055.929720351409;14334.641633959156;15199.54401367958;813.3127507256373;828.6022709099636;837.7444879311807;838.4466252273501;839.2740279658112;649.7238673563741;671.1912145864246;675.0212192321129;822.313368337439;824.2375802382802;722.6206241723111;862.1034124510502;866.2939704141137;867.7266661001764;868.8436081505326;846.6359465429863;848.7326492154982;849.7748096754334;851.7231899632583;853.1383302864152;503.74309102357694;518.8962207558466;523.2595876834275;629.4775336470718;630.3129588748286;11737.354445505494;11777.941110294394;11782.057435405148;14247.643808904757;14779.187144707037;11235.60675376366;13247.403866826016;13704.65738356539;13716.862831371658;13736.862631373759;11442;11594.594189203423;11635.418229088511;11660.941695291469;11983.041356691443;3244.3511297740547;3623.691986181178;3655.670989610948;3676.6323367663285;3762.0218743126984;111107.15010719454;112434.43782781034;112702;113698.43150784276;115370;10574.52414641343;10759.892401076046;10798.568057277778;10800.693103225842;11018.724531886606;20995.16019359239;21374.9006394072;21432.357029288836;21458;21497.78502214958;7321.926780732231;7486.887696684554;7544.886826697604;7547.962260188664;7663.961680191564;4098.139390727921;4103;4168.979155104205;4183.811728472226;4253.085586598896;3367.9494807577908;3467.323871844966;3492.4935884297142;3496.790192588453;3497.632748561364;522.8276877761442;620.1875543038634;628.355935166458;628.7422156915643;629.7512482569451;627.7645882793952;632.6077831744348;651.6741629185407;656.6060363781693;656.7176114270909;7726.922730772732;8578.528180949983;8853.867191992125;8873;9375.671851485165;502.63558919783594;549.4560385218684;625.2247213455282;653.1280740211776;660.6036378173154;3949.921001579952;4245.639120674778;4422.049259409242;4429.247028005247;4493.977530112394;114319.85680143093;115364;115375.42312288552;115450.84549154401;115856;80891.78662320069;85580;98418.50790746143;99203;100794;76336.61831690917;77462.61268693733;81747.59126204331;84426.57786711027;86984.56507717421;9676.453862500497;9701.417914925127;9778.41329520231;9861.457619830691;9934.440255076132;41989;47909.28136077892;56325.71837140788;56662;56912.29263122113;76081.61959190169;78116.60941695255;78535;80903;81105.9723506917;11100.722481938015;11745.412729363668;11889.583864564698;12328.506859725869;12737.617871463872;13221.801672974721;13563;13703.177809331472;13966.441342346192;14538.345774439964;13086.541971030969;13253.204807711569;13419.463221471422;13462.192268463923;14040.78938815898;12677.746445071232;12874.935625321814;12887.677808054874;13181.40683669218;13339.399727012502;7368.336849683555;12698.98408127366;12955;13023.609291721263;13137.671558211121;9635.373700709431;10099.69700908974;11087.33475991443;11185.720356990814;11619.709507262387;9854.359466634645;11099.72250693739;11105.888941110485;11247.582397862567;11419.543218271176 09:00:13 INFO - PROCESS | 1919 | __end_tp_report 09:00:13 INFO - PROCESS | 1919 | __start_cc_report 09:00:13 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,1972 09:00:13 INFO - PROCESS | 1919 | __end_cc_report 09:00:13 INFO - PROCESS | 1919 | __startTimestamp1480438813795__endTimestamp 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | ------- Summary: start ------- 09:00:13 INFO - PROCESS | 1919 | Number of tests: 6 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | [#0] dojo.html Cycles:165 Average:5570.25 Median:5732.63 stddev:638.63 (11.1%) stddev-sans-first:614.53 09:00:13 INFO - PROCESS | 1919 | Values: 3268.4 3271.0 3297.8 3309.6 3320.0 5400.9 5492.6 5518.5 5571.2 5591.0 5508.1 5530.2 5530.6 5541.8 5545.8 4109.4 4979.6 5028.1 5041.3 5103.4 5069.5 5150.2 5152.3 5156.6 5167.6 3995.5 5065.1 5071.8 5098.3 5154.1 5123.2 5130.8 5132.1 5134.8 5190.4 4934.7 4955.8 4992.3 5063.6 5086.2 5472.0 5501.6 5531.1 5533.2 5548.3 6063.8 6081.0 6091.5 6092.8 6097.3 6022.3 6059.7 6159.1 6163.4 6186.0 5545.4 5580.9 5585.6 5649.1 5658.3 6162.0 6173.9 6175.0 6182.7 6192.2 5861.1 5887.1 5909.8 5932.7 5946.3 5960.6 5980.0 6002.1 6013.1 6090.1 6030.8 6034.0 6064.5 6065.5 6066.0 6055.9 6060.9 6064.4 6073.4 6131.5 4726.6 4751.7 4759.5 4762.3 4801.0 4297.4 4349.7 4350.0 4384.9 4401.1 5607.5 5618.9 5637.7 5644.2 5648.3 5970.7 6085.8 6097.4 6105.2 6139.2 5472.9 5551.7 5597.4 5613.9 5616.1 5272.8 5273.1 5279.6 5284.3 5306.0 6112.9 6138.1 6152.8 6160.1 6162.6 5993.0 5999.7 6024.1 6042.7 6107.9 6110.0 6121.2 6127.7 6131.0 6160.3 6013.8 6016.4 6020.1 6020.2 6067.5 5953.9 5990.9 6026.7 6079.2 6088.3 5839.5 5860.4 5917.1 5931.8 6003.7 4395.7 5937.1 5938.1 5965.0 5991.1 5716.3 5732.6 5776.7 5789.0 5794.6 5760.7 5808.9 5811.1 5900.6 5933.5 5696.3 5697.3 5708.5 5715.0 5719.6 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | [#1] ext.html Cycles:180 Average:67165.17 Median:37845.00 stddev:145195.23 (383.7%) stddev-sans-first:145516.16 09:00:13 INFO - PROCESS | 1919 | Values: 458.9 467.8 500.9 510.1 529.9 30187.7 39415.6 40433.4 40573.1 42049.8 40995.6 41234.6 41348.4 41366.8 41612.8 8401.5 9252.7 9412.1 9429.9 9450.9 7302.9 10931.7 11284.0 11302.2 11487.6 11228.0 11261.2 11317.4 11331.4 11339.3 9488.5 11170.0 11244.9 11292.7 11315.7 11222.9 11268.8 11276.2 11279.3 11296.0 38774.8 39611.8 39769.4 39837.8 39915.2 3229.2 3343.1 3668.3 3942.6 3968.2 29030.4 30300.9 30465.8 30615.0 30970.2 3110.8 3215.8 3231.3 3272.9 3298.6 389138.0 477040.0 480704.0 481904.0 482204.6 58182.1 58929.4 59365.8 59708.4 59827.0 62822.7 62831.2 63017.1 63065.4 63105.4 15137.8 15365.3 15372.2 15373.2 15379.5 9963.3 10179.9 10226.7 11806.5 11893.6 16675.7 16881.1 17044.7 17295.7 17379.5 5787.6 6886.2 7045.8 7050.2 7053.6 831.6 930.3 939.1 963.5 966.3 24670.0 29015.7 29184.4 29535.6 29813.7 961.1 1003.4 1018.3 1033.8 1092.5 14549.6 15161.5 15502.7 15529.8 15655.2 651581.0 655179.0 655269.0 656260.0 656985.0 56503.7 56764.4 56765.4 56901.4 57235.4 1215.9 1253.7 1339.8 1358.5 1392.7 29783.7 30184.5 30739.9 31243.9 31382.8 48839.5 49206.8 49343.8 49349.0 49365.8 481139.8 492427.0 493951.0 496248.0 496689.0 22560.3 25929.6 26033.6 26601.6 26639.6 45494.3 45769.5 46005.5 46848.5 47028.5 37624.8 37701.8 37939.8 39159.0 39162.6 37830.0 38651.0 38814.8 39031.0 39806.2 36429.0 36475.1 37694.6 37860.0 37893.4 26764.3 30510.1 33644.7 33736.8 33939.7 23493.9 24477.6 24556.0 25381.5 25494.9 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | [#2] jquery.html Cycles:180 Average:33430.35 Median:366.23 stddev:96081.71 (26235.6%) stddev-sans-first:96319.09 09:00:13 INFO - PROCESS | 1919 | Values: 321.8 347.1 361.8 370.6 399.8 14735.7 14966.3 15758.3 19584.9 20350.4 16107.7 18287.0 18992.5 19310.5 19572.5 5559.6 5786.5 5822.5 5939.9 5948.4 5619.8 5768.9 5776.9 5806.6 5923.2 5774.5 5774.7 5776.0 5780.3 5787.3 5588.6 5690.6 5714.8 5776.9 5782.1 4994.9 5049.1 5057.7 5076.9 5088.8 24965.4 25475.1 25508.9 25778.5 26144.0 2277.2 2285.0 2404.6 2592.5 2763.8 14695.9 14951.9 15167.9 15703.1 15846.1 1758.1 1760.7 1836.8 1857.5 1891.8 108389.0 111657.8 112006.0 112172.4 112981.0 10359.8 10592.5 10864.5 10947.7 11099.9 13514.7 13815.8 13975.6 14003.3 14022.3 8197.7 8264.9 8277.8 8402.7 8438.1 8164.2 8171.1 8184.0 8369.4 8381.5 5438.0 6455.8 6558.6 6579.5 6706.1 1783.9 1824.7 1830.5 1832.7 1835.0 829.8 835.8 877.2 907.1 922.5 21479.5 22057.0 22113.8 22124.6 22188.4 929.5 947.7 955.6 977.7 1025.4 10861.2 11317.3 11382.8 11419.4 11564.8 567766.0 571946.0 580765.0 582824.0 582856.0 117183.0 117443.4 120474.0 121522.0 122647.0 762.4 963.6 975.3 978.4 980.9 14933.9 18980.4 18996.3 19218.2 19244.9 38122.8 48678.3 48806.0 49092.0 50360.0 66048.8 68214.7 68397.0 68957.3 70515.3 6809.8 7184.6 7260.8 7367.3 7538.9 11692.4 11757.6 11823.2 12031.5 12074.8 10076.1 10305.8 10397.8 10475.3 10543.7 9820.3 9871.9 9875.3 10117.1 10132.8 8482.4 8758.7 10465.8 10489.3 10717.4 7417.9 7483.1 7574.3 7782.1 7842.6 8847.1 9720.6 9816.6 10298.4 10344.6 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | [#3] mootools.html Cycles:180 Average:5382.87 Median:5111.16 stddev:2962.02 (58.0%) stddev-sans-first:2954.67 09:00:13 INFO - PROCESS | 1919 | Values: 1330.5 1459.9 1496.2 1652.3 1849.3 7458.2 7803.6 7807.5 7816.0 7816.0 7601.1 8074.2 8097.8 8235.4 8425.5 2273.9 2313.3 2318.7 2320.1 2325.5 2003.4 2255.4 2320.4 2321.5 2328.8 2048.0 2071.3 2072.6 2072.7 2073.2 2202.6 2269.7 2273.7 2277.4 2285.1 2255.5 2279.7 2292.6 2294.0 2297.0 8233.5 8330.6 8339.2 8357.1 8383.5 4962.9 5119.9 5127.5 5136.7 5141.3 3242.2 3407.9 3436.9 3475.4 3514.2 918.9 1016.5 1046.2 1067.4 1089.6 10883.3 10993.4 10994.9 10995.6 11000.2 4309.6 4505.0 4591.2 4592.2 4635.6 9366.0 9379.1 9381.7 9389.5 9397.8 5103.2 5104.9 5108.5 5113.8 5117.7 4485.2 4567.0 4626.3 4674.9 4701.2 3654.3 3686.9 3719.6 3770.2 3788.4 1238.9 1240.1 1243.8 1256.3 1258.4 687.8 805.9 807.3 868.6 876.5 5516.9 5764.6 5852.6 5939.9 5960.9 851.2 913.7 924.4 934.7 991.8 3676.9 3869.1 3995.4 4002.6 4028.8 9763.5 10143.4 10256.3 10285.3 10291.4 9831.5 10005.9 10198.1 10202.4 10212.1 7687.8 7697.2 7740.6 7793.6 7855.8 5456.1 5591.6 5617.6 5622.7 5770.9 9114.6 9132.6 9189.3 9347.3 9348.5 8944.6 9033.4 9206.0 9279.7 9375.0 6845.0 7187.7 7201.4 7201.7 7218.9 6581.5 7533.7 7585.6 7616.6 7699.2 6002.3 7064.0 7111.1 7151.4 7162.0 5550.9 6780.3 6925.0 6955.0 7041.6 6494.6 6547.3 6554.4 6565.2 6627.9 4593.0 4804.8 4809.4 4832.0 4951.5 4750.8 4868.9 4889.3 4917.5 5039.1 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | [#4] prototype.html Cycles:180 Average:4345.83 Median:4878.98 stddev:1352.42 (27.7%) stddev-sans-first:1321.38 09:00:13 INFO - PROCESS | 1919 | Values: 282.8 295.2 303.9 308.1 311.6 5102.3 5178.8 5187.2 5204.0 5291.9 4045.9 4932.9 4994.6 5012.2 5103.9 3298.3 3480.5 3944.6 3990.3 4019.6 3175.7 3467.6 3836.2 3967.2 3998.2 3032.8 3131.6 3505.0 3970.0 3996.7 3891.1 3934.4 3935.2 3941.4 3969.0 3406.6 3441.1 3452.8 3463.7 3465.0 4170.1 4407.8 5030.8 5055.2 5083.3 3886.6 3936.3 4005.9 4142.4 4143.5 5405.2 5406.7 5421.3 5433.9 5446.4 3682.9 3783.8 3794.3 3834.1 3836.7 5297.5 5582.6 5652.2 5665.6 5691.4 3827.2 3835.9 3841.3 3845.7 3880.9 3927.4 3928.3 3930.4 3937.9 3938.9 3553.6 3700.6 4057.9 4299.7 4556.9 5433.6 5453.2 5454.0 5465.9 5536.5 1203.8 1236.9 1255.7 1258.3 1259.8 751.6 768.8 824.7 869.4 887.1 4448.4 4504.8 4782.9 4819.2 4861.3 4343.0 4896.7 5248.9 5289.4 5365.4 4576.1 4664.8 4784.4 4806.4 4820.7 2413.2 2689.0 2695.3 2700.8 2702.4 4488.3 5188.8 5221.3 5255.8 5304.3 4363.7 4580.7 4920.8 5205.4 5770.0 5832.3 5837.2 5856.4 5857.8 5894.4 5223.9 5227.7 5265.7 5649.7 5706.0 4736.2 5487.6 5567.9 5582.2 5614.7 5044.1 5214.7 5809.9 5815.9 5906.6 3535.6 3774.7 3777.6 3796.5 3814.2 4734.8 4991.1 5500.6 5513.3 5539.2 4214.4 5434.5 5511.0 5535.7 5539.3 5139.6 5406.4 5444.8 5500.7 5509.9 4465.9 5330.8 5361.2 5361.9 5375.3 5223.2 5332.7 5368.5 5487.8 5519.0 4991.9 5349.8 5379.0 5421.6 5435.0 09:00:13 INFO - PROCESS | 1919 | 09:00:13 INFO - PROCESS | 1919 | [#5] yui.html Cycles:180 Average:21281.92 Median:4135.99 stddev:32116.00 (776.5%) stddev-sans-first:32168.66 09:00:13 INFO - PROCESS | 1919 | Values: 631.5 761.2 766.9 780.4 788.1 14588.0 14893.0 15276.0 15534.8 15604.5 12039.8 14030.7 14055.9 14334.6 15199.5 813.3 828.6 837.7 838.4 839.3 649.7 671.2 675.0 822.3 824.2 722.6 862.1 866.3 867.7 868.8 846.6 848.7 849.8 851.7 853.1 503.7 518.9 523.3 629.5 630.3 11737.4 11777.9 11782.1 14247.6 14779.2 11235.6 13247.4 13704.7 13716.9 13736.9 11442.0 11594.6 11635.4 11660.9 11983.0 3244.4 3623.7 3655.7 3676.6 3762.0 111107.2 112434.4 112702.0 113698.4 115370.0 10574.5 10759.9 10798.6 10800.7 11018.7 20995.2 21374.9 21432.4 21458.0 21497.8 7321.9 7486.9 7544.9 7548.0 7664.0 4098.1 4103.0 4169.0 4183.8 4253.1 3367.9 3467.3 3492.5 3496.8 3497.6 522.8 620.2 628.4 628.7 629.8 627.8 632.6 651.7 656.6 656.7 7726.9 8578.5 8853.9 8873.0 9375.7 502.6 549.5 625.2 653.1 660.6 3949.9 4245.6 4422.0 4429.2 4494.0 114319.9 115364.0 115375.4 115450.8 115856.0 80891.8 85580.0 98418.5 99203.0 100794.0 76336.6 77462.6 81747.6 84426.6 86984.6 9676.5 9701.4 9778.4 9861.5 9934.4 41989.0 47909.3 56325.7 56662.0 56912.3 76081.6 78116.6 78535.0 80903.0 81106.0 11100.7 11745.4 11889.6 12328.5 12737.6 13221.8 13563.0 13703.2 13966.4 14538.3 13086.5 13253.2 13419.5 13462.2 14040.8 12677.7 12874.9 12887.7 13181.4 13339.4 7368.3 12699.0 12955.0 13023.6 13137.7 9635.4 10099.7 11087.3 11185.7 11619.7 9854.4 11099.7 11105.9 11247.6 11419.5 09:00:13 INFO - PROCESS | 1919 | -------- Summary: end -------- 09:00:13 INFO - PROCESS | 1919 | 09:00:14 INFO - TEST-INFO | 1919: exit 0 09:00:14 INFO - TEST-OK | dromaeo_css | took 1121127ms 09:00:14 INFO - TEST-START | kraken 09:00:14 INFO - operating with platform_type : mac_ 09:00:14 INFO - Initialising browser for kraken test... 09:00:14 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpPGGbN2/profile http://localhost:54520/getInfo.html) 09:00:17 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 09:00:17 INFO - PROCESS | 1925 | colorDepth:24 09:00:17 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 09:00:17 INFO - PROCESS | 1925 | __metrics 09:00:17 INFO - PROCESS | 1925 | 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" 09:00:17 INFO - PROCESS | 1925 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:18 INFO - TEST-INFO | 1925: exit 0 09:00:18 INFO - Browser initialized. 09:00:18 INFO - Running cycle 1/1 for kraken test... 09:00:18 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpPGGbN2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:30 INFO - PROCESS | 1926 | RSS: Main: 245096448 09:00:30 INFO - PROCESS | 1926 | 09:00:32 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54520/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:33 INFO - PROCESS | 1926 | RSS: Main: 295915520 09:00:33 INFO - PROCESS | 1926 | 09:00:36 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54520/tests/kraken/driver.html?testName=audio-dft) 09:00:37 INFO - PROCESS | 1926 | RSS: Main: 296624128 09:00:37 INFO - PROCESS | 1926 | 09:00:40 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54520/tests/kraken/driver.html?testName=audio-fft) 09:00:41 INFO - PROCESS | 1926 | RSS: Main: 387002368 09:00:41 INFO - PROCESS | 1926 | 09:00:43 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54520/tests/kraken/driver.html?testName=audio-oscillator) 09:00:43 INFO - PROCESS | 1926 | RSS: Main: 291110912 09:00:43 INFO - PROCESS | 1926 | 09:00:45 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54520/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:46 INFO - PROCESS | 1926 | RSS: Main: 293367808 09:00:46 INFO - PROCESS | 1926 | 09:00:49 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54520/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:49 INFO - PROCESS | 1926 | RSS: Main: 337059840 09:00:49 INFO - PROCESS | 1926 | 09:00:52 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54520/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:53 INFO - PROCESS | 1926 | RSS: Main: 338190336 09:00:53 INFO - PROCESS | 1926 | 09:00:56 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54520/tests/kraken/driver.html?testName=json-parse-financial) 09:00:56 INFO - PROCESS | 1926 | RSS: Main: 335667200 09:00:56 INFO - PROCESS | 1926 | 09:00:58 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54520/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:59 INFO - PROCESS | 1926 | RSS: Main: 309886976 09:00:59 INFO - PROCESS | 1926 | 09:01:00 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:01 INFO - PROCESS | 1926 | RSS: Main: 313827328 09:01:01 INFO - PROCESS | 1926 | 09:01:03 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:04 INFO - PROCESS | 1926 | RSS: Main: 315588608 09:01:04 INFO - PROCESS | 1926 | 09:01:07 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:08 INFO - PROCESS | 1926 | RSS: Main: 333479936 09:01:08 INFO - PROCESS | 1926 | 09:01:11 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:12 INFO - PROCESS | 1926 | RSS: Main: 327499776 09:01:12 INFO - PROCESS | 1926 | 09:01:13 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54520/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54520/tests/kraken/driver.html?testName=ai-astar) 09:01:14 INFO - PROCESS | 1926 | RSS: Main: 371204096 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | __start_tp_report 09:01:14 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 09:01:14 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 09:01:14 INFO - PROCESS | 1926 | |i|pagename|runs| 09:01:14 INFO - PROCESS | 1926 | |0;ai-astar;110;111;109;109;110;110;110;111;110;110 09:01:14 INFO - PROCESS | 1926 | |1;audio-beat-detection;150;116;115;151;116;117;110;117;134;116 09:01:14 INFO - PROCESS | 1926 | |2;audio-dft;184;183;181;184;185;193;207;254;183;184 09:01:14 INFO - PROCESS | 1926 | |3;audio-fft;80;58;58;89;60;58;59;59;77;59 09:01:14 INFO - PROCESS | 1926 | |4;audio-oscillator;90;71;88;68;67;68;82;67;69;81 09:01:14 INFO - PROCESS | 1926 | |5;imaging-gaussian-blur;89;87;89;87;89;86;96;128;90;87 09:01:14 INFO - PROCESS | 1926 | |6;imaging-darkroom;97;123;164;112;96;96;96;97;96;97 09:01:14 INFO - PROCESS | 1926 | |7;imaging-desaturate;88;85;87;86;84;87;84;85;87;84 09:01:14 INFO - PROCESS | 1926 | |8;json-parse-financial;57;56;56;54;58;56;56;54;57;56 09:01:14 INFO - PROCESS | 1926 | |9;json-stringify-tinderbox;65;70;69;71;76;71;68;69;69;78 09:01:14 INFO - PROCESS | 1926 | |10;stanford-crypto-aes;99;97;102;105;88;88;87;85;87;90 09:01:14 INFO - PROCESS | 1926 | |11;stanford-crypto-ccm;160;159;151;149;154;151;159;158;196;163 09:01:14 INFO - PROCESS | 1926 | |12;stanford-crypto-pbkdf2;177;185;234;196;175;176;230;226;174;173 09:01:14 INFO - PROCESS | 1926 | |13;stanford-crypto-sha256-iterative;69;71;69;69;72;80;87;88;86;77 09:01:14 INFO - PROCESS | 1926 | __end_tp_report 09:01:14 INFO - PROCESS | 1926 | __start_cc_report 09:01:14 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,2013 09:01:14 INFO - PROCESS | 1926 | __end_cc_report 09:01:14 INFO - PROCESS | 1926 | __startTimestamp1480438874206__endTimestamp 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | ------- Summary: start ------- 09:01:14 INFO - PROCESS | 1926 | Number of tests: 14 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:01:14 INFO - PROCESS | 1926 | Values: 110.0 111.0 109.0 109.0 110.0 110.0 110.0 111.0 110.0 110.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:117.00 stddev:15.17 (13.0%) stddev-sans-first:12.90 09:01:14 INFO - PROCESS | 1926 | Values: 150.0 116.0 115.0 151.0 116.0 117.0 110.0 117.0 134.0 116.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#2] audio-dft Cycles:10 Average:193.80 Median:184.50 stddev:22.51 (12.2%) stddev-sans-first:23.60 09:01:14 INFO - PROCESS | 1926 | Values: 184.0 183.0 181.0 184.0 185.0 193.0 207.0 254.0 183.0 184.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#3] audio-fft Cycles:10 Average:65.70 Median:59.50 stddev:11.64 (19.6%) stddev-sans-first:11.14 09:01:14 INFO - PROCESS | 1926 | Values: 80.0 58.0 58.0 89.0 60.0 58.0 59.0 59.0 77.0 59.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:9.17 (12.1%) stddev-sans-first:7.99 09:01:14 INFO - PROCESS | 1926 | Values: 90.0 71.0 88.0 68.0 67.0 68.0 82.0 67.0 69.0 81.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:89.00 stddev:12.68 (14.2%) stddev-sans-first:13.38 09:01:14 INFO - PROCESS | 1926 | Values: 89.0 87.0 89.0 87.0 89.0 86.0 96.0 128.0 90.0 87.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:96.00 stddev:21.89 (22.8%) stddev-sans-first:22.89 09:01:14 INFO - PROCESS | 1926 | Values: 97.0 123.0 164.0 112.0 96.0 96.0 96.0 97.0 96.0 97.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.50 stddev:1.49 (1.7%) stddev-sans-first:1.33 09:01:14 INFO - PROCESS | 1926 | Values: 88.0 85.0 87.0 86.0 84.0 87.0 84.0 85.0 87.0 84.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.25 (2.2%) stddev-sans-first:1.27 09:01:14 INFO - PROCESS | 1926 | Values: 57.0 56.0 56.0 54.0 58.0 56.0 56.0 54.0 57.0 56.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:3.81 (5.4%) stddev-sans-first:3.46 09:01:14 INFO - PROCESS | 1926 | Values: 65.0 70.0 69.0 71.0 76.0 71.0 68.0 69.0 69.0 78.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:88.00 stddev:7.24 (8.2%) stddev-sans-first:7.32 09:01:14 INFO - PROCESS | 1926 | Values: 99.0 97.0 102.0 105.0 88.0 88.0 87.0 85.0 87.0 90.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#11] stanford-crypto-ccm Cycles:10 Average:160.00 Median:159.00 stddev:13.46 (8.5%) stddev-sans-first:14.27 09:01:14 INFO - PROCESS | 1926 | Values: 160.0 159.0 151.0 149.0 154.0 151.0 159.0 158.0 196.0 163.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.60 Median:190.50 stddev:25.42 (13.3%) stddev-sans-first:26.15 09:01:14 INFO - PROCESS | 1926 | Values: 177.0 185.0 234.0 196.0 175.0 176.0 230.0 226.0 174.0 173.0 09:01:14 INFO - PROCESS | 1926 | 09:01:14 INFO - PROCESS | 1926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:78.50 stddev:7.91 (10.1%) stddev-sans-first:7.87 09:01:14 INFO - PROCESS | 1926 | Values: 69.0 71.0 69.0 69.0 72.0 80.0 87.0 88.0 86.0 77.0 09:01:14 INFO - PROCESS | 1926 | -------- Summary: end -------- 09:01:14 INFO - PROCESS | 1926 | 09:01:15 INFO - TEST-INFO | 1926: exit 0 09:01:15 INFO - TEST-OK | kraken | took 60817ms 09:01:15 INFO - SUITE-END | took 1181s 09:01:15 INFO - Completed test suite (00:19:41) 09:01:15 INFO - javascript benchmark 09:01:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.4116858965385, 3270.983645081773, 3297.8186199759, 3309.6028476582815, 3320.0, 5400.9189862152, 5492.5605951523885, 5518.503334699876, 5571.192177134313, 5591.0, 5508.063629183039, 5530.170474428838, 5530.5852061095475, 5541.778328866841, 5545.77816887324, 4109.445224894631, 4979.626528010404, 5028.094942910275, 5041.269015992679, 5103.438621751623, 5069.467705890884, 5150.1759718445055, 5152.252923326116, 5156.639035267533, 5167.586593072564, 3995.5205375355, 5065.138926382524, 5071.847844564651, 5098.337216161894, 5154.07226699194, 5123.1546794778815, 5130.820421285274, 5132.127538318495, 5134.794608215667, 5190.377154741455, 4934.728589927553, 4955.776990035457, 4992.276119962585, 5063.569596584295, 5086.160783470723, 5471.972640136813, 5501.642393244466, 5531.115021596565, 5533.170024496318, 5548.278723765885, 6063.787767428119, 6081.0, 6091.512678985715, 6092.847678808021, 6097.298810636745, 6022.3074346450285, 6059.727312270914, 6159.106929495243, 6163.383661633846, 6185.969070154665, 5545.390007099216, 5580.91628625571, 5585.553155747531, 5649.096144616841, 5658.321001479808, 6161.96919015411, 6173.876522469525, 6174.9691251544355, 6182.69086545671, 6192.195014648157, 5861.0915308127305, 5887.116932460165, 5909.8227053188475, 5932.673702946293, 5946.345901950782, 5960.612560183574, 5979.970100149559, 6002.129691194752, 6013.0980352946535, 6090.147379366892, 6030.819075427744, 6034.0, 6064.4845188158615, 6065.4541091302, 6065.999110146777, 6055.909161362583, 6060.909086363708, 6064.423879731418, 6073.423024812636, 6131.478824299985, 4726.621870250372, 4751.667383283137, 4759.50025247351, 4762.333273341735, 4801.01579176268, 4297.3768803523935, 4349.652027837766, 4349.978250108792, 4384.912301753947, 4401.075774087478, 5607.523360514402, 5618.887622247532, 5637.746301416446, 5644.209810626516, 5648.322201335866, 5970.701464926737, 6085.756569737161, 6097.420745029215, 6105.176214193607, 6139.2325959255095, 5472.945270547243, 5551.694656793834, 5597.44025597437, 5613.915791263053, 5616.129499927518, 5272.815451459181, 5273.1035723927025, 5279.577633789288, 5284.313039304942, 5306.0, 6112.877742445126, 6138.079288106641, 6152.846178845386, 6160.075988601746, 6162.630242185483, 5993.041113421831, 5999.670018149044, 6024.0662697282, 6042.667653279112, 6107.9083813741945, 6110.0424004731585, 6121.209103132208, 6127.662978536223, 6131.049687298476, 6160.260768707604, 6013.849653758691, 6016.42843929826, 6020.066889632114, 6020.247469066367, 6067.514598831995, 5953.880922381615, 5990.921634105903, 6026.698665066641, 6079.240094988127, 6088.330283668882, 5839.532837373085, 5860.443257890493, 5917.082852157922, 5931.822045338647, 6003.729832157476, 4395.7362558246605, 5937.109433584997, 5938.138969849261, 5965.0, 5991.131285963598, 5716.342620598518, 5732.627379220337, 5776.653400795798, 5789.015867302484, 5794.594378393641, 5760.740766665426, 5808.94191058084, 5811.070228763547, 5900.557458190567, 5933.465988061095, 5696.287964004499, 5697.259356283656, 5708.457696518824, 5715.028445164416, 5719.599628025998], "value": 5529.761560199066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.8967482316479, 467.77546777546775, 500.8873003574194, 510.06403250036203, 529.8607992815447, 30187.698123018792, 39415.60584394155, 40433.38266469341, 40573.14555117267, 42049.78975105128, 40995.59004409955, 41234.58765412345, 41348.379774303336, 41366.79316603413, 41612.751617451446, 8401.453905496153, 9252.67615633453, 9412.105849944244, 9429.858552121723, 9450.85823712645, 7302.853942921165, 10931.672049838478, 11284.040856527165, 11302.152338574599, 11487.59793407231, 11228.0, 11261.155413344031, 11317.377544235063, 11331.433428328592, 11339.319640821577, 9488.525573721321, 11170.0, 11244.943775281072, 11292.684999575067, 11315.660530184108, 11222.887771122347, 11268.830967535494, 11276.1542884284, 11279.266847654877, 11296.0, 38774.80612596947, 39611.80194099011, 39769.40345894814, 39837.80081099605, 39915.20169596621, 3229.2411283348392, 3343.147497388175, 3668.3030224257304, 3942.64516193544, 3968.206358728237, 29030.41939161205, 30300.939467118766, 30465.781368745225, 30615.0, 30970.225744356347, 3110.797798143136, 3215.8070515769127, 3231.272963583175, 3272.8527216275324, 3298.620658624241, 389138.0, 477040.0, 480704.0, 481904.0, 482204.5889770599, 58182.14541036991, 58929.41070589325, 59365.81268374608, 59708.402915970284, 59827.0, 62822.685886570274, 62831.203631491626, 63017.05474417887, 63065.36934630687, 63105.36894631087, 15137.848621513864, 15365.308561114776, 15372.231388430533, 15373.154476503676, 15379.461718839786, 9963.302568820112, 10179.931107233782, 10226.693199204035, 11806.52773889052, 11893.583724569771, 16675.666486670198, 16881.07154106536, 17044.659106817795, 17295.74056389155, 17379.47861564155, 5787.565932555075, 6886.208086070066, 7045.753398631024, 7050.224475307712, 7053.647317634201, 831.6340810043562, 930.316217580078, 939.1031564855547, 963.4652767713845, 966.3428868369435, 24670.0, 29015.69429375683, 29184.41631167365, 29535.556966645516, 29813.701862981525, 961.1445813226235, 1003.3779056984716, 1018.2871989607305, 1033.844923261517, 1092.4919912240846, 14549.636259093608, 15161.469348572968, 15502.689946201013, 15529.767053494206, 15655.217239137997, 651581.0, 655179.0, 655269.0, 656260.0, 656985.0, 56503.71748141233, 56764.43235567674, 56765.43234567684, 56901.430985689614, 57235.42764572301, 1215.9452824622913, 1253.7116463213513, 1339.7521458530202, 1358.456617353047, 1392.7284179585288, 29783.702162978094, 30184.54723179198, 30739.9241026563, 31243.906463273677, 31382.843085784425, 48839.5116048835, 49206.75396622994, 49343.7532812348, 49349.0, 49365.765855852456, 481139.78290326375, 492427.0, 493951.0, 496248.0, 496689.0, 22560.323190304316, 25929.6110558338, 26033.609495857956, 26601.600975985762, 26639.60040599431, 45494.31758523691, 45769.54230457786, 46005.539944600125, 46848.531514684415, 47028.529714703785, 37624.811875940446, 37701.81149094237, 37939.81030094832, 39159.0, 39162.608373917035, 37830.0, 38651.0, 38814.80592597019, 39031.02422439462, 39806.20387592174, 36429.0, 36475.08812279714, 37694.62305376911, 37860.0, 37893.43159852659, 26764.330891727863, 30510.08469745911, 33644.66355336415, 33736.831315843265, 33939.66060339365, 23493.942772574934, 24477.632835507124, 24556.0, 25381.492370152864, 25494.872525637995], "value": 19662.937312141894, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.78118879162173, 347.0646607393073, 361.8371732720275, 370.61456085670903, 399.8484365028719, 14735.70528589429, 14966.32651530681, 15758.290876910538, 19584.902075489637, 20350.389488315337, 16107.677846443094, 18287.0, 18992.525186870334, 19310.517237069045, 19572.510687232825, 5559.58303127266, 5786.537077033827, 5822.505087067604, 5939.85150371242, 5948.40515948406, 5619.847931174099, 5768.884622307552, 5776.913346299809, 5806.59353845231, 5923.17075609415, 5774.451427114417, 5774.6535207887455, 5776.018076926912, 5780.335261444946, 5787.305523337184, 5588.636738612018, 5690.60165788395, 5714.79998200061, 5776.884462310731, 5782.074868021138, 4994.87512812179, 5049.065922804293, 5057.671251368649, 5076.898462030738, 5088.821891233789, 24965.375865603324, 25475.108371207105, 25508.872455637604, 25778.484430311477, 26144.0, 2277.2029789573517, 2285.0288627333316, 2404.6393041043984, 2592.5333439980795, 2763.77889768818, 14695.853041469556, 14951.925240373837, 15167.924160379127, 15703.057816531045, 15846.128462934534, 1758.1209395302349, 1760.7270873014704, 1836.7612210412694, 1857.4891904726173, 1891.7919028906808, 108389.0, 111657.76684466346, 112006.0, 112172.43913780378, 112981.0, 10359.792804144026, 10592.470376481146, 10864.456777161111, 10947.671569852917, 11099.889001110047, 13514.662133446545, 13815.792763108562, 13975.580732578039, 14003.299835008209, 14022.298885055707, 8197.71308004229, 8264.917350826536, 8277.751667449866, 8402.747917562483, 8438.071812100665, 8164.183581641907, 8171.06032806223, 8183.95908020456, 8369.414141010071, 8381.455205411628, 5438.0, 6455.7740479083, 6558.573692709959, 6579.47364210862, 6706.061151438705, 1783.9464816055538, 1824.6533158699804, 1830.5149135478841, 1832.670119378498, 1834.9816501835078, 829.7676650537738, 835.7964531075354, 877.2061284537504, 907.0702529906766, 922.5018490015317, 21479.46301342479, 22057.0, 22113.778862211493, 22124.55750884973, 22188.445288867584, 929.4516235421135, 947.7204224753714, 955.6464108279841, 977.6969139566758, 1025.4462590201356, 10861.239713219999, 11317.264377815416, 11382.829257561143, 11419.429028548539, 11564.826527602092, 567766.0, 571946.0, 580765.0, 582824.0, 582856.0, 117183.0, 117443.41278293554, 120474.0, 121522.0, 122647.0, 762.3520007993161, 963.5615794813343, 975.2880397310004, 978.4422878959067, 980.9460479673686, 14933.850661493247, 18980.43058708241, 18996.335128270443, 19218.231270749573, 19244.903775481594, 38122.809385952896, 48678.29625963216, 48806.0477580907, 49092.0, 50360.0, 66048.79950810407, 68214.65892670504, 68397.0, 68957.31042689508, 70515.29484705087, 6809.829754256183, 7184.640767961477, 7260.818479538054, 7367.300106489874, 7538.924610753822, 11692.415379231175, 11757.647270581896, 11823.231489953125, 12031.4585843639, 12074.818877717016, 10076.143527800219, 10305.845412318671, 10397.792044159225, 10475.266731328733, 10543.683689489328, 9820.263480238867, 9871.851922221316, 9875.259355548218, 10117.08946194846, 10132.797344053226, 8482.406231563731, 8758.693445729368, 10465.790684186426, 10489.265751397328, 10717.41054241993, 7417.888731669137, 7483.102027756704, 7574.280443357872, 7782.066152061789, 7842.64708088126, 8847.071057538866, 9720.562574684014, 9816.607335706492, 10298.3820970742, 10344.586216551254], "value": 9311.159335793389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.4877622115482, 1459.9343029563668, 1496.2219645784191, 1652.3225477554206, 1849.3157531713268, 7458.179600243969, 7803.6098195090235, 7807.5315481071175, 7815.960920195391, 7815.960920195405, 7601.125870524891, 8074.192580741923, 8097.757067287991, 8235.423520353577, 8425.536595487245, 2273.920412785553, 2313.3060081975423, 2318.675385446039, 2320.0951628864755, 2325.5232677301196, 2003.3989803059096, 2255.4474153832334, 2320.3503019154664, 2321.535692861426, 2328.8486248393883, 2048.0, 2071.337172104927, 2072.5647614001077, 2072.730545029144, 2073.2121793718443, 2202.581509513195, 2269.7049383580193, 2273.7044184256106, 2277.3851060213815, 2285.06312411912, 2255.548890221962, 2279.7036385269976, 2292.5644127615865, 2293.9885300573555, 2296.9770302297097, 8233.46482478637, 8330.583470826496, 8339.20777526134, 8357.080721120672, 8383.455075420079, 4962.900741985176, 5119.923201151985, 5127.461616530248, 5136.743162841843, 5141.254518094893, 3242.1732458223237, 3407.880724174642, 3436.914077148091, 3475.4265546184847, 3514.1741690702665, 918.8713580098791, 1016.5171543516844, 1046.199657262195, 1067.3542506783363, 1089.6458650938478, 10883.346999180074, 10993.395363255018, 10994.890051099546, 10995.560177592966, 11000.22998390113, 4309.59058889405, 4505.0, 4591.1965406053805, 4592.15045216636, 4635.629149668019, 9366.016568260371, 9379.062093790566, 9381.671641492516, 9389.530523473799, 9397.76505587352, 5103.157978933508, 5104.872378190575, 5108.540231379194, 5113.769880355393, 5117.692938423632, 4485.215087359699, 4566.97716511422, 4626.329182268552, 4674.906501870011, 4701.2242979908615, 3654.2691461707764, 3686.944695829565, 3719.5536535615897, 3770.1517158639085, 3788.3749181385315, 1238.9132760706664, 1240.1009268280425, 1243.776120298337, 1256.3215863433827, 1258.4337048328107, 687.8108520156997, 805.9113497515268, 807.2976510435841, 868.6047848229041, 876.4872549558452, 5516.889662206733, 5764.625299355528, 5852.590318677737, 5939.851503712442, 5960.92703313399, 851.2423942691009, 913.6847787513298, 924.4360939826701, 934.7429456899271, 991.7966816802682, 3676.852925882988, 3869.1487872667967, 3995.4006898965386, 4002.5797291284, 4028.778417187083, 9763.511824408752, 10143.442110683836, 10256.28206025586, 10285.33145345565, 10291.43397113151, 9831.459269740233, 10005.949970250102, 10198.133158681447, 10202.438865862301, 10212.131968782589, 7687.769366919001, 7697.191794861571, 7740.574268415178, 7793.571353575608, 7855.84288314242, 5456.127019676833, 5591.580631452576, 5617.606767526234, 5622.690752008679, 5770.913436298543, 9114.635414583343, 9132.589033493641, 9189.310801689766, 9347.252219822261, 9348.485833279236, 8944.552772361487, 9033.367664263438, 9205.953970230106, 9279.72160835176, 9374.95312523433, 6845.0, 7187.712491500281, 7201.3518783309755, 7201.747938822116, 7218.855622887618, 6581.473482121514, 7533.7363192290195, 7585.62071896414, 7616.581088040211, 7699.153093159636, 6002.339742628395, 7064.0, 7111.111111111111, 7151.392131668658, 7162.0, 5550.861228469321, 6780.254172040973, 6925.0, 6954.965225173842, 7041.647917604202, 6494.64279464634, 6547.345265473415, 6554.377334153248, 6565.161754708689, 6627.867442651216, 4593.0, 4804.807807687654, 4809.350737650372, 4832.033593281288, 4951.455339912679, 4750.8337208197545, 4868.853934381974, 4889.315495830516, 4917.532834380728, 5039.118154323052], "value": 4351.955987464691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.75117896251294, 295.2456473709671, 303.89667513045566, 308.1203164964028, 311.5529215575648, 5102.3111879896205, 5178.799010420575, 5187.247849061884, 5203.973980130104, 5291.862249616342, 4045.939310910339, 4932.901341973158, 4994.578713581191, 5012.198048312271, 5103.948960510394, 3298.3403319336107, 3480.4605286180554, 3944.5858184890603, 3990.3216453203027, 4019.5779443158485, 3175.7459403247685, 3467.6358982306874, 3836.1943991761764, 3967.166894952049, 3998.2003599280115, 3032.7725420593433, 3131.617852719069, 3505.019663889894, 3969.98015009926, 3996.700247481436, 3891.1050458394584, 3934.370500719871, 3935.173613541131, 3941.4284928685465, 3968.9801550992206, 3406.6423025582453, 3441.0709108540805, 3452.8100954447495, 3463.688268055862, 3465.012471445626, 4170.082581831992, 4407.779611019469, 5030.773615187325, 5055.241713742968, 5083.288339632454, 3886.553046399672, 3936.264296314063, 4005.898377946059, 4142.440770495975, 4143.544210136883, 5405.243265942771, 5406.675599464005, 5421.2952316199035, 5433.918491222635, 5446.400895901447, 3682.9447558286647, 3783.829727662262, 3794.3359912015285, 3834.0989867381145, 3836.7122465814896, 5297.496737809902, 5582.63712858667, 5652.180433837112, 5665.631733937281, 5691.381964296429, 3827.215420838777, 3835.8684188164557, 3841.250956063541, 3845.7115716321387, 3880.941785873214, 3927.3716205407, 3928.2929072766606, 3930.4104384342577, 3937.901552461154, 3938.8818335449982, 3553.573571171476, 3700.593774365778, 4057.857974970862, 4299.656027517791, 4556.886077848014, 5433.619646624698, 5453.209284653783, 5454.036546843134, 5465.918011229755, 5536.474034966672, 1203.8314635950974, 1236.8763123687559, 1255.736295377981, 1258.314218750783, 1259.7921342978489, 751.6023883810626, 768.7962689887185, 824.6577670266772, 869.4305230074185, 887.1483375959023, 4448.421705178306, 4504.752238626907, 4782.904341913142, 4819.180739274261, 4861.29511220871, 4343.0, 4896.6572339935865, 5248.947510524922, 5289.444608316071, 5365.409804921455, 4576.123789246393, 4664.813407463731, 4784.425868895755, 4806.399200099988, 4820.68665536739, 2413.1674572272536, 2688.9916281394476, 2695.339641787735, 2700.784646908899, 2702.3919618086165, 4488.281874900001, 5188.825297895492, 5221.269022336875, 5255.789768409298, 5304.32131773452, 4363.672724545671, 4580.725156490621, 4920.803167873245, 5205.427402985669, 5770.0, 5832.270966129234, 5837.211976383134, 5856.355800861902, 5857.824265272134, 5894.410558944071, 5223.895522089461, 5227.686338819683, 5265.6840589564745, 5649.689267090185, 5706.0, 4736.194846876108, 5487.640314664733, 5567.860803479945, 5582.246396736551, 5614.6631202128, 5044.1172794761505, 5214.713190774392, 5809.912851307149, 5815.883682326415, 5906.645601263938, 3535.646435356444, 3774.6602805747616, 3777.6411240932066, 3796.5064541609413, 3814.2371525694416, 4734.839964208791, 4991.07665081961, 5500.58745594074, 5513.255710479034, 5539.224508568885, 4214.4310518079665, 5434.527290083081, 5511.035568775528, 5535.730350556252, 5539.25220095282, 5139.640225184201, 5406.351237851483, 5444.8366549003595, 5500.697461639648, 5509.862253443696, 4465.933011004772, 5330.828157246432, 5361.195820626937, 5361.865953351197, 5375.301210842722, 5223.242629818579, 5332.73336333174, 5368.463153684756, 5487.835364939058, 5518.972405137949, 4991.925121123113, 5349.839504814861, 5378.97310513445, 5421.62048656606, 5435.0], "value": 3914.42872847432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.5168895794717, 761.1741260732109, 766.9233076692332, 780.3640033372798, 788.0622059748898, 14588.0, 14893.0, 15276.007059541122, 15534.766978495332, 15604.53186404407, 12039.819402708967, 14030.719385612281, 14055.929720351409, 14334.641633959156, 15199.54401367958, 813.3127507256373, 828.6022709099636, 837.7444879311807, 838.4466252273501, 839.2740279658112, 649.7238673563741, 671.1912145864246, 675.0212192321129, 822.313368337439, 824.2375802382802, 722.6206241723111, 862.1034124510502, 866.2939704141137, 867.7266661001764, 868.8436081505326, 846.6359465429863, 848.7326492154982, 849.7748096754334, 851.7231899632583, 853.1383302864152, 503.74309102357694, 518.8962207558466, 523.2595876834275, 629.4775336470718, 630.3129588748286, 11737.354445505494, 11777.941110294394, 11782.057435405148, 14247.643808904757, 14779.187144707037, 11235.60675376366, 13247.403866826016, 13704.65738356539, 13716.862831371658, 13736.862631373759, 11442.0, 11594.594189203423, 11635.418229088511, 11660.941695291469, 11983.041356691443, 3244.3511297740547, 3623.691986181178, 3655.670989610948, 3676.6323367663285, 3762.0218743126984, 111107.15010719454, 112434.43782781034, 112702.0, 113698.43150784276, 115370.0, 10574.52414641343, 10759.892401076046, 10798.568057277778, 10800.693103225842, 11018.724531886606, 20995.16019359239, 21374.9006394072, 21432.357029288836, 21458.0, 21497.78502214958, 7321.926780732231, 7486.887696684554, 7544.886826697604, 7547.962260188664, 7663.961680191564, 4098.139390727921, 4103.0, 4168.979155104205, 4183.811728472226, 4253.085586598896, 3367.9494807577908, 3467.323871844966, 3492.4935884297142, 3496.790192588453, 3497.632748561364, 522.8276877761442, 620.1875543038634, 628.355935166458, 628.7422156915643, 629.7512482569451, 627.7645882793952, 632.6077831744348, 651.6741629185407, 656.6060363781693, 656.7176114270909, 7726.922730772732, 8578.528180949983, 8853.867191992125, 8873.0, 9375.671851485165, 502.63558919783594, 549.4560385218684, 625.2247213455282, 653.1280740211776, 660.6036378173154, 3949.921001579952, 4245.639120674778, 4422.049259409242, 4429.247028005247, 4493.977530112394, 114319.85680143093, 115364.0, 115375.42312288552, 115450.84549154401, 115856.0, 80891.78662320069, 85580.0, 98418.50790746143, 99203.0, 100794.0, 76336.61831690917, 77462.61268693733, 81747.59126204331, 84426.57786711027, 86984.56507717421, 9676.453862500497, 9701.417914925127, 9778.41329520231, 9861.457619830691, 9934.440255076132, 41989.0, 47909.28136077892, 56325.71837140788, 56662.0, 56912.29263122113, 76081.61959190169, 78116.60941695255, 78535.0, 80903.0, 81105.9723506917, 11100.722481938015, 11745.412729363668, 11889.583864564698, 12328.506859725869, 12737.617871463872, 13221.801672974721, 13563.0, 13703.177809331472, 13966.441342346192, 14538.345774439964, 13086.541971030969, 13253.204807711569, 13419.463221471422, 13462.192268463923, 14040.78938815898, 12677.746445071232, 12874.935625321814, 12887.677808054874, 13181.40683669218, 13339.399727012502, 7368.336849683555, 12698.98408127366, 12955.0, 13023.609291721263, 13137.671558211121, 9635.373700709431, 10099.69700908974, 11087.33475991443, 11185.720356990814, 11619.709507262387, 9854.359466634645, 11099.72250693739, 11105.888941110485, 11247.582397862567, 11419.543218271176], "value": 7251.623714475376, "unit": "score"}], "name": "dromaeo_css", "value": 7071.844228226211, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 115.0, 151.0, 116.0, 117.0, 110.0, 117.0, 134.0, 116.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 181.0, 184.0, 185.0, 193.0, 207.0, 254.0, 183.0, 184.0], "value": 193.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 89.0, 60.0, 58.0, 59.0, 59.0, 77.0, 59.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 88.0, 68.0, 67.0, 68.0, 82.0, 67.0, 69.0, 81.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 89.0, 86.0, 96.0, 128.0, 90.0, 87.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 123.0, 164.0, 112.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 86.0, 84.0, 87.0, 84.0, 85.0, 87.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 54.0, 58.0, 56.0, 56.0, 54.0, 57.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 69.0, 71.0, 76.0, 71.0, 68.0, 69.0, 69.0, 78.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 102.0, 105.0, 88.0, 88.0, 87.0, 85.0, 87.0, 90.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 151.0, 149.0, 154.0, 151.0, 159.0, 158.0, 196.0, 163.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 185.0, 234.0, 196.0, 175.0, 176.0, 230.0, 226.0, 174.0, 173.0], "value": 194.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 69.0, 72.0, 80.0, 87.0, 88.0, 86.0, 77.0], "value": 76.8, "unit": "score"}], "name": "kraken", "value": 1505.4999999999998, "alertThreshold": 2.0}]} 09:01:15 INFO - Return code: 0 09:01:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:15 INFO - # TBPL SUCCESS # 09:01:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:15 INFO - 2016-11-29 09:01:15.503 screenresolution[1930:20903] starting screenresolution argv=screenresolution get 09:01:15 INFO - 2016-11-29 09:01:15.507 screenresolution[1930:20903] Display 0: 1600x1200x32@60 09:01:15 INFO - 2016-11-29 09:01:15.513 screenresolution[1931:20906] starting screenresolution argv=screenresolution list 09:01:15 INFO - Available Modes on Display 0 09:01:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:15 INFO - Intel Iris: 09:01:15 INFO - Chipset Model: Intel Iris 09:01:15 INFO - Type: GPU 09:01:15 INFO - Bus: Built-In 09:01:15 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:15 INFO - Vendor: Intel (0x8086) 09:01:15 INFO - Device ID: 0x0a2e 09:01:15 INFO - Revision ID: 0x0009 09:01:15 INFO - Displays: 09:01:15 INFO - Display: 09:01:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:15 INFO - Display Serial Number: 1600x1200 60 09:01:15 INFO - Main Display: Yes 09:01:15 INFO - Mirror: Off 09:01:15 INFO - Online: Yes 09:01:15 INFO - Rotation: Supported 09:01:15 INFO - Return code: 0 09:01:15 INFO - Running post-action listener: _resource_record_post_action 09:01:15 INFO - [mozharness: 2016-11-29 17:01:15.754623Z] Finished run-tests step (success) 09:01:15 INFO - Running post-run listener: _resource_record_post_run 09:01:15 INFO - Total resource usage - Wall time: 1216s; CPU: 53.0%; Read bytes: 716800; Write bytes: 693961728; Read time: 11; Write time: 2024 09:01:15 INFO - TinderboxPrint: CPU usage
53.5% 09:01:15 INFO - TinderboxPrint: I/O read bytes / time
716,800 / 11 09:01:15 INFO - TinderboxPrint: I/O write bytes / time
693,961,728 / 2,024 09:01:15 INFO - TinderboxPrint: CPU idle
2,262.9 (46.5%) 09:01:15 INFO - TinderboxPrint: CPU system
974.4 (20.0%) 09:01:15 INFO - TinderboxPrint: CPU user
1,628.4 (33.5%) 09:01:15 INFO - TinderboxPrint: Swap in / out
384,344,064 / 0 09:01:15 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 368108032; Write bytes: 367224320; Read time: 28615; Write time: 800 09:01:15 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 716800; Write bytes: 308190720; Read time: 11; Write time: 1176 09:01:16 INFO - Running post-run listener: _upload_blobber_files 09:01:16 INFO - Blob upload gear active. 09:01:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:16 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 09:01:16 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'] 09:01:16 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 09:01:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:17 INFO - (blobuploader) - INFO - Done attempting. 09:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:18 INFO - (blobuploader) - INFO - Done attempting. 09:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:21 INFO - (blobuploader) - INFO - Done attempting. 09:01:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:21 INFO - Return code: 0 09:01:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bea7e372e1ede72b03bdf7287bd9e16e22253be399ec15eebf0c32550ea0d9ed24aa5edffc958da3bfba2801e586a43fb4995a430c8877c18558ba2d9716e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd9a0a726457a8f3c23aee98ea0fb6d456d88e466898063fd0f7996d655720ca2912d77173559af5dfee955c9ffd65a9b8bfeee30c51eda7d845dceadba118d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec10368b57387dff2bc7061d7d97ea64df4761083a791640837c287291c8e733b9b92056f816264b7a4f55cebf56b3df535172a02111ce6fafc205347acbae72"} 09:01:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:21 INFO - Contents: 09:01:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bea7e372e1ede72b03bdf7287bd9e16e22253be399ec15eebf0c32550ea0d9ed24aa5edffc958da3bfba2801e586a43fb4995a430c8877c18558ba2d9716e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd9a0a726457a8f3c23aee98ea0fb6d456d88e466898063fd0f7996d655720ca2912d77173559af5dfee955c9ffd65a9b8bfeee30c51eda7d845dceadba118d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec10368b57387dff2bc7061d7d97ea64df4761083a791640837c287291c8e733b9b92056f816264b7a4f55cebf56b3df535172a02111ce6fafc205347acbae72"} 09:01:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:21 INFO - Copying logs to upload dir... 09:01:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.803110 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-29 09:01:21.527766) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 09:01:21.531862) ========= 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.ODgOfTww7v/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.k0v8gq8pdk/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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/1bea7e372e1ede72b03bdf7287bd9e16e22253be399ec15eebf0c32550ea0d9ed24aa5edffc958da3bfba2801e586a43fb4995a430c8877c18558ba2d9716e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd9a0a726457a8f3c23aee98ea0fb6d456d88e466898063fd0f7996d655720ca2912d77173559af5dfee955c9ffd65a9b8bfeee30c51eda7d845dceadba118d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec10368b57387dff2bc7061d7d97ea64df4761083a791640837c287291c8e733b9b92056f816264b7a4f55cebf56b3df535172a02111ce6fafc205347acbae72"} build_url:https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010988 build_url: 'https://queue.taskcluster.net/v1/task/Az6ITlt_QS-x5mIsJWZbRw/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/1bea7e372e1ede72b03bdf7287bd9e16e22253be399ec15eebf0c32550ea0d9ed24aa5edffc958da3bfba2801e586a43fb4995a430c8877c18558ba2d9716e30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd9a0a726457a8f3c23aee98ea0fb6d456d88e466898063fd0f7996d655720ca2912d77173559af5dfee955c9ffd65a9b8bfeee30c51eda7d845dceadba118d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec10368b57387dff2bc7061d7d97ea64df4761083a791640837c287291c8e733b9b92056f816264b7a4f55cebf56b3df535172a02111ce6fafc205347acbae72"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 09:01:21.565760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:01:21.566124) ========= 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.ODgOfTww7v/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.k0v8gq8pdk/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.005196 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 09:01:21.615494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 09:01:21.615838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 09:01:21.616192) ========= ========= Total master_lag: 0.19 =========