builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0220 starttime: 1488382286.69 results: success (0) buildid: 20170301072337 builduid: 5c3bca1a69b945f58736c30ea2f1c0cc revision: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:26.691948) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:26.692429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:26.692699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:26.717651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:26.717953) ========= 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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-03-01 07:31:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.70M=0.002s 2017-03-01 07:31:27 (7.70 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.445935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:27.187260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:27.187585) ========= 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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.020707 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:27.236194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:31:27.236559) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 --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 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-03-01 07:31:27,310 truncating revision to first 12 chars 2017-03-01 07:31:27,310 Setting DEBUG logging. 2017-03-01 07:31:27,310 attempt 1/10 2017-03-01 07:31:27,311 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34c6c2f302e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-01 07:31:28,086 unpacking tar archive at: mozilla-central-34c6c2f302e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.030403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:31:28.290564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:28.290878) ========= script_repo_revision: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:28.291245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:28.291589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:31:28.311237) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-01 07:31:28.311530) ========= /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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:31:28 INFO - MultiFileLogger online at 20170301 07:31:28 in /builds/slave/test 07:31:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:31:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:31:28 INFO - {'append_to_log': False, 07:31:28 INFO - 'base_work_dir': '/builds/slave/test', 07:31:28 INFO - 'blob_upload_branch': 'Firefox', 07:31:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:31:28 INFO - 'branch': 'Firefox', 07:31:28 INFO - 'buildbot_json_path': 'buildprops.json', 07:31:28 INFO - 'config_files': ('talos/mac_config.py',), 07:31:28 INFO - 'default_actions': ('clobber', 07:31:28 INFO - 'read-buildbot-config', 07:31:28 INFO - 'download-and-extract', 07:31:28 INFO - 'populate-webroot', 07:31:28 INFO - 'create-virtualenv', 07:31:28 INFO - 'install', 07:31:28 INFO - 'run-tests'), 07:31:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:31:28 INFO - 'download_minidump_stackwalk': True, 07:31:28 INFO - 'download_symbols': 'ondemand', 07:31:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:31:28 INFO - 'tooltool.py': '/tools/tooltool.py', 07:31:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:31:28 INFO - '/tools/misc-python/virtualenv.py')}, 07:31:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:31:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:31:28 INFO - 'gecko_profile': False, 07:31:28 INFO - 'gecko_profile_interval': 0, 07:31:28 INFO - 'installer_path': 'installer.exe', 07:31:28 INFO - 'log_level': 'info', 07:31:28 INFO - 'log_name': 'talos', 07:31:28 INFO - 'log_to_console': True, 07:31:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:31:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:31:28 INFO - 'opt_config_files': (), 07:31:28 INFO - 'pip_index': False, 07:31:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:31:28 INFO - 'cmd': ('bash', 07:31:28 INFO - '-c', 07:31:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:31:28 INFO - 'enabled': True, 07:31:28 INFO - 'halt_on_failure': False, 07:31:28 INFO - 'name': 'check_screen_resolution'},), 07:31:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:31:28 INFO - 'cmd': ('bash', 07:31:28 INFO - '-c', 07:31:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:31:28 INFO - 'enabled': True, 07:31:28 INFO - 'halt_on_failure': False, 07:31:28 INFO - 'name': 'check_screen_resolution'},), 07:31:28 INFO - 'run_cmd_checks_enabled': True, 07:31:28 INFO - 'suite': 'dromaeojs', 07:31:28 INFO - 'system_bits': '32', 07:31:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:31:28 INFO - 'title': 't-yosemite-r7-0220', 07:31:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:31:28 INFO - 'use_talos_json': True, 07:31:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:31:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:31:28 INFO - 'work_dir': 'build'} 07:31:28 INFO - [mozharness: 2017-03-01 15:31:28.505714Z] Running clobber step. 07:31:28 INFO - Running pre-action listener: _resource_record_pre_action 07:31:28 INFO - Running main action method: clobber 07:31:28 INFO - rmtree: /builds/slave/test/build 07:31:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:31:31 INFO - Running post-action listener: _resource_record_post_action 07:31:31 INFO - [mozharness: 2017-03-01 15:31:31.796970Z] Finished clobber step (success) 07:31:31 INFO - [mozharness: 2017-03-01 15:31:31.797200Z] Running read-buildbot-config step. 07:31:31 INFO - Running pre-action listener: _resource_record_pre_action 07:31:31 INFO - Running main action method: read_buildbot_config 07:31:31 INFO - Using buildbot properties: 07:31:31 INFO - { 07:31:31 INFO - "project": "", 07:31:31 INFO - "product": "firefox", 07:31:31 INFO - "script_repo_revision": "production", 07:31:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:31:31 INFO - "repository": "", 07:31:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:31:31 INFO - "buildid": "20170301072337", 07:31:31 INFO - "stage_platform": "macosx64", 07:31:31 INFO - "basedir": "/builds/slave/test", 07:31:31 INFO - "buildnumber": 8, 07:31:31 INFO - "platform": "yosemite_r7", 07:31:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:31:31 INFO - "slavebuilddir": "test", 07:31:31 INFO - "branch": "mozilla-central", 07:31:31 INFO - "revision": "34c6c2f302e7b48e3ad2cec575cbd34d423a9d32", 07:31:31 INFO - "slavename": "t-yosemite-r7-0220", 07:31:31 INFO - "builduid": "5c3bca1a69b945f58736c30ea2f1c0cc", 07:31:31 INFO - "repo_path": "mozilla-central" 07:31:31 INFO - } 07:31:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg. 07:31:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.test_packages.json. 07:31:31 INFO - Running post-action listener: _resource_record_post_action 07:31:31 INFO - [mozharness: 2017-03-01 15:31:31.802788Z] Finished read-buildbot-config step (success) 07:31:31 INFO - [mozharness: 2017-03-01 15:31:31.802993Z] Running download-and-extract step. 07:31:31 INFO - Running pre-action listener: _resource_record_pre_action 07:31:31 INFO - Running main action method: download_and_extract 07:31:31 INFO - mkdir: /builds/slave/test/build/tests 07:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.test_packages.json 07:31:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/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 07:31:32 INFO - Downloaded 1199 bytes. 07:31:32 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:31:32 INFO - Using the following test package requirements: 07:31:32 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:31:32 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:31:32 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:31:32 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'jsshell-mac.zip'], 07:31:32 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:31:32 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:31:32 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:31:32 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:31:32 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:31:32 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:31:32 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:31:32 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:31:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip 07:31:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:31:32 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:31:33 INFO - Expected file size: 51762826 07:31:33 INFO - Obtained file size: 51762826 07:31:48 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 07:31:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip 07:31:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:31:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:31:49 INFO - Expected file size: 51762826 07:31:49 INFO - Obtained file size: 51762826 07:32:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.talos.tests.zip 07:32:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:32:04 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 07:32:05 INFO - Expected file size: 14404421 07:32:05 INFO - Obtained file size: 14404421 07:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:05 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:32:05 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 07:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 07:32:07 INFO - Downloaded 74973774 bytes. 07:32:07 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:32:07 INFO - mkdir: /builds/slave/test/properties 07:32:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:07 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:07 INFO - Contents: 07:32:07 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg 07:32:07 INFO - Running post-action listener: _resource_record_post_action 07:32:07 INFO - Running post-action listener: set_extra_try_arguments 07:32:07 INFO - [mozharness: 2017-03-01 15:32:07.673733Z] Finished download-and-extract step (success) 07:32:07 INFO - [mozharness: 2017-03-01 15:32:07.673858Z] Running populate-webroot step. 07:32:07 INFO - Running pre-action listener: _resource_record_pre_action 07:32:07 INFO - Running main action method: populate_webroot 07:32:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:07 INFO - '--tppagecycles', 07:32:07 INFO - '7'], 07:32:07 INFO - 'tests': ['tsvgm']}}, 07:32:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:32:07 INFO - 'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:32:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:32:07 INFO - 'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['damp', 'tps']}, 07:32:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:32:07 INFO - 'tests': ['damp', 'tps']}, 07:32:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['dromaeo_dom']}, 07:32:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['basic_compositor_video']}, 07:32:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['a11yr', 07:32:07 INFO - 'ts_paint', 07:32:07 INFO - 'tpaint', 07:32:07 INFO - 'sessionrestore', 07:32:07 INFO - 'sessionrestore_no_auto_restore', 07:32:07 INFO - 'tabpaint']}, 07:32:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:07 INFO - 'ts_paint', 07:32:07 INFO - 'tpaint', 07:32:07 INFO - 'sessionrestore', 07:32:07 INFO - 'sessionrestore_no_auto_restore', 07:32:07 INFO - 'tabpaint']}, 07:32:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:07 INFO - 'ts_paint', 07:32:07 INFO - 'tpaint', 07:32:07 INFO - 'sessionrestore', 07:32:07 INFO - 'sessionrestore_no_auto_restore', 07:32:07 INFO - 'tabpaint']}, 07:32:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:07 INFO - 'ts_paint', 07:32:07 INFO - 'tpaint', 07:32:07 INFO - 'sessionrestore', 07:32:07 INFO - 'sessionrestore_no_auto_restore', 07:32:07 INFO - 'tabpaint']}, 07:32:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['a11yr', 07:32:07 INFO - 'ts_paint', 07:32:07 INFO - 'tpaint', 07:32:07 INFO - 'sessionrestore', 07:32:07 INFO - 'sessionrestore_no_auto_restore', 07:32:07 INFO - 'tabpaint']}, 07:32:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['a11yr', 07:32:07 INFO - 'ts_paint', 07:32:07 INFO - 'tpaint', 07:32:07 INFO - 'sessionrestore', 07:32:07 INFO - 'sessionrestore_no_auto_restore', 07:32:07 INFO - 'tabpaint']}, 07:32:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['tsvgx', 07:32:07 INFO - 'tsvgr_opacity', 07:32:07 INFO - 'tart', 07:32:07 INFO - 'tscrollx', 07:32:07 INFO - 'cart', 07:32:07 INFO - 'tsvg_static']}, 07:32:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:07 INFO - 'tsvgr_opacity', 07:32:07 INFO - 'tart', 07:32:07 INFO - 'tscrollx', 07:32:07 INFO - 'cart', 07:32:07 INFO - 'tsvg_static']}, 07:32:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:32:07 INFO - 'talos_options': ['--disable-e10s'], 07:32:07 INFO - 'tests': ['tp5o']}, 07:32:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:32:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:32:07 INFO - 'talos_options': ['--disable-e10s', 07:32:07 INFO - '--xperf_path', 07:32:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:07 INFO - 'tests': ['tp5n']}, 07:32:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:32:07 INFO - 'talos_options': ['--xperf_path', 07:32:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:07 INFO - 'tests': ['tp5n']}}, 07:32:07 INFO - 'talos.zip': {'path': '', 07:32:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:07 INFO - Running post-action listener: _resource_record_post_action 07:32:07 INFO - [mozharness: 2017-03-01 15:32:07.692189Z] Finished populate-webroot step (success) 07:32:07 INFO - [mozharness: 2017-03-01 15:32:07.692320Z] Running create-virtualenv step. 07:32:07 INFO - Running pre-action listener: _resource_record_pre_action 07:32:07 INFO - Running main action method: create_virtualenv 07:32:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:32:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:07 INFO - Using real prefix '/tools/python27' 07:32:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:11 INFO - Installing pip.................done. 07:32:11 INFO - Return code: 0 07:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:32:11 INFO - Reading from file tmpfile_stdout 07:32:11 INFO - Output received: 07:32:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:32:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:11 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:32:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:11 INFO - 'HOME': '/Users/cltbld', 07:32:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:11 INFO - 'LOGNAME': 'cltbld', 07:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:11 INFO - 'MOZ_NO_REMOTE': '1', 07:32:11 INFO - 'NO_EM_RESTART': '1', 07:32:11 INFO - 'PAGER': '/bin/cat', 07:32:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:11 INFO - 'PWD': '/builds/slave/test', 07:32:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:11 INFO - 'SHELL': '/bin/bash', 07:32:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:11 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:11 INFO - 'USER': 'cltbld', 07:32:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:11 INFO - 'XPC_FLAGS': '0x0', 07:32:11 INFO - 'XPC_SERVICE_NAME': '0', 07:32:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:32:12 INFO - Cleaning up... 07:32:12 INFO - Return code: 0 07:32:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:12 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:12 INFO - 'HOME': '/Users/cltbld', 07:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:12 INFO - 'LOGNAME': 'cltbld', 07:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:12 INFO - 'MOZ_NO_REMOTE': '1', 07:32:12 INFO - 'NO_EM_RESTART': '1', 07:32:12 INFO - 'PAGER': '/bin/cat', 07:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:12 INFO - 'PWD': '/builds/slave/test', 07:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:12 INFO - 'SHELL': '/bin/bash', 07:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:12 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:12 INFO - 'USER': 'cltbld', 07:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:12 INFO - 'XPC_FLAGS': '0x0', 07:32:12 INFO - 'XPC_SERVICE_NAME': '0', 07:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:12 INFO - Downloading/unpacking psutil>=3.1.1 07:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:16 INFO - Installing collected packages: psutil 07:32:16 INFO - Running setup.py install for psutil 07:32:16 INFO - building 'psutil._psutil_osx' extension 07:32:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:32:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:32:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:32:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:32:16 INFO - building 'psutil._psutil_posix' extension 07:32:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:32:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:32:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:32:16 INFO - ^ 07:32:16 INFO - 1 warning generated. 07:32:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:32:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:17 INFO - Successfully installed psutil 07:32:17 INFO - Cleaning up... 07:32:17 INFO - Return code: 0 07:32:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:32: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 mozsystemmonitor==0.3 07:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:17 INFO - 'HOME': '/Users/cltbld', 07:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:17 INFO - 'LOGNAME': 'cltbld', 07:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:17 INFO - 'MOZ_NO_REMOTE': '1', 07:32:17 INFO - 'NO_EM_RESTART': '1', 07:32:17 INFO - 'PAGER': '/bin/cat', 07:32:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:17 INFO - 'PWD': '/builds/slave/test', 07:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:17 INFO - 'SHELL': '/bin/bash', 07:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:17 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:17 INFO - 'USER': 'cltbld', 07:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:17 INFO - 'XPC_FLAGS': '0x0', 07:32:17 INFO - 'XPC_SERVICE_NAME': '0', 07:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:32:20 INFO - Installing collected packages: mozsystemmonitor 07:32:20 INFO - Running setup.py install for mozsystemmonitor 07:32:20 INFO - Successfully installed mozsystemmonitor 07:32:20 INFO - Cleaning up... 07:32:20 INFO - Return code: 0 07:32:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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', '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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:32: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 jsonschema==2.5.1 07:32:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:20 INFO - 'HOME': '/Users/cltbld', 07:32:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:20 INFO - 'LOGNAME': 'cltbld', 07:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:20 INFO - 'MOZ_NO_REMOTE': '1', 07:32:20 INFO - 'NO_EM_RESTART': '1', 07:32:20 INFO - 'PAGER': '/bin/cat', 07:32:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:20 INFO - 'PWD': '/builds/slave/test', 07:32:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:20 INFO - 'SHELL': '/bin/bash', 07:32:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:20 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:20 INFO - 'USER': 'cltbld', 07:32:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:20 INFO - 'XPC_FLAGS': '0x0', 07:32:20 INFO - 'XPC_SERVICE_NAME': '0', 07:32:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:20 INFO - Downloading/unpacking jsonschema==2.5.1 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:23 INFO - warning: no files found matching '*.txt' 07:32:23 INFO - no previously-included directories found matching 'build' 07:32:23 INFO - no previously-included directories found matching 'dist' 07:32:23 INFO - no previously-included directories found matching '.git*' 07:32:23 INFO - Installing collected packages: jsonschema, functools32 07:32:23 INFO - Running setup.py install for functools32 07:32:23 INFO - warning: no files found matching '*.txt' 07:32:23 INFO - no previously-included directories found matching 'build' 07:32:23 INFO - no previously-included directories found matching 'dist' 07:32:23 INFO - no previously-included directories found matching '.git*' 07:32:23 INFO - Successfully installed jsonschema functools32 07:32:23 INFO - Cleaning up... 07:32:24 INFO - Return code: 0 07:32:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:24 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:24 INFO - 'HOME': '/Users/cltbld', 07:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:24 INFO - 'LOGNAME': 'cltbld', 07:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:24 INFO - 'MOZ_NO_REMOTE': '1', 07:32:24 INFO - 'NO_EM_RESTART': '1', 07:32:24 INFO - 'PAGER': '/bin/cat', 07:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:24 INFO - 'PWD': '/builds/slave/test', 07:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:24 INFO - 'SHELL': '/bin/bash', 07:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:24 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:24 INFO - 'USER': 'cltbld', 07:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:24 INFO - 'XPC_FLAGS': '0x0', 07:32:24 INFO - 'XPC_SERVICE_NAME': '0', 07:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:32:24 INFO - Cleaning up... 07:32:24 INFO - Return code: 0 07:32:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:24 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:24 INFO - 'HOME': '/Users/cltbld', 07:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:24 INFO - 'LOGNAME': 'cltbld', 07:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:24 INFO - 'MOZ_NO_REMOTE': '1', 07:32:24 INFO - 'NO_EM_RESTART': '1', 07:32:24 INFO - 'PAGER': '/bin/cat', 07:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:24 INFO - 'PWD': '/builds/slave/test', 07:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:24 INFO - 'SHELL': '/bin/bash', 07:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:24 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:24 INFO - 'USER': 'cltbld', 07:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:24 INFO - 'XPC_FLAGS': '0x0', 07:32:24 INFO - 'XPC_SERVICE_NAME': '0', 07:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:27 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:32:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:28 INFO - Downloading docopt-0.6.1.tar.gz 07:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:28 INFO - Running setup.py install for blobuploader 07:32:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:32:28 INFO - Running setup.py install for requests 07:32:29 INFO - Running setup.py install for docopt 07:32:29 INFO - Successfully installed blobuploader requests docopt 07:32:29 INFO - Cleaning up... 07:32:29 INFO - Return code: 0 07:32:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:29 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:29 INFO - 'HOME': '/Users/cltbld', 07:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:29 INFO - 'LOGNAME': 'cltbld', 07:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:29 INFO - 'MOZ_NO_REMOTE': '1', 07:32:29 INFO - 'NO_EM_RESTART': '1', 07:32:29 INFO - 'PAGER': '/bin/cat', 07:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:29 INFO - 'PWD': '/builds/slave/test', 07:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:29 INFO - 'SHELL': '/bin/bash', 07:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:29 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:29 INFO - 'USER': 'cltbld', 07:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:29 INFO - 'XPC_FLAGS': '0x0', 07:32:29 INFO - 'XPC_SERVICE_NAME': '0', 07:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xPZIKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-dCk8i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vsFzvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-19ax0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-w4aPNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-e4bbFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-635CBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BGPrrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-sSGHVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-KdPaUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lKhwdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vAk4XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:30 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yS5bW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:31 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-RoozvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:31 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3o6NWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:31 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-oiILwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:31 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-WmnQy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:31 INFO - Running setup.py install for manifestparser 07:32:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:32:31 INFO - Running setup.py install for mozcrash 07:32:31 INFO - Running setup.py install for mozdebug 07:32:31 INFO - Running setup.py install for mozdevice 07:32:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for mozfile 07:32:32 INFO - Running setup.py install for mozhttpd 07:32:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for mozinfo 07:32:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for mozInstall 07:32:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for mozleak 07:32:32 INFO - Running setup.py install for mozlog 07:32:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:32:32 INFO - Running setup.py install for moznetwork 07:32:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:32:33 INFO - Running setup.py install for mozprocess 07:32:33 INFO - Running setup.py install for mozprofile 07:32:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:32:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:32:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:32:33 INFO - Running setup.py install for mozrunner 07:32:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:32:33 INFO - Running setup.py install for mozscreenshot 07:32:33 INFO - Running setup.py install for moztest 07:32:33 INFO - Running setup.py install for mozversion 07:32:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:32:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:33 INFO - Cleaning up... 07:32:34 INFO - Return code: 0 07:32:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:34 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:32:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:34 INFO - 'HOME': '/Users/cltbld', 07:32:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:34 INFO - 'LOGNAME': 'cltbld', 07:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:34 INFO - 'MOZ_NO_REMOTE': '1', 07:32:34 INFO - 'NO_EM_RESTART': '1', 07:32:34 INFO - 'PAGER': '/bin/cat', 07:32:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:34 INFO - 'PWD': '/builds/slave/test', 07:32:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:34 INFO - 'SHELL': '/bin/bash', 07:32:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:34 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:34 INFO - 'USER': 'cltbld', 07:32:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:34 INFO - 'XPC_FLAGS': '0x0', 07:32:34 INFO - 'XPC_SERVICE_NAME': '0', 07:32:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-IkHUN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lUyAKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-WorGkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-94tlXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xrkqsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pp2Jxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-K1A1eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lvE3VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9bjf8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ei3NHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-MP_5Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xd0lbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ieOt9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-16twmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-DjML74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-XEhSIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:35 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)) 07:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:35 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-i40LYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:38 INFO - Downloading blessings-1.6.tar.gz 07:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:32:38 INFO - Installing collected packages: blessings 07:32:38 INFO - Running setup.py install for blessings 07:32:38 INFO - Successfully installed blessings 07:32:38 INFO - Cleaning up... 07:32:38 INFO - Return code: 0 07:32:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:39 INFO - Reading from file tmpfile_stdout 07:32:39 INFO - Current package versions: 07:32:39 INFO - blessings == 1.6 07:32:39 INFO - blobuploader == 1.2.4 07:32:39 INFO - docopt == 0.6.1 07:32:39 INFO - functools32 == 3.2.3-2 07:32:39 INFO - jsonschema == 2.5.1 07:32:39 INFO - manifestparser == 1.1 07:32:39 INFO - mozInstall == 1.12 07:32:39 INFO - mozcrash == 1.0 07:32:39 INFO - mozdebug == 0.1 07:32:39 INFO - mozdevice == 0.49 07:32:39 INFO - mozfile == 1.2 07:32:39 INFO - mozhttpd == 0.7 07:32:39 INFO - mozinfo == 0.9 07:32:39 INFO - mozleak == 0.1 07:32:39 INFO - mozlog == 3.4 07:32:39 INFO - moznetwork == 0.27 07:32:39 INFO - mozprocess == 0.25 07:32:39 INFO - mozprofile == 0.28 07:32:39 INFO - mozrunner == 6.13 07:32:39 INFO - mozscreenshot == 0.1 07:32:39 INFO - mozsystemmonitor == 0.3 07:32:39 INFO - moztest == 0.8 07:32:39 INFO - mozversion == 1.4 07:32:39 INFO - psutil == 3.1.1 07:32:39 INFO - requests == 1.2.3 07:32:39 INFO - wsgiref == 0.1.2 07:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:39 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:39 INFO - 'HOME': '/Users/cltbld', 07:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:39 INFO - 'LOGNAME': 'cltbld', 07:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:39 INFO - 'MOZ_NO_REMOTE': '1', 07:32:39 INFO - 'NO_EM_RESTART': '1', 07:32:39 INFO - 'PAGER': '/bin/cat', 07:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:39 INFO - 'PWD': '/builds/slave/test', 07:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:39 INFO - 'SHELL': '/bin/bash', 07:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:39 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:39 INFO - 'USER': 'cltbld', 07:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:39 INFO - 'XPC_FLAGS': '0x0', 07:32:39 INFO - 'XPC_SERVICE_NAME': '0', 07:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:32:39 INFO - Cleaning up... 07:32:39 INFO - Return code: 0 07:32:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:39 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 0x10d4f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92046f8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, '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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:39 INFO - 'HOME': '/Users/cltbld', 07:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:39 INFO - 'LOGNAME': 'cltbld', 07:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:39 INFO - 'MOZ_NO_REMOTE': '1', 07:32:39 INFO - 'NO_EM_RESTART': '1', 07:32:39 INFO - 'PAGER': '/bin/cat', 07:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:39 INFO - 'PWD': '/builds/slave/test', 07:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:39 INFO - 'SHELL': '/bin/bash', 07:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:32:39 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:39 INFO - 'USER': 'cltbld', 07:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:39 INFO - 'XPC_FLAGS': '0x0', 07:32:39 INFO - 'XPC_SERVICE_NAME': '0', 07:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:32:39 INFO - Cleaning up... 07:32:39 INFO - Return code: 0 07:32:39 INFO - Running post-action listener: _resource_record_post_action 07:32:39 INFO - Running post-action listener: _start_resource_monitoring 07:32:39 INFO - Starting resource monitoring. 07:32:39 INFO - [mozharness: 2017-03-01 15:32:39.832787Z] Finished create-virtualenv step (success) 07:32:39 INFO - [mozharness: 2017-03-01 15:32:39.833819Z] Running install step. 07:32:39 INFO - Running pre-action listener: _resource_record_pre_action 07:32:39 INFO - Running main action method: install 07:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:40 INFO - Reading from file tmpfile_stdout 07:32:40 INFO - Detecting whether we're running mozinstall >=1.0... 07:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:32:40 INFO - Reading from file tmpfile_stdout 07:32:40 INFO - Output received: 07:32:40 INFO - Usage: mozinstall [options] installer 07:32:40 INFO - Options: 07:32:40 INFO - -h, --help show this help message and exit 07:32:40 INFO - -d DEST, --destination=DEST 07:32:40 INFO - Directory to install application into. [default: 07:32:40 INFO - "/builds/slave/test"] 07:32:40 INFO - --app=APP Application being installed. [default: firefox] 07:32:40 INFO - mkdir: /builds/slave/test/build/application 07:32:40 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'] 07:32:40 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 07:33:00 INFO - Reading from file tmpfile_stdout 07:33:00 INFO - Output received: 07:33:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:33:00 INFO - Running post-action listener: _resource_record_post_action 07:33:00 INFO - [mozharness: 2017-03-01 15:33:00.745441Z] Finished install step (success) 07:33:00 INFO - [mozharness: 2017-03-01 15:33:00.745589Z] Running run-tests step. 07:33:00 INFO - Running pre-action listener: _resource_record_pre_action 07:33:00 INFO - Running main action method: run_tests 07:33:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:00 INFO - 2017-03-01 07:33:00.760 screenresolution[1912:25530] starting screenresolution argv=screenresolution get 07:33:00 INFO - 2017-03-01 07:33:00.763 screenresolution[1912:25530] Display 0: 1600x1200x32@60 07:33:00 INFO - 2017-03-01 07:33:00.769 screenresolution[1913:25533] starting screenresolution argv=screenresolution list 07:33:00 INFO - Available Modes on Display 0 07:33:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:00 INFO - Intel Iris: 07:33:00 INFO - Chipset Model: Intel Iris 07:33:00 INFO - Type: GPU 07:33:00 INFO - Bus: Built-In 07:33:00 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:00 INFO - Vendor: Intel (0x8086) 07:33:00 INFO - Device ID: 0x0a2e 07:33:00 INFO - Revision ID: 0x0009 07:33:00 INFO - Displays: 07:33:00 INFO - Display: 07:33:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:01 INFO - Display Serial Number: 1600x1200 60 07:33:01 INFO - Main Display: Yes 07:33:01 INFO - Mirror: Off 07:33:01 INFO - Online: Yes 07:33:01 INFO - Rotation: Supported 07:33:01 INFO - Return code: 0 07:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:01 INFO - Python 2.7.3 07:33:01 INFO - Return code: 0 07:33:01 INFO - grabbing minidump binary from tooltool 07:33: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')]} 07:33:01 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 0x10d2d1d30>, '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 0x10d1f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2c6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:33:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:33:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:33:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:01 INFO - Return code: 0 07:33:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:33:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:01 INFO - ENV: RUST_BACKTRACE is now 1 07:33:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:33:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFqTxxOaZ1/Render', 07:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:01 INFO - 'HOME': '/Users/cltbld', 07:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:01 INFO - 'LOGNAME': 'cltbld', 07:33:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:01 INFO - 'MOZ_NO_REMOTE': '1', 07:33:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:01 INFO - 'NO_EM_RESTART': '1', 07:33:01 INFO - 'PAGER': '/bin/cat', 07:33:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:01 INFO - 'PWD': '/builds/slave/test', 07:33:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:01 INFO - 'RUST_BACKTRACE': '1', 07:33:01 INFO - 'SHELL': '/bin/bash', 07:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u8AI1AwPTj/Listeners', 07:33:01 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 07:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:01 INFO - 'USER': 'cltbld', 07:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:01 INFO - 'XPC_FLAGS': '0x0', 07:33:01 INFO - 'XPC_SERVICE_NAME': '0', 07:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:33:01 INFO - mozversion application_buildid: 20170301024203 07:33:01 INFO - mozversion application_changeset: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 07:33:01 INFO - mozversion application_display_name: Nightly 07:33:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:01 INFO - mozversion application_name: Firefox 07:33:01 INFO - mozversion application_remotingname: firefox 07:33:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:33:01 INFO - mozversion application_vendor: Mozilla 07:33:01 INFO - mozversion application_version: 54.0a1 07:33:01 INFO - mozversion platform_buildid: 20170301024203 07:33:01 INFO - mozversion platform_changeset: 34c6c2f302e7b48e3ad2cec575cbd34d423a9d32 07:33:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:33:01 INFO - mozversion platform_version: 54.0a1 07:33:01 INFO - using testdate: 1488382381 07:33:01 INFO - actual date: 1488382381 07:33:01 INFO - starting webserver on 'localhost:57192' 07:33:01 INFO - SUITE-START | Running 2 tests 07:33:01 INFO - TEST-START | dromaeo_css 07:33:01 INFO - operating with platform_type : mac_ 07:33:01 INFO - Initialising browser for dromaeo_css test... 07:33:01 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpHj2i_G/profile http://localhost:57192/getInfo.html) 07:33:01 INFO - PROCESS | 1923 | 1488382381884 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:33:01 INFO - PROCESS | 1923 | 1488382381885 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:33:01 INFO - PROCESS | 1923 | 1488382381926 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:33:03 INFO - PROCESS | 1923 | __metrics Screen width/height:1600/1200 07:33:03 INFO - PROCESS | 1923 | colorDepth:24 07:33:03 INFO - PROCESS | 1923 | Browser inner width/height: 1024/689 07:33:03 INFO - PROCESS | 1923 | __metrics 07:33:03 INFO - PROCESS | 1923 | 1488382383720 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:33:03 INFO - PROCESS | 1923 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:33:03 INFO - PROCESS | 1923 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:33:04 INFO - TEST-INFO | 1923: exit 0 07:33:04 INFO - Browser initialized. 07:33:04 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:04 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpHj2i_G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:04 INFO - PROCESS | 1925 | 1488382384840 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:33:04 INFO - PROCESS | 1925 | 1488382384841 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:33:16 INFO - PROCESS | 1925 | RSS: Main: 230952960 07:33:16 INFO - PROCESS | 1925 | 07:36:20 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:57192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57192/tests/dromaeo/cssquery-ext.html) 07:36:23 INFO - PROCESS | 1925 | RSS: Main: 489119744 07:36:23 INFO - PROCESS | 1925 | 07:38:06 INFO - PROCESS | 1925 | ************************* 07:38:06 INFO - PROCESS | 1925 | A coding exception was thrown and uncaught in a Task. 07:38:06 INFO - PROCESS | 1925 | 07:38:06 ERROR - PROCESS | 1925 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:38:06 INFO - PROCESS | 1925 | Full stack: 07:38:06 INFO - PROCESS | 1925 | ************************* 07:39:26 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:57192/tests/dromaeo/cssquery-ext.html (next: http://localhost:57192/tests/dromaeo/cssquery-jquery.html) 07:39:27 INFO - PROCESS | 1925 | RSS: Main: 364019712 07:39:27 INFO - PROCESS | 1925 | 07:42:30 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:57192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57192/tests/dromaeo/cssquery-mootools.html) 07:42:30 INFO - PROCESS | 1925 | RSS: Main: 344821760 07:42:30 INFO - PROCESS | 1925 | 07:45:33 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:57192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57192/tests/dromaeo/cssquery-prototype.html) 07:45:33 INFO - PROCESS | 1925 | RSS: Main: 355979264 07:45:33 INFO - PROCESS | 1925 | 07:48:37 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:57192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57192/tests/dromaeo/cssquery-yui.html) 07:48:38 INFO - PROCESS | 1925 | RSS: Main: 333619200 07:48:38 INFO - PROCESS | 1925 | 07:51:41 INFO - PROCESS | 1925 | Cycle 1(1): loaded http://localhost:57192/tests/dromaeo/cssquery-yui.html (next: http://localhost:57192/tests/dromaeo/cssquery-dojo.html) 07:51:42 INFO - PROCESS | 1925 | RSS: Main: 394072064 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | __start_tp_report 07:51:42 INFO - PROCESS | 1925 | _x_x_mozilla_page_load 07:51:42 INFO - PROCESS | 1925 | _x_x_mozilla_page_load_details 07:51:42 INFO - PROCESS | 1925 | |i|pagename|runs| 07:51:42 INFO - PROCESS | 1925 | |0;dojo.html;3240.9513857292136;3318.917027074323;3325.517799919012;3336.399448099341;3385.475251336042;5612.607117501777;5681.431856814316;5775.537956963443;5784.710764461776;5825.475707186352;5677.977963966485;5735.053716136832;5741.0240259155935;5751.827445176651;5752.856178595527;4356.368326592658;5098.082345177876;5218.660787048849;5254.185601231815;5273.973630131844;5301;5305.310309659739;5309.33633295838;5313.521783039526;5323.760430780605;5307.708076055816;5319.122344813101;5322.494363035506;5328.92006619901;5330.01394741972;5289.576833853283;5314.867128321785;5317;5318.9202161967405;5321.760520776575;5152.072626927152;5248;5267.631265811395;5271.4992075753125;5272.420033796279;5821.7380217890295;5904.822855314347;5938.851528711817;5940.910886336708;5952.077427998667;6212.689365531705;6228.314885362606;6229.3459186785185;6236.064590311445;6265.530085243625;6163.229596300463;6166.07508873668;6196.349383314777;6202.565820392574;6240.812775616739;5983.252093488314;5992.940070599282;5995.880082398327;6001.969990150022;6043.939560604382;6377.234731832117;6412;6418.518611104186;6424.71088801005;6432.549721519542;6070.180525628984;6091.360407157274;6096.055111457731;6227.439530442191;6227.875442491216;6213.5339849511465;6222.657753823583;6229.501639868799;6231.3145553989025;6237.844053898598;6119.632822030692;6201.782937597162;6205.968970155121;6217.533684973645;6217.658028808459;6144.095330447575;6217.036359364306;6220.377962203744;6226.315105338409;6226.937730622636;5034.89930201394;5053.823116190915;5110.003549307849;5118;5121.590272778169;4386.824527018884;4406.49325327585;4420.602145806893;4434.224010798098;4532.5694059064335;5773.797917072966;5810.6054546908435;5935.6735379553675;6017.308009578867;6038.486728628028;5299.364076310867;6302.873942521124;6302.936970630327;6321.083442900754;6331.841703957346;5735.426457354231;5782.2194003808945;5792.304923409133;6002.249718785152;6011.278646562353;5489.1217405214975;5525.364583072998;5539.889202215933;5569.415211402745;5637.661740295595;6497.967510162419;6517.348265173445;6531.020346947996;6533.18335208099;6540.640264785482;6104.48947159306;6281.089242059968;6308.179936608211;6314.55798094129;6317.241930968313;6239.032949892774;6276.246850377984;6345.650989195638;6361.363863613602;6374.107624932421;6168.907466388097;6176.166217560752;6176.4441200292185;6189.1954045975535;6189.6286222826775;6089.086637004485;6274.6548939808745;6284.465820405317;6286;6290.9056364155485;6197.194364732556;6200.81397558074;6210.658413787285;6212.565120441525;6229.96885015572;6108.205933228652;6197.442230199304;6200.782972596118;6219.40915613016;6227.875442491034;4973.204287314013;5890.764369425175;5895.616784908967;5951.613145145551;5954.345022047484;6102.237220347457;6121.938780612137;6127.264728232641;6129.3564175762685;6141.263048434038;5924.407559244041;5937.3468918418075;5943.613665111754;5945.881082378415;5949.286085669747 07:51:42 INFO - PROCESS | 1925 | |1;ext.html;744.8063503489093;766.750805988054;836.8075342671185;852.1052894460814;855.208931738142;22428.775712242874;26041.47917041658;27139.728602713967;27153.45693086137;36778.44832327517;36519.81740091302;38021.619783802154;38049;38129.80935095328;38185.809070954674;8729.738107856774;8857.95571022144;8858.73423797287;8862.379633425662;8877.201051905327;7172.246914074025;7352.264773522658;8825.249853762405;8946.776330591754;8961.014288428267;7298.124225092996;7320.04839370881;7370.373518250955;10529.684109476728;10776.461176941122;10639.148868090573;10686.305390149693;10691.946540267249;10692.144628429707;10711.357318560833;10480.58077676892;10556.313839600401;10563.41901195434;10564.78870422595;10574.78850422995;25858.87070564654;26218.34454138643;26260.343491412677;36526.26947461036;36577.81711091428;3063;3732.3654978653694;3755.661990420875;3767.095896984704;3943.1719338938856;22174.88912555427;26066.34834129162;26542.86728566364;26594.468110637677;27497.17508474749;3032.7725420593542;3034.5296479045564;3063.55578441127;3088.5830412894197;3171.127939816569;309970.99999999773;313251;313909.43045284855;314409;314823;48087.75956120197;48154;48204.758976205594;48266.5173348269;48291.758541207775;40310.79844600817;41098.589014110075;41260.79369603133;42944;49622.50377496251;11775.646730598095;12039.337836418907;13055.673608159683;13234.007449441331;13243.337833108306;11361.204715669988;11438.199326047263;11443;11448.94275528617;11481.024112950492;11526.88473115275;11533.653990380302;11574.305541667358;11638.301701897914;11676.474558644712;5364.195370694349;5424.430434804368;5446.8910621787345;5460.836174914759;5467.644603100785;828.9626966786509;904.7738065483497;908.1599520443564;940.8259471997702;943.9811203775886;26336.473270534483;26765.464690706078;26995.481927710873;27201;27444.313892152455;968.5157421289356;994.980145351021;995.9900400996042;1010.2625083688948;1022.0801278849095;12163.391830408444;13810.309484525733;14014.719705606034;14189.36147873348;14211.43154273838;395386;397426;397485;397637;398217;52485;52530.73734631302;52609.73695131576;52619;52834;1367.8153449284218;1419.5457453614952;1425.9714805704036;1426.0873041253606;1427.6716355238354;24723;25929;26148.477030458904;26260;26421.33946651349;42827.143457130056;42972;42986;43004.784976074916;43088.78455607702;385127;386327;386646;386904;387013;25508.872455638346;26625.733742663102;27038.45923081488;29940.401191976474;32330.83834580812;40117;41239.587604123575;42115.7894210527;42322;42449;31890.20274493156;33808.66191338153;34698;35914.4612830813;36024.27951441009;34536.65463345334;34538.309233815686;35577.82211088928;35644;35819.28361432809;33983.49024764581;35096.29807403889;35267.52072343599;35324.646753532135;35779.10552236111;25807.483850323264;29236.415271694874;30749.406511277808;30805.508019261648;31164.909228176904;23172.884135579214;23363.700975641164;23547;23675.52648946977;23684.407889802205 07:51:42 INFO - PROCESS | 1925 | |2;jquery.html;375.472461192025;390.49820980040636;405.21590721953015;412.7440986588315;431.99992018477224;12403;14293.785593216096;15452.227388630567;20187;20621.896890515527;21695.240666576672;22130.44673883154;22200.444988875286;22282.108715651397;22406.77593224067;6535.640539770311;6567.179102612174;6724.966375168117;6811.046453496489;6881.449484041264;6538.771143009995;6685.4985876059245;6773.221079575838;6791.354821291994;6792.422644075259;5864.208331875185;6713.664316784166;6744.291849355821;6749.561278516905;6778.22050464198;6456.838579035515;6676.399124078856;6677.565958212701;6760.3577660122455;6769.153855768029;6389.520785941027;6534.803955881332;6546.639934803584;6553.541252112354;6557.311482294338;19606.80393196064;25319;25718.6142207867;25770.742292577022;25996.960121595304;2843.4881721290158;2845.089571337173;2848.7863410244313;2850.6721727001245;2861.2131663792625;14288.928330375264;14924.776128358084;15354.616134596612;16081.961813699556;16108;1930.540451556908;1935.0324837581209;1942.2134035715558;1953.5213872601162;1967.163955318998;126730;130584;131169.34415327862;131623;132767.33616331953;19108.2356705733;20084.89957550203;20508.897455512626;20684.482887927923;20997;32511.674883250864;32607.836960815042;32688.673113268564;32706.509402358985;32767.18082047968;9843.655472058443;9982.900170998197;10179.440130792878;10244.231682623833;10406.427646479517;8249.917500825035;8283.50298982063;8298.70954516589;8464.492130472192;8479.660813567389;9355.532223388804;9452.57463414148;9499.952500237454;9578.808423831484;9605.711828645151;3828.444875493038;3887.4363217333894;3888.494495715539;3916.3146449371247;3927.351986922183;875.9693410730594;965.5510187762584;1021.443313394187;1030.125172186613;1039.2413538117066;20761.58476830455;21651.35045948624;21912.52293327113;22023.889880550494;22029.559408812056;969.3892847506027;989.4360214677565;991.5360329580985;1021.4739409204266;1027.3579013116803;9284.7678808029;11294.661160165044;11422.31466112036;11455.59905403307;11461.54153833854;667410;667431;690939;698290;699823;85598;102657;103872.96127038784;105736;122478;906.6962567539816;950.9334346595672;1057.4025675493322;1059.3379138038727;1061.4109169410897;20178.192872284944;20491.692624610343;20646.17415303431;20683.68974465354;20695.68956465624;48433.27350089822;51743;51836.48163518317;52298;52658.21012684736;77294;78284;79277.8108328387;79617.60191199007;82668;10581;11349.659510214708;11534.653960381202;11672.591459298883;11780.352080635646;12753.362331883554;12797.744045119232;13114.934425327812;13132.146410483288;13188;10028.247881408777;10179.592816287266;10403.219758518293;10507.422091785025;10524.210684198562;8572.485650860719;10226.437545935045;10925.453727313761;10976.286541374786;11347;11078.446077696244;11444.771104578029;11529.711757206136;11643.41782910834;11650.941745291559;11400.543978241109;11776.52893884235;11812.586559470721;11817.468213930566;11926.912790261496;9442.905570944202;11301.434928253719;11328.263662861887;11330.03694685928;11661.941690291495 07:51:42 INFO - PROCESS | 1925 | |3;mootools.html;1417.6668482906516;1534.3785766764458;1541.5914782582624;1551.8991265567745;1571.748520236762;10192.898071019288;10701.83947240791;10721.98141176587;10729.356238625687;10735.51690173942;8484.703035393763;10486.737831554196;10490.108340791043;10614;10649.840252396201;1934.8839069655796;1959.4905324615631;2286.5198308355266;2289.370423133635;2342.8360014798886;2294.19703103914;2321.245595181564;2331.5453486570127;2335.5095429959642;2336.8130549555995;2285.3029825903095;2287.0508738873345;2310.260716570698;2315.583195024895;2317.2700599311165;2219.567184399035;2271.193726227182;2293.3693234360517;2296.1159953417887;2297.310806757966;2247.0786977339376;2318.0065143976167;2318.026428899866;2322.9430609072833;2324.697789287399;10526.894731052667;10641.361518308926;10641.893581064167;10648.946755266252;10661.360318380923;5519.69641669708;5712.200291959129;5714.599978001542;5726.083826587767;5727.3699893011735;3230.9030729078167;3233.7089661930304;3303.719183869374;3319.369319829225;3583.6953858922025;1202.789511835434;1206.541514224589;1737.9478615641551;1755.727862181364;1835.7429959805638;12957.805632915513;13084.869151308556;13331.66670833237;14579.70840583193;14753.77869331961;3874.2251549690177;4205.642520385741;4645.721256724607;4646.163690535668;4656.41794775653;11327.830082548768;11339.716507087389;11348.31910085381;11374.658760237206;11410.885891141148;5581.134924086773;5588.30146231721;5589.916151257735;5590.91613625796;5598.412166722517;4819.228923372314;5068.986202759389;5073.086844368049;5169.870753231199;5170;3565;3656.8171591420323;3746.7751934883995;3746.9063273417837;3828.406596977473;881.3786280672239;1007.1992765751245;1008.8587597736323;1013.5439052426437;1027.111548510548;758.3364556013488;766.2299389113905;887.4320434921656;889.6263569300909;939.8355287824603;5860.824175274749;6148.477379422709;6343.429091381798;6362.6500542469685;6445.033245013192;978.283113136441;985.7535616095976;989.3272574649163;1043.666026871409;1090.465671820802;3821.2739579479808;3977.284088864032;3990.6009399059863;4088.364654138309;4108.623611090258;12398.62804115878;13088.541901033419;13096.214227146402;13103.60689179326;13130.540431084866;12649.873501265054;12679.746405072032;12862;12984.350782461028;13046.869531304756;8358.373122015873;8651.221390074923;8681.696140635173;8727.738167854848;8757.255633271243;5502.669839809624;6265.903466893366;6381.521385896169;6587.341265873374;6617.536772425884;11232.494537745984;11518.424078795859;11573.421328933351;11645.301281923112;11754.823677645014;10963.945180274048;11853.466594003117;12009.279443233434;12034.398280085785;12228.816567751668;7877.291043806085;8075.959620202097;8123.3501319893085;8134.67461301565;8167.3466122711225;9622.47076410804;9693.9030609693;9729.173020293354;9788.265880058882;9810.85283720759;7884.491401326584;8640.740777776677;8641.438306510057;8759.693410730593;9055.728328150166;8281.503109813431;8614.44006139599;8630;8639;8691.217790398894;7338.889916651147;7353;7358.742444014434;7432.2567743225245;7446.106467223751;4900.966099068846;5317.8404647860625;5471;5484.698341591251;5497.202905578589;5389.380221274447;5575.888482230252;5670.404607516316;5715.571332150189;5727.971360143172 07:51:42 INFO - PROCESS | 1925 | |4;prototype.html;359.86864794350055;366.7817648499143;377.72048683973867;380.13329608492637;381.40881633468155;4552.385427967223;4702.601673146694;4757.9286310705365;5145.202493613487;5395.271638328824;4437.800298986545;4873.5126487351245;5041.873953151173;5062.822801201959;5213.061648903196;3882.3594106972314;4121.443605113302;4471.955280447187;4514.593686568208;4550.567696068884;3793.60167182446;4404.339349097645;4523.751193684346;4552.544745525454;4607.608353289957;3726.1555530012683;4229.175310814392;4501.549845015488;4509.075639493913;4535.977320113411;3871;4445.5776701213335;4531.365608814768;4542.772861356919;4558.316252562109;4143.410368519675;4256.2551553478015;4360.302351623725;4370.715903466296;4376.496702879146;4271.893202669927;4541.977290113561;4685.765711714401;4762.166620841339;5039.949600503985;4996.875078123039;5050.7222102784335;5051.191809310492;5052.797888084472;5052.913623570913;4770.499097594738;4883.656994326553;5184.507471790174;5553.444655534414;5577.2191893135;3379.2565635560136;3716.535433070866;4325.891852703676;4407.382966384709;4412.4705035395955;5045.823396181153;5277.572316734307;5492.418563275254;5543.334799824047;5606.971965140148;3897.922041559153;4354.542773008852;4588.839390621312;4628.274239237447;4639.652026097989;3824.617538246209;4310.663694254791;4586.747728874877;4591.816327346869;4627.079761898774;4741.415928319075;4900.485449027872;4927.546373819731;4953.8018479261145;5033.464793238098;4886.511348865085;5100.48995100487;5496.890062198733;5547.559074007424;5592.5246354059545;1001.47923079998;1322.0956855577676;1322.8412590489204;1403.5228022472409;1491.3661693780316;1032.2516175772505;1089.9972025736342;1115.8605174353206;1132.314949455584;1140.6064907606863;4396.626286765597;4436.600705936481;4809.807607695653;4887.169181239198;4890.459505255833;4487.237169681162;4717.056588682277;5016.372953380827;5161.66449180802;5420.642020720999;4173.7078404512;4262.403263543107;4593.517680643551;4594.035252596992;4871.488493708181;2485.2295788305682;2718.3747738020365;2755.2698534888273;2765.6819465761696;2812.831230126199;5169.914317993188;5622.94762411725;5634.4786907534735;5678.3186017678145;5688.63023903445;4588.9541104588525;5092.337996060563;5554.250176226158;5607.682194684246;5665.931934843752;5303.575713942875;5310.592692936375;5597.272354593877;5661.264035675418;5732.57005724564;4788.497207793132;5125.589952803842;5330.840074797762;5341.385740639721;5476.561875049907;5000.474950130184;5150.253213283978;5246.396664383645;5331.733413329395;5339.599530035185;5347.812826551052;5563.693996830213;5608.495235428831;5614.466625670555;5667.546596272371;3971.960280397159;4322.675799315127;4353.934690979574;4354.346847972829;4356.673249506236;4727.879599464474;4885.682430641997;5277.672308706977;5402.459754024566;5478.397376288684;5119.769610367468;5155.149400349051;5285.524302812765;5467.4532546745;5556.305461817273;4517.593416592523;4840.273958906192;4904.239842824368;4987.376577927759;5509.732761464806;4954.950450495449;4987.700737955734;5387.919181212364;5449.155380915964;5453.15476101205;4416.734995900256;5524.640898341595;5533.78648540587;5543.695096769717;5587.832365029056;4369.497507786646;4647.909839341358;4653;5269.367675878919;5370.543503802221 07:51:42 INFO - PROCESS | 1925 | |5;yui.html;697.6720941157654;734.4711807498602;756.4931495897748;809.7854068671801;814.4624547798452;14401;14977;14980.400783968627;15014.099154050751;15062.623434414145;13515.594532164027;13585.932070339635;13587.184768913872;13591.796123058137;13604.979626528;926.1618235496852;938.8075444533854;962.3359881681653;973.0026722609311;974.5809302000137;947.2564037230775;961.1205746741758;964.5514835601444;964.7105868239535;967.2503809547621;1001.6594357918307;1001.849722541621;1002.503760638485;1002.6340385759182;1002.7593377589362;991.4447909170888;993.1558175550796;995.2286977592424;997.1922742578535;1001.7095042437684;740.0009986518211;740.2301606329411;740.359588955555;741.158784779274;741.6477173342619;15102;15281.770773438408;15404.614884627861;15431.3827446902;15463.458778942682;11785;13939.09395889264;14096.224707641075;14168.716625667428;14192.50326238587;11444.771104577945;11565.363904985223;11615.529738854153;11841.171118021743;12177.695557611041;3595.7123430125525;3616.222512159872;3678.1907980244305;3698.3527882620433;3788.8105594720428;94031.11937761275;107404;107567;107990;109778;10493.895061049445;10530.071052709807;10618.787624247472;10620.575176992988;10920.890791091988;21850.344489665335;22301.553968920532;22301.665475017886;22309.888450557642;22330.441738956655;7369.189389167187;7437;7466.25337466249;7651.885221721679;7659.119201291923;3646;4040.3535434330365;4167.39537788882;4224.5353011168745;4270.530241673413;3324.750643701732;3396;3418.5897692277085;3428.057284246852;3438.535797667333;527.2855281094139;527.3539913605803;530.1252932661063;533.1549494051893;535.5501378841792;650.4731167754135;663.667432182412;679.3715812873072;689.1041645860362;692.4356649330779;9754.664169812562;9759.9024009759;9802.803943921082;9929.453880036523;10003.599856005678;652.5823472977298;677.1197443323758;678.782789507353;686.9965650171818;698.1622053535777;3848.4804551385764;4668.206404911173;4683.578477936934;4684.81260749573;4692.976535117371;88932.6660100099;91319.71700707402;109456;110710.44644776724;113093;75039.24960750322;75984.24015759882;78546;80737.19262807297;85634;72744.58486004095;73726;75882.62058689671;77506.83739743795;79122;8960.910390896008;10182.195629500551;10265.538050787583;10272.229582781172;10371.429571373646;46862.29706554336;47073.76463117662;48795.75602121967;50358.49641503538;51034;48922;64989;67382.66308668621;69897;70108;12036.338001410006;12309.507619695112;12330.938345308216;12657.936710316759;13043.608691739262;13353.66615834612;13578;13644.727105458034;13825.654358641115;14277.500287489887;12778.488860445477;13069.803952940523;13165.736685266433;13514.93242533781;13925.23411212393;12762.553310634083;12868.871311286768;12877;13026.4138113787;13279.867201327863;12476.875231247934;12704.793044660742;12851.293178874877;12862.742745145231;13383.598492045254;9478.620855165716;10485.318454300446;11165.944170279097;11189.38458384764;11469.598564050219;10488.318259313426;10506.579736810441;10555.472226388803;10584.047435730821;10665.41340226295 07:51:42 INFO - PROCESS | 1925 | __end_tp_report 07:51:42 INFO - PROCESS | 1925 | __start_cc_report 07:51:42 INFO - PROCESS | 1925 | _x_x_mozilla_cycle_collect,3252 07:51:42 INFO - PROCESS | 1925 | __end_cc_report 07:51:42 INFO - PROCESS | 1925 | __startTimestamp1488383502245__endTimestamp 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | ------- Summary: start ------- 07:51:42 INFO - PROCESS | 1925 | Number of tests: 6 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | [#0] dojo.html Cycles:165 Average:5795.20 Median:6011.28 stddev:653.04 (10.9%) stddev-sans-first:623.55 07:51:42 INFO - PROCESS | 1925 | Values: 3241.0 3318.9 3325.5 3336.4 3385.5 5612.6 5681.4 5775.5 5784.7 5825.5 5678.0 5735.1 5741.0 5751.8 5752.9 4356.4 5098.1 5218.7 5254.2 5274.0 5301.0 5305.3 5309.3 5313.5 5323.8 5307.7 5319.1 5322.5 5328.9 5330.0 5289.6 5314.9 5317.0 5318.9 5321.8 5152.1 5248.0 5267.6 5271.5 5272.4 5821.7 5904.8 5938.9 5940.9 5952.1 6212.7 6228.3 6229.3 6236.1 6265.5 6163.2 6166.1 6196.3 6202.6 6240.8 5983.3 5992.9 5995.9 6002.0 6043.9 6377.2 6412.0 6418.5 6424.7 6432.5 6070.2 6091.4 6096.1 6227.4 6227.9 6213.5 6222.7 6229.5 6231.3 6237.8 6119.6 6201.8 6206.0 6217.5 6217.7 6144.1 6217.0 6220.4 6226.3 6226.9 5034.9 5053.8 5110.0 5118.0 5121.6 4386.8 4406.5 4420.6 4434.2 4532.6 5773.8 5810.6 5935.7 6017.3 6038.5 5299.4 6302.9 6302.9 6321.1 6331.8 5735.4 5782.2 5792.3 6002.2 6011.3 5489.1 5525.4 5539.9 5569.4 5637.7 6498.0 6517.3 6531.0 6533.2 6540.6 6104.5 6281.1 6308.2 6314.6 6317.2 6239.0 6276.2 6345.7 6361.4 6374.1 6168.9 6176.2 6176.4 6189.2 6189.6 6089.1 6274.7 6284.5 6286.0 6290.9 6197.2 6200.8 6210.7 6212.6 6230.0 6108.2 6197.4 6200.8 6219.4 6227.9 4973.2 5890.8 5895.6 5951.6 5954.3 6102.2 6121.9 6127.3 6129.4 6141.3 5924.4 5937.3 5943.6 5945.9 5949.3 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | [#1] ext.html Cycles:180 Average:49965.18 Median:34537.48 stddev:97190.23 (281.4%) stddev-sans-first:97392.61 07:51:42 INFO - PROCESS | 1925 | Values: 744.8 766.8 836.8 852.1 855.2 22428.8 26041.5 27139.7 27153.5 36778.4 36519.8 38021.6 38049.0 38129.8 38185.8 8729.7 8858.0 8858.7 8862.4 8877.2 7172.2 7352.3 8825.2 8946.8 8961.0 7298.1 7320.0 7370.4 10529.7 10776.5 10639.1 10686.3 10691.9 10692.1 10711.4 10480.6 10556.3 10563.4 10564.8 10574.8 25858.9 26218.3 26260.3 36526.3 36577.8 3063.0 3732.4 3755.7 3767.1 3943.2 22174.9 26066.3 26542.9 26594.5 27497.2 3032.8 3034.5 3063.6 3088.6 3171.1 309971.0 313251.0 313909.4 314409.0 314823.0 48087.8 48154.0 48204.8 48266.5 48291.8 40310.8 41098.6 41260.8 42944.0 49622.5 11775.6 12039.3 13055.7 13234.0 13243.3 11361.2 11438.2 11443.0 11448.9 11481.0 11526.9 11533.7 11574.3 11638.3 11676.5 5364.2 5424.4 5446.9 5460.8 5467.6 829.0 904.8 908.2 940.8 944.0 26336.5 26765.5 26995.5 27201.0 27444.3 968.5 995.0 996.0 1010.3 1022.1 12163.4 13810.3 14014.7 14189.4 14211.4 395386.0 397426.0 397485.0 397637.0 398217.0 52485.0 52530.7 52609.7 52619.0 52834.0 1367.8 1419.5 1426.0 1426.1 1427.7 24723.0 25929.0 26148.5 26260.0 26421.3 42827.1 42972.0 42986.0 43004.8 43088.8 385127.0 386327.0 386646.0 386904.0 387013.0 25508.9 26625.7 27038.5 29940.4 32330.8 40117.0 41239.6 42115.8 42322.0 42449.0 31890.2 33808.7 34698.0 35914.5 36024.3 34536.7 34538.3 35577.8 35644.0 35819.3 33983.5 35096.3 35267.5 35324.6 35779.1 25807.5 29236.4 30749.4 30805.5 31164.9 23172.9 23363.7 23547.0 23675.5 23684.4 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | [#2] jquery.html Cycles:180 Average:38542.61 Median:22241.28 stddev:113126.98 (508.6%) stddev-sans-first:113408.03 07:51:42 INFO - PROCESS | 1925 | Values: 375.5 390.5 405.2 412.7 432.0 12403.0 14293.8 15452.2 20187.0 20621.9 21695.2 22130.4 22200.4 22282.1 22406.8 6535.6 6567.2 6725.0 6811.0 6881.4 6538.8 6685.5 6773.2 6791.4 6792.4 5864.2 6713.7 6744.3 6749.6 6778.2 6456.8 6676.4 6677.6 6760.4 6769.2 6389.5 6534.8 6546.6 6553.5 6557.3 19606.8 25319.0 25718.6 25770.7 25997.0 2843.5 2845.1 2848.8 2850.7 2861.2 14288.9 14924.8 15354.6 16082.0 16108.0 1930.5 1935.0 1942.2 1953.5 1967.2 126730.0 130584.0 131169.3 131623.0 132767.3 19108.2 20084.9 20508.9 20684.5 20997.0 32511.7 32607.8 32688.7 32706.5 32767.2 9843.7 9982.9 10179.4 10244.2 10406.4 8249.9 8283.5 8298.7 8464.5 8479.7 9355.5 9452.6 9500.0 9578.8 9605.7 3828.4 3887.4 3888.5 3916.3 3927.4 876.0 965.6 1021.4 1030.1 1039.2 20761.6 21651.4 21912.5 22023.9 22029.6 969.4 989.4 991.5 1021.5 1027.4 9284.8 11294.7 11422.3 11455.6 11461.5 667410.0 667431.0 690939.0 698290.0 699823.0 85598.0 102657.0 103873.0 105736.0 122478.0 906.7 950.9 1057.4 1059.3 1061.4 20178.2 20491.7 20646.2 20683.7 20695.7 48433.3 51743.0 51836.5 52298.0 52658.2 77294.0 78284.0 79277.8 79617.6 82668.0 10581.0 11349.7 11534.7 11672.6 11780.4 12753.4 12797.7 13114.9 13132.1 13188.0 10028.2 10179.6 10403.2 10507.4 10524.2 8572.5 10226.4 10925.5 10976.3 11347.0 11078.4 11444.8 11529.7 11643.4 11650.9 11400.5 11776.5 11812.6 11817.5 11926.9 9442.9 11301.4 11328.3 11330.0 11661.9 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | [#3] mootools.html Cycles:180 Average:6366.02 Median:3620.26 stddev:3930.49 (108.6%) stddev-sans-first:3923.93 07:51:42 INFO - PROCESS | 1925 | Values: 1417.7 1534.4 1541.6 1551.9 1571.7 10192.9 10701.8 10722.0 10729.4 10735.5 8484.7 10486.7 10490.1 10614.0 10649.8 1934.9 1959.5 2286.5 2289.4 2342.8 2294.2 2321.2 2331.5 2335.5 2336.8 2285.3 2287.1 2310.3 2315.6 2317.3 2219.6 2271.2 2293.4 2296.1 2297.3 2247.1 2318.0 2318.0 2322.9 2324.7 10526.9 10641.4 10641.9 10648.9 10661.4 5519.7 5712.2 5714.6 5726.1 5727.4 3230.9 3233.7 3303.7 3319.4 3583.7 1202.8 1206.5 1737.9 1755.7 1835.7 12957.8 13084.9 13331.7 14579.7 14753.8 3874.2 4205.6 4645.7 4646.2 4656.4 11327.8 11339.7 11348.3 11374.7 11410.9 5581.1 5588.3 5589.9 5590.9 5598.4 4819.2 5069.0 5073.1 5169.9 5170.0 3565.0 3656.8 3746.8 3746.9 3828.4 881.4 1007.2 1008.9 1013.5 1027.1 758.3 766.2 887.4 889.6 939.8 5860.8 6148.5 6343.4 6362.7 6445.0 978.3 985.8 989.3 1043.7 1090.5 3821.3 3977.3 3990.6 4088.4 4108.6 12398.6 13088.5 13096.2 13103.6 13130.5 12649.9 12679.7 12862.0 12984.4 13046.9 8358.4 8651.2 8681.7 8727.7 8757.3 5502.7 6265.9 6381.5 6587.3 6617.5 11232.5 11518.4 11573.4 11645.3 11754.8 10963.9 11853.5 12009.3 12034.4 12228.8 7877.3 8076.0 8123.4 8134.7 8167.3 9622.5 9693.9 9729.2 9788.3 9810.9 7884.5 8640.7 8641.4 8759.7 9055.7 8281.5 8614.4 8630.0 8639.0 8691.2 7338.9 7353.0 7358.7 7432.3 7446.1 4901.0 5317.8 5471.0 5484.7 5497.2 5389.4 5575.9 5670.4 5715.6 5728.0 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | [#4] prototype.html Cycles:180 Average:4500.66 Median:4799.15 stddev:1244.43 (25.9%) stddev-sans-first:1208.48 07:51:42 INFO - PROCESS | 1925 | Values: 359.9 366.8 377.7 380.1 381.4 4552.4 4702.6 4757.9 5145.2 5395.3 4437.8 4873.5 5041.9 5062.8 5213.1 3882.4 4121.4 4472.0 4514.6 4550.6 3793.6 4404.3 4523.8 4552.5 4607.6 3726.2 4229.2 4501.5 4509.1 4536.0 3871.0 4445.6 4531.4 4542.8 4558.3 4143.4 4256.3 4360.3 4370.7 4376.5 4271.9 4542.0 4685.8 4762.2 5039.9 4996.9 5050.7 5051.2 5052.8 5052.9 4770.5 4883.7 5184.5 5553.4 5577.2 3379.3 3716.5 4325.9 4407.4 4412.5 5045.8 5277.6 5492.4 5543.3 5607.0 3897.9 4354.5 4588.8 4628.3 4639.7 3824.6 4310.7 4586.7 4591.8 4627.1 4741.4 4900.5 4927.5 4953.8 5033.5 4886.5 5100.5 5496.9 5547.6 5592.5 1001.5 1322.1 1322.8 1403.5 1491.4 1032.3 1090.0 1115.9 1132.3 1140.6 4396.6 4436.6 4809.8 4887.2 4890.5 4487.2 4717.1 5016.4 5161.7 5420.6 4173.7 4262.4 4593.5 4594.0 4871.5 2485.2 2718.4 2755.3 2765.7 2812.8 5169.9 5622.9 5634.5 5678.3 5688.6 4589.0 5092.3 5554.3 5607.7 5665.9 5303.6 5310.6 5597.3 5661.3 5732.6 4788.5 5125.6 5330.8 5341.4 5476.6 5000.5 5150.3 5246.4 5331.7 5339.6 5347.8 5563.7 5608.5 5614.5 5667.5 3972.0 4322.7 4353.9 4354.3 4356.7 4727.9 4885.7 5277.7 5402.5 5478.4 5119.8 5155.1 5285.5 5467.5 5556.3 4517.6 4840.3 4904.2 4987.4 5509.7 4955.0 4987.7 5387.9 5449.2 5453.2 4416.7 5524.6 5533.8 5543.7 5587.8 4369.5 4647.9 4653.0 5269.4 5370.5 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | [#5] yui.html Cycles:180 Average:19864.64 Median:3433.30 stddev:28546.35 (831.5%) stddev-sans-first:28590.15 07:51:42 INFO - PROCESS | 1925 | Values: 697.7 734.5 756.5 809.8 814.5 14401.0 14977.0 14980.4 15014.1 15062.6 13515.6 13585.9 13587.2 13591.8 13605.0 926.2 938.8 962.3 973.0 974.6 947.3 961.1 964.6 964.7 967.3 1001.7 1001.8 1002.5 1002.6 1002.8 991.4 993.2 995.2 997.2 1001.7 740.0 740.2 740.4 741.2 741.6 15102.0 15281.8 15404.6 15431.4 15463.5 11785.0 13939.1 14096.2 14168.7 14192.5 11444.8 11565.4 11615.5 11841.2 12177.7 3595.7 3616.2 3678.2 3698.4 3788.8 94031.1 107404.0 107567.0 107990.0 109778.0 10493.9 10530.1 10618.8 10620.6 10920.9 21850.3 22301.6 22301.7 22309.9 22330.4 7369.2 7437.0 7466.3 7651.9 7659.1 3646.0 4040.4 4167.4 4224.5 4270.5 3324.8 3396.0 3418.6 3428.1 3438.5 527.3 527.4 530.1 533.2 535.6 650.5 663.7 679.4 689.1 692.4 9754.7 9759.9 9802.8 9929.5 10003.6 652.6 677.1 678.8 687.0 698.2 3848.5 4668.2 4683.6 4684.8 4693.0 88932.7 91319.7 109456.0 110710.4 113093.0 75039.2 75984.2 78546.0 80737.2 85634.0 72744.6 73726.0 75882.6 77506.8 79122.0 8960.9 10182.2 10265.5 10272.2 10371.4 46862.3 47073.8 48795.8 50358.5 51034.0 48922.0 64989.0 67382.7 69897.0 70108.0 12036.3 12309.5 12330.9 12657.9 13043.6 13353.7 13578.0 13644.7 13825.7 14277.5 12778.5 13069.8 13165.7 13514.9 13925.2 12762.6 12868.9 12877.0 13026.4 13279.9 12476.9 12704.8 12851.3 12862.7 13383.6 9478.6 10485.3 11165.9 11189.4 11469.6 10488.3 10506.6 10555.5 10584.0 10665.4 07:51:42 INFO - PROCESS | 1925 | -------- Summary: end -------- 07:51:42 INFO - PROCESS | 1925 | 07:51:42 INFO - PROCESS | 1925 | 1488383502269 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:51:42 INFO - TEST-INFO | 1925: exit 0 07:51:43 INFO - TEST-OK | dromaeo_css | took 1121651ms 07:51:43 INFO - TEST-START | kraken 07:51:43 INFO - operating with platform_type : mac_ 07:51:43 INFO - Initialising browser for kraken test... 07:51:43 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpjeJNZ3/profile http://localhost:57192/getInfo.html) 07:51:43 INFO - PROCESS | 1928 | 1488383503561 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:51:43 INFO - PROCESS | 1928 | 1488383503562 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:51:43 INFO - PROCESS | 1928 | 1488383503628 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:51:45 INFO - PROCESS | 1928 | __metrics Screen width/height:1600/1200 07:51:45 INFO - PROCESS | 1928 | colorDepth:24 07:51:45 INFO - PROCESS | 1928 | Browser inner width/height: 1024/689 07:51:45 INFO - PROCESS | 1928 | __metrics 07:51:45 INFO - PROCESS | 1928 | 1488383505573 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:51:45 INFO - PROCESS | 1928 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:51:45 INFO - PROCESS | 1928 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:51:46 INFO - TEST-INFO | 1928: exit 0 07:51:46 INFO - Browser initialized. 07:51:46 INFO - Running cycle 1/1 for kraken test... 07:51:46 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpjeJNZ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:46 INFO - PROCESS | 1929 | 1488383506701 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:51:46 INFO - PROCESS | 1929 | 1488383506702 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:51:58 INFO - PROCESS | 1929 | RSS: Main: 232251392 07:51:58 INFO - PROCESS | 1929 | 07:52:01 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57192/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:02 INFO - PROCESS | 1929 | RSS: Main: 284463104 07:52:02 INFO - PROCESS | 1929 | 07:52:04 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57192/tests/kraken/driver.html?testName=audio-dft) 07:52:05 INFO - PROCESS | 1929 | RSS: Main: 286298112 07:52:05 INFO - PROCESS | 1929 | 07:52:08 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57192/tests/kraken/driver.html?testName=audio-fft) 07:52:09 INFO - PROCESS | 1929 | RSS: Main: 375889920 07:52:09 INFO - PROCESS | 1929 | 07:52:11 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57192/tests/kraken/driver.html?testName=audio-oscillator) 07:52:12 INFO - PROCESS | 1929 | RSS: Main: 279437312 07:52:12 INFO - PROCESS | 1929 | 07:52:14 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:14 INFO - PROCESS | 1929 | RSS: Main: 282628096 07:52:14 INFO - PROCESS | 1929 | 07:52:17 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57192/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:18 INFO - PROCESS | 1929 | RSS: Main: 325656576 07:52:18 INFO - PROCESS | 1929 | 07:52:21 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57192/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:22 INFO - PROCESS | 1929 | RSS: Main: 328187904 07:52:22 INFO - PROCESS | 1929 | 07:52:25 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57192/tests/kraken/driver.html?testName=json-parse-financial) 07:52:26 INFO - PROCESS | 1929 | RSS: Main: 324603904 07:52:26 INFO - PROCESS | 1929 | 07:52:27 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:28 INFO - PROCESS | 1929 | RSS: Main: 302276608 07:52:28 INFO - PROCESS | 1929 | 07:52:30 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:30 INFO - PROCESS | 1929 | RSS: Main: 306876416 07:52:30 INFO - PROCESS | 1929 | 07:52:33 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:52:33 INFO - PROCESS | 1929 | RSS: Main: 313851904 07:52:33 INFO - PROCESS | 1929 | 07:52:36 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:52:37 INFO - PROCESS | 1929 | RSS: Main: 324284416 07:52:37 INFO - PROCESS | 1929 | 07:52:40 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:52:41 INFO - PROCESS | 1929 | RSS: Main: 318263296 07:52:41 INFO - PROCESS | 1929 | 07:52:42 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:57192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57192/tests/kraken/driver.html?testName=ai-astar) 07:52:43 INFO - PROCESS | 1929 | RSS: Main: 363065344 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | __start_tp_report 07:52:43 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 07:52:43 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 07:52:43 INFO - PROCESS | 1929 | |i|pagename|runs| 07:52:43 INFO - PROCESS | 1929 | |0;ai-astar;114;114;116;116;115;116;115;115;111;115 07:52:43 INFO - PROCESS | 1929 | |1;audio-beat-detection;141;109;111;147;111;110;111;109;132;111 07:52:43 INFO - PROCESS | 1929 | |2;audio-dft;184;183;188;188;186;183;182;183;184;186 07:52:43 INFO - PROCESS | 1929 | |3;audio-fft;81;62;61;93;65;59;75;85;77;62 07:52:43 INFO - PROCESS | 1929 | |4;audio-oscillator;92;70;86;70;70;68;86;70;69;84 07:52:43 INFO - PROCESS | 1929 | |5;imaging-gaussian-blur;89;87;88;88;88;93;88;88;88;88 07:52:43 INFO - PROCESS | 1929 | |6;imaging-darkroom;95;95;95;98;95;95;95;98;95;94 07:52:43 INFO - PROCESS | 1929 | |7;imaging-desaturate;86;103;138;125;85;85;88;85;83;85 07:52:43 INFO - PROCESS | 1929 | |8;json-parse-financial;64;63;62;61;60;60;60;60;62;60 07:52:43 INFO - PROCESS | 1929 | |9;json-stringify-tinderbox;62;55;66;65;64;58;59;60;60;59 07:52:43 INFO - PROCESS | 1929 | |10;stanford-crypto-aes;91;89;85;90;90;90;88;101;106;91 07:52:43 INFO - PROCESS | 1929 | |11;stanford-crypto-ccm;142;137;158;144;139;142;149;144;206;140 07:52:43 INFO - PROCESS | 1929 | |12;stanford-crypto-pbkdf2;174;169;174;176;174;174;171;177;171;174 07:52:43 INFO - PROCESS | 1929 | |13;stanford-crypto-sha256-iterative;69;67;68;67;66;65;67;63;66;66 07:52:43 INFO - PROCESS | 1929 | __end_tp_report 07:52:43 INFO - PROCESS | 1929 | __start_cc_report 07:52:43 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,2175 07:52:43 INFO - PROCESS | 1929 | __end_cc_report 07:52:43 INFO - PROCESS | 1929 | __startTimestamp1488383563149__endTimestamp 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | ------- Summary: start ------- 07:52:43 INFO - PROCESS | 1929 | Number of tests: 14 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:1.56 07:52:43 INFO - PROCESS | 1929 | Values: 114.0 114.0 116.0 116.0 115.0 116.0 115.0 115.0 111.0 115.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:111.00 stddev:14.81 (13.3%) stddev-sans-first:13.44 07:52:43 INFO - PROCESS | 1929 | Values: 141.0 109.0 111.0 147.0 111.0 110.0 111.0 109.0 132.0 111.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:2.16 (1.2%) stddev-sans-first:2.28 07:52:43 INFO - PROCESS | 1929 | Values: 184.0 183.0 188.0 188.0 186.0 183.0 182.0 183.0 184.0 186.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#3] audio-fft Cycles:10 Average:72.00 Median:76.00 stddev:11.85 (15.6%) stddev-sans-first:12.11 07:52:43 INFO - PROCESS | 1929 | Values: 81.0 62.0 61.0 93.0 65.0 59.0 75.0 85.0 77.0 62.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.00 stddev:9.28 (12.0%) stddev-sans-first:7.97 07:52:43 INFO - PROCESS | 1929 | Values: 92.0 70.0 86.0 70.0 70.0 68.0 86.0 70.0 69.0 84.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:88.00 stddev:1.65 (1.9%) stddev-sans-first:1.74 07:52:43 INFO - PROCESS | 1929 | Values: 89.0 87.0 88.0 88.0 88.0 93.0 88.0 88.0 88.0 88.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 07:52:43 INFO - PROCESS | 1929 | Values: 95.0 95.0 95.0 98.0 95.0 95.0 95.0 98.0 95.0 94.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:85.00 stddev:19.64 (23.1%) stddev-sans-first:20.47 07:52:43 INFO - PROCESS | 1929 | Values: 86.0 103.0 138.0 125.0 85.0 85.0 88.0 85.0 83.0 85.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.50 stddev:1.48 (2.4%) stddev-sans-first:1.17 07:52:43 INFO - PROCESS | 1929 | Values: 64.0 63.0 62.0 61.0 60.0 60.0 60.0 60.0 62.0 60.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:3.43 (5.6%) stddev-sans-first:3.61 07:52:43 INFO - PROCESS | 1929 | Values: 62.0 55.0 66.0 65.0 64.0 58.0 59.0 60.0 60.0 59.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:90.00 stddev:6.37 (7.1%) stddev-sans-first:6.74 07:52:43 INFO - PROCESS | 1929 | Values: 91.0 89.0 85.0 90.0 90.0 90.0 88.0 101.0 106.0 91.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:144.00 stddev:20.52 (14.3%) stddev-sans-first:21.56 07:52:43 INFO - PROCESS | 1929 | Values: 142.0 137.0 158.0 144.0 139.0 142.0 149.0 144.0 206.0 140.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:2.41 (1.4%) stddev-sans-first:2.55 07:52:43 INFO - PROCESS | 1929 | Values: 174.0 169.0 174.0 176.0 174.0 174.0 171.0 177.0 171.0 174.0 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.65 (2.5%) stddev-sans-first:1.45 07:52:43 INFO - PROCESS | 1929 | Values: 69.0 67.0 68.0 67.0 66.0 65.0 67.0 63.0 66.0 66.0 07:52:43 INFO - PROCESS | 1929 | -------- Summary: end -------- 07:52:43 INFO - PROCESS | 1929 | 07:52:43 INFO - PROCESS | 1929 | 1488383563171 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:52:44 INFO - TEST-INFO | 1929: exit 0 07:52:44 INFO - TEST-OK | kraken | took 61082ms 07:52:44 INFO - SUITE-END | took 1182s 07:52:44 INFO - Completed test suite (00:19:42) 07:52:44 INFO - javascript benchmark 07:52:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7417.597161860364, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.9513857292136, 3318.917027074323, 3325.517799919012, 3336.399448099341, 3385.475251336042, 5612.607117501777, 5681.431856814316, 5775.537956963443, 5784.710764461776, 5825.475707186352, 5677.977963966485, 5735.053716136832, 5741.0240259155935, 5751.827445176651, 5752.856178595527, 4356.368326592658, 5098.082345177876, 5218.660787048849, 5254.185601231815, 5273.973630131844, 5301.0, 5305.310309659739, 5309.33633295838, 5313.521783039526, 5323.760430780605, 5307.708076055816, 5319.122344813101, 5322.494363035506, 5328.92006619901, 5330.01394741972, 5289.576833853283, 5314.867128321785, 5317.0, 5318.9202161967405, 5321.760520776575, 5152.072626927152, 5248.0, 5267.631265811395, 5271.4992075753125, 5272.420033796279, 5821.7380217890295, 5904.822855314347, 5938.851528711817, 5940.910886336708, 5952.077427998667, 6212.689365531705, 6228.314885362606, 6229.3459186785185, 6236.064590311445, 6265.530085243625, 6163.229596300463, 6166.07508873668, 6196.349383314777, 6202.565820392574, 6240.812775616739, 5983.252093488314, 5992.940070599282, 5995.880082398327, 6001.969990150022, 6043.939560604382, 6377.234731832117, 6412.0, 6418.518611104186, 6424.71088801005, 6432.549721519542, 6070.180525628984, 6091.360407157274, 6096.055111457731, 6227.439530442191, 6227.875442491216, 6213.5339849511465, 6222.657753823583, 6229.501639868799, 6231.3145553989025, 6237.844053898598, 6119.632822030692, 6201.782937597162, 6205.968970155121, 6217.533684973645, 6217.658028808459, 6144.095330447575, 6217.036359364306, 6220.377962203744, 6226.315105338409, 6226.937730622636, 5034.89930201394, 5053.823116190915, 5110.003549307849, 5118.0, 5121.590272778169, 4386.824527018884, 4406.49325327585, 4420.602145806893, 4434.224010798098, 4532.5694059064335, 5773.797917072966, 5810.6054546908435, 5935.6735379553675, 6017.308009578867, 6038.486728628028, 5299.364076310867, 6302.873942521124, 6302.936970630327, 6321.083442900754, 6331.841703957346, 5735.426457354231, 5782.2194003808945, 5792.304923409133, 6002.249718785152, 6011.278646562353, 5489.1217405214975, 5525.364583072998, 5539.889202215933, 5569.415211402745, 5637.661740295595, 6497.967510162419, 6517.348265173445, 6531.020346947996, 6533.18335208099, 6540.640264785482, 6104.48947159306, 6281.089242059968, 6308.179936608211, 6314.55798094129, 6317.241930968313, 6239.032949892774, 6276.246850377984, 6345.650989195638, 6361.363863613602, 6374.107624932421, 6168.907466388097, 6176.166217560752, 6176.4441200292185, 6189.1954045975535, 6189.6286222826775, 6089.086637004485, 6274.6548939808745, 6284.465820405317, 6286.0, 6290.9056364155485, 6197.194364732556, 6200.81397558074, 6210.658413787285, 6212.565120441525, 6229.96885015572, 6108.205933228652, 6197.442230199304, 6200.782972596118, 6219.40915613016, 6227.875442491034, 4973.204287314013, 5890.764369425175, 5895.616784908967, 5951.613145145551, 5954.345022047484, 6102.237220347457, 6121.938780612137, 6127.264728232641, 6129.3564175762685, 6141.263048434038, 5924.407559244041, 5937.3468918418075, 5943.613665111754, 5945.881082378415, 5949.286085669747], "value": 5752.438600730325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.8063503489093, 766.750805988054, 836.8075342671185, 852.1052894460814, 855.208931738142, 22428.775712242874, 26041.47917041658, 27139.728602713967, 27153.45693086137, 36778.44832327517, 36519.81740091302, 38021.619783802154, 38049.0, 38129.80935095328, 38185.809070954674, 8729.738107856774, 8857.95571022144, 8858.73423797287, 8862.379633425662, 8877.201051905327, 7172.246914074025, 7352.264773522658, 8825.249853762405, 8946.776330591754, 8961.014288428267, 7298.124225092996, 7320.04839370881, 7370.373518250955, 10529.684109476728, 10776.461176941122, 10639.148868090573, 10686.305390149693, 10691.946540267249, 10692.144628429707, 10711.357318560833, 10480.58077676892, 10556.313839600401, 10563.41901195434, 10564.78870422595, 10574.78850422995, 25858.87070564654, 26218.34454138643, 26260.343491412677, 36526.26947461036, 36577.81711091428, 3063.0, 3732.3654978653694, 3755.661990420875, 3767.095896984704, 3943.1719338938856, 22174.88912555427, 26066.34834129162, 26542.86728566364, 26594.468110637677, 27497.17508474749, 3032.7725420593542, 3034.5296479045564, 3063.55578441127, 3088.5830412894197, 3171.127939816569, 309970.99999999773, 313251.0, 313909.43045284855, 314409.0, 314823.0, 48087.75956120197, 48154.0, 48204.758976205594, 48266.5173348269, 48291.758541207775, 40310.79844600817, 41098.589014110075, 41260.79369603133, 42944.0, 49622.50377496251, 11775.646730598095, 12039.337836418907, 13055.673608159683, 13234.007449441331, 13243.337833108306, 11361.204715669988, 11438.199326047263, 11443.0, 11448.94275528617, 11481.024112950492, 11526.88473115275, 11533.653990380302, 11574.305541667358, 11638.301701897914, 11676.474558644712, 5364.195370694349, 5424.430434804368, 5446.8910621787345, 5460.836174914759, 5467.644603100785, 828.9626966786509, 904.7738065483497, 908.1599520443564, 940.8259471997702, 943.9811203775886, 26336.473270534483, 26765.464690706078, 26995.481927710873, 27201.0, 27444.313892152455, 968.5157421289356, 994.980145351021, 995.9900400996042, 1010.2625083688948, 1022.0801278849095, 12163.391830408444, 13810.309484525733, 14014.719705606034, 14189.36147873348, 14211.43154273838, 395386.0, 397426.0, 397485.0, 397637.0, 398217.0, 52485.0, 52530.73734631302, 52609.73695131576, 52619.0, 52834.0, 1367.8153449284218, 1419.5457453614952, 1425.9714805704036, 1426.0873041253606, 1427.6716355238354, 24723.0, 25929.0, 26148.477030458904, 26260.0, 26421.33946651349, 42827.143457130056, 42972.0, 42986.0, 43004.784976074916, 43088.78455607702, 385127.0, 386327.0, 386646.0, 386904.0, 387013.0, 25508.872455638346, 26625.733742663102, 27038.45923081488, 29940.401191976474, 32330.83834580812, 40117.0, 41239.587604123575, 42115.7894210527, 42322.0, 42449.0, 31890.20274493156, 33808.66191338153, 34698.0, 35914.4612830813, 36024.27951441009, 34536.65463345334, 34538.309233815686, 35577.82211088928, 35644.0, 35819.28361432809, 33983.49024764581, 35096.29807403889, 35267.52072343599, 35324.646753532135, 35779.10552236111, 25807.483850323264, 29236.415271694874, 30749.406511277808, 30805.508019261648, 31164.909228176904, 23172.884135579214, 23363.700975641164, 23547.0, 23675.52648946977, 23684.407889802205], "value": 17412.654889095702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.472461192025, 390.49820980040636, 405.21590721953015, 412.7440986588315, 431.99992018477224, 12403.0, 14293.785593216096, 15452.227388630567, 20187.0, 20621.896890515527, 21695.240666576672, 22130.44673883154, 22200.444988875286, 22282.108715651397, 22406.77593224067, 6535.640539770311, 6567.179102612174, 6724.966375168117, 6811.046453496489, 6881.449484041264, 6538.771143009995, 6685.4985876059245, 6773.221079575838, 6791.354821291994, 6792.422644075259, 5864.208331875185, 6713.664316784166, 6744.291849355821, 6749.561278516905, 6778.22050464198, 6456.838579035515, 6676.399124078856, 6677.565958212701, 6760.3577660122455, 6769.153855768029, 6389.520785941027, 6534.803955881332, 6546.639934803584, 6553.541252112354, 6557.311482294338, 19606.80393196064, 25319.0, 25718.6142207867, 25770.742292577022, 25996.960121595304, 2843.4881721290158, 2845.089571337173, 2848.7863410244313, 2850.6721727001245, 2861.2131663792625, 14288.928330375264, 14924.776128358084, 15354.616134596612, 16081.961813699556, 16108.0, 1930.540451556908, 1935.0324837581209, 1942.2134035715558, 1953.5213872601162, 1967.163955318998, 126730.0, 130584.0, 131169.34415327862, 131623.0, 132767.33616331953, 19108.2356705733, 20084.89957550203, 20508.897455512626, 20684.482887927923, 20997.0, 32511.674883250864, 32607.836960815042, 32688.673113268564, 32706.509402358985, 32767.18082047968, 9843.655472058443, 9982.900170998197, 10179.440130792878, 10244.231682623833, 10406.427646479517, 8249.917500825035, 8283.50298982063, 8298.70954516589, 8464.492130472192, 8479.660813567389, 9355.532223388804, 9452.57463414148, 9499.952500237454, 9578.808423831484, 9605.711828645151, 3828.444875493038, 3887.4363217333894, 3888.494495715539, 3916.3146449371247, 3927.351986922183, 875.9693410730594, 965.5510187762584, 1021.443313394187, 1030.125172186613, 1039.2413538117066, 20761.58476830455, 21651.35045948624, 21912.52293327113, 22023.889880550494, 22029.559408812056, 969.3892847506027, 989.4360214677565, 991.5360329580985, 1021.4739409204266, 1027.3579013116803, 9284.7678808029, 11294.661160165044, 11422.31466112036, 11455.59905403307, 11461.54153833854, 667410.0, 667431.0, 690939.0, 698290.0, 699823.0, 85598.0, 102657.0, 103872.96127038784, 105736.0, 122478.0, 906.6962567539816, 950.9334346595672, 1057.4025675493322, 1059.3379138038727, 1061.4109169410897, 20178.192872284944, 20491.692624610343, 20646.17415303431, 20683.68974465354, 20695.68956465624, 48433.27350089822, 51743.0, 51836.48163518317, 52298.0, 52658.21012684736, 77294.0, 78284.0, 79277.8108328387, 79617.60191199007, 82668.0, 10581.0, 11349.659510214708, 11534.653960381202, 11672.591459298883, 11780.352080635646, 12753.362331883554, 12797.744045119232, 13114.934425327812, 13132.146410483288, 13188.0, 10028.247881408777, 10179.592816287266, 10403.219758518293, 10507.422091785025, 10524.210684198562, 8572.485650860719, 10226.437545935045, 10925.453727313761, 10976.286541374786, 11347.0, 11078.446077696244, 11444.771104578029, 11529.711757206136, 11643.41782910834, 11650.941745291559, 11400.543978241109, 11776.52893884235, 11812.586559470721, 11817.468213930566, 11926.912790261496, 9442.905570944202, 11301.434928253719, 11328.263662861887, 11330.03694685928, 11661.941690291495], "value": 11046.537273636975, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.6668482906516, 1534.3785766764458, 1541.5914782582624, 1551.8991265567745, 1571.748520236762, 10192.898071019288, 10701.83947240791, 10721.98141176587, 10729.356238625687, 10735.51690173942, 8484.703035393763, 10486.737831554196, 10490.108340791043, 10614.0, 10649.840252396201, 1934.8839069655796, 1959.4905324615631, 2286.5198308355266, 2289.370423133635, 2342.8360014798886, 2294.19703103914, 2321.245595181564, 2331.5453486570127, 2335.5095429959642, 2336.8130549555995, 2285.3029825903095, 2287.0508738873345, 2310.260716570698, 2315.583195024895, 2317.2700599311165, 2219.567184399035, 2271.193726227182, 2293.3693234360517, 2296.1159953417887, 2297.310806757966, 2247.0786977339376, 2318.0065143976167, 2318.026428899866, 2322.9430609072833, 2324.697789287399, 10526.894731052667, 10641.361518308926, 10641.893581064167, 10648.946755266252, 10661.360318380923, 5519.69641669708, 5712.200291959129, 5714.599978001542, 5726.083826587767, 5727.3699893011735, 3230.9030729078167, 3233.7089661930304, 3303.719183869374, 3319.369319829225, 3583.6953858922025, 1202.789511835434, 1206.541514224589, 1737.9478615641551, 1755.727862181364, 1835.7429959805638, 12957.805632915513, 13084.869151308556, 13331.66670833237, 14579.70840583193, 14753.77869331961, 3874.2251549690177, 4205.642520385741, 4645.721256724607, 4646.163690535668, 4656.41794775653, 11327.830082548768, 11339.716507087389, 11348.31910085381, 11374.658760237206, 11410.885891141148, 5581.134924086773, 5588.30146231721, 5589.916151257735, 5590.91613625796, 5598.412166722517, 4819.228923372314, 5068.986202759389, 5073.086844368049, 5169.870753231199, 5170.0, 3565.0, 3656.8171591420323, 3746.7751934883995, 3746.9063273417837, 3828.406596977473, 881.3786280672239, 1007.1992765751245, 1008.8587597736323, 1013.5439052426437, 1027.111548510548, 758.3364556013488, 766.2299389113905, 887.4320434921656, 889.6263569300909, 939.8355287824603, 5860.824175274749, 6148.477379422709, 6343.429091381798, 6362.6500542469685, 6445.033245013192, 978.283113136441, 985.7535616095976, 989.3272574649163, 1043.666026871409, 1090.465671820802, 3821.2739579479808, 3977.284088864032, 3990.6009399059863, 4088.364654138309, 4108.623611090258, 12398.62804115878, 13088.541901033419, 13096.214227146402, 13103.60689179326, 13130.540431084866, 12649.873501265054, 12679.746405072032, 12862.0, 12984.350782461028, 13046.869531304756, 8358.373122015873, 8651.221390074923, 8681.696140635173, 8727.738167854848, 8757.255633271243, 5502.669839809624, 6265.903466893366, 6381.521385896169, 6587.341265873374, 6617.536772425884, 11232.494537745984, 11518.424078795859, 11573.421328933351, 11645.301281923112, 11754.823677645014, 10963.945180274048, 11853.466594003117, 12009.279443233434, 12034.398280085785, 12228.816567751668, 7877.291043806085, 8075.959620202097, 8123.3501319893085, 8134.67461301565, 8167.3466122711225, 9622.47076410804, 9693.9030609693, 9729.173020293354, 9788.265880058882, 9810.85283720759, 7884.491401326584, 8640.740777776677, 8641.438306510057, 8759.693410730593, 9055.728328150166, 8281.503109813431, 8614.44006139599, 8630.0, 8639.0, 8691.217790398894, 7338.889916651147, 7353.0, 7358.742444014434, 7432.2567743225245, 7446.106467223751, 4900.966099068846, 5317.8404647860625, 5471.0, 5484.698341591251, 5497.202905578589, 5389.380221274447, 5575.888482230252, 5670.404607516316, 5715.571332150189, 5727.971360143172], "value": 4909.077793063833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.86864794350055, 366.7817648499143, 377.72048683973867, 380.13329608492637, 381.40881633468155, 4552.385427967223, 4702.601673146694, 4757.9286310705365, 5145.202493613487, 5395.271638328824, 4437.800298986545, 4873.5126487351245, 5041.873953151173, 5062.822801201959, 5213.061648903196, 3882.3594106972314, 4121.443605113302, 4471.955280447187, 4514.593686568208, 4550.567696068884, 3793.60167182446, 4404.339349097645, 4523.751193684346, 4552.544745525454, 4607.608353289957, 3726.1555530012683, 4229.175310814392, 4501.549845015488, 4509.075639493913, 4535.977320113411, 3871.0, 4445.5776701213335, 4531.365608814768, 4542.772861356919, 4558.316252562109, 4143.410368519675, 4256.2551553478015, 4360.302351623725, 4370.715903466296, 4376.496702879146, 4271.893202669927, 4541.977290113561, 4685.765711714401, 4762.166620841339, 5039.949600503985, 4996.875078123039, 5050.7222102784335, 5051.191809310492, 5052.797888084472, 5052.913623570913, 4770.499097594738, 4883.656994326553, 5184.507471790174, 5553.444655534414, 5577.2191893135, 3379.2565635560136, 3716.535433070866, 4325.891852703676, 4407.382966384709, 4412.4705035395955, 5045.823396181153, 5277.572316734307, 5492.418563275254, 5543.334799824047, 5606.971965140148, 3897.922041559153, 4354.542773008852, 4588.839390621312, 4628.274239237447, 4639.652026097989, 3824.617538246209, 4310.663694254791, 4586.747728874877, 4591.816327346869, 4627.079761898774, 4741.415928319075, 4900.485449027872, 4927.546373819731, 4953.8018479261145, 5033.464793238098, 4886.511348865085, 5100.48995100487, 5496.890062198733, 5547.559074007424, 5592.5246354059545, 1001.47923079998, 1322.0956855577676, 1322.8412590489204, 1403.5228022472409, 1491.3661693780316, 1032.2516175772505, 1089.9972025736342, 1115.8605174353206, 1132.314949455584, 1140.6064907606863, 4396.626286765597, 4436.600705936481, 4809.807607695653, 4887.169181239198, 4890.459505255833, 4487.237169681162, 4717.056588682277, 5016.372953380827, 5161.66449180802, 5420.642020720999, 4173.7078404512, 4262.403263543107, 4593.517680643551, 4594.035252596992, 4871.488493708181, 2485.2295788305682, 2718.3747738020365, 2755.2698534888273, 2765.6819465761696, 2812.831230126199, 5169.914317993188, 5622.94762411725, 5634.4786907534735, 5678.3186017678145, 5688.63023903445, 4588.9541104588525, 5092.337996060563, 5554.250176226158, 5607.682194684246, 5665.931934843752, 5303.575713942875, 5310.592692936375, 5597.272354593877, 5661.264035675418, 5732.57005724564, 4788.497207793132, 5125.589952803842, 5330.840074797762, 5341.385740639721, 5476.561875049907, 5000.474950130184, 5150.253213283978, 5246.396664383645, 5331.733413329395, 5339.599530035185, 5347.812826551052, 5563.693996830213, 5608.495235428831, 5614.466625670555, 5667.546596272371, 3971.960280397159, 4322.675799315127, 4353.934690979574, 4354.346847972829, 4356.673249506236, 4727.879599464474, 4885.682430641997, 5277.672308706977, 5402.459754024566, 5478.397376288684, 5119.769610367468, 5155.149400349051, 5285.524302812765, 5467.4532546745, 5556.305461817273, 4517.593416592523, 4840.273958906192, 4904.239842824368, 4987.376577927759, 5509.732761464806, 4954.950450495449, 4987.700737955734, 5387.919181212364, 5449.155380915964, 5453.15476101205, 4416.734995900256, 5524.640898341595, 5533.78648540587, 5543.695096769717, 5587.832365029056, 4369.497507786646, 4647.909839341358, 4653.0, 5269.367675878919, 5370.543503802221], "value": 4128.90470700201, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.6720941157654, 734.4711807498602, 756.4931495897748, 809.7854068671801, 814.4624547798452, 14401.0, 14977.0, 14980.400783968627, 15014.099154050751, 15062.623434414145, 13515.594532164027, 13585.932070339635, 13587.184768913872, 13591.796123058137, 13604.979626528, 926.1618235496852, 938.8075444533854, 962.3359881681653, 973.0026722609311, 974.5809302000137, 947.2564037230775, 961.1205746741758, 964.5514835601444, 964.7105868239535, 967.2503809547621, 1001.6594357918307, 1001.849722541621, 1002.503760638485, 1002.6340385759182, 1002.7593377589362, 991.4447909170888, 993.1558175550796, 995.2286977592424, 997.1922742578535, 1001.7095042437684, 740.0009986518211, 740.2301606329411, 740.359588955555, 741.158784779274, 741.6477173342619, 15102.0, 15281.770773438408, 15404.614884627861, 15431.3827446902, 15463.458778942682, 11785.0, 13939.09395889264, 14096.224707641075, 14168.716625667428, 14192.50326238587, 11444.771104577945, 11565.363904985223, 11615.529738854153, 11841.171118021743, 12177.695557611041, 3595.7123430125525, 3616.222512159872, 3678.1907980244305, 3698.3527882620433, 3788.8105594720428, 94031.11937761275, 107404.0, 107567.0, 107990.0, 109778.0, 10493.895061049445, 10530.071052709807, 10618.787624247472, 10620.575176992988, 10920.890791091988, 21850.344489665335, 22301.553968920532, 22301.665475017886, 22309.888450557642, 22330.441738956655, 7369.189389167187, 7437.0, 7466.25337466249, 7651.885221721679, 7659.119201291923, 3646.0, 4040.3535434330365, 4167.39537788882, 4224.5353011168745, 4270.530241673413, 3324.750643701732, 3396.0, 3418.5897692277085, 3428.057284246852, 3438.535797667333, 527.2855281094139, 527.3539913605803, 530.1252932661063, 533.1549494051893, 535.5501378841792, 650.4731167754135, 663.667432182412, 679.3715812873072, 689.1041645860362, 692.4356649330779, 9754.664169812562, 9759.9024009759, 9802.803943921082, 9929.453880036523, 10003.599856005678, 652.5823472977298, 677.1197443323758, 678.782789507353, 686.9965650171818, 698.1622053535777, 3848.4804551385764, 4668.206404911173, 4683.578477936934, 4684.81260749573, 4692.976535117371, 88932.6660100099, 91319.71700707402, 109456.0, 110710.44644776724, 113093.0, 75039.24960750322, 75984.24015759882, 78546.0, 80737.19262807297, 85634.0, 72744.58486004095, 73726.0, 75882.62058689671, 77506.83739743795, 79122.0, 8960.910390896008, 10182.195629500551, 10265.538050787583, 10272.229582781172, 10371.429571373646, 46862.29706554336, 47073.76463117662, 48795.75602121967, 50358.49641503538, 51034.0, 48922.0, 64989.0, 67382.66308668621, 69897.0, 70108.0, 12036.338001410006, 12309.507619695112, 12330.938345308216, 12657.936710316759, 13043.608691739262, 13353.66615834612, 13578.0, 13644.727105458034, 13825.654358641115, 14277.500287489887, 12778.488860445477, 13069.803952940523, 13165.736685266433, 13514.93242533781, 13925.23411212393, 12762.553310634083, 12868.871311286768, 12877.0, 13026.4138113787, 13279.867201327863, 12476.875231247934, 12704.793044660742, 12851.293178874877, 12862.742745145231, 13383.598492045254, 9478.620855165716, 10485.318454300446, 11165.944170279097, 11189.38458384764, 11469.598564050219, 10488.318259313426, 10506.579736810441, 10555.472226388803, 10584.047435730821, 10665.41340226295], "value": 7426.102865500527, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1451.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 116.0, 115.0, 116.0, 115.0, 115.0, 111.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 111.0, 147.0, 111.0, 110.0, 111.0, 109.0, 132.0, 111.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 188.0, 188.0, 186.0, 183.0, 182.0, 183.0, 184.0, 186.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 61.0, 93.0, 65.0, 59.0, 75.0, 85.0, 77.0, 62.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 86.0, 70.0, 70.0, 68.0, 86.0, 70.0, 69.0, 84.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 88.0, 88.0, 93.0, 88.0, 88.0, 88.0, 88.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 98.0, 95.0, 95.0, 95.0, 98.0, 95.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 103.0, 138.0, 125.0, 85.0, 85.0, 88.0, 85.0, 83.0, 85.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 61.0, 60.0, 60.0, 60.0, 60.0, 62.0, 60.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 55.0, 66.0, 65.0, 64.0, 58.0, 59.0, 60.0, 60.0, 59.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 85.0, 90.0, 90.0, 90.0, 88.0, 101.0, 106.0, 91.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 158.0, 144.0, 139.0, 142.0, 149.0, 144.0, 206.0, 140.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 169.0, 174.0, 176.0, 174.0, 174.0, 171.0, 177.0, 171.0, 174.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 67.0, 66.0, 65.0, 67.0, 63.0, 66.0, 66.0], "value": 66.4, "unit": "score"}]}]} 07:52:44 INFO - Return code: 0 07:52:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:52:44 ERROR - # TBPL SUCCESS # 07:52:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:52:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:52:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:52:44 INFO - 2017-03-01 07:52:44.470 screenresolution[1933:28010] starting screenresolution argv=screenresolution get 07:52:44 INFO - 2017-03-01 07:52:44.473 screenresolution[1933:28010] Display 0: 1600x1200x32@60 07:52:44 INFO - 2017-03-01 07:52:44.478 screenresolution[1934:28013] starting screenresolution argv=screenresolution list 07:52:44 INFO - Available Modes on Display 0 07:52:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:52:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:52:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:52:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:52:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:52:44 INFO - Intel Iris: 07:52:44 INFO - Chipset Model: Intel Iris 07:52:44 INFO - Type: GPU 07:52:44 INFO - Bus: Built-In 07:52:44 INFO - VRAM (Dynamic, Max): 1536 MB 07:52:44 INFO - Vendor: Intel (0x8086) 07:52:44 INFO - Device ID: 0x0a2e 07:52:44 INFO - Revision ID: 0x0009 07:52:44 INFO - Displays: 07:52:44 INFO - Display: 07:52:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:52:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:52:44 INFO - Display Serial Number: 1600x1200 60 07:52:44 INFO - Main Display: Yes 07:52:44 INFO - Mirror: Off 07:52:44 INFO - Online: Yes 07:52:44 INFO - Rotation: Supported 07:52:44 INFO - Return code: 0 07:52:44 INFO - Running post-action listener: _resource_record_post_action 07:52:44 INFO - [mozharness: 2017-03-01 15:52:44.715969Z] Finished run-tests step (success) 07:52:44 INFO - Running post-run listener: _resource_record_post_run 07:52:44 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 12288; Write bytes: 514854912; Read time: 1; Write time: 1643 07:52:44 INFO - TinderboxPrint: CPU usage
53.8% 07:52:44 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 1 07:52:44 INFO - TinderboxPrint: I/O write bytes / time
514,854,912 / 1,643 07:52:44 INFO - TinderboxPrint: CPU idle
2,226.5 (46.2%) 07:52:44 INFO - TinderboxPrint: CPU system
957.6 (19.9%) 07:52:44 INFO - TinderboxPrint: CPU user
1,633.6 (33.9%) 07:52:44 INFO - TinderboxPrint: Swap in / out
209,899,520 / 0 07:52:44 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200557056; Write bytes: 195450880; Read time: 15369; Write time: 459 07:52:44 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 12288; Write bytes: 300996608; Read time: 1; Write time: 1123 07:52:45 INFO - Running post-run listener: _upload_blobber_files 07:52:45 INFO - Blob upload gear active. 07:52:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:52:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:52:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:46 INFO - (blobuploader) - INFO - Done attempting. 07:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:47 INFO - (blobuploader) - INFO - Done attempting. 07:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:48 INFO - (blobuploader) - INFO - Done attempting. 07:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:52:51 INFO - (blobuploader) - INFO - Done attempting. 07:52:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:52:51 INFO - Return code: 0 07:52:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:52:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:52:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aeda30c617710b46274180a6ad7b5abdbf53dfae269681923d435a8b91fc78c160be4535011c5ab51800aff8c7893dd0ba604166370da30a7c4e1dd5a9a1d53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa745f110494b2a210b14f74ef0f33747697296617d9840b54a85c788b58b00aba36387e36520c9554eb96d0475ea2acfdb8e517c52a9bd3747b84a056298c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f34f960183e5d86b0014b299792cbef0f95beb94300deec7dcbc9cc4a650c61bdd7fe1132a8baec98f3847010e84e1d2fa9e70637efa3bfd5be3b9bc65b291", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aa1b8a22502dc14ab795b4a55fec749d7b7e32c9f59bbb65d69074b49e7626c3a6d2a0f3db8b7845806fc0e03dcf72e681d02793615a603fc424c02d16606b1"} 07:52:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:52:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:52:51 INFO - Contents: 07:52:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aeda30c617710b46274180a6ad7b5abdbf53dfae269681923d435a8b91fc78c160be4535011c5ab51800aff8c7893dd0ba604166370da30a7c4e1dd5a9a1d53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa745f110494b2a210b14f74ef0f33747697296617d9840b54a85c788b58b00aba36387e36520c9554eb96d0475ea2acfdb8e517c52a9bd3747b84a056298c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f34f960183e5d86b0014b299792cbef0f95beb94300deec7dcbc9cc4a650c61bdd7fe1132a8baec98f3847010e84e1d2fa9e70637efa3bfd5be3b9bc65b291", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aa1b8a22502dc14ab795b4a55fec749d7b7e32c9f59bbb65d69074b49e7626c3a6d2a0f3db8b7845806fc0e03dcf72e681d02793615a603fc424c02d16606b1"} 07:52:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:52:51 INFO - Copying logs to upload dir... 07:52:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:52:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.913126 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-01 07:52:51.267848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 07:52:51.271940) ========= 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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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/aeda30c617710b46274180a6ad7b5abdbf53dfae269681923d435a8b91fc78c160be4535011c5ab51800aff8c7893dd0ba604166370da30a7c4e1dd5a9a1d53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa745f110494b2a210b14f74ef0f33747697296617d9840b54a85c788b58b00aba36387e36520c9554eb96d0475ea2acfdb8e517c52a9bd3747b84a056298c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f34f960183e5d86b0014b299792cbef0f95beb94300deec7dcbc9cc4a650c61bdd7fe1132a8baec98f3847010e84e1d2fa9e70637efa3bfd5be3b9bc65b291", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aa1b8a22502dc14ab795b4a55fec749d7b7e32c9f59bbb65d69074b49e7626c3a6d2a0f3db8b7845806fc0e03dcf72e681d02793615a603fc424c02d16606b1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1488364923/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aeda30c617710b46274180a6ad7b5abdbf53dfae269681923d435a8b91fc78c160be4535011c5ab51800aff8c7893dd0ba604166370da30a7c4e1dd5a9a1d53d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa745f110494b2a210b14f74ef0f33747697296617d9840b54a85c788b58b00aba36387e36520c9554eb96d0475ea2acfdb8e517c52a9bd3747b84a056298c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f34f960183e5d86b0014b299792cbef0f95beb94300deec7dcbc9cc4a650c61bdd7fe1132a8baec98f3847010e84e1d2fa9e70637efa3bfd5be3b9bc65b291", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aa1b8a22502dc14ab795b4a55fec749d7b7e32c9f59bbb65d69074b49e7626c3a6d2a0f3db8b7845806fc0e03dcf72e681d02793615a603fc424c02d16606b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 07:52:51.307951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:52:51.308381) ========= 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.fFqTxxOaZ1/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.u8AI1AwPTj/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005370 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:52:51.357714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 07:52:51.358086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 07:52:51.358501) ========= ========= Total master_lag: 0.19 =========