builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0026 starttime: 1486040138.83 results: success (0) buildid: 20170202030211 builduid: 4d0386e0cde34ef09888b39e4e39cbca revision: f985243bb630b2c78cd57731c8d8ab191aa09527 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:38.832963) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:38.833424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:38.833773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:38.859437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:38.859802) ========= 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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-02 04:55:38-- 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% 15.1M=0.001s 2017-02-02 04:55:38 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090327 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:38.973984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:38.977364) ========= 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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.035402 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:39.035890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 04:55:39.039296) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f985243bb630b2c78cd57731c8d8ab191aa09527 --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 f985243bb630b2c78cd57731c8d8ab191aa09527 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-02 04:55:39,142 truncating revision to first 12 chars 2017-02-02 04:55:39,142 Setting DEBUG logging. 2017-02-02 04:55:39,142 attempt 1/10 2017-02-02 04:55:39,142 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f985243bb630?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 04:55:40,154 unpacking tar archive at: mozilla-central-f985243bb630/testing/mozharness/ program finished with exit code 0 elapsedTime=1.265715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 04:55:40.328685) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:40.329010) ========= script_repo_revision: f985243bb630b2c78cd57731c8d8ab191aa09527 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:40.329417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:40.329696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 04:55:40.348989) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-02 04:55:40.349315) ========= /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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:55:40 INFO - MultiFileLogger online at 20170202 04:55:40 in /builds/slave/test 04:55:40 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 04:55:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:55:40 INFO - {'append_to_log': False, 04:55:40 INFO - 'base_work_dir': '/builds/slave/test', 04:55:40 INFO - 'blob_upload_branch': 'Firefox', 04:55:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:55:40 INFO - 'branch': 'Firefox', 04:55:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:40 INFO - 'config_files': ('talos/mac_config.py',), 04:55:40 INFO - 'default_actions': ('clobber', 04:55:40 INFO - 'read-buildbot-config', 04:55:40 INFO - 'download-and-extract', 04:55:40 INFO - 'populate-webroot', 04:55:40 INFO - 'create-virtualenv', 04:55:40 INFO - 'install', 04:55:40 INFO - 'run-tests'), 04:55:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:40 INFO - 'download_minidump_stackwalk': True, 04:55:40 INFO - 'download_symbols': 'ondemand', 04:55:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:40 INFO - 'installer_path': 'installer.exe', 04:55:40 INFO - 'log_level': 'info', 04:55:40 INFO - 'log_name': 'talos', 04:55:40 INFO - 'log_to_console': True, 04:55:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:55:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:55:40 INFO - 'opt_config_files': (), 04:55:40 INFO - 'pip_index': False, 04:55:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:40 INFO - 'cmd': ('bash', 04:55:40 INFO - '-c', 04:55:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:40 INFO - 'enabled': True, 04:55:40 INFO - 'halt_on_failure': False, 04:55:40 INFO - 'name': 'check_screen_resolution'},), 04:55:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:40 INFO - 'cmd': ('bash', 04:55:40 INFO - '-c', 04:55:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:40 INFO - 'enabled': True, 04:55:40 INFO - 'halt_on_failure': False, 04:55:40 INFO - 'name': 'check_screen_resolution'},), 04:55:40 INFO - 'run_cmd_checks_enabled': True, 04:55:40 INFO - 'sps_profile': False, 04:55:40 INFO - 'sps_profile_interval': 0, 04:55:40 INFO - 'suite': 'dromaeojs', 04:55:40 INFO - 'system_bits': '32', 04:55:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:40 INFO - 'title': 't-yosemite-r7-0026', 04:55:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:40 INFO - 'use_talos_json': True, 04:55:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:55:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:40 INFO - 'work_dir': 'build'} 04:55:40 INFO - [mozharness: 2017-02-02 12:55:40.562280Z] Running clobber step. 04:55:40 INFO - Running pre-action listener: _resource_record_pre_action 04:55:40 INFO - Running main action method: clobber 04:55:40 INFO - rmtree: /builds/slave/test/build 04:55:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:55:43 INFO - Running post-action listener: _resource_record_post_action 04:55:43 INFO - [mozharness: 2017-02-02 12:55:43.709895Z] Finished clobber step (success) 04:55:43 INFO - [mozharness: 2017-02-02 12:55:43.710028Z] Running read-buildbot-config step. 04:55:43 INFO - Running pre-action listener: _resource_record_pre_action 04:55:43 INFO - Running main action method: read_buildbot_config 04:55:43 INFO - Using buildbot properties: 04:55:43 INFO - { 04:55:43 INFO - "project": "", 04:55:43 INFO - "product": "firefox", 04:55:43 INFO - "script_repo_revision": "production", 04:55:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:55:43 INFO - "repository": "", 04:55:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:55:43 INFO - "buildid": "20170202030211", 04:55:43 INFO - "stage_platform": "macosx64", 04:55:43 INFO - "basedir": "/builds/slave/test", 04:55:43 INFO - "nightly_build": "True", 04:55:43 INFO - "buildnumber": 78, 04:55:43 INFO - "slavename": "t-yosemite-r7-0026", 04:55:43 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:55:43 INFO - "platform": "yosemite_r7", 04:55:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:55:43 INFO - "branch": "mozilla-central", 04:55:43 INFO - "repo_path": "mozilla-central", 04:55:43 INFO - "revision": "f985243bb630b2c78cd57731c8d8ab191aa09527", 04:55:43 INFO - "pgo_build": "False", 04:55:43 INFO - "builduid": "4d0386e0cde34ef09888b39e4e39cbca", 04:55:43 INFO - "slavebuilddir": "test" 04:55:43 INFO - } 04:55:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:55:43 INFO - Running post-action listener: _resource_record_post_action 04:55:43 INFO - [mozharness: 2017-02-02 12:55:43.713509Z] Finished read-buildbot-config step (success) 04:55:43 INFO - [mozharness: 2017-02-02 12:55:43.713648Z] Running download-and-extract step. 04:55:43 INFO - Running pre-action listener: _resource_record_pre_action 04:55:43 INFO - Running main action method: download_and_extract 04:55:43 INFO - mkdir: /builds/slave/test/build/tests 04:55:43 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')]} 04:55:43 INFO - trying https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:55:43 INFO - Downloading https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:55:44 INFO - Downloaded 1199 bytes. 04:55:44 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:55:44 INFO - Using the following test package requirements: 04:55:44 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:55:44 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:55:44 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:55:44 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'jsshell-mac.zip'], 04:55:44 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:55:44 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:55:44 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:55:44 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:55:44 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:55:44 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:55:44 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:55:44 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:55:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:55:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:55:44 INFO - Fetch https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:55:45 INFO - Expected file size: 16377142 04:55:45 INFO - Obtained file size: 16377142 04:55:52 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:55:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:55:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:55:52 INFO - Fetch https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:55:53 INFO - Expected file size: 16377142 04:55:53 INFO - Obtained file size: 16377142 04:55:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:55:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:55:59 INFO - Fetch https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:56:01 INFO - Expected file size: 14403454 04:56:01 INFO - Obtained file size: 14403454 04:56:01 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')]} 04:56:01 INFO - trying https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:56:01 INFO - Downloading https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:56:04 INFO - Downloaded 70289056 bytes. 04:56:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:56:04 INFO - mkdir: /builds/slave/test/properties 04:56:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:04 INFO - Contents: 04:56:04 INFO - build_url:https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:56:04 INFO - Running post-action listener: _resource_record_post_action 04:56:04 INFO - Running post-action listener: set_extra_try_arguments 04:56:04 INFO - [mozharness: 2017-02-02 12:56:04.761900Z] Finished download-and-extract step (success) 04:56:04 INFO - [mozharness: 2017-02-02 12:56:04.762051Z] Running populate-webroot step. 04:56:04 INFO - Running pre-action listener: _resource_record_pre_action 04:56:04 INFO - Running main action method: populate_webroot 04:56:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:04 INFO - '--tppagecycles', 04:56:04 INFO - '7'], 04:56:04 INFO - 'tests': ['tsvgm']}}, 04:56:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:56:04 INFO - 'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:56:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:56:04 INFO - 'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['damp', 'tps']}, 04:56:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:56:04 INFO - 'tests': ['damp', 'tps']}, 04:56:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['dromaeo_dom']}, 04:56:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['basic_compositor_video']}, 04:56:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:56:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['a11yr', 04:56:04 INFO - 'ts_paint', 04:56:04 INFO - 'tpaint', 04:56:04 INFO - 'sessionrestore', 04:56:04 INFO - 'sessionrestore_no_auto_restore', 04:56:04 INFO - 'tabpaint']}, 04:56:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:04 INFO - 'ts_paint', 04:56:04 INFO - 'tpaint', 04:56:04 INFO - 'sessionrestore', 04:56:04 INFO - 'sessionrestore_no_auto_restore', 04:56:04 INFO - 'tabpaint']}, 04:56:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:56:04 INFO - 'ts_paint', 04:56:04 INFO - 'tpaint', 04:56:04 INFO - 'sessionrestore', 04:56:04 INFO - 'sessionrestore_no_auto_restore', 04:56:04 INFO - 'tabpaint']}, 04:56:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:56:04 INFO - 'ts_paint', 04:56:04 INFO - 'tpaint', 04:56:04 INFO - 'sessionrestore', 04:56:04 INFO - 'sessionrestore_no_auto_restore', 04:56:04 INFO - 'tabpaint']}, 04:56:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['a11yr', 04:56:04 INFO - 'ts_paint', 04:56:04 INFO - 'tpaint', 04:56:04 INFO - 'sessionrestore', 04:56:04 INFO - 'sessionrestore_no_auto_restore', 04:56:04 INFO - 'tabpaint']}, 04:56:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['a11yr', 04:56:04 INFO - 'ts_paint', 04:56:04 INFO - 'tpaint', 04:56:04 INFO - 'sessionrestore', 04:56:04 INFO - 'sessionrestore_no_auto_restore', 04:56:04 INFO - 'tabpaint']}, 04:56:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['tsvgx', 04:56:04 INFO - 'tsvgr_opacity', 04:56:04 INFO - 'tart', 04:56:04 INFO - 'tscrollx', 04:56:04 INFO - 'cart', 04:56:04 INFO - 'tsvg_static']}, 04:56:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:04 INFO - 'tsvgr_opacity', 04:56:04 INFO - 'tart', 04:56:04 INFO - 'tscrollx', 04:56:04 INFO - 'cart', 04:56:04 INFO - 'tsvg_static']}, 04:56:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:56:04 INFO - 'talos_options': ['--disable-e10s'], 04:56:04 INFO - 'tests': ['tp5o']}, 04:56:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:56:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:56:04 INFO - 'talos_options': ['--disable-e10s', 04:56:04 INFO - '--xperf_path', 04:56:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:04 INFO - 'tests': ['tp5n']}, 04:56:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:56:04 INFO - 'talos_options': ['--xperf_path', 04:56:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:04 INFO - 'tests': ['tp5n']}}, 04:56:04 INFO - 'talos.zip': {'path': '', 04:56:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:04 INFO - Running post-action listener: _resource_record_post_action 04:56:04 INFO - [mozharness: 2017-02-02 12:56:04.781389Z] Finished populate-webroot step (success) 04:56:04 INFO - [mozharness: 2017-02-02 12:56:04.781528Z] Running create-virtualenv step. 04:56:04 INFO - Running pre-action listener: _resource_record_pre_action 04:56:04 INFO - Running main action method: create_virtualenv 04:56:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:04 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 04:56:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:04 INFO - Using real prefix '/tools/python27' 04:56:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:08 INFO - Installing pip.................done. 04:56:08 INFO - Return code: 0 04:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:56:08 INFO - Reading from file tmpfile_stdout 04:56:08 INFO - Output received: 04:56:08 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) 04:56:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:08 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:08 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 04:56:08 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 04:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:08 INFO - 'HOME': '/Users/cltbld', 04:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:08 INFO - 'LOGNAME': 'cltbld', 04:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:08 INFO - 'MOZ_NO_REMOTE': '1', 04:56:08 INFO - 'NO_EM_RESTART': '1', 04:56:08 INFO - 'PAGER': '/bin/cat', 04:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:08 INFO - 'PWD': '/builds/slave/test', 04:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:08 INFO - 'SHELL': '/bin/bash', 04:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:08 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:08 INFO - 'USER': 'cltbld', 04:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:08 INFO - 'XPC_FLAGS': '0x0', 04:56:08 INFO - 'XPC_SERVICE_NAME': '0', 04:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:09 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 04:56:09 INFO - Cleaning up... 04:56:09 INFO - Return code: 0 04:56:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:56:09 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')]} 04:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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')]} 04:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:09 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 04:56:09 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 04:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:09 INFO - 'HOME': '/Users/cltbld', 04:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:09 INFO - 'LOGNAME': 'cltbld', 04:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:09 INFO - 'MOZ_NO_REMOTE': '1', 04:56:09 INFO - 'NO_EM_RESTART': '1', 04:56:09 INFO - 'PAGER': '/bin/cat', 04:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:09 INFO - 'PWD': '/builds/slave/test', 04:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:09 INFO - 'SHELL': '/bin/bash', 04:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:09 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:09 INFO - 'USER': 'cltbld', 04:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:09 INFO - 'XPC_FLAGS': '0x0', 04:56:09 INFO - 'XPC_SERVICE_NAME': '0', 04:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:09 INFO - Downloading/unpacking psutil>=3.1.1 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:12 INFO - Installing collected packages: psutil 04:56:12 INFO - Running setup.py install for psutil 04:56:12 INFO - building 'psutil._psutil_osx' extension 04:56:12 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 04:56:13 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 04:56:13 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 04:56:13 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 04:56:13 INFO - building 'psutil._psutil_posix' extension 04:56:13 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 04:56:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:56:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:56:13 INFO - ^ 04:56:13 INFO - 1 warning generated. 04:56:13 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 04:56:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:13 INFO - Successfully installed psutil 04:56:13 INFO - Cleaning up... 04:56:14 INFO - Return code: 0 04:56:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:56:14 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')]} 04:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:14 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')]} 04:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:14 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:14 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 04:56:14 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 04:56:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:14 INFO - 'HOME': '/Users/cltbld', 04:56:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:14 INFO - 'LOGNAME': 'cltbld', 04:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:14 INFO - 'MOZ_NO_REMOTE': '1', 04:56:14 INFO - 'NO_EM_RESTART': '1', 04:56:14 INFO - 'PAGER': '/bin/cat', 04:56:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:14 INFO - 'PWD': '/builds/slave/test', 04:56:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:14 INFO - 'SHELL': '/bin/bash', 04:56:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:14 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:14 INFO - 'USER': 'cltbld', 04:56:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:14 INFO - 'XPC_FLAGS': '0x0', 04:56:14 INFO - 'XPC_SERVICE_NAME': '0', 04:56:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:14 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 04:56:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:56:17 INFO - Installing collected packages: mozsystemmonitor 04:56:17 INFO - Running setup.py install for mozsystemmonitor 04:56:17 INFO - Successfully installed mozsystemmonitor 04:56:17 INFO - Cleaning up... 04:56:17 INFO - Return code: 0 04:56:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:17 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:17 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 04:56:17 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 04:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:17 INFO - 'HOME': '/Users/cltbld', 04:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:17 INFO - 'LOGNAME': 'cltbld', 04:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:17 INFO - 'MOZ_NO_REMOTE': '1', 04:56:17 INFO - 'NO_EM_RESTART': '1', 04:56:17 INFO - 'PAGER': '/bin/cat', 04:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:17 INFO - 'PWD': '/builds/slave/test', 04:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:17 INFO - 'SHELL': '/bin/bash', 04:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:17 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:17 INFO - 'USER': 'cltbld', 04:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:17 INFO - 'XPC_FLAGS': '0x0', 04:56:17 INFO - 'XPC_SERVICE_NAME': '0', 04:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:56:17 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 04:56:17 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 04:56:17 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 04:56:17 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 04:56:17 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 04:56:17 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 04:56:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:56:20 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 04:56:20 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 04:56:20 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 04:56:20 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 04:56:20 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 04:56:20 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 04:56:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:20 INFO - warning: no files found matching '*.txt' 04:56:20 INFO - no previously-included directories found matching 'build' 04:56:20 INFO - no previously-included directories found matching 'dist' 04:56:20 INFO - no previously-included directories found matching '.git*' 04:56:20 INFO - Installing collected packages: jsonschema, functools32 04:56:20 INFO - Running setup.py install for functools32 04:56:20 INFO - warning: no files found matching '*.txt' 04:56:20 INFO - no previously-included directories found matching 'build' 04:56:20 INFO - no previously-included directories found matching 'dist' 04:56:20 INFO - no previously-included directories found matching '.git*' 04:56:20 INFO - Successfully installed jsonschema functools32 04:56:20 INFO - Cleaning up... 04:56:20 INFO - Return code: 0 04:56:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:56:20 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')]} 04:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:20 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')]} 04:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:20 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:20 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 04:56:20 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 04:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:20 INFO - 'HOME': '/Users/cltbld', 04:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:20 INFO - 'LOGNAME': 'cltbld', 04:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:20 INFO - 'MOZ_NO_REMOTE': '1', 04:56:20 INFO - 'NO_EM_RESTART': '1', 04:56:20 INFO - 'PAGER': '/bin/cat', 04:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:20 INFO - 'PWD': '/builds/slave/test', 04:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:20 INFO - 'SHELL': '/bin/bash', 04:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:20 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:20 INFO - 'USER': 'cltbld', 04:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:20 INFO - 'XPC_FLAGS': '0x0', 04:56:20 INFO - 'XPC_SERVICE_NAME': '0', 04:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:56:21 INFO - Cleaning up... 04:56:21 INFO - Return code: 0 04:56:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:21 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:21 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 04:56:21 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 04:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:21 INFO - 'HOME': '/Users/cltbld', 04:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:21 INFO - 'LOGNAME': 'cltbld', 04:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:21 INFO - 'MOZ_NO_REMOTE': '1', 04:56:21 INFO - 'NO_EM_RESTART': '1', 04:56:21 INFO - 'PAGER': '/bin/cat', 04:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:21 INFO - 'PWD': '/builds/slave/test', 04:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:21 INFO - 'SHELL': '/bin/bash', 04:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:21 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:21 INFO - 'USER': 'cltbld', 04:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:21 INFO - 'XPC_FLAGS': '0x0', 04:56:21 INFO - 'XPC_SERVICE_NAME': '0', 04:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:21 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 04:56:21 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 04:56:21 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 04:56:21 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 04:56:21 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 04:56:21 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 04:56:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:24 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 04:56:25 INFO - Downloading docopt-0.6.1.tar.gz 04:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:25 INFO - Running setup.py install for blobuploader 04:56:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:25 INFO - Running setup.py install for requests 04:56:26 INFO - Running setup.py install for docopt 04:56:26 INFO - Successfully installed blobuploader requests docopt 04:56:26 INFO - Cleaning up... 04:56:26 INFO - Return code: 0 04:56:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:26 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')]} 04:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:26 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')]} 04:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:26 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:26 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 04:56:26 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 04:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:26 INFO - 'HOME': '/Users/cltbld', 04:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:26 INFO - 'LOGNAME': 'cltbld', 04:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:26 INFO - 'MOZ_NO_REMOTE': '1', 04:56:26 INFO - 'NO_EM_RESTART': '1', 04:56:26 INFO - 'PAGER': '/bin/cat', 04:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:26 INFO - 'PWD': '/builds/slave/test', 04:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:26 INFO - 'SHELL': '/bin/bash', 04:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:26 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:26 INFO - 'USER': 'cltbld', 04:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:26 INFO - 'XPC_FLAGS': '0x0', 04:56:26 INFO - 'XPC_SERVICE_NAME': '0', 04:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-CbNhDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-JVbbFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0Q6VaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:26 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gCIK6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-_Fe_vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-_2iAAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GXuf7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-GxwbNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-hqYe3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qYNvgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-2zTY2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0TydcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ww4pPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:27 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-jqoteP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-iRs6_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-KiGFz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:28 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-zc0oQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:28 INFO - Running setup.py install for manifestparser 04:56:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:28 INFO - Running setup.py install for mozcrash 04:56:28 INFO - Running setup.py install for mozdebug 04:56:28 INFO - Running setup.py install for mozdevice 04:56:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Running setup.py install for mozfile 04:56:29 INFO - Running setup.py install for mozhttpd 04:56:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Running setup.py install for mozinfo 04:56:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Running setup.py install for mozInstall 04:56:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Running setup.py install for mozleak 04:56:29 INFO - Running setup.py install for mozlog 04:56:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Running setup.py install for moznetwork 04:56:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:30 INFO - Running setup.py install for mozprocess 04:56:30 INFO - Running setup.py install for mozprofile 04:56:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:30 INFO - Running setup.py install for mozrunner 04:56:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:30 INFO - Running setup.py install for mozscreenshot 04:56:30 INFO - Running setup.py install for moztest 04:56:30 INFO - Running setup.py install for mozversion 04:56:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:30 INFO - Cleaning up... 04:56:30 INFO - Return code: 0 04:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:30 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:30 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 04:56:30 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 04:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:30 INFO - 'HOME': '/Users/cltbld', 04:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:30 INFO - 'LOGNAME': 'cltbld', 04:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:30 INFO - 'MOZ_NO_REMOTE': '1', 04:56:30 INFO - 'NO_EM_RESTART': '1', 04:56:30 INFO - 'PAGER': '/bin/cat', 04:56:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:30 INFO - 'PWD': '/builds/slave/test', 04:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:30 INFO - 'SHELL': '/bin/bash', 04:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:30 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:30 INFO - 'USER': 'cltbld', 04:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:30 INFO - 'XPC_FLAGS': '0x0', 04:56:30 INFO - 'XPC_SERVICE_NAME': '0', 04:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-yJi4CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-MoW0y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-k5y4Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-O26pcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-aD67My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-phkg_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-pXwg3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:31 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-JHZrul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:32 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-lDxup3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:32 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-yTM6F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:32 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-zPiN8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:32 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LYEPQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-prpbnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:32 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-sFxOfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:32 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-yjH4Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:32 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)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-3cK1qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:32 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-e6WMec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:33 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)) 04:56:33 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)) 04:56:33 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)) 04:56:33 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)) 04:56:33 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)) 04:56:33 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)) 04:56:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:33 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 04:56:33 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 04:56:33 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 04:56:33 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 04:56:33 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 04:56:33 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 04:56:35 INFO - Downloading blessings-1.6.tar.gz 04:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:35 INFO - Installing collected packages: blessings 04:56:35 INFO - Running setup.py install for blessings 04:56:35 INFO - Successfully installed blessings 04:56:35 INFO - Cleaning up... 04:56:36 INFO - Return code: 0 04:56:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:36 INFO - Reading from file tmpfile_stdout 04:56:36 INFO - Current package versions: 04:56:36 INFO - blessings == 1.6 04:56:36 INFO - blobuploader == 1.2.4 04:56:36 INFO - docopt == 0.6.1 04:56:36 INFO - functools32 == 3.2.3-2 04:56:36 INFO - jsonschema == 2.5.1 04:56:36 INFO - manifestparser == 1.1 04:56:36 INFO - mozInstall == 1.12 04:56:36 INFO - mozcrash == 1.0 04:56:36 INFO - mozdebug == 0.1 04:56:36 INFO - mozdevice == 0.49 04:56:36 INFO - mozfile == 1.2 04:56:36 INFO - mozhttpd == 0.7 04:56:36 INFO - mozinfo == 0.9 04:56:36 INFO - mozleak == 0.1 04:56:36 INFO - mozlog == 3.4 04:56:36 INFO - moznetwork == 0.27 04:56:36 INFO - mozprocess == 0.24 04:56:36 INFO - mozprofile == 0.28 04:56:36 INFO - mozrunner == 6.13 04:56:36 INFO - mozscreenshot == 0.1 04:56:36 INFO - mozsystemmonitor == 0.3 04:56:36 INFO - moztest == 0.8 04:56:36 INFO - mozversion == 1.4 04:56:36 INFO - psutil == 3.1.1 04:56:36 INFO - requests == 1.2.3 04:56:36 INFO - wsgiref == 0.1.2 04:56:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:36 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')]} 04:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:36 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')]} 04:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:37 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 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:37 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 04:56:37 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 04:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:37 INFO - 'HOME': '/Users/cltbld', 04:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:37 INFO - 'LOGNAME': 'cltbld', 04:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:37 INFO - 'MOZ_NO_REMOTE': '1', 04:56:37 INFO - 'NO_EM_RESTART': '1', 04:56:37 INFO - 'PAGER': '/bin/cat', 04:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:37 INFO - 'PWD': '/builds/slave/test', 04:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:37 INFO - 'SHELL': '/bin/bash', 04:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:37 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:37 INFO - 'USER': 'cltbld', 04:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:37 INFO - 'XPC_FLAGS': '0x0', 04:56:37 INFO - 'XPC_SERVICE_NAME': '0', 04:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 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)) 04:56:37 INFO - Cleaning up... 04:56:37 INFO - Return code: 0 04:56:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102166b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102169768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe341cc4260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, '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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 04:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:37 INFO - 'HOME': '/Users/cltbld', 04:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:37 INFO - 'LOGNAME': 'cltbld', 04:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:37 INFO - 'MOZ_NO_REMOTE': '1', 04:56:37 INFO - 'NO_EM_RESTART': '1', 04:56:37 INFO - 'PAGER': '/bin/cat', 04:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:37 INFO - 'PWD': '/builds/slave/test', 04:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:37 INFO - 'SHELL': '/bin/bash', 04:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:56:37 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:37 INFO - 'USER': 'cltbld', 04:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:37 INFO - 'XPC_FLAGS': '0x0', 04:56:37 INFO - 'XPC_SERVICE_NAME': '0', 04:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:56:37 INFO - Cleaning up... 04:56:37 INFO - Return code: 0 04:56:37 INFO - Running post-action listener: _resource_record_post_action 04:56:37 INFO - Running post-action listener: _start_resource_monitoring 04:56:38 INFO - Starting resource monitoring. 04:56:38 INFO - [mozharness: 2017-02-02 12:56:38.032965Z] Finished create-virtualenv step (success) 04:56:38 INFO - [mozharness: 2017-02-02 12:56:38.033877Z] Running install step. 04:56:38 INFO - Running pre-action listener: _resource_record_pre_action 04:56:38 INFO - Running main action method: install 04:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:38 INFO - Reading from file tmpfile_stdout 04:56:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:38 INFO - Reading from file tmpfile_stdout 04:56:38 INFO - Output received: 04:56:38 INFO - Usage: mozinstall [options] installer 04:56:38 INFO - Options: 04:56:38 INFO - -h, --help show this help message and exit 04:56:38 INFO - -d DEST, --destination=DEST 04:56:38 INFO - Directory to install application into. [default: 04:56:38 INFO - "/builds/slave/test"] 04:56:38 INFO - --app=APP Application being installed. [default: firefox] 04:56:38 INFO - mkdir: /builds/slave/test/build/application 04:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:57:00 INFO - Reading from file tmpfile_stdout 04:57:00 INFO - Output received: 04:57:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:57:00 INFO - Running post-action listener: _resource_record_post_action 04:57:00 INFO - [mozharness: 2017-02-02 12:57:00.076651Z] Finished install step (success) 04:57:00 INFO - [mozharness: 2017-02-02 12:57:00.076841Z] Running run-tests step. 04:57:00 INFO - Running pre-action listener: _resource_record_pre_action 04:57:00 INFO - Running main action method: run_tests 04:57:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:00 INFO - 2017-02-02 04:57:00.090 screenresolution[1622:7451] starting screenresolution argv=screenresolution get 04:57:00 INFO - 2017-02-02 04:57:00.093 screenresolution[1622:7451] Display 0: 1600x1200x32@60 04:57:00 INFO - 2017-02-02 04:57:00.099 screenresolution[1623:7455] starting screenresolution argv=screenresolution list 04:57:00 INFO - Available Modes on Display 0 04:57:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:00 INFO - Intel Iris: 04:57:00 INFO - Chipset Model: Intel Iris 04:57:00 INFO - Type: GPU 04:57:00 INFO - Bus: Built-In 04:57:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:00 INFO - Vendor: Intel (0x8086) 04:57:00 INFO - Device ID: 0x0a2e 04:57:00 INFO - Revision ID: 0x0009 04:57:00 INFO - Displays: 04:57:00 INFO - Display: 04:57:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:00 INFO - Display Serial Number: 1600x1200 60 04:57:00 INFO - Main Display: Yes 04:57:00 INFO - Mirror: Off 04:57:00 INFO - Online: Yes 04:57:00 INFO - Rotation: Supported 04:57:00 INFO - Return code: 0 04:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:00 INFO - Python 2.7.3 04:57:00 INFO - Return code: 0 04:57:00 INFO - grabbing minidump binary from tooltool 04:57:00 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')]} 04:57:00 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 0x101f44d30>, '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 0x101e6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f39be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:00 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 04:57:00 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 04:57:00 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 04:57:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:00 INFO - Return code: 0 04:57:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:57:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:57:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:00 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 04:57:00 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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 04:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iRFX4HGdQH/Render', 04:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:00 INFO - 'HOME': '/Users/cltbld', 04:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:00 INFO - 'LOGNAME': 'cltbld', 04:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:00 INFO - 'MOZ_NO_REMOTE': '1', 04:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:00 INFO - 'NO_EM_RESTART': '1', 04:57:00 INFO - 'PAGER': '/bin/cat', 04:57:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:00 INFO - 'PWD': '/builds/slave/test', 04:57:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:00 INFO - 'SHELL': '/bin/bash', 04:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xmv8ShXxGi/Listeners', 04:57:00 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 04:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:00 INFO - 'USER': 'cltbld', 04:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:00 INFO - 'XPC_FLAGS': '0x0', 04:57:00 INFO - 'XPC_SERVICE_NAME': '0', 04:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:00 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 04:57:00 INFO - mozversion application_buildid: 20170202030211 04:57:00 INFO - mozversion application_changeset: f985243bb630b2c78cd57731c8d8ab191aa09527 04:57:00 INFO - mozversion application_display_name: Nightly 04:57:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:00 INFO - mozversion application_name: Firefox 04:57:00 INFO - mozversion application_remotingname: firefox 04:57:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:57:00 INFO - mozversion application_vendor: Mozilla 04:57:00 INFO - mozversion application_version: 54.0a1 04:57:00 INFO - mozversion platform_buildid: 20170202030211 04:57:00 INFO - mozversion platform_changeset: f985243bb630b2c78cd57731c8d8ab191aa09527 04:57:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:57:00 INFO - mozversion platform_version: 54.0a1 04:57:00 INFO - using testdate: 1486040220 04:57:00 INFO - actual date: 1486040220 04:57:00 INFO - starting webserver on 'localhost:49235' 04:57:00 INFO - SUITE-START | Running 2 tests 04:57:00 INFO - TEST-START | dromaeo_css 04:57:00 INFO - operating with platform_type : mac_ 04:57:00 INFO - Initialising browser for dromaeo_css test... 04:57:00 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpmnjOau/profile http://localhost:49235/getInfo.html) 04:57:02 INFO - PROCESS | 1633 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:57:03 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 04:57:03 INFO - PROCESS | 1633 | colorDepth:24 04:57:03 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 04:57:03 INFO - PROCESS | 1633 | __metrics 04:57:03 INFO - PROCESS | 1633 | 1486040223269 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 04:57:03 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:57:03 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:57:04 INFO - TEST-INFO | 1633: exit 0 04:57:04 INFO - Browser initialized. 04:57:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:04 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpmnjOau/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:16 INFO - PROCESS | 1636 | RSS: Main: 237899776 04:57:16 INFO - PROCESS | 1636 | 05:00:18 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 05:00:21 INFO - PROCESS | 1636 | RSS: Main: 457351168 05:00:21 INFO - PROCESS | 1636 | 05:02:05 INFO - PROCESS | 1636 | ************************* 05:02:05 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 05:02:05 INFO - PROCESS | 1636 | 05:02:05 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:02:05 INFO - PROCESS | 1636 | Full stack: 05:02:05 INFO - PROCESS | 1636 | ************************* 05:03:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 05:03:25 INFO - PROCESS | 1636 | RSS: Main: 366714880 05:03:25 INFO - PROCESS | 1636 | 05:06:27 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 05:06:27 INFO - PROCESS | 1636 | RSS: Main: 344092672 05:06:27 INFO - PROCESS | 1636 | 05:09:30 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 05:09:30 INFO - PROCESS | 1636 | RSS: Main: 336416768 05:09:30 INFO - PROCESS | 1636 | 05:12:34 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 05:12:35 INFO - PROCESS | 1636 | RSS: Main: 335159296 05:12:35 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 05:15:38 INFO - PROCESS | 1636 | RSS: Main: 427229184 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | __start_tp_report 05:15:38 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 05:15:38 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 05:15:38 INFO - PROCESS | 1636 | |i|pagename|runs| 05:15:38 INFO - PROCESS | 1636 | |0;dojo.html;2770.875310611022;3300.8514616842226;3313.221392972651;3326.301476689895;3348.8995330140106;5518.420565840589;5537.778488860446;5578.972105139469;5612.298462692163;5629.099344104944;4601.76991150442;5600.131979543167;5641.210230567724;5738.626989245696;5744.396838331967;5081.237814327862;5092.643514953955;5101.54086132248;5115.2071428928575;5162.948370516303;5147.588192944556;5214.843554693365;5216.530512253897;5245.186996015624;5289.180177072541;5184.300119483859;5210.583153347723;5219.869503262411;5227.242049902762;5232.450592687751;4904.558589726942;4929.1620424527555;4932.802687892516;4938.555530002317;5076.36545431821;5114.232865070232;5129.717865517395;5139.357580302462;5186.818461353872;5212.8957420851375;5603.663780173202;5607.663540187561;5617.9719101404235;5626.156076588503;5626.437356264381;6009.038553831409;6088.1476593276975;6107.450329470369;6214.1921550198185;6263.34234905333;6136.427173609184;6144.77104579086;6189.071639254103;6198;6216.440520353145;5747.339056008571;5801.912971305392;5814.156947242626;5815.360310365856;5859.121131830259;6240.094595064627;6351.237851457762;6361.077643741724;6371.203599550056;6397.976323788172;5946.464818166386;6150.7539698411565;6157.784477543264;6168.444839964424;6180.165677633462;6134.742747059107;6159.692015399212;6185.350538193515;6202.379762023852;6210.4100110489435;6161.876762464725;6190.473809726133;6195.101710251988;6215;6217.6891155442045;5027.798888044437;6139.3553676863285;6230.532710046674;6257.342978987232;6270.968645156836;4847.587955023862;4886.144924638174;4889.48660390661;4906.31311616374;4939.234418665113;4386.8025938832825;4419.64642828573;4444.888877778081;4451.821927122879;4483.3723278741;5738.426157384311;5751.281089863767;5761.135829625589;5761.53907687384;5800;6073.726682299307;6149.046897730859;6166.260048794174;6188.969055154786;6192.81421557354;4728.59806916416;5580.832575022756;5620.49415552594;5672.914906276409;5735.541156707453;5439.5104440600535;5467.507924286754;5482.23248745176;5485.451454854483;5490.670559766427;6301.6219026858535;6321.146645202931;6330.272018717722;6332.620042797447;6342.080398342215;6281.309056003927;6291.685415729104;6305.8108256752375;6325.557210995186;6346.682665866781;5220.399654039834;6258.43674069336;6270.74917003333;6289.213848268966;6331.366863313632;5891.528677705687;5945.40545945402;5965.8806823862415;6001.549883758823;6018.067199584071;6026.939730602813;6063.302720187235;6067.059605761114;6124.326324104434;6144.446999770043;5891.293044834647;5903.0555111182;5903.7048147593305;5909.645421274738;5916.822495325147;5837.445442682938;5847.415258474119;5848.970755146197;5850.327212370632;5882.735276912635;5559.72201389937;5741.339745929272;5741.425857414225;5749.885002300014;5776.306843178677;5968.671723055274;6046.516278697782;6047.848803779941;6056.9091463628965;6110.7555697771595;5876.882462350814;5901.557383196192;5902.734376952962;5914.763409463573;5917.467427931507 05:15:38 INFO - PROCESS | 1636 | |1;ext.html;426.8378016353786;449.50778897107654;497.74117458921364;516.5789881246782;539.0431983229767;38457.80771096144;40381;40512.79743601285;40713.38929916054;40742.59257407425;41378.79310603443;41656.79171604138;41666.58333416665;41762.373564396556;41783;8134.959325203366;8276.172382761706;9257.351985361045;9450.00774918634;9480.288978326618;8243.629036693363;8439.493630382167;8441.113683063282;8442.197991190827;11035.944820275887;9350.953245233764;11321.773564528705;11329.943350283236;11339;11353.886461135366;11156.597237842454;11221.38282394464;11245.044171245454;11287.661370158909;11292.887071129266;8186.222308880647;8384.496930184148;8940.64237430502;11137.220394572383;11152.996230339308;39367.01582460433;39877.80061099676;40010.59989400098;40176.57616221802;40348.596514034776;3862.1310205203886;4019.4975628046495;4033.3143365627916;4036.899077523056;4164.416981622575;28055.719442805515;28862.845486180737;29008.27479313013;29132.854335728396;29212.561811572632;3044.071558174756;3158.8262645554487;3261.96738032619;3263.951040734391;3265.7877237979455;482478;485115;485378.99999999645;486210;494273;53553;54371;54441;54699.72650136724;54778.90442191134;57964.17483639739;57964.8407031857;58047.70976145177;58170;58177.8364432709;15077.623059423382;15332.15673137988;15338.926275160631;15345.769813452807;15365.231738413035;11580.247283926517;11793.587224447103;11887.405629718653;11917.284962902253;11945.462454189583;15127.621809454851;15414.922925385301;17052.55548830146;20933.89533052325;21206.575868482545;8329.458585191944;8354.415190936576;8387;8388.651177670263;8452.450590711584;777.1761932351725;849.1847826086902;853.6239174066676;868.3357231717741;896.7130518234103;26369.868150659124;29896.252593684898;30155.547666785016;30771.846140769154;30822.075337739905;996.9661889744984;1020.3418794877263;1033.1682995188944;1076.3380520979542;1102.9283096598695;14295.356708948122;15595.688086238211;15668.37326506927;15897.28462219203;15918.681626367408;650205;919444;932496;933256;935289;50956.49043509518;51298;51337.229941550904;51399.48600514022;51424.74287628538;1356.51165580391;1383.7855132454486;1400.824896887889;1405.0726520496628;1408.6548795544747;27723.168304950883;27726.44547109087;27941.860290698416;28349.574756378257;28425.715742842305;44338.778306109554;44710.55289447194;44915.55084449114;44990.77504612587;45094;525774;526821;526914;527839;530184;22386.440338991655;24599.754002459747;24832.627510587718;24954.62568061517;24993.250202493226;35658.82170589234;41536.376954345105;41963.74108776742;43342.783286083366;43610;33155.33689326152;33319.96534224533;33671.82148624786;34038.829805850815;34748.56038396388;29140.125796226148;34525;34723.437445314514;35031.47452788261;35225.47161792626;33859.66140338565;34292.97121086371;34436.82781586076;34560.65439345675;34610.30779384348;30016.399672006875;30916.53625195579;30936.845315773277;31074;31176.90880819251;22894.77105228993;22998.42503937415;23189.53620927606;23528.529429411657;23699.763002369757 05:15:38 INFO - PROCESS | 1636 | |2;jquery.html;361.28826212361656;377.59408635716613;391.790392140205;413.2169538724118;422.8710243375769;19865.900670496645;21423;21849.453763655918;22185.445363865892;22525.324240272777;22186.334409967687;22360.32919012428;22460.775392246072;22501.987410566562;22537.436564085867;5805.535557155428;6104.725287362057;6174.9073763893575;6176.7838125665385;6179.629222246657;6065.727042283108;6090.847728806771;6116.266048074237;6135.202423684915;6192.349803270637;5896.823095307148;6066.484348830332;6090.116933044706;6098.268207815068;6102.725377358008;5968.7612495500125;6013.54898382623;6046.12331211974;6061.515078793686;6070.150178974903;5309.52214300711;5310.070737620939;5312.760925758312;5313.282706834567;5320.9467905320835;26531;26715.064972726057;26766.5985010225;26790.464190716273;27098.1870543884;2339.415146213447;2700.5179485644176;2706.796990225741;2718.972810271892;2730.167298973812;14363.71272574553;15566;15627.531174064796;15672;16204.108774017424;1837.3477415517566;1860.8418284445838;1873.0821897270375;1884.9246030158915;1909.847212223019;125068.37465812612;130154;131539;134098;134463.999999999;11137.498812553455;11527.308361498337;11581.652550423501;11613.187076904704;11760.235584686969;12025.819612705816;14708.485203017843;14766.852331476763;14814.185219812798;14824.184669843262;8361.874571881426;8623.784405389915;8649.783755406164;8785.297176225886;8809.03100658927;8429.704960326359;8442.240198382053;8445.493270403795;8641.006284277388;8658.393912426196;7146.464015198881;7248.238934911758;7276.454265930077;7282.344588987016;7297.635118244067;1900.078461945955;1942.6503229418558;1945.105251584287;1949.39568733693;1951.8536109791823;932.7807965128189;1032.7624646331385;1035.632350515556;1058.6241884131177;1103.2442776697987;21913.890430547744;22152.667709984362;22790.772092279196;22926;22949.311520654406;748.6256871564218;869.5087275689216;949.3340232756065;951.2152474208667;960.8366577681811;10105.444200568892;10677.359358438518;10948.671539853816;11129.220954533104;11163.944180279046;738993;751494.2425287839;756540;761492;776632;123962.26509421293;152249.23875380552;160570;162193.37806621782;168352;957.2724729205714;1035.5857656937135;1068.6793961811582;1069.7860427914447;1078.8921107889305;18355.174017169527;18580.907095464438;18789.530261743566;18819.717704234172;18977.9562124079;42726.57273427226;56821.43178568161;59001.5249618763;60141.39858601358;62043;90972.54513727389;92808;93057;94997;96411;8164.428490005643;8211;8267.173282671925;8658.870116948377;8676.78308042304;9319.161275484968;12567.43446544926;13089.934550327187;13280.800787987995;13716.177029378268;11604.49852909829;11846.289222646668;11890;12000.399980001139;12000.939995299968;10062.345947513388;10570.154387649123;11260.436978151223;11384.37385943781;11876.346800926032;10659.307145035547;11142.442877856236;11633.88366116328;11775.23460975034;11831.76336473283;7019.929800701928;7818.92181078182;8337.124601916712;8339.416240863082;8583.957080214559;9454.061917306797;9592.808143837225;11170.720731981766;11856.940715296714;11904 05:15:38 INFO - PROCESS | 1636 | |3;mootools.html;1301.9023573231998;1416.2493878244527;1425.1306702911227;1434.8134742483476;1440.1071335771824;7382.852342953138;7750.883736743954;8153.633086511114;8358.080611132771;8368;8273.669053237863;8355.289800366962;8357.91642083579;8393.874091888627;8411.789705257372;2017.3645301729982;2256.187772401934;2298.6207275799475;2299.620562607168;2300.8389412741117;2078.355709729981;2188;2237.2617036377956;2252.0991603358625;2259.830512711545;2188.72640919885;2216.1357070742424;2224.788645078723;2225.087714037245;2229.9888500557477;1899.8765080269739;2223.466368071667;2237.3735354100795;2250.696156018933;2254.921077762287;2228.4094714900566;2246.8314876384175;2272.9090836366527;2274.476870319819;2279.350385140244;8385.161483851565;8440.113788052227;8444.493330400195;8447.155284471564;8456.704015359495;5032.748362581856;5205.557527610158;5205.817796377109;5209.062368773619;5212.8957420851375;3240.54632351471;3416.5558477398026;3417.5898892133105;3444.7588668793196;3464.9307013859834;1182.4797089280776;1225.7068792423988;1236.2767780848214;1283.4801905228398;1285.5115056278648;10612.840807387895;10735.194860385423;10746.785064298749;10755.085817705505;10755.193360498071;3873.3996230584303;4391.363252328394;4600.447946246405;4636.744979026186;4684.508126646653;9380.8592871107;9416.858747118798;9431.198348140484;9432.292578056673;9460.810783784424;5194.27280180775;5201.245819356248;5206.219067139959;5207.3230480037355;5213.817516386984;4660.219316155897;4691.319758634979;4763.118823017753;4777.426708794897;4799.088173247072;3240.951385729216;3698.6671199592165;3765.077555998798;3789.2610940866266;3878.4182372644327;1221.2001139253803;1225.3995542184443;1228.4717571444187;1234.7221875078214;1236.5177580743518;752.7403045949138;845.0830848529291;879.3624622149018;891.1845661219911;930.6230976454547;4553.453585569753;4861.416630004422;5435.320584926884;5605.0751625982075;5673.205751194836;940.9012053734397;1011.327467234281;1017.018577073128;1048.6696690542608;1065.350136416785;3692.150805314739;3745.176061266517;3874.8062596870045;3884.941725874114;3890.319194141014;9740.220782337537;10057.899421005697;10063.04401081896;10080;10087.092161705481;7411.481196316314;9946.651867184613;9997.600095996224;9999.550020249106;10013.349132306377;7511.887321690179;7689.8849666798005;7706.961465192639;7816.49192802466;7821.608919554;5619.719014049199;5626.549876009991;5702.340803416409;5819.359870414336;5924.052151655715;9233.169014788702;9372.718818435458;9382.296327775308;9383.624655013722;9386.95306523463;8499.617517211864;8854.070322616033;9474.38416502925;9574.234061275221;9605.903940960501;6586.967065164644;6762;6828.931710682829;7177.964110179416;7247.47802961363;7753.418493613114;7975.72084977023;7987.400944929037;8091.433599648203;8094.595270236582;7126.5011449198055;7163.0329905462095;7210;7212.206657267591;7244.203137654748;6925.861482770417;6992.510524263253;7010.228874823867;7059.470539709439;7101.82245443868;6325;6345.302016778243;6444.355564443518;6458.354164583504;6480.935190648033;4819.759012049313;4972.403311602631;4974.32846565709;4975.975120124376;5129.948700512947;4173.373993900817;4904.975475122602;4923.138450771173;4942.82700105509;5098.980203959297 05:15:38 INFO - PROCESS | 1636 | |4;prototype.html;298.4329773430482;366.14322485384196;367.9871204507842;376.29632587062196;378.4040136784565;5255.474452554743;5281.445448227933;5296.140084354449;5308.018985760679;5322.217057285804;4597.7815529129575;5173.741312934357;5213.530782229599;5214.687118772877;5218.8695282617955;3519.9824000879958;3553.92892142157;3830.138218900746;3841.8436109972827;3844.6539811416965;4037.253108174982;4040.919181616366;4042.6967977401664;4052.615001574846;4075.9388609170737;3561.786292822426;3934.055826601609;4039.6768258539246;4082.6527246008745;4083.203775263825;3458.3602033623733;3557.8970519139148;3966.5835087315995;4082.203970225807;4122.948648094746;3019.773516986235;3343.21434462901;3440.7247420206572;3502.509648649191;3597.892063238107;4031.778252196128;4542.205828697679;4762.0713610987605;5075.771590278447;5088.491150884919;4099.733517321364;4669.6497762667595;4680.812767489297;4688.734041808727;4721.598664113554;4803.9039219215765;5155.639105262633;5228.215767634847;5460.808871689472;5483.148762643443;3558.323918455485;3950.249452603996;3976.6619837313865;3990.6009399060154;3993.880183594497;4474.485434175079;5364.681431447644;5643.351014633328;5725.227094342252;5743.425657434265;3236.2556611979376;3424.4863270509622;3592.389293820057;4093.038136038029;4094.836206551764;3525.0964479180957;3682.2635472905527;3821.8597585351736;3885.9222815544094;4169.478815148106;3868.9613103869165;4287.2711639021445;4447.066116115588;4721.362616046789;4827.686200396963;5187.974060129675;5256.316678831728;5487.780488780484;5558.360788509292;5618.078599128512;1262.8800263974908;1286.9511348251144;1328.1367111377488;1343.3417625363502;1353.15427857589;800.8118092248317;891.9420237684529;950.3585080071063;975.2246963663904;976.7558110472382;4259.829606815692;4336.566343365638;4839.7096174229655;4869.732164730903;4899.6570240083565;4950.302085363485;5200.60995425337;5335.466453354634;5365.275687782178;5493.187248208082;4018.4729802674797;4208.747475151501;4327.788219298602;4732.384789977281;4884.389451318585;2444.3378502618034;2538.365408647838;2805.9158225253277;2807.284142543679;2848.5614764543775;4841.757912104381;4842.661013729005;4979.427365852901;5095.8726031848755;5593.356763972195;4958;5028.145215313405;5426.124154198281;5491.670499769947;5843.152742852262;5427.255193916185;5810.622309549865;5872.265966754156;5918.822435326947;5957.910631340534;5036.897973856844;5303.96572668326;5513.558915286687;5702.319909642461;5734.082546792493;5218.321618189611;5495.873345963988;5591.356993945748;5634.380218175916;5692.2600061993335;5001.324821149244;5516.66899985986;5631.324241091095;5689.459501347365;5806.65160090396;3300.1089705779787;3459.377312083849;3663.87176448823;3725.3480640887196;3736.140687641803;5775.566832487664;5793.91309130355;5799.94200057994;5801.709914504342;5819.738111784895;5157.510036546522;5341.305630268041;5355.571554275571;5497.890042199054;5551.278333816578;4510.210713125124;5078.819604003969;5174.767135478988;5509.559235261249;5542.944570554404;5155.922661160011;5360.356757189163;5386.757595908115;5401.270828438111;5408.107662235687;4998.800047998039;5219.520727654334;5502.056399826074;5504.614676972574;5556.916646250229;4949.876253093701;5395.136778115482;5419.674819510842;5434.358979483834;5446.809361672323 05:15:38 INFO - PROCESS | 1636 | |5;yui.html;692.8025512728872;704.4118161335285;723.8516104198643;780.16911988732;835.6657337065174;14792.112473251598;15795.526134215963;15807;15810.920945395272;15819.920900395482;12118.45466953987;14619.707605847876;14641.633959151;14776.556703298918;14794.778078328834;690.4752388184991;711.9074520312353;848.7368915636142;871.1462766488861;885.5218182181615;869.6651789061225;871.3073106880046;878.3236907581158;884.933629977751;886.5389997201484;934.0566028311421;937.409432057806;938.699616122841;939.6570251858057;939.7086903060073;931.329442801182;932.282142750082;932.5290728182224;934.5560858592182;935.8783358163463;538.5637633516864;558.0318148013193;558.040170906041;564.4242872270303;695.4297476069625;14705.044172128884;15282.694346113016;15303.387864485407;15640.843591564053;15678.980866243657;14289.285535723173;14363;14391.928040359835;14448.49430269946;14466.421343146261;11695.649130526097;11809.291442513477;11836.940815295868;11869.881301186964;12253.264804111783;3693.8891833244775;3729.925401491982;3749.981250093732;3776.376897811858;3876.3022655921923;104211;105021.42467862912;105832.94167058308;106474;106558;11259.887401126047;11266.830997535044;11273.098152147808;11424.028957538701;11587.710307242387;23440.17959371414;23567.41081472977;23823.52352952966;23932.641010384858;23974.640380394307;7748.806279843049;7765.1458339582605;7790.610469476504;7829.29536341732;8085.393595480245;4152.1280531088205;4235.364695295731;4271.9786401067795;4423.867283981485;4466.062126953311;3517.085557754951;3620.6198349173483;3621.728370372233;3621.7323936622497;3631.9818400907825;645.270843946347;651.6741629185407;668.9632070236183;670.940213544414;677.6002158726375;650.3821369698805;658.3844105761128;688.9586624802528;691.180950573572;715.1132595581441;10094.646687365906;10168.898311016796;10184.592616295266;10472.790544189074;10485.528151233213;681.1689738518999;701.2321507948787;703.6587255181233;705.1256442011868;717.5622870049266;4666.183417901853;4880.585150262267;4882.5605695487575;4894.412670479565;4896.094222568836;65833;102241.97758022325;105024;107003;109076.45461772798;90303.64544531837;90892.09107908969;92270;92434;93695;78416.60791696006;79220;80662.5966870162;81005;82118.58940705378;9507.334486585873;9544.57049432791;9568.473733944422;9574.186194173573;9580;53264.46735532595;53273.46726532685;54030.45969540254;54081.72959135179;54469.72765136307;69056;70881.29118708747;70995.64502177663;71575.92636110359;72124;11204.327740335606;11662.53349865996;11683.7426247809;11720.003799677123;12028.398580070787;12551.372431378577;12618.55835045769;12737.93631031876;12879.356032198166;12978.091533592558;11714.589989350332;11805.586804461802;11937.940310298392;11943.522259109539;12015.219010764273;10603.115749185403;11881;12180.817287740869;12277.877221228031;13734.244616545786;13058.477660893457;13191.162688680324;13675.974301927594;13724.588262352145;13898.722025559635;10874.401907894826;10978.154239929976;11758.412079396167;11800.409979501163;11803.468843902217;10786.352818830896;10871.891281087088;10972.177086718688;11127.88872111301;11135.554577816796 05:15:38 INFO - PROCESS | 1636 | __end_tp_report 05:15:38 INFO - PROCESS | 1636 | __start_cc_report 05:15:38 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,2568 05:15:38 INFO - PROCESS | 1636 | __end_cc_report 05:15:38 INFO - PROCESS | 1636 | __startTimestamp1486041338600__endTimestamp 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | ------- Summary: start ------- 05:15:38 INFO - PROCESS | 1636 | Number of tests: 6 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5661.96 Median:5847.42 stddev:658.14 (11.3%) stddev-sans-first:619.85 05:15:38 INFO - PROCESS | 1636 | Values: 2770.9 3300.9 3313.2 3326.3 3348.9 5518.4 5537.8 5579.0 5612.3 5629.1 4601.8 5600.1 5641.2 5738.6 5744.4 5081.2 5092.6 5101.5 5115.2 5162.9 5147.6 5214.8 5216.5 5245.2 5289.2 5184.3 5210.6 5219.9 5227.2 5232.5 4904.6 4929.2 4932.8 4938.6 5076.4 5114.2 5129.7 5139.4 5186.8 5212.9 5603.7 5607.7 5618.0 5626.2 5626.4 6009.0 6088.1 6107.5 6214.2 6263.3 6136.4 6144.8 6189.1 6198.0 6216.4 5747.3 5801.9 5814.2 5815.4 5859.1 6240.1 6351.2 6361.1 6371.2 6398.0 5946.5 6150.8 6157.8 6168.4 6180.2 6134.7 6159.7 6185.4 6202.4 6210.4 6161.9 6190.5 6195.1 6215.0 6217.7 5027.8 6139.4 6230.5 6257.3 6271.0 4847.6 4886.1 4889.5 4906.3 4939.2 4386.8 4419.6 4444.9 4451.8 4483.4 5738.4 5751.3 5761.1 5761.5 5800.0 6073.7 6149.0 6166.3 6189.0 6192.8 4728.6 5580.8 5620.5 5672.9 5735.5 5439.5 5467.5 5482.2 5485.5 5490.7 6301.6 6321.1 6330.3 6332.6 6342.1 6281.3 6291.7 6305.8 6325.6 6346.7 5220.4 6258.4 6270.7 6289.2 6331.4 5891.5 5945.4 5965.9 6001.5 6018.1 6026.9 6063.3 6067.1 6124.3 6144.4 5891.3 5903.1 5903.7 5909.6 5916.8 5837.4 5847.4 5849.0 5850.3 5882.7 5559.7 5741.3 5741.4 5749.9 5776.3 5968.7 6046.5 6047.8 6056.9 6110.8 5876.9 5901.6 5902.7 5914.8 5917.5 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:73781.84 Median:35442.15 stddev:177117.62 (499.7%) stddev-sans-first:177528.85 05:15:38 INFO - PROCESS | 1636 | Values: 426.8 449.5 497.7 516.6 539.0 38457.8 40381.0 40512.8 40713.4 40742.6 41378.8 41656.8 41666.6 41762.4 41783.0 8135.0 8276.2 9257.4 9450.0 9480.3 8243.6 8439.5 8441.1 8442.2 11035.9 9351.0 11321.8 11329.9 11339.0 11353.9 11156.6 11221.4 11245.0 11287.7 11292.9 8186.2 8384.5 8940.6 11137.2 11153.0 39367.0 39877.8 40010.6 40176.6 40348.6 3862.1 4019.5 4033.3 4036.9 4164.4 28055.7 28862.8 29008.3 29132.9 29212.6 3044.1 3158.8 3262.0 3264.0 3265.8 482478.0 485115.0 485379.0 486210.0 494273.0 53553.0 54371.0 54441.0 54699.7 54778.9 57964.2 57964.8 58047.7 58170.0 58177.8 15077.6 15332.2 15338.9 15345.8 15365.2 11580.2 11793.6 11887.4 11917.3 11945.5 15127.6 15414.9 17052.6 20933.9 21206.6 8329.5 8354.4 8387.0 8388.7 8452.5 777.2 849.2 853.6 868.3 896.7 26369.9 29896.3 30155.5 30771.8 30822.1 997.0 1020.3 1033.2 1076.3 1102.9 14295.4 15595.7 15668.4 15897.3 15918.7 650205.0 919444.0 932496.0 933256.0 935289.0 50956.5 51298.0 51337.2 51399.5 51424.7 1356.5 1383.8 1400.8 1405.1 1408.7 27723.2 27726.4 27941.9 28349.6 28425.7 44338.8 44710.6 44915.6 44990.8 45094.0 525774.0 526821.0 526914.0 527839.0 530184.0 22386.4 24599.8 24832.6 24954.6 24993.3 35658.8 41536.4 41963.7 43342.8 43610.0 33155.3 33320.0 33671.8 34038.8 34748.6 29140.1 34525.0 34723.4 35031.5 35225.5 33859.7 34293.0 34436.8 34560.7 34610.3 30016.4 30916.5 30936.8 31074.0 31176.9 22894.8 22998.4 23189.5 23528.5 23699.8 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:41476.73 Median:14435.21 stddev:126038.44 (873.1%) stddev-sans-first:126354.20 05:15:38 INFO - PROCESS | 1636 | Values: 361.3 377.6 391.8 413.2 422.9 19865.9 21423.0 21849.5 22185.4 22525.3 22186.3 22360.3 22460.8 22502.0 22537.4 5805.5 6104.7 6174.9 6176.8 6179.6 6065.7 6090.8 6116.3 6135.2 6192.3 5896.8 6066.5 6090.1 6098.3 6102.7 5968.8 6013.5 6046.1 6061.5 6070.2 5309.5 5310.1 5312.8 5313.3 5320.9 26531.0 26715.1 26766.6 26790.5 27098.2 2339.4 2700.5 2706.8 2719.0 2730.2 14363.7 15566.0 15627.5 15672.0 16204.1 1837.3 1860.8 1873.1 1884.9 1909.8 125068.4 130154.0 131539.0 134098.0 134464.0 11137.5 11527.3 11581.7 11613.2 11760.2 12025.8 14708.5 14766.9 14814.2 14824.2 8361.9 8623.8 8649.8 8785.3 8809.0 8429.7 8442.2 8445.5 8641.0 8658.4 7146.5 7248.2 7276.5 7282.3 7297.6 1900.1 1942.7 1945.1 1949.4 1951.9 932.8 1032.8 1035.6 1058.6 1103.2 21913.9 22152.7 22790.8 22926.0 22949.3 748.6 869.5 949.3 951.2 960.8 10105.4 10677.4 10948.7 11129.2 11163.9 738993.0 751494.2 756540.0 761492.0 776632.0 123962.3 152249.2 160570.0 162193.4 168352.0 957.3 1035.6 1068.7 1069.8 1078.9 18355.2 18580.9 18789.5 18819.7 18978.0 42726.6 56821.4 59001.5 60141.4 62043.0 90972.5 92808.0 93057.0 94997.0 96411.0 8164.4 8211.0 8267.2 8658.9 8676.8 9319.2 12567.4 13089.9 13280.8 13716.2 11604.5 11846.3 11890.0 12000.4 12000.9 10062.3 10570.2 11260.4 11384.4 11876.3 10659.3 11142.4 11633.9 11775.2 11831.8 7019.9 7818.9 8337.1 8339.4 8584.0 9454.1 9592.8 11170.7 11856.9 11904.0 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5395.40 Median:5114.46 stddev:2957.25 (57.8%) stddev-sans-first:2949.54 05:15:38 INFO - PROCESS | 1636 | Values: 1301.9 1416.2 1425.1 1434.8 1440.1 7382.9 7750.9 8153.6 8358.1 8368.0 8273.7 8355.3 8357.9 8393.9 8411.8 2017.4 2256.2 2298.6 2299.6 2300.8 2078.4 2188.0 2237.3 2252.1 2259.8 2188.7 2216.1 2224.8 2225.1 2230.0 1899.9 2223.5 2237.4 2250.7 2254.9 2228.4 2246.8 2272.9 2274.5 2279.4 8385.2 8440.1 8444.5 8447.2 8456.7 5032.7 5205.6 5205.8 5209.1 5212.9 3240.5 3416.6 3417.6 3444.8 3464.9 1182.5 1225.7 1236.3 1283.5 1285.5 10612.8 10735.2 10746.8 10755.1 10755.2 3873.4 4391.4 4600.4 4636.7 4684.5 9380.9 9416.9 9431.2 9432.3 9460.8 5194.3 5201.2 5206.2 5207.3 5213.8 4660.2 4691.3 4763.1 4777.4 4799.1 3241.0 3698.7 3765.1 3789.3 3878.4 1221.2 1225.4 1228.5 1234.7 1236.5 752.7 845.1 879.4 891.2 930.6 4553.5 4861.4 5435.3 5605.1 5673.2 940.9 1011.3 1017.0 1048.7 1065.4 3692.2 3745.2 3874.8 3884.9 3890.3 9740.2 10057.9 10063.0 10080.0 10087.1 7411.5 9946.7 9997.6 9999.6 10013.3 7511.9 7689.9 7707.0 7816.5 7821.6 5619.7 5626.5 5702.3 5819.4 5924.1 9233.2 9372.7 9382.3 9383.6 9387.0 8499.6 8854.1 9474.4 9574.2 9605.9 6587.0 6762.0 6828.9 7178.0 7247.5 7753.4 7975.7 7987.4 8091.4 8094.6 7126.5 7163.0 7210.0 7212.2 7244.2 6925.9 6992.5 7010.2 7059.5 7101.8 6325.0 6345.3 6444.4 6458.4 6480.9 4819.8 4972.4 4974.3 4976.0 5129.9 4173.4 4905.0 4923.1 4942.8 5099.0 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4409.61 Median:4954.15 stddev:1346.18 (27.2%) stddev-sans-first:1314.11 05:15:38 INFO - PROCESS | 1636 | Values: 298.4 366.1 368.0 376.3 378.4 5255.5 5281.4 5296.1 5308.0 5322.2 4597.8 5173.7 5213.5 5214.7 5218.9 3520.0 3553.9 3830.1 3841.8 3844.7 4037.3 4040.9 4042.7 4052.6 4075.9 3561.8 3934.1 4039.7 4082.7 4083.2 3458.4 3557.9 3966.6 4082.2 4122.9 3019.8 3343.2 3440.7 3502.5 3597.9 4031.8 4542.2 4762.1 5075.8 5088.5 4099.7 4669.6 4680.8 4688.7 4721.6 4803.9 5155.6 5228.2 5460.8 5483.1 3558.3 3950.2 3976.7 3990.6 3993.9 4474.5 5364.7 5643.4 5725.2 5743.4 3236.3 3424.5 3592.4 4093.0 4094.8 3525.1 3682.3 3821.9 3885.9 4169.5 3869.0 4287.3 4447.1 4721.4 4827.7 5188.0 5256.3 5487.8 5558.4 5618.1 1262.9 1287.0 1328.1 1343.3 1353.2 800.8 891.9 950.4 975.2 976.8 4259.8 4336.6 4839.7 4869.7 4899.7 4950.3 5200.6 5335.5 5365.3 5493.2 4018.5 4208.7 4327.8 4732.4 4884.4 2444.3 2538.4 2805.9 2807.3 2848.6 4841.8 4842.7 4979.4 5095.9 5593.4 4958.0 5028.1 5426.1 5491.7 5843.2 5427.3 5810.6 5872.3 5918.8 5957.9 5036.9 5304.0 5513.6 5702.3 5734.1 5218.3 5495.9 5591.4 5634.4 5692.3 5001.3 5516.7 5631.3 5689.5 5806.7 3300.1 3459.4 3663.9 3725.3 3736.1 5775.6 5793.9 5799.9 5801.7 5819.7 5157.5 5341.3 5355.6 5497.9 5551.3 4510.2 5078.8 5174.8 5509.6 5542.9 5155.9 5360.4 5386.8 5401.3 5408.1 4998.8 5219.5 5502.1 5504.6 5556.9 4949.9 5395.1 5419.7 5434.4 5446.8 05:15:38 INFO - PROCESS | 1636 | 05:15:38 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20622.59 Median:3739.95 stddev:29702.43 (794.2%) stddev-sans-first:29748.06 05:15:38 INFO - PROCESS | 1636 | Values: 692.8 704.4 723.9 780.2 835.7 14792.1 15795.5 15807.0 15810.9 15819.9 12118.5 14619.7 14641.6 14776.6 14794.8 690.5 711.9 848.7 871.1 885.5 869.7 871.3 878.3 884.9 886.5 934.1 937.4 938.7 939.7 939.7 931.3 932.3 932.5 934.6 935.9 538.6 558.0 558.0 564.4 695.4 14705.0 15282.7 15303.4 15640.8 15679.0 14289.3 14363.0 14391.9 14448.5 14466.4 11695.6 11809.3 11836.9 11869.9 12253.3 3693.9 3729.9 3750.0 3776.4 3876.3 104211.0 105021.4 105832.9 106474.0 106558.0 11259.9 11266.8 11273.1 11424.0 11587.7 23440.2 23567.4 23823.5 23932.6 23974.6 7748.8 7765.1 7790.6 7829.3 8085.4 4152.1 4235.4 4272.0 4423.9 4466.1 3517.1 3620.6 3621.7 3621.7 3632.0 645.3 651.7 669.0 670.9 677.6 650.4 658.4 689.0 691.2 715.1 10094.6 10168.9 10184.6 10472.8 10485.5 681.2 701.2 703.7 705.1 717.6 4666.2 4880.6 4882.6 4894.4 4896.1 65833.0 102242.0 105024.0 107003.0 109076.5 90303.6 90892.1 92270.0 92434.0 93695.0 78416.6 79220.0 80662.6 81005.0 82118.6 9507.3 9544.6 9568.5 9574.2 9580.0 53264.5 53273.5 54030.5 54081.7 54469.7 69056.0 70881.3 70995.6 71575.9 72124.0 11204.3 11662.5 11683.7 11720.0 12028.4 12551.4 12618.6 12737.9 12879.4 12978.1 11714.6 11805.6 11937.9 11943.5 12015.2 10603.1 11881.0 12180.8 12277.9 13734.2 13058.5 13191.2 13676.0 13724.6 13898.7 10874.4 10978.2 11758.4 11800.4 11803.5 10786.4 10871.9 10972.2 11127.9 11135.6 05:15:38 INFO - PROCESS | 1636 | -------- Summary: end -------- 05:15:38 INFO - PROCESS | 1636 | 05:15:39 INFO - TEST-INFO | 1636: exit 0 05:15:39 INFO - TEST-OK | dromaeo_css | took 1118572ms 05:15:39 INFO - TEST-START | kraken 05:15:39 INFO - operating with platform_type : mac_ 05:15:39 INFO - Initialising browser for kraken test... 05:15:39 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpTGr_6Q/profile http://localhost:49235/getInfo.html) 05:15:41 INFO - PROCESS | 1648 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:15:41 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:15:41 INFO - PROCESS | 1648 | colorDepth:24 05:15:41 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:15:41 INFO - PROCESS | 1648 | __metrics 05:15:41 INFO - PROCESS | 1648 | 1486041341593 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:15:41 INFO - PROCESS | 1648 | 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" 05:15:41 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:42 INFO - TEST-INFO | 1648: exit 0 05:15:42 INFO - Browser initialized. 05:15:42 INFO - Running cycle 1/1 for kraken test... 05:15:42 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpTGr_6Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:54 INFO - PROCESS | 1650 | RSS: Main: 237260800 05:15:54 INFO - PROCESS | 1650 | 05:15:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:58 INFO - PROCESS | 1650 | RSS: Main: 292036608 05:15:58 INFO - PROCESS | 1650 | 05:16:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 05:16:01 INFO - PROCESS | 1650 | RSS: Main: 293261312 05:16:01 INFO - PROCESS | 1650 | 05:16:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 05:16:05 INFO - PROCESS | 1650 | RSS: Main: 381177856 05:16:05 INFO - PROCESS | 1650 | 05:16:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 05:16:08 INFO - PROCESS | 1650 | RSS: Main: 287490048 05:16:08 INFO - PROCESS | 1650 | 05:16:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:11 INFO - PROCESS | 1650 | RSS: Main: 289173504 05:16:11 INFO - PROCESS | 1650 | 05:16:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:14 INFO - PROCESS | 1650 | RSS: Main: 330948608 05:16:14 INFO - PROCESS | 1650 | 05:16:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:18 INFO - PROCESS | 1650 | RSS: Main: 334299136 05:16:18 INFO - PROCESS | 1650 | 05:16:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 05:16:21 INFO - PROCESS | 1650 | RSS: Main: 329613312 05:16:21 INFO - PROCESS | 1650 | 05:16:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:23 INFO - PROCESS | 1650 | RSS: Main: 306798592 05:16:23 INFO - PROCESS | 1650 | 05:16:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:26 INFO - PROCESS | 1650 | RSS: Main: 310448128 05:16:26 INFO - PROCESS | 1650 | 05:16:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:29 INFO - PROCESS | 1650 | RSS: Main: 312709120 05:16:29 INFO - PROCESS | 1650 | 05:16:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:33 INFO - PROCESS | 1650 | RSS: Main: 330436608 05:16:33 INFO - PROCESS | 1650 | 05:16:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:36 INFO - PROCESS | 1650 | RSS: Main: 324964352 05:16:36 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 05:16:38 INFO - PROCESS | 1650 | RSS: Main: 369762304 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | __start_tp_report 05:16:38 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 05:16:38 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 05:16:38 INFO - PROCESS | 1650 | |i|pagename|runs| 05:16:38 INFO - PROCESS | 1650 | |0;ai-astar;114;121;96;151;168;165;113;110;113;113 05:16:38 INFO - PROCESS | 1650 | |1;audio-beat-detection;145;111;110;149;125;135;116;109;131;109 05:16:38 INFO - PROCESS | 1650 | |2;audio-dft;184;184;183;183;188;178;182;189;203;185 05:16:38 INFO - PROCESS | 1650 | |3;audio-fft;84;74;83;112;65;58;58;59;77;60 05:16:38 INFO - PROCESS | 1650 | |4;audio-oscillator;86;71;88;71;69;69;85;68;71;98 05:16:38 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;87;84;87;85;87;84;87;83;86;84 05:16:38 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;94;94;95;94;95;95;96;95;94 05:16:38 INFO - PROCESS | 1650 | |7;imaging-desaturate;85;86;99;131;84;85;84;87;85;86 05:16:38 INFO - PROCESS | 1650 | |8;json-parse-financial;57;58;57;58;60;57;58;58;58;57 05:16:38 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;65;77;65;75;73;70;70;72;71;72 05:16:38 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;91;87;91;87;87;87;88;86;90;87 05:16:38 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;142;159;149;146;128;140;176;172;205;178 05:16:38 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;173;174;174;174;171;174;174;172;172;174 05:16:38 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;69;68;68;68;66;67;67;67;67 05:16:38 INFO - PROCESS | 1650 | __end_tp_report 05:16:38 INFO - PROCESS | 1650 | __start_cc_report 05:16:38 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2067 05:16:38 INFO - PROCESS | 1650 | __end_cc_report 05:16:38 INFO - PROCESS | 1650 | __startTimestamp1486041398612__endTimestamp 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | ------- Summary: start ------- 05:16:38 INFO - PROCESS | 1650 | Number of tests: 14 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:126.40 Median:136.00 stddev:25.26 (18.6%) stddev-sans-first:26.39 05:16:38 INFO - PROCESS | 1650 | Values: 114.0 121.0 96.0 151.0 168.0 165.0 113.0 110.0 113.0 113.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:128.00 stddev:15.33 (12.0%) stddev-sans-first:14.26 05:16:38 INFO - PROCESS | 1650 | Values: 145.0 111.0 110.0 149.0 125.0 135.0 116.0 109.0 131.0 109.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:185.90 Median:184.50 stddev:6.74 (3.7%) stddev-sans-first:7.11 05:16:38 INFO - PROCESS | 1650 | Values: 184.0 184.0 183.0 183.0 188.0 178.0 182.0 189.0 203.0 185.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:73.00 Median:69.50 stddev:17.12 (24.6%) stddev-sans-first:17.69 05:16:38 INFO - PROCESS | 1650 | Values: 84.0 74.0 83.0 112.0 65.0 58.0 58.0 59.0 77.0 60.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:10.65 (13.7%) stddev-sans-first:10.85 05:16:38 INFO - PROCESS | 1650 | Values: 86.0 71.0 88.0 71.0 69.0 69.0 85.0 68.0 71.0 98.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.56 05:16:38 INFO - PROCESS | 1650 | Values: 87.0 84.0 87.0 85.0 87.0 84.0 87.0 83.0 86.0 84.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:16:38 INFO - PROCESS | 1650 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 95.0 96.0 95.0 94.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:85.50 stddev:14.67 (17.2%) stddev-sans-first:15.38 05:16:38 INFO - PROCESS | 1650 | Values: 85.0 86.0 99.0 131.0 84.0 85.0 84.0 87.0 85.0 86.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 05:16:38 INFO - PROCESS | 1650 | Values: 57.0 58.0 57.0 58.0 60.0 57.0 58.0 58.0 58.0 57.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:72.00 stddev:3.83 (5.3%) stddev-sans-first:3.39 05:16:38 INFO - PROCESS | 1650 | Values: 65.0 77.0 65.0 75.0 73.0 70.0 70.0 72.0 71.0 72.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:87.50 stddev:1.85 (2.1%) stddev-sans-first:1.64 05:16:38 INFO - PROCESS | 1650 | Values: 91.0 87.0 91.0 87.0 87.0 87.0 88.0 86.0 90.0 87.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:159.50 Median:165.50 stddev:23.12 (14.0%) stddev-sans-first:23.64 05:16:38 INFO - PROCESS | 1650 | Values: 142.0 159.0 149.0 146.0 128.0 140.0 176.0 172.0 205.0 178.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:174.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 05:16:38 INFO - PROCESS | 1650 | Values: 173.0 174.0 174.0 174.0 171.0 174.0 174.0 172.0 172.0 174.0 05:16:38 INFO - PROCESS | 1650 | 05:16:38 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 05:16:38 INFO - PROCESS | 1650 | Values: 67.0 69.0 68.0 68.0 68.0 66.0 67.0 67.0 67.0 67.0 05:16:38 INFO - PROCESS | 1650 | -------- Summary: end -------- 05:16:38 INFO - PROCESS | 1650 | 05:16:39 INFO - TEST-INFO | 1650: exit 0 05:16:39 INFO - TEST-OK | kraken | took 60280ms 05:16:39 INFO - SUITE-END | took 1178s 05:16:39 INFO - Completed test suite (00:19:39) 05:16:39 INFO - javascript benchmark 05:16:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7260.480379426268, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2770.875310611022, 3300.8514616842226, 3313.221392972651, 3326.301476689895, 3348.8995330140106, 5518.420565840589, 5537.778488860446, 5578.972105139469, 5612.298462692163, 5629.099344104944, 4601.76991150442, 5600.131979543167, 5641.210230567724, 5738.626989245696, 5744.396838331967, 5081.237814327862, 5092.643514953955, 5101.54086132248, 5115.2071428928575, 5162.948370516303, 5147.588192944556, 5214.843554693365, 5216.530512253897, 5245.186996015624, 5289.180177072541, 5184.300119483859, 5210.583153347723, 5219.869503262411, 5227.242049902762, 5232.450592687751, 4904.558589726942, 4929.1620424527555, 4932.802687892516, 4938.555530002317, 5076.36545431821, 5114.232865070232, 5129.717865517395, 5139.357580302462, 5186.818461353872, 5212.8957420851375, 5603.663780173202, 5607.663540187561, 5617.9719101404235, 5626.156076588503, 5626.437356264381, 6009.038553831409, 6088.1476593276975, 6107.450329470369, 6214.1921550198185, 6263.34234905333, 6136.427173609184, 6144.77104579086, 6189.071639254103, 6198.0, 6216.440520353145, 5747.339056008571, 5801.912971305392, 5814.156947242626, 5815.360310365856, 5859.121131830259, 6240.094595064627, 6351.237851457762, 6361.077643741724, 6371.203599550056, 6397.976323788172, 5946.464818166386, 6150.7539698411565, 6157.784477543264, 6168.444839964424, 6180.165677633462, 6134.742747059107, 6159.692015399212, 6185.350538193515, 6202.379762023852, 6210.4100110489435, 6161.876762464725, 6190.473809726133, 6195.101710251988, 6215.0, 6217.6891155442045, 5027.798888044437, 6139.3553676863285, 6230.532710046674, 6257.342978987232, 6270.968645156836, 4847.587955023862, 4886.144924638174, 4889.48660390661, 4906.31311616374, 4939.234418665113, 4386.8025938832825, 4419.64642828573, 4444.888877778081, 4451.821927122879, 4483.3723278741, 5738.426157384311, 5751.281089863767, 5761.135829625589, 5761.53907687384, 5800.0, 6073.726682299307, 6149.046897730859, 6166.260048794174, 6188.969055154786, 6192.81421557354, 4728.59806916416, 5580.832575022756, 5620.49415552594, 5672.914906276409, 5735.541156707453, 5439.5104440600535, 5467.507924286754, 5482.23248745176, 5485.451454854483, 5490.670559766427, 6301.6219026858535, 6321.146645202931, 6330.272018717722, 6332.620042797447, 6342.080398342215, 6281.309056003927, 6291.685415729104, 6305.8108256752375, 6325.557210995186, 6346.682665866781, 5220.399654039834, 6258.43674069336, 6270.74917003333, 6289.213848268966, 6331.366863313632, 5891.528677705687, 5945.40545945402, 5965.8806823862415, 6001.549883758823, 6018.067199584071, 6026.939730602813, 6063.302720187235, 6067.059605761114, 6124.326324104434, 6144.446999770043, 5891.293044834647, 5903.0555111182, 5903.7048147593305, 5909.645421274738, 5916.822495325147, 5837.445442682938, 5847.415258474119, 5848.970755146197, 5850.327212370632, 5882.735276912635, 5559.72201389937, 5741.339745929272, 5741.425857414225, 5749.885002300014, 5776.306843178677, 5968.671723055274, 6046.516278697782, 6047.848803779941, 6056.9091463628965, 6110.7555697771595, 5876.882462350814, 5901.557383196192, 5902.734376952962, 5914.763409463573, 5917.467427931507], "value": 5618.837998280537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.8378016353786, 449.50778897107654, 497.74117458921364, 516.5789881246782, 539.0431983229767, 38457.80771096144, 40381.0, 40512.79743601285, 40713.38929916054, 40742.59257407425, 41378.79310603443, 41656.79171604138, 41666.58333416665, 41762.373564396556, 41783.0, 8134.959325203366, 8276.172382761706, 9257.351985361045, 9450.00774918634, 9480.288978326618, 8243.629036693363, 8439.493630382167, 8441.113683063282, 8442.197991190827, 11035.944820275887, 9350.953245233764, 11321.773564528705, 11329.943350283236, 11339.0, 11353.886461135366, 11156.597237842454, 11221.38282394464, 11245.044171245454, 11287.661370158909, 11292.887071129266, 8186.222308880647, 8384.496930184148, 8940.64237430502, 11137.220394572383, 11152.996230339308, 39367.01582460433, 39877.80061099676, 40010.59989400098, 40176.57616221802, 40348.596514034776, 3862.1310205203886, 4019.4975628046495, 4033.3143365627916, 4036.899077523056, 4164.416981622575, 28055.719442805515, 28862.845486180737, 29008.27479313013, 29132.854335728396, 29212.561811572632, 3044.071558174756, 3158.8262645554487, 3261.96738032619, 3263.951040734391, 3265.7877237979455, 482478.0, 485115.0, 485378.99999999645, 486210.0, 494273.0, 53553.0, 54371.0, 54441.0, 54699.72650136724, 54778.90442191134, 57964.17483639739, 57964.8407031857, 58047.70976145177, 58170.0, 58177.8364432709, 15077.623059423382, 15332.15673137988, 15338.926275160631, 15345.769813452807, 15365.231738413035, 11580.247283926517, 11793.587224447103, 11887.405629718653, 11917.284962902253, 11945.462454189583, 15127.621809454851, 15414.922925385301, 17052.55548830146, 20933.89533052325, 21206.575868482545, 8329.458585191944, 8354.415190936576, 8387.0, 8388.651177670263, 8452.450590711584, 777.1761932351725, 849.1847826086902, 853.6239174066676, 868.3357231717741, 896.7130518234103, 26369.868150659124, 29896.252593684898, 30155.547666785016, 30771.846140769154, 30822.075337739905, 996.9661889744984, 1020.3418794877263, 1033.1682995188944, 1076.3380520979542, 1102.9283096598695, 14295.356708948122, 15595.688086238211, 15668.37326506927, 15897.28462219203, 15918.681626367408, 650205.0, 919444.0, 932496.0, 933256.0, 935289.0, 50956.49043509518, 51298.0, 51337.229941550904, 51399.48600514022, 51424.74287628538, 1356.51165580391, 1383.7855132454486, 1400.824896887889, 1405.0726520496628, 1408.6548795544747, 27723.168304950883, 27726.44547109087, 27941.860290698416, 28349.574756378257, 28425.715742842305, 44338.778306109554, 44710.55289447194, 44915.55084449114, 44990.77504612587, 45094.0, 525774.0, 526821.0, 526914.0, 527839.0, 530184.0, 22386.440338991655, 24599.754002459747, 24832.627510587718, 24954.62568061517, 24993.250202493226, 35658.82170589234, 41536.376954345105, 41963.74108776742, 43342.783286083366, 43610.0, 33155.33689326152, 33319.96534224533, 33671.82148624786, 34038.829805850815, 34748.56038396388, 29140.125796226148, 34525.0, 34723.437445314514, 35031.47452788261, 35225.47161792626, 33859.66140338565, 34292.97121086371, 34436.82781586076, 34560.65439345675, 34610.30779384348, 30016.399672006875, 30916.53625195579, 30936.845315773277, 31074.0, 31176.90880819251, 22894.77105228993, 22998.42503937415, 23189.53620927606, 23528.529429411657, 23699.763002369757], "value": 19387.96211756983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.28826212361656, 377.59408635716613, 391.790392140205, 413.2169538724118, 422.8710243375769, 19865.900670496645, 21423.0, 21849.453763655918, 22185.445363865892, 22525.324240272777, 22186.334409967687, 22360.32919012428, 22460.775392246072, 22501.987410566562, 22537.436564085867, 5805.535557155428, 6104.725287362057, 6174.9073763893575, 6176.7838125665385, 6179.629222246657, 6065.727042283108, 6090.847728806771, 6116.266048074237, 6135.202423684915, 6192.349803270637, 5896.823095307148, 6066.484348830332, 6090.116933044706, 6098.268207815068, 6102.725377358008, 5968.7612495500125, 6013.54898382623, 6046.12331211974, 6061.515078793686, 6070.150178974903, 5309.52214300711, 5310.070737620939, 5312.760925758312, 5313.282706834567, 5320.9467905320835, 26531.0, 26715.064972726057, 26766.5985010225, 26790.464190716273, 27098.1870543884, 2339.415146213447, 2700.5179485644176, 2706.796990225741, 2718.972810271892, 2730.167298973812, 14363.71272574553, 15566.0, 15627.531174064796, 15672.0, 16204.108774017424, 1837.3477415517566, 1860.8418284445838, 1873.0821897270375, 1884.9246030158915, 1909.847212223019, 125068.37465812612, 130154.0, 131539.0, 134098.0, 134463.999999999, 11137.498812553455, 11527.308361498337, 11581.652550423501, 11613.187076904704, 11760.235584686969, 12025.819612705816, 14708.485203017843, 14766.852331476763, 14814.185219812798, 14824.184669843262, 8361.874571881426, 8623.784405389915, 8649.783755406164, 8785.297176225886, 8809.03100658927, 8429.704960326359, 8442.240198382053, 8445.493270403795, 8641.006284277388, 8658.393912426196, 7146.464015198881, 7248.238934911758, 7276.454265930077, 7282.344588987016, 7297.635118244067, 1900.078461945955, 1942.6503229418558, 1945.105251584287, 1949.39568733693, 1951.8536109791823, 932.7807965128189, 1032.7624646331385, 1035.632350515556, 1058.6241884131177, 1103.2442776697987, 21913.890430547744, 22152.667709984362, 22790.772092279196, 22926.0, 22949.311520654406, 748.6256871564218, 869.5087275689216, 949.3340232756065, 951.2152474208667, 960.8366577681811, 10105.444200568892, 10677.359358438518, 10948.671539853816, 11129.220954533104, 11163.944180279046, 738993.0, 751494.2425287839, 756540.0, 761492.0, 776632.0, 123962.26509421293, 152249.23875380552, 160570.0, 162193.37806621782, 168352.0, 957.2724729205714, 1035.5857656937135, 1068.6793961811582, 1069.7860427914447, 1078.8921107889305, 18355.174017169527, 18580.907095464438, 18789.530261743566, 18819.717704234172, 18977.9562124079, 42726.57273427226, 56821.43178568161, 59001.5249618763, 60141.39858601358, 62043.0, 90972.54513727389, 92808.0, 93057.0, 94997.0, 96411.0, 8164.428490005643, 8211.0, 8267.173282671925, 8658.870116948377, 8676.78308042304, 9319.161275484968, 12567.43446544926, 13089.934550327187, 13280.800787987995, 13716.177029378268, 11604.49852909829, 11846.289222646668, 11890.0, 12000.399980001139, 12000.939995299968, 10062.345947513388, 10570.154387649123, 11260.436978151223, 11384.37385943781, 11876.346800926032, 10659.307145035547, 11142.442877856236, 11633.88366116328, 11775.23460975034, 11831.76336473283, 7019.929800701928, 7818.92181078182, 8337.124601916712, 8339.416240863082, 8583.957080214559, 9454.061917306797, 9592.808143837225, 11170.720731981766, 11856.940715296714, 11904.0], "value": 10231.176249060038, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.9023573231998, 1416.2493878244527, 1425.1306702911227, 1434.8134742483476, 1440.1071335771824, 7382.852342953138, 7750.883736743954, 8153.633086511114, 8358.080611132771, 8368.0, 8273.669053237863, 8355.289800366962, 8357.91642083579, 8393.874091888627, 8411.789705257372, 2017.3645301729982, 2256.187772401934, 2298.6207275799475, 2299.620562607168, 2300.8389412741117, 2078.355709729981, 2188.0, 2237.2617036377956, 2252.0991603358625, 2259.830512711545, 2188.72640919885, 2216.1357070742424, 2224.788645078723, 2225.087714037245, 2229.9888500557477, 1899.8765080269739, 2223.466368071667, 2237.3735354100795, 2250.696156018933, 2254.921077762287, 2228.4094714900566, 2246.8314876384175, 2272.9090836366527, 2274.476870319819, 2279.350385140244, 8385.161483851565, 8440.113788052227, 8444.493330400195, 8447.155284471564, 8456.704015359495, 5032.748362581856, 5205.557527610158, 5205.817796377109, 5209.062368773619, 5212.8957420851375, 3240.54632351471, 3416.5558477398026, 3417.5898892133105, 3444.7588668793196, 3464.9307013859834, 1182.4797089280776, 1225.7068792423988, 1236.2767780848214, 1283.4801905228398, 1285.5115056278648, 10612.840807387895, 10735.194860385423, 10746.785064298749, 10755.085817705505, 10755.193360498071, 3873.3996230584303, 4391.363252328394, 4600.447946246405, 4636.744979026186, 4684.508126646653, 9380.8592871107, 9416.858747118798, 9431.198348140484, 9432.292578056673, 9460.810783784424, 5194.27280180775, 5201.245819356248, 5206.219067139959, 5207.3230480037355, 5213.817516386984, 4660.219316155897, 4691.319758634979, 4763.118823017753, 4777.426708794897, 4799.088173247072, 3240.951385729216, 3698.6671199592165, 3765.077555998798, 3789.2610940866266, 3878.4182372644327, 1221.2001139253803, 1225.3995542184443, 1228.4717571444187, 1234.7221875078214, 1236.5177580743518, 752.7403045949138, 845.0830848529291, 879.3624622149018, 891.1845661219911, 930.6230976454547, 4553.453585569753, 4861.416630004422, 5435.320584926884, 5605.0751625982075, 5673.205751194836, 940.9012053734397, 1011.327467234281, 1017.018577073128, 1048.6696690542608, 1065.350136416785, 3692.150805314739, 3745.176061266517, 3874.8062596870045, 3884.941725874114, 3890.319194141014, 9740.220782337537, 10057.899421005697, 10063.04401081896, 10080.0, 10087.092161705481, 7411.481196316314, 9946.651867184613, 9997.600095996224, 9999.550020249106, 10013.349132306377, 7511.887321690179, 7689.8849666798005, 7706.961465192639, 7816.49192802466, 7821.608919554, 5619.719014049199, 5626.549876009991, 5702.340803416409, 5819.359870414336, 5924.052151655715, 9233.169014788702, 9372.718818435458, 9382.296327775308, 9383.624655013722, 9386.95306523463, 8499.617517211864, 8854.070322616033, 9474.38416502925, 9574.234061275221, 9605.903940960501, 6586.967065164644, 6762.0, 6828.931710682829, 7177.964110179416, 7247.47802961363, 7753.418493613114, 7975.72084977023, 7987.400944929037, 8091.433599648203, 8094.595270236582, 7126.5011449198055, 7163.0329905462095, 7210.0, 7212.206657267591, 7244.203137654748, 6925.861482770417, 6992.510524263253, 7010.228874823867, 7059.470539709439, 7101.82245443868, 6325.0, 6345.302016778243, 6444.355564443518, 6458.354164583504, 6480.935190648033, 4819.759012049313, 4972.403311602631, 4974.32846565709, 4975.975120124376, 5129.948700512947, 4173.373993900817, 4904.975475122602, 4923.138450771173, 4942.82700105509, 5098.980203959297], "value": 4380.966309023282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4329773430482, 366.14322485384196, 367.9871204507842, 376.29632587062196, 378.4040136784565, 5255.474452554743, 5281.445448227933, 5296.140084354449, 5308.018985760679, 5322.217057285804, 4597.7815529129575, 5173.741312934357, 5213.530782229599, 5214.687118772877, 5218.8695282617955, 3519.9824000879958, 3553.92892142157, 3830.138218900746, 3841.8436109972827, 3844.6539811416965, 4037.253108174982, 4040.919181616366, 4042.6967977401664, 4052.615001574846, 4075.9388609170737, 3561.786292822426, 3934.055826601609, 4039.6768258539246, 4082.6527246008745, 4083.203775263825, 3458.3602033623733, 3557.8970519139148, 3966.5835087315995, 4082.203970225807, 4122.948648094746, 3019.773516986235, 3343.21434462901, 3440.7247420206572, 3502.509648649191, 3597.892063238107, 4031.778252196128, 4542.205828697679, 4762.0713610987605, 5075.771590278447, 5088.491150884919, 4099.733517321364, 4669.6497762667595, 4680.812767489297, 4688.734041808727, 4721.598664113554, 4803.9039219215765, 5155.639105262633, 5228.215767634847, 5460.808871689472, 5483.148762643443, 3558.323918455485, 3950.249452603996, 3976.6619837313865, 3990.6009399060154, 3993.880183594497, 4474.485434175079, 5364.681431447644, 5643.351014633328, 5725.227094342252, 5743.425657434265, 3236.2556611979376, 3424.4863270509622, 3592.389293820057, 4093.038136038029, 4094.836206551764, 3525.0964479180957, 3682.2635472905527, 3821.8597585351736, 3885.9222815544094, 4169.478815148106, 3868.9613103869165, 4287.2711639021445, 4447.066116115588, 4721.362616046789, 4827.686200396963, 5187.974060129675, 5256.316678831728, 5487.780488780484, 5558.360788509292, 5618.078599128512, 1262.8800263974908, 1286.9511348251144, 1328.1367111377488, 1343.3417625363502, 1353.15427857589, 800.8118092248317, 891.9420237684529, 950.3585080071063, 975.2246963663904, 976.7558110472382, 4259.829606815692, 4336.566343365638, 4839.7096174229655, 4869.732164730903, 4899.6570240083565, 4950.302085363485, 5200.60995425337, 5335.466453354634, 5365.275687782178, 5493.187248208082, 4018.4729802674797, 4208.747475151501, 4327.788219298602, 4732.384789977281, 4884.389451318585, 2444.3378502618034, 2538.365408647838, 2805.9158225253277, 2807.284142543679, 2848.5614764543775, 4841.757912104381, 4842.661013729005, 4979.427365852901, 5095.8726031848755, 5593.356763972195, 4958.0, 5028.145215313405, 5426.124154198281, 5491.670499769947, 5843.152742852262, 5427.255193916185, 5810.622309549865, 5872.265966754156, 5918.822435326947, 5957.910631340534, 5036.897973856844, 5303.96572668326, 5513.558915286687, 5702.319909642461, 5734.082546792493, 5218.321618189611, 5495.873345963988, 5591.356993945748, 5634.380218175916, 5692.2600061993335, 5001.324821149244, 5516.66899985986, 5631.324241091095, 5689.459501347365, 5806.65160090396, 3300.1089705779787, 3459.377312083849, 3663.87176448823, 3725.3480640887196, 3736.140687641803, 5775.566832487664, 5793.91309130355, 5799.94200057994, 5801.709914504342, 5819.738111784895, 5157.510036546522, 5341.305630268041, 5355.571554275571, 5497.890042199054, 5551.278333816578, 4510.210713125124, 5078.819604003969, 5174.767135478988, 5509.559235261249, 5542.944570554404, 5155.922661160011, 5360.356757189163, 5386.757595908115, 5401.270828438111, 5408.107662235687, 4998.800047998039, 5219.520727654334, 5502.056399826074, 5504.614676972574, 5556.916646250229, 4949.876253093701, 5395.136778115482, 5419.674819510842, 5434.358979483834, 5446.809361672323], "value": 4001.94846400029, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.8025512728872, 704.4118161335285, 723.8516104198643, 780.16911988732, 835.6657337065174, 14792.112473251598, 15795.526134215963, 15807.0, 15810.920945395272, 15819.920900395482, 12118.45466953987, 14619.707605847876, 14641.633959151, 14776.556703298918, 14794.778078328834, 690.4752388184991, 711.9074520312353, 848.7368915636142, 871.1462766488861, 885.5218182181615, 869.6651789061225, 871.3073106880046, 878.3236907581158, 884.933629977751, 886.5389997201484, 934.0566028311421, 937.409432057806, 938.699616122841, 939.6570251858057, 939.7086903060073, 931.329442801182, 932.282142750082, 932.5290728182224, 934.5560858592182, 935.8783358163463, 538.5637633516864, 558.0318148013193, 558.040170906041, 564.4242872270303, 695.4297476069625, 14705.044172128884, 15282.694346113016, 15303.387864485407, 15640.843591564053, 15678.980866243657, 14289.285535723173, 14363.0, 14391.928040359835, 14448.49430269946, 14466.421343146261, 11695.649130526097, 11809.291442513477, 11836.940815295868, 11869.881301186964, 12253.264804111783, 3693.8891833244775, 3729.925401491982, 3749.981250093732, 3776.376897811858, 3876.3022655921923, 104211.0, 105021.42467862912, 105832.94167058308, 106474.0, 106558.0, 11259.887401126047, 11266.830997535044, 11273.098152147808, 11424.028957538701, 11587.710307242387, 23440.17959371414, 23567.41081472977, 23823.52352952966, 23932.641010384858, 23974.640380394307, 7748.806279843049, 7765.1458339582605, 7790.610469476504, 7829.29536341732, 8085.393595480245, 4152.1280531088205, 4235.364695295731, 4271.9786401067795, 4423.867283981485, 4466.062126953311, 3517.085557754951, 3620.6198349173483, 3621.728370372233, 3621.7323936622497, 3631.9818400907825, 645.270843946347, 651.6741629185407, 668.9632070236183, 670.940213544414, 677.6002158726375, 650.3821369698805, 658.3844105761128, 688.9586624802528, 691.180950573572, 715.1132595581441, 10094.646687365906, 10168.898311016796, 10184.592616295266, 10472.790544189074, 10485.528151233213, 681.1689738518999, 701.2321507948787, 703.6587255181233, 705.1256442011868, 717.5622870049266, 4666.183417901853, 4880.585150262267, 4882.5605695487575, 4894.412670479565, 4896.094222568836, 65833.0, 102241.97758022325, 105024.0, 107003.0, 109076.45461772798, 90303.64544531837, 90892.09107908969, 92270.0, 92434.0, 93695.0, 78416.60791696006, 79220.0, 80662.5966870162, 81005.0, 82118.58940705378, 9507.334486585873, 9544.57049432791, 9568.473733944422, 9574.186194173573, 9580.0, 53264.46735532595, 53273.46726532685, 54030.45969540254, 54081.72959135179, 54469.72765136307, 69056.0, 70881.29118708747, 70995.64502177663, 71575.92636110359, 72124.0, 11204.327740335606, 11662.53349865996, 11683.7426247809, 11720.003799677123, 12028.398580070787, 12551.372431378577, 12618.55835045769, 12737.93631031876, 12879.356032198166, 12978.091533592558, 11714.589989350332, 11805.586804461802, 11937.940310298392, 11943.522259109539, 12015.219010764273, 10603.115749185403, 11881.0, 12180.817287740869, 12277.877221228031, 13734.244616545786, 13058.477660893457, 13191.162688680324, 13675.974301927594, 13724.588262352145, 13898.722025559635, 10874.401907894826, 10978.154239929976, 11758.412079396167, 11800.409979501163, 11803.468843902217, 10786.352818830896, 10871.891281087088, 10972.177086718688, 11127.88872111301, 11135.554577816796], "value": 7495.449256957971, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1475.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 96.0, 151.0, 168.0, 165.0, 113.0, 110.0, 113.0, 113.0], "value": 126.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 110.0, 149.0, 125.0, 135.0, 116.0, 109.0, 131.0, 109.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 183.0, 188.0, 178.0, 182.0, 189.0, 203.0, 185.0], "value": 185.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 74.0, 83.0, 112.0, 65.0, 58.0, 58.0, 59.0, 77.0, 60.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 88.0, 71.0, 69.0, 69.0, 85.0, 68.0, 71.0, 98.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 87.0, 84.0, 87.0, 83.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 99.0, 131.0, 84.0, 85.0, 84.0, 87.0, 85.0, 86.0], "value": 91.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 58.0, 60.0, 57.0, 58.0, 58.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 65.0, 75.0, 73.0, 70.0, 70.0, 72.0, 71.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 91.0, 87.0, 87.0, 87.0, 88.0, 86.0, 90.0, 87.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 159.0, 149.0, 146.0, 128.0, 140.0, 176.0, 172.0, 205.0, 178.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 174.0, 174.0, 171.0, 174.0, 174.0, 172.0, 172.0, 174.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 67.4, "unit": "score"}]}]} 05:16:39 INFO - Return code: 0 05:16:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:16:39 ERROR - # TBPL SUCCESS # 05:16:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:39 INFO - 2017-02-02 05:16:39.941 screenresolution[1654:9953] starting screenresolution argv=screenresolution get 05:16:39 INFO - 2017-02-02 05:16:39.944 screenresolution[1654:9953] Display 0: 1600x1200x32@60 05:16:39 INFO - 2017-02-02 05:16:39.950 screenresolution[1655:9956] starting screenresolution argv=screenresolution list 05:16:39 INFO - Available Modes on Display 0 05:16:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:40 INFO - Intel Iris: 05:16:40 INFO - Chipset Model: Intel Iris 05:16:40 INFO - Type: GPU 05:16:40 INFO - Bus: Built-In 05:16:40 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:40 INFO - Vendor: Intel (0x8086) 05:16:40 INFO - Device ID: 0x0a2e 05:16:40 INFO - Revision ID: 0x0009 05:16:40 INFO - Displays: 05:16:40 INFO - Display: 05:16:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:40 INFO - Display Serial Number: 1600x1200 60 05:16:40 INFO - Main Display: Yes 05:16:40 INFO - Mirror: Off 05:16:40 INFO - Online: Yes 05:16:40 INFO - Rotation: Supported 05:16:40 INFO - Return code: 0 05:16:40 INFO - Running post-action listener: _resource_record_post_action 05:16:40 INFO - [mozharness: 2017-02-02 13:16:40.186925Z] Finished run-tests step (success) 05:16:40 INFO - Running post-run listener: _resource_record_post_run 05:16:40 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38990848; Write bytes: 556372480; Read time: 378; Write time: 1947 05:16:40 INFO - TinderboxPrint: CPU usage
53.8% 05:16:40 INFO - TinderboxPrint: I/O read bytes / time
38,990,848 / 378 05:16:40 INFO - TinderboxPrint: I/O write bytes / time
556,372,480 / 1,947 05:16:40 INFO - TinderboxPrint: CPU idle
2,221.9 (46.2%) 05:16:40 INFO - TinderboxPrint: CPU system
960.5 (20.0%) 05:16:40 INFO - TinderboxPrint: CPU user
1,623.3 (33.8%) 05:16:40 INFO - TinderboxPrint: Swap in / out
291,184,640 / 0 05:16:40 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 253487616; Write bytes: 257169408; Read time: 18189; Write time: 592 05:16:40 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34432000; Write bytes: 297835008; Read time: 346; Write time: 1350 05:16:40 INFO - Running post-run listener: _upload_blobber_files 05:16:40 INFO - Blob upload gear active. 05:16:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:16:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:16:40 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'] 05:16:40 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 05:16:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:16:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:41 INFO - (blobuploader) - INFO - Done attempting. 05:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:42 INFO - (blobuploader) - INFO - Done attempting. 05:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:43 INFO - (blobuploader) - INFO - Done attempting. 05:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:16:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:46 INFO - (blobuploader) - INFO - Done attempting. 05:16:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:46 INFO - Return code: 0 05:16:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e30dbc3be872a1be7cff26fd4e85f75b90da3f2895270ac53a3a6cdcc735f8d222cc0e7b7ae9bc200260cf21535c5dc2d5dc216726dd8dd1fbe09fdc021056d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca7cb4bd0c82bd507291e9f7eeb271e1fcf4b668486359050f37115a7d15cd25dc8b511f6dab15251676efc98e193b990a65551b74ae49d113f066be16629dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7dca6ca27440ef1179d1a4c8884cee1054a2413c27edc154caf6f74e4e78cb043712d406afa9ea3290c8faf7899510f007ee727def072f67a7df5c8e483baeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4d2cc0002adfec01e1445d6d4b071f057eb6b2aed5d5613908595e3fbe5060f8538e756ce1339950d1f7283f62e983c4be763fe09cb048e2ddda108974ae7b3"} 05:16:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:46 INFO - Contents: 05:16:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e30dbc3be872a1be7cff26fd4e85f75b90da3f2895270ac53a3a6cdcc735f8d222cc0e7b7ae9bc200260cf21535c5dc2d5dc216726dd8dd1fbe09fdc021056d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca7cb4bd0c82bd507291e9f7eeb271e1fcf4b668486359050f37115a7d15cd25dc8b511f6dab15251676efc98e193b990a65551b74ae49d113f066be16629dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7dca6ca27440ef1179d1a4c8884cee1054a2413c27edc154caf6f74e4e78cb043712d406afa9ea3290c8faf7899510f007ee727def072f67a7df5c8e483baeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4d2cc0002adfec01e1445d6d4b071f057eb6b2aed5d5613908595e3fbe5060f8538e756ce1339950d1f7283f62e983c4be763fe09cb048e2ddda108974ae7b3"} 05:16:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:16:46 INFO - Copying logs to upload dir... 05:16:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:16:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.993223 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-02 05:16:46.383494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 05:16:46.386694) ========= 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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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/1e30dbc3be872a1be7cff26fd4e85f75b90da3f2895270ac53a3a6cdcc735f8d222cc0e7b7ae9bc200260cf21535c5dc2d5dc216726dd8dd1fbe09fdc021056d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca7cb4bd0c82bd507291e9f7eeb271e1fcf4b668486359050f37115a7d15cd25dc8b511f6dab15251676efc98e193b990a65551b74ae49d113f066be16629dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7dca6ca27440ef1179d1a4c8884cee1054a2413c27edc154caf6f74e4e78cb043712d406afa9ea3290c8faf7899510f007ee727def072f67a7df5c8e483baeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4d2cc0002adfec01e1445d6d4b071f057eb6b2aed5d5613908595e3fbe5060f8538e756ce1339950d1f7283f62e983c4be763fe09cb048e2ddda108974ae7b3"} build_url:https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011016 build_url: 'https://queue.taskcluster.net/v1/task/dPbNL-ZEQbOgRyT0Tclb-Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e30dbc3be872a1be7cff26fd4e85f75b90da3f2895270ac53a3a6cdcc735f8d222cc0e7b7ae9bc200260cf21535c5dc2d5dc216726dd8dd1fbe09fdc021056d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca7cb4bd0c82bd507291e9f7eeb271e1fcf4b668486359050f37115a7d15cd25dc8b511f6dab15251676efc98e193b990a65551b74ae49d113f066be16629dfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7dca6ca27440ef1179d1a4c8884cee1054a2413c27edc154caf6f74e4e78cb043712d406afa9ea3290c8faf7899510f007ee727def072f67a7df5c8e483baeb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4d2cc0002adfec01e1445d6d4b071f057eb6b2aed5d5613908595e3fbe5060f8538e756ce1339950d1f7283f62e983c4be763fe09cb048e2ddda108974ae7b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 05:16:46.420886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:16:46.421211) ========= 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.iRFX4HGdQH/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.Xmv8ShXxGi/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005066 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 05:16:46.470115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 05:16:46.470445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 05:16:46.470763) ========= ========= Total master_lag: 0.18 =========