builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1467544083.66 results: success (0) buildid: 20160703011557 builduid: 4397c447e0f64c5aa455d05e22a107e4 revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:03.657834) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:03.658263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:03.658539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:03.866974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:03.867637) ========= 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.adkAK1amTO/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.DUjeZFMEWB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-03 04:08:03-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2016-07-03 04:08:04 (15.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.651101 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.580418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.580708) ========= 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.adkAK1amTO/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.DUjeZFMEWB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.027979 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.651295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 04:08:04.651619) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.adkAK1amTO/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.DUjeZFMEWB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-03 04:08:04,724 truncating revision to first 12 chars 2016-07-03 04:08:04,724 Setting DEBUG logging. 2016-07-03 04:08:04,725 attempt 1/10 2016-07-03 04:08:04,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13ce99eb20be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 04:08:05,856 unpacking tar archive at: mozilla-beta-13ce99eb20be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.387727 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 04:08:06.077483) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:06.077869) ========= script_repo_revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:06.078268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:06.078533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:06.134285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-03 04:08:06.134576) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.adkAK1amTO/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.DUjeZFMEWB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:08:06 INFO - MultiFileLogger online at 20160703 04:08:06 in /builds/slave/test 04:08:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:08:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:06 INFO - {'append_to_log': False, 04:08:06 INFO - 'base_work_dir': '/builds/slave/test', 04:08:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:08:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:06 INFO - 'branch': 'Mozilla-Beta', 04:08:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:06 INFO - 'config_files': ('talos/mac_config.py',), 04:08:06 INFO - 'default_actions': ('clobber', 04:08:06 INFO - 'read-buildbot-config', 04:08:06 INFO - 'download-and-extract', 04:08:06 INFO - 'populate-webroot', 04:08:06 INFO - 'create-virtualenv', 04:08:06 INFO - 'install', 04:08:06 INFO - 'run-tests'), 04:08:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:06 INFO - 'download_minidump_stackwalk': True, 04:08:06 INFO - 'download_symbols': 'ondemand', 04:08:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:06 INFO - 'installer_path': 'installer.exe', 04:08:06 INFO - 'log_level': 'info', 04:08:06 INFO - 'log_name': 'talos', 04:08:06 INFO - 'log_to_console': True, 04:08:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:08:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:08:06 INFO - 'opt_config_files': (), 04:08:06 INFO - 'pip_index': False, 04:08:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:08:06 INFO - 'cmd': ('bash', 04:08:06 INFO - '-c', 04:08:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:08:06 INFO - 'enabled': True, 04:08:06 INFO - 'halt_on_failure': False, 04:08:06 INFO - 'name': 'check_screen_resolution'},), 04:08:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:08:06 INFO - 'cmd': ('bash', 04:08:06 INFO - '-c', 04:08:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:08:06 INFO - 'enabled': True, 04:08:06 INFO - 'halt_on_failure': False, 04:08:06 INFO - 'name': 'check_screen_resolution'},), 04:08:06 INFO - 'run_cmd_checks_enabled': True, 04:08:06 INFO - 'sps_profile': False, 04:08:06 INFO - 'sps_profile_interval': 0, 04:08:06 INFO - 'suite': 'dromaeojs', 04:08:06 INFO - 'system_bits': '32', 04:08:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:06 INFO - 'title': 't-yosemite-r7-0084', 04:08:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:06 INFO - 'use_talos_json': True, 04:08:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:06 INFO - 'work_dir': 'build'} 04:08:06 INFO - ##### 04:08:06 INFO - ##### Running clobber step. 04:08:06 INFO - ##### 04:08:06 INFO - Running pre-action listener: _resource_record_pre_action 04:08:06 INFO - Running main action method: clobber 04:08:06 INFO - rmtree: /builds/slave/test/build 04:08:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:08 INFO - Running post-action listener: _resource_record_post_action 04:08:08 INFO - ##### 04:08:08 INFO - ##### Running read-buildbot-config step. 04:08:08 INFO - ##### 04:08:08 INFO - Running pre-action listener: _resource_record_pre_action 04:08:08 INFO - Running main action method: read_buildbot_config 04:08:08 INFO - Using buildbot properties: 04:08:08 INFO - { 04:08:08 INFO - "project": "", 04:08:08 INFO - "product": "firefox", 04:08:08 INFO - "script_repo_revision": "production", 04:08:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:08:08 INFO - "repository": "", 04:08:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:08:08 INFO - "buildid": "20160703011557", 04:08:08 INFO - "pgo_build": "False", 04:08:08 INFO - "basedir": "/builds/slave/test", 04:08:08 INFO - "buildnumber": 35, 04:08:08 INFO - "slavename": "t-yosemite-r7-0084", 04:08:08 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:08:08 INFO - "platform": "yosemite_r7", 04:08:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:08:08 INFO - "branch": "mozilla-beta", 04:08:08 INFO - "repo_path": "releases/mozilla-beta", 04:08:08 INFO - "revision": "13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67", 04:08:08 INFO - "stage_platform": "macosx64", 04:08:08 INFO - "builduid": "4397c447e0f64c5aa455d05e22a107e4", 04:08:08 INFO - "slavebuilddir": "test" 04:08:08 INFO - } 04:08:08 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg. 04:08:08 INFO - Running post-action listener: _resource_record_post_action 04:08:08 INFO - ##### 04:08:08 INFO - ##### Running download-and-extract step. 04:08:08 INFO - ##### 04:08:08 INFO - Running pre-action listener: _resource_record_pre_action 04:08:08 INFO - Running main action method: download_and_extract 04:08:08 INFO - mkdir: /builds/slave/test/build/tests 04:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.test_packages.json 04:08:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:08:08 INFO - Downloaded 1165 bytes. 04:08:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:08:08 INFO - Using the following test package requirements: 04:08:08 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:08:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:08 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:08:08 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:08 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:08:08 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:08:08 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:08 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:08:08 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:08:08 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:08 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:08:08 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:08 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:08:08 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:08 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:08:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:08 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:08:08 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip 04:08:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:08:10 INFO - Downloaded 18351375 bytes. 04:08:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:08:13 INFO - Return code: 0 04:08:13 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip 04:08:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:08:14 INFO - Downloaded 18351375 bytes. 04:08:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:08:18 INFO - Return code: 0 04:08:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.talos.tests.zip 04:08:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:08:22 INFO - Downloaded 10840145 bytes. 04:08:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:08:22 INFO - Return code: 0 04:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg 04:08:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:08:33 INFO - Downloaded 86196308 bytes. 04:08:33 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg 04:08:33 INFO - mkdir: /builds/slave/test/properties 04:08:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:33 INFO - Contents: 04:08:33 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg 04:08:33 INFO - Running post-action listener: _resource_record_post_action 04:08:33 INFO - Running post-action listener: set_extra_try_arguments 04:08:33 INFO - ##### 04:08:33 INFO - ##### Running populate-webroot step. 04:08:33 INFO - ##### 04:08:33 INFO - Running pre-action listener: _resource_record_pre_action 04:08:33 INFO - Running main action method: populate_webroot 04:08:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:33 INFO - '--tppagecycles', 04:08:33 INFO - '7'], 04:08:33 INFO - 'tests': ['tsvgm']}}, 04:08:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['damp', 'tps']}, 04:08:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'tests': ['damp', 'tps']}, 04:08:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['dromaeo_dom']}, 04:08:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['tsvgx', 04:08:33 INFO - 'tsvgr_opacity', 04:08:33 INFO - 'tart', 04:08:33 INFO - 'tscrollx', 04:08:33 INFO - 'cart']}, 04:08:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:33 INFO - 'tsvgr_opacity', 04:08:33 INFO - 'tart', 04:08:33 INFO - 'tscrollx', 04:08:33 INFO - 'cart']}, 04:08:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--disable-e10s'], 04:08:33 INFO - 'tests': ['tp5o']}, 04:08:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'tests': ['tp5o']}, 04:08:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--disable-e10s', 04:08:33 INFO - '--xperf_path', 04:08:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:33 INFO - 'tests': ['tp5n']}, 04:08:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--xperf_path', 04:08:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:33 INFO - 'tests': ['tp5n']}}, 04:08:33 INFO - 'talos.zip': {'path': '', 04:08:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:33 INFO - Running post-action listener: _resource_record_post_action 04:08:33 INFO - ##### 04:08:33 INFO - ##### Running create-virtualenv step. 04:08:33 INFO - ##### 04:08:33 INFO - Running pre-action listener: _resource_record_pre_action 04:08:33 INFO - Running main action method: create_virtualenv 04:08:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:08:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:33 INFO - Using real prefix '/tools/python27' 04:08:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:37 INFO - Installing pip.................done. 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:37 INFO - 'HOME': '/Users/cltbld', 04:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:37 INFO - 'LOGNAME': 'cltbld', 04:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:37 INFO - 'MOZ_NO_REMOTE': '1', 04:08:37 INFO - 'NO_EM_RESTART': '1', 04:08:37 INFO - 'PAGER': '/bin/cat', 04:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:37 INFO - 'PWD': '/builds/slave/test', 04:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:37 INFO - 'SHELL': '/bin/bash', 04:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:08:37 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - 'XPC_FLAGS': '0x0', 04:08:37 INFO - 'XPC_SERVICE_NAME': '0', 04:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:08:37 INFO - Cleaning up... 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:37 INFO - 'HOME': '/Users/cltbld', 04:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:37 INFO - 'LOGNAME': 'cltbld', 04:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:37 INFO - 'MOZ_NO_REMOTE': '1', 04:08:37 INFO - 'NO_EM_RESTART': '1', 04:08:37 INFO - 'PAGER': '/bin/cat', 04:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:37 INFO - 'PWD': '/builds/slave/test', 04:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:37 INFO - 'SHELL': '/bin/bash', 04:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:08:37 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - 'XPC_FLAGS': '0x0', 04:08:37 INFO - 'XPC_SERVICE_NAME': '0', 04:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:38 INFO - Downloading/unpacking psutil>=0.7.1 04:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:42 INFO - Installing collected packages: psutil 04:08:42 INFO - Running setup.py install for psutil 04:08:42 INFO - building 'psutil._psutil_osx' extension 04:08:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:08:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:08:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:08:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:08:42 INFO - building 'psutil._psutil_posix' extension 04:08:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:08:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:08:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:08:43 INFO - ^ 04:08:43 INFO - 1 warning generated. 04:08:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:43 INFO - Successfully installed psutil 04:08:43 INFO - Cleaning up... 04:08:43 INFO - Return code: 0 04:08:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:43 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:43 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.0.0'] in /builds/slave/test/build 04:08:43 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.0.0 04:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:43 INFO - 'HOME': '/Users/cltbld', 04:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:43 INFO - 'LOGNAME': 'cltbld', 04:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:43 INFO - 'MOZ_NO_REMOTE': '1', 04:08:43 INFO - 'NO_EM_RESTART': '1', 04:08:43 INFO - 'PAGER': '/bin/cat', 04:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:43 INFO - 'PWD': '/builds/slave/test', 04:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:43 INFO - 'SHELL': '/bin/bash', 04:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:08:43 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:43 INFO - 'USER': 'cltbld', 04:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:43 INFO - 'XPC_FLAGS': '0x0', 04:08:43 INFO - 'XPC_SERVICE_NAME': '0', 04:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:46 INFO - Installing collected packages: mozsystemmonitor 04:08:46 INFO - Running setup.py install for mozsystemmonitor 04:08:46 INFO - Successfully installed mozsystemmonitor 04:08:46 INFO - Cleaning up... 04:08:46 INFO - Return code: 0 04:08:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:46 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 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:46 INFO - 'HOME': '/Users/cltbld', 04:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:46 INFO - 'LOGNAME': 'cltbld', 04:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:46 INFO - 'MOZ_NO_REMOTE': '1', 04:08:46 INFO - 'NO_EM_RESTART': '1', 04:08:46 INFO - 'PAGER': '/bin/cat', 04:08:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:46 INFO - 'PWD': '/builds/slave/test', 04:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:46 INFO - 'SHELL': '/bin/bash', 04:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:08:46 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:46 INFO - 'USER': 'cltbld', 04:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:46 INFO - 'XPC_FLAGS': '0x0', 04:08:46 INFO - 'XPC_SERVICE_NAME': '0', 04:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:50 INFO - Downloading docopt-0.6.1.tar.gz 04:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:50 INFO - Running setup.py install for blobuploader 04:08:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:50 INFO - Running setup.py install for requests 04:08:50 INFO - Running setup.py install for docopt 04:08:51 INFO - Successfully installed blobuploader requests docopt 04:08:51 INFO - Cleaning up... 04:08:51 INFO - Return code: 0 04:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 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 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:08:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:51 INFO - 'HOME': '/Users/cltbld', 04:08:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:51 INFO - 'LOGNAME': 'cltbld', 04:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:51 INFO - 'MOZ_NO_REMOTE': '1', 04:08:51 INFO - 'NO_EM_RESTART': '1', 04:08:51 INFO - 'PAGER': '/bin/cat', 04:08:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:51 INFO - 'PWD': '/builds/slave/test', 04:08:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:51 INFO - 'SHELL': '/bin/bash', 04:08:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:08:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:08:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:51 INFO - 'USER': 'cltbld', 04:08:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:51 INFO - 'XPC_FLAGS': '0x0', 04:08:51 INFO - 'XPC_SERVICE_NAME': '0', 04:08:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-R1TnWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-V_xWWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dEnXGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-CD2h0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4wLCHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dva1Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JjzO0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-H698QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-DzfnvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-UXcndp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-aPlMi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-VZrpVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-pP_4J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-doDH4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-iyJyvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-P7Qb9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-XEMZx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:53 INFO - Running setup.py install for manifestparser 04:08:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:53 INFO - Running setup.py install for mozcrash 04:08:53 INFO - Running setup.py install for mozdebug 04:08:53 INFO - Running setup.py install for mozdevice 04:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:53 INFO - Running setup.py install for mozfile 04:08:53 INFO - Running setup.py install for mozhttpd 04:08:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozinfo 04:08:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozInstall 04:08:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozleak 04:08:54 INFO - Running setup.py install for mozlog 04:08:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for moznetwork 04:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozprocess 04:08:54 INFO - Running setup.py install for mozprofile 04:08:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozrunner 04:08:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Running setup.py install for mozscreenshot 04:08:55 INFO - Running setup.py install for moztest 04:08:55 INFO - Running setup.py install for mozversion 04:08:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:55 INFO - Cleaning up... 04:08:55 INFO - Return code: 0 04:08:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 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 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:08:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:55 INFO - 'HOME': '/Users/cltbld', 04:08:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:55 INFO - 'LOGNAME': 'cltbld', 04:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:55 INFO - 'MOZ_NO_REMOTE': '1', 04:08:55 INFO - 'NO_EM_RESTART': '1', 04:08:55 INFO - 'PAGER': '/bin/cat', 04:08:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:55 INFO - 'PWD': '/builds/slave/test', 04:08:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:55 INFO - 'SHELL': '/bin/bash', 04:08:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:08:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:08:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:55 INFO - 'USER': 'cltbld', 04:08:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:55 INFO - 'XPC_FLAGS': '0x0', 04:08:55 INFO - 'XPC_SERVICE_NAME': '0', 04:08:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-I5ug5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-QGjwrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-OkKHs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-UiuB1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-M48lRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mHWHAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wS18OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-kXjs6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uDh5UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-XrfKBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-tuD0Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-EfKMO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hfITI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uTBnxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-zB4CQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-A2S28E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-2t7568-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:00 INFO - Downloading blessings-1.6.tar.gz 04:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:00 INFO - Installing collected packages: blessings 04:09:00 INFO - Running setup.py install for blessings 04:09:00 INFO - Successfully installed blessings 04:09:00 INFO - Cleaning up... 04:09:00 INFO - Return code: 0 04:09:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:00 INFO - Reading from file tmpfile_stdout 04:09:00 INFO - Current package versions: 04:09:00 INFO - blessings == 1.6 04:09:00 INFO - blobuploader == 1.2.4 04:09:00 INFO - docopt == 0.6.1 04:09:00 INFO - manifestparser == 1.1 04:09:00 INFO - mozInstall == 1.12 04:09:00 INFO - mozcrash == 0.17 04:09:00 INFO - mozdebug == 0.1 04:09:00 INFO - mozdevice == 0.48 04:09:00 INFO - mozfile == 1.2 04:09:00 INFO - mozhttpd == 0.7 04:09:00 INFO - mozinfo == 0.9 04:09:00 INFO - mozleak == 0.1 04:09:00 INFO - mozlog == 3.1 04:09:00 INFO - moznetwork == 0.27 04:09:00 INFO - mozprocess == 0.22 04:09:00 INFO - mozprofile == 0.28 04:09:00 INFO - mozrunner == 6.11 04:09:00 INFO - mozscreenshot == 0.1 04:09:00 INFO - mozsystemmonitor == 0.0 04:09:00 INFO - moztest == 0.7 04:09:00 INFO - mozversion == 1.4 04:09:00 INFO - psutil == 3.1.1 04:09:00 INFO - requests == 1.2.3 04:09:00 INFO - wsgiref == 0.1.2 04:09:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:00 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 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:09:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:09:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:00 INFO - 'HOME': '/Users/cltbld', 04:09:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:00 INFO - 'LOGNAME': 'cltbld', 04:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:00 INFO - 'MOZ_NO_REMOTE': '1', 04:09:00 INFO - 'NO_EM_RESTART': '1', 04:09:00 INFO - 'PAGER': '/bin/cat', 04:09:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:00 INFO - 'PWD': '/builds/slave/test', 04:09:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:00 INFO - 'SHELL': '/bin/bash', 04:09:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:09:00 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:09:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:00 INFO - 'USER': 'cltbld', 04:09:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:00 INFO - 'XPC_FLAGS': '0x0', 04:09:00 INFO - 'XPC_SERVICE_NAME': '0', 04:09:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:01 INFO - Cleaning up... 04:09:01 INFO - Return code: 0 04:09:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:01 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 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:01 INFO - 'HOME': '/Users/cltbld', 04:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:01 INFO - 'LOGNAME': 'cltbld', 04:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:01 INFO - 'MOZ_NO_REMOTE': '1', 04:09:01 INFO - 'NO_EM_RESTART': '1', 04:09:01 INFO - 'PAGER': '/bin/cat', 04:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:01 INFO - 'PWD': '/builds/slave/test', 04:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:01 INFO - 'SHELL': '/bin/bash', 04:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:09:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:01 INFO - 'USER': 'cltbld', 04:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:01 INFO - 'XPC_FLAGS': '0x0', 04:09:01 INFO - 'XPC_SERVICE_NAME': '0', 04:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:01 INFO - Downloading/unpacking jsonschema 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:04 INFO - warning: no files found matching '*.txt' 04:09:04 INFO - no previously-included directories found matching 'build' 04:09:04 INFO - no previously-included directories found matching 'dist' 04:09:04 INFO - no previously-included directories found matching '.git*' 04:09:04 INFO - Installing collected packages: jsonschema, functools32 04:09:04 INFO - Running setup.py install for functools32 04:09:04 INFO - warning: no files found matching '*.txt' 04:09:04 INFO - no previously-included directories found matching 'build' 04:09:04 INFO - no previously-included directories found matching 'dist' 04:09:04 INFO - no previously-included directories found matching '.git*' 04:09:04 INFO - Successfully installed jsonschema functools32 04:09:04 INFO - Cleaning up... 04:09:04 INFO - Return code: 0 04:09:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:04 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10baada30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10babd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc483d71cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, '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.adkAK1amTO/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.DUjeZFMEWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:09:04 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', 'flake8'] in /builds/slave/test/build 04:09:04 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 flake8 04:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:04 INFO - 'HOME': '/Users/cltbld', 04:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:04 INFO - 'LOGNAME': 'cltbld', 04:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:04 INFO - 'MOZ_NO_REMOTE': '1', 04:09:04 INFO - 'NO_EM_RESTART': '1', 04:09:04 INFO - 'PAGER': '/bin/cat', 04:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:04 INFO - 'PWD': '/builds/slave/test', 04:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:04 INFO - 'SHELL': '/bin/bash', 04:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:09:04 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:04 INFO - 'USER': 'cltbld', 04:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:04 INFO - 'XPC_FLAGS': '0x0', 04:09:04 INFO - 'XPC_SERVICE_NAME': '0', 04:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:04 INFO - Downloading/unpacking flake8 04:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:08 INFO - no previously-included directories found matching 'docs/_build' 04:09:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:08 INFO - Running setup.py install for pep8 04:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:08 INFO - no previously-included directories found matching 'docs/_build' 04:09:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:08 INFO - Cleaning up... 04:09:08 INFO - Return code: 0 04:09:08 INFO - Running post-action listener: _resource_record_post_action 04:09:08 INFO - Running post-action listener: _start_resource_monitoring 04:09:08 INFO - Starting resource monitoring. 04:09:08 INFO - ##### 04:09:08 INFO - ##### Running install step. 04:09:08 INFO - ##### 04:09:08 INFO - Running pre-action listener: _resource_record_pre_action 04:09:08 INFO - Running main action method: install 04:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:09 INFO - Reading from file tmpfile_stdout 04:09:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:09 INFO - Reading from file tmpfile_stdout 04:09:09 INFO - Output received: 04:09:09 INFO - Usage: mozinstall [options] installer 04:09:09 INFO - Options: 04:09:09 INFO - -h, --help show this help message and exit 04:09:09 INFO - -d DEST, --destination=DEST 04:09:09 INFO - Directory to install application into. [default: 04:09:09 INFO - "/builds/slave/test"] 04:09:09 INFO - --app=APP Application being installed. [default: firefox] 04:09:09 INFO - mkdir: /builds/slave/test/build/application 04:09:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:09:31 INFO - Reading from file tmpfile_stdout 04:09:31 INFO - Output received: 04:09:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:09:31 INFO - Running post-action listener: _resource_record_post_action 04:09:31 INFO - ##### 04:09:31 INFO - ##### Running run-tests step. 04:09:31 INFO - ##### 04:09:31 INFO - Running pre-action listener: _resource_record_pre_action 04:09:31 INFO - Running main action method: run_tests 04:09:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:09:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:09:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:09:31 INFO - 2016-07-03 04:09:31.310 screenresolution[1675:9446] starting screenresolution argv=screenresolution get 04:09:31 INFO - 2016-07-03 04:09:31.313 screenresolution[1675:9446] Display 0: 1600x1200x32@60 04:09:31 INFO - 2016-07-03 04:09:31.318 screenresolution[1676:9448] starting screenresolution argv=screenresolution list 04:09:31 INFO - Available Modes on Display 0 04:09:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:09:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:09:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:09:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:09:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:09:31 INFO - Intel Iris: 04:09:31 INFO - Chipset Model: Intel Iris 04:09:31 INFO - Type: GPU 04:09:31 INFO - Bus: Built-In 04:09:31 INFO - VRAM (Dynamic, Max): 1536 MB 04:09:31 INFO - Vendor: Intel (0x8086) 04:09:31 INFO - Device ID: 0x0a2e 04:09:31 INFO - Revision ID: 0x0009 04:09:31 INFO - Displays: 04:09:31 INFO - Display: 04:09:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:09:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:09:31 INFO - Display Serial Number: 1600x1200 60 04:09:31 INFO - Main Display: Yes 04:09:31 INFO - Mirror: Off 04:09:31 INFO - Online: Yes 04:09:31 INFO - Rotation: Supported 04:09:31 INFO - Return code: 0 04:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:31 INFO - Python 2.7.3 04:09:31 INFO - Return code: 0 04:09:31 INFO - grabbing minidump binary from tooltool 04:09: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:31 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b94ce00>, '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 0x10b7b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b947b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:09:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:09:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:31 INFO - Return code: 0 04:09:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:09:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:09:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:32 INFO - Return code: 0 04:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:09:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adkAK1amTO/Render', 04:09:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:32 INFO - 'HOME': '/Users/cltbld', 04:09:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:32 INFO - 'LOGNAME': 'cltbld', 04:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:32 INFO - 'MOZ_NO_REMOTE': '1', 04:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:32 INFO - 'NO_EM_RESTART': '1', 04:09:32 INFO - 'PAGER': '/bin/cat', 04:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:32 INFO - 'PWD': '/builds/slave/test', 04:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:32 INFO - 'SHELL': '/bin/bash', 04:09:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUjeZFMEWB/Listeners', 04:09:32 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 04:09:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:32 INFO - 'USER': 'cltbld', 04:09:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:32 INFO - 'XPC_FLAGS': '0x0', 04:09:32 INFO - 'XPC_SERVICE_NAME': '0', 04:09:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:09:32 INFO - mozversion application_buildid: 20160703011557 04:09:32 INFO - mozversion application_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 04:09:32 INFO - mozversion application_display_name: Firefox 04:09:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:32 INFO - mozversion application_name: Firefox 04:09:32 INFO - mozversion application_remotingname: firefox 04:09:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:32 INFO - mozversion application_vendor: Mozilla 04:09:32 INFO - mozversion application_version: 48.0 04:09:32 INFO - mozversion platform_buildid: 20160703011557 04:09:32 INFO - mozversion platform_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 04:09:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:32 INFO - mozversion platform_version: 48.0 04:09:32 INFO - using testdate: 1467544172 04:09:32 INFO - actual date: 1467544172 04:09:32 INFO - starting webserver on 'localhost:49269' 04:09:32 INFO - SUITE-START | Running 2 tests 04:09:32 INFO - TEST-START | dromaeo_css 04:09:32 INFO - operating with platform_type : mac_ 04:09:32 INFO - Initialising browser for dromaeo_css test... 04:09:33 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpR3BBXA/profile http://localhost:49269/getInfo.html) 04:09:35 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 04:09:35 INFO - PROCESS | 1694 | colorDepth:24 04:09:35 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 04:09:35 INFO - PROCESS | 1694 | __metrics 04:09:35 INFO - PROCESS | 1694 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:09:35 ERROR - PROCESS | 1694 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:09:35 INFO - TEST-INFO | 1694: exit 0 04:09:35 INFO - Browser initialized. 04:09:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:36 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpR3BBXA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:47 INFO - PROCESS | 1698 | RSS: Main: 161968128 04:09:47 INFO - PROCESS | 1698 | 04:10:39 INFO - PROCESS | 1698 | 1467544239025 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:12:48 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 04:12:50 INFO - PROCESS | 1698 | RSS: Main: 299229184 04:12:50 INFO - PROCESS | 1698 | 04:15:53 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 04:15:53 INFO - PROCESS | 1698 | RSS: Main: 311418880 04:15:53 INFO - PROCESS | 1698 | 04:18:55 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 04:18:56 INFO - PROCESS | 1698 | RSS: Main: 314847232 04:18:56 INFO - PROCESS | 1698 | 04:21:58 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 04:21:58 INFO - PROCESS | 1698 | RSS: Main: 309043200 04:21:58 INFO - PROCESS | 1698 | 04:25:02 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 04:25:02 INFO - PROCESS | 1698 | RSS: Main: 273866752 04:25:02 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 04:28:05 INFO - PROCESS | 1698 | RSS: Main: 318447616 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | __start_tp_report 04:28:05 INFO - PROCESS | 1698 | _x_x_mozilla_page_load 04:28:05 INFO - PROCESS | 1698 | _x_x_mozilla_page_load_details 04:28:05 INFO - PROCESS | 1698 | |i|pagename|runs| 04:28:05 INFO - PROCESS | 1698 | |0;dojo.html;3019.5319725442555;3628.9092772680697;3637.9818100909492;3654.744167908246;3706.2031663192406;5852.824415267538;5871.588988770788;5889.263842019747;5944.613600115989;5979.342272350038;5562.443755624436;5852.648841069539;5944.167816505693;5944.881102377961;5961.523078153748;4556.225441674923;4761.476237613869;5282.788688452457;5283.969625922947;5345.786168553253;5358.892822143554;5392.78428862845;5403.675779453226;5410.431904649994;5425.782968681248;5300.973495132519;5349.893002139955;5359.5712343012465;5360.865978350553;5400.054990376688;5355.866103347428;5387.4612538746205;5390.595705322116;5411.864703382407;5432.402435732066;4950.87622809429;5188.9740551297;5241.580673546107;5351.598630102719;5355.705436201008;5745.569082318842;5774.422557744234;5790.247267855194;5795.014847475939;5805.390434004453;6261.27995280544;6279.591826531307;6285.748570057238;6295.087212354183;6298.874022519524;6186.7525298987985;6249.843753906189;6308.432241098323;6319.905201421982;6327.335629758855;6051.348099780843;6076.665783381913;6085.847853803691;6093.786717464867;6099.085137229363;6389.584676995981;6407.103005579223;6407.9426894561875;6415.166028416276;6430.0676401921455;5170.663906846043;6254.468370188585;6320.336364681734;6333.2400111985935;6357;5348.358197016305;6297.4017468340435;6303.873922521616;6312.116303717483;6318.4313411793155;6205.100260462208;6234.844128896814;6270.31026587075;6277.435030847246;6295.527835412271;6216.782412615627;6239.1577137085915;6278.811635650938;6324.272708638566;6349.333320001426;5043.646944713908;5077.31456253401;5084.796608135707;5090.49095090488;5092.1852503599985;4582.473015603182;4601.815927362868;4601.8849528761375;4615.746133962664;4637.698549594265;5954;6021.608595441282;6061.4544690977145;6106.725576339096;6133.355997620275;6270.717817698214;6323.20959880015;6324.810255692337;6327.746890124344;6342.904856427157;6061.787837425757;6078.513718902477;6081.57428979976;6100.328963813977;6108.3280839107665;5458.918116228259;5471.50756431923;5560.165975103686;5566.276384070045;5588.133839254922;6489.837754055998;6511.739530418825;6544.214694236627;6549.508786841101;6558;6291.402316779899;6339;6348.968255158695;6349.746010159542;6354.904676429765;6346.048092785934;6433.710483028369;6442.8389290268115;6444.581102228341;6456.063870738811;6249.687515624291;6330.39861213184;6346.2067241594805;6370.904436433365;6375.203099612549;6312.242530896322;6317.557770955989;6318.968405158129;6326.493880489457;6327.683615819283;6159.753609855556;6258.968705156445;6260.060990851227;6313.873722525615;6336.714847831767;6205.81382558524;6274.623522588659;6288.937110629018;6299.244090709144;6320.08358787964;6184.81445556634;6203.596766210182;6223.284322302993;6227;6231.53263505248;6097.359777223328;6111.995225780643;6122.581127188433;6200.81397558074;6280.937190628035;4798.832040878552;4854.514548545118;6249.9062514063235;6258.217722784652;6278.434940855345 04:28:05 INFO - PROCESS | 1698 | |1;ext.html;513.4172713969643;518.3883018038713;568.6929058308513;590.9793157239498;624.8625302433466;32600.836995815018;33337.333253334946;33396.66603333969;33491.16272093199;33499.49750753741;40886.7955660222;42061;42172.578274217245;42188.99999999992;42252.788736056355;9720.9792971738;9914.454704991223;9930.006999300085;9952.601895924154;9967.302288839785;9319.089586634758;9886.555105020256;9999.650012249573;10044;11834.408279586029;11972.580959666413;12017.459214335377;12050;12051.879481205207;12052.457639406248;10524.842127368096;11559.884401155965;11935.403229838474;11996.880031199707;12023.458944347438;11700.23948443357;11820.23168494045;11838.230515016583;11843.526258949632;11861.881381186164;39794.60205397967;41704;42188.78905605483;42302.153956921;42310;3357.3285342931513;3400.829958502065;3855.8072096395067;3877.3214687429586;3990.3216453203027;29361;30258.84870575655;30309.545356819664;30318.242043948856;30740.53889191664;2734.986325068382;2750.0787236275874;2796.4546913351905;2803.3972695870284;2818.9013384531445;351347.2432637846;354078;354895;355121;355468;37618;64575;65017.67491162514;65159.34840651533;65276.020859687145;36992.44511332332;36998.445023324675;37094.25811483809;37135.62864371376;37162.256754865295;16180.838191618168;16405.769567282263;16439.589010274838;16449.69704241407;16455.588610284838;11735.41322933867;13766.724665506634;13864.02951793385;13887.930560347335;13903.513377031755;8013.599320033975;8198.057223419264;8483.133710583661;8618.913810861937;8675.39272250949;3053.2977415194187;3454.9654503455145;3485.390056740111;3549.343371476285;3563.483294922222;1068.9358638481715;1075.4031512510476;1086.999960036768;1094.3871431998107;1118.1948996722347;29213.415731685247;29899.252518687208;29942.70057299443;30501;30538.54192187119;1137.9601713940137;1145.6505765741529;1170.4089434835353;1191.249512806926;1213.2841623442212;16028.599285017968;16061.598460038358;16070.839291607168;16365.918170409072;16443;653695;660235;661721;662842.5436600937;662911;60988;61498;61558;61592.076118858255;61690;1258.238765546831;1483.9183844888419;1549.2486144220045;1558.462330495977;1558.6960542694292;28708.138755837357;29883.55174672425;29896.402071958873;29932.700672993862;30632.234194144432;48033.27950080681;48341.03317933692;48831.511684882695;48936.75531622319;48984;354383.2280838579;358433;359203;360389;664407;27635.30911727223;28576.714232858238;28718.712812871603;28723.425531489673;28750.424991499636;42588.787056064524;46406;46618.76690616525;46730.53269467262;47139.76430117827;38119;38385;40018.199636007696;41241;42036.5287214946;36351.63648363482;37001.44497832588;37438.8128059358;37719.245615087;37744.056398590255;36397;37297.81351093336;37775;37884.81057594695;37945;31677.524837127923;32879.50680739743;33120.337593248485;33122.66877331196;33194.33611327712;25483.61774573346;25793.87103064473;25988.09041683532;26138.86930565335;26235.212943610957 04:28:05 INFO - PROCESS | 1698 | |2;jquery.html;411.3418530351437;411.6953454443712;414.5015767998686;414.6019820971867;422.1514755341762;20841.8536980466;21616.027278772453;21629.783702162993;21712.8914355428;22680.54638907225;12214.328211948361;12556.874431255685;17574.736378954294;21702.782972170273;21714.674279885814;5211.114110601188;5332.706701131437;5660.575456840733;6215.50275977923;6242.9687851560675;6106.175666285061;6194.442500174983;6214.3474935131835;6218.968905155468;6226;5964.254468191476;6178.536609754264;6203.844903877417;6236.563440559163;6244.000959846426;6146.8770624587705;6207.658578778165;6211.347808480113;6214.663847272813;6220.098085777559;5519.254900588409;5530.142827861688;5838.241028666289;5843.357230704619;5845.298564172326;14181.78727319091;14235.85764142366;14396.928015359961;14442.277886105652;14443.133411995314;2028.239410221167;2068.989655051715;2094.8219401350902;2188.6060509108356;2752.8348299101917;10085.647002354883;12053.915147636755;13153.671158221025;13893.171668787207;15346.309416076303;1708.5216139480965;1742.3901634427848;1771.1941066814697;1775.4407361681158;1806.6025474395612;78936.21063789345;79906.60046699787;81007.5949620254;104850;120969.99999999913;11536.94231528837;11914.40427978615;12085.516579336903;12176.756464870654;12177.878221217852;14489.78265326021;15985.680286394207;16034.518964431085;16055.19724013818;16058.116803575915;8370.288525475282;8784.912150878537;8927.732168034969;9258.027907069662;9300;7610.238976102456;9212.216961558208;9359.298052645943;9377.015413381632;9459.959404465504;4716.693414928019;4792.137415265286;4823.131836269435;4837.05677392905;4841.588464980516;1724.8792584519215;1763.393070947605;1955.1201959118453;2027.2869425335568;2041.6835390514493;778.661282342183;1008.2891561449161;1048.7535429174138;1079.8758142813676;1088.7713580148259;16486.6702665946;19707.605847882962;20395.796042039685;20506.38480845577;20667.793322066587;991.9553620087113;1006.9697909062739;1053.4048262731533;1069.7325668582855;1078.795028944498;10868.184886133571;11198.496067676973;11214.860582859268;11248.726502726697;11271.492782824793;600821;657769;662319;684293;695877.5206124039;142687;145641.27179364246;146846;147940;152161.47838521472;1023.3859684189426;1031.185363562792;1039.26212389203;1041.193075366597;1042.2704107124891;18766.718499222796;18910.716339254646;19008.049597519792;19101.522461938563;19311.51721206981;35865.82067089648;49807;53184.202236965706;53397;57422.42577574171;82132;83248;84087.5795621018;84625.73061403961;84726;8184.754457366289;8301.792455188668;8403.369747268856;8663.393562450568;8891.333150013645;12287.324197168884;12771.489140434278;13017.869821302045;13133.277669728257;13163.407646655733;10754.24720269605;10883.23817332779;11456.770864582828;11489.310641361544;11588.956993870592;10745.194110441591;10826.296290741077;11027.889721102687;11038.779224415306;11424.428778561205;11395.772084558428;11455;11536.307821530734;11731.530738770354;11798.705032374259;8463.74608761738;8464.788380290296;8474.618642160995;8479.915200847912;8511.872321915052;10971.122310215324;11380.260283081574;11393;11403;11632.360220187971 04:28:05 INFO - PROCESS | 1698 | |3;mootools.html;1483.3176738700197;1609.806823181218;1620.7244768389369;1885.1799467231756;1987.1852540458415;8185.7135000275;8842.690505832297;8990.820183596325;9011.098890110994;9036.8644470333;8566.271866891322;8833.911660883405;8845.778855528615;8853.822923541526;8869.46783193009;2506.348349429152;2531.3798119460666;2531.405119796846;2534.556452620793;2535.277445927911;2467.1858286765323;2531.6835395575554;2538.9873050634815;2542.1356738708837;2544.478381931709;2490.8256422050463;2521.621756736486;2522.419843436011;2523.0538548044483;2537.4544472938314;2482.0692240409758;2510.669345247022;2515.6855393075866;2534.9112781052577;2538.1243471002476;2479.9876000619884;2517.471331020488;2522.4198434360014;2525.861077640729;2530.8481491110592;8785.956070219672;8855.380123391365;8958.507282099481;8958.731238062803;8971.192592666692;5496.972515137439;5668.8866222675315;5669.886602267931;5679.261695979538;5699.173619825144;3338.9499157512655;3516.613172551017;3525;3642.963570364289;3678.062094165997;1031.4584842957433;1050.453764042701;1051.989480105197;1052.321252791945;1053.2153545608571;11957.402129893557;12155.392230388534;12175.208611440228;12198.756024879453;12199.878001219962;4625.421822272216;4748.601956012191;4749.4775574686755;4760.476347601761;4829.444613869379;9604.27967902396;9609.423434593948;9615.326927115175;9618.567164477616;9626.037396260457;5455.727213639302;5459.099248624012;5492.588055895823;5507.476789704971;5527.419620939824;4568.132054909556;4668.206404911173;4715.882102947454;4722.9763851181215;5159.277701121846;3637.9818100909856;3910.631279052309;3986.5016872890887;4015.437838702584;4030.7380020298588;1187.2045729361348;1224.3082658298033;1233.5620854596489;1235.123062625546;1238.2013601227159;921.7234829551107;930.186087173723;962.8844538655406;983.4738414947968;1019.5310157327564;5791.449812267828;5885.970570147208;6048.274207095089;6065.363136870565;6188.845278867974;943.5235206220815;948.8339540580371;952.8046750416148;982.1504398695077;999.3803841618243;3964.385520244367;4013.3177359848896;4022.1553473770837;4062.7968601569805;4120.958790412057;10373.481325933673;10850.186236032328;10953.452327383598;10982.560697572168;10983.39591322485;10728.517216725266;10748.140148788078;10822.837657435144;10840.728981775519;10858.619948301772;8481;8484.745457636282;8506;8533.786655333543;8537.701180458778;5633.492985631149;5939.465448109518;5956.612820166675;5992.850178745566;6069.9089513656445;9843.261755368232;9985.45080020606;10105;10123.088921997056;10135.847962280424;9371.203447707021;9834.60661573529;10136.239782016231;10335.689929302132;10375.844362334721;7050.612216328152;7141.321574450419;7164;7265;7277.781666550012;7430.814229644302;7704.961475192588;7794.181610930771;8605.612747426256;8614.61234244448;7896.131425543071;7907.802304942423;7925.28672419485;8091.271785539329;8125.959370203112;7677.347425468674;7702.884456733042;7775.688972441265;7792.025996750406;7883.975083239142;7045.929540704527;7058.54119482232;7105.467089968376;7108.680109395193;7113.8577228454105;5085.4406015337545;5152.252923326172;5326.227696983993;5346.625736198429;5355.357357117015;5281.815136470205;5286.682799032071;5325.334333208349;5395.406505284494;5577.330720313588 04:28:05 INFO - PROCESS | 1698 | |4;prototype.html;321.75868098925804;330.2289154823487;335.77335298673387;338.16304646001134;340.8806917578846;5477.643953143043;6670.032845237443;6678.332166783319;6698.196216454026;6701.6261666358405;5989.940100598993;6557.278699343068;6669.066330713692;6675.66621668917;6679.699413526391;3910.921781564367;4701.50634183411;4772.880677983044;4854.854354369375;4940.629452791037;4808.711477311355;4862.610991120702;4880.267959806022;4885.36490256268;4896.755162241891;4824.0834241494;4831.033793241349;4833.589144922686;4841.467438581753;4850.248211527219;4677.789499472515;4774.737389443597;4871.391076115486;4887.682300650446;4894.265860120975;4205.8527951521855;4210.51579068408;4210.768407737573;4212.978935105336;4213.5786421357925;5174.43081261061;6348.746050158034;6415.775447859302;6417.582857114273;6440.227172739301;5843.357230704619;5848.883022339572;5853.122031695238;5854.47309742121;5886.852828679274;6814.352636499525;7078.469114816357;7083.858322833515;7083.893741593829;7098.538594991309;4752.358431611723;4758.524147585248;4768.61851051915;4771.713697178146;4782.832600858988;7326.780196594111;7493.775186744352;7510.699572017113;7512.924870751332;7522.887156692654;4822.228443449031;4831.0096430231715;4858.392700912386;4860.8298709545;4861.076395484846;4031;4912.354361289008;4915.729634870045;4917.975410122926;4939.3084968104495;5656.547476201894;5842.386549412336;5849.444302791313;5853.209816674695;5854.151148083504;7072.575645461289;7117.299004517622;7127.821804454827;7139.286071392819;7157.6779044943105;1494.7593497397133;1649.0765171503997;1719.3982106262708;1721.8364255395718;1722.991385043092;988.8318985772436;1040.4173662748885;1052.2003277509148;1061.9893801062044;1098.417838545572;6647.534672572873;6780.559263647847;6788.811957907346;6858.554193977476;6865.897011544831;7398.371138453184;7423.480356375002;7451.664675089634;7457.962710186414;7466.2160473150625;6852.6231057292325;6853.794386168323;6854.6229957351825;6858.828529286808;6868.450523958071;3724.906877328034;3866.420036994417;3900.414937759302;3920.5099362579676;3934.5475270343704;7351.852962940711;7761.883571746428;7817.8827317590285;7822.1004584472375;7849.960750196213;7613.276738709814;7616.200298968529;7638;7661.731839385595;7666.693332266758;6216.689165541795;7782.182870798598;7786.688532458751;7790.337821285254;7794.805129871798;7028.8945665814035;7324.340809327186;7357.117145942521;7377.8524429510035;7382.5939573323985;7196.316349946746;7232.855342893218;7258.3104605062435;7258.528195667264;7289.198188199188;7726.18875018115;7754.418418618513;7756;7759.883601745865;7781.455298129076;4608.193566125981;4667.346571480063;4671.369365135799;4674.485806561208;4675.9064818702755;7068.5758854468895;7335.3398194160645;7350.77947661571;7354;7393.371563416955;7096.084057304396;7158.498905076594;7177.784666460015;7198.136223653195;7202.53183543068;7141.178764442156;7144.428445724226;7144.892826607501;7151.356377926011;7152.892706609509;6984;6985.860282794214;6991.510594258353;7013.754518592029;7026.2271150174465;6045.274567051806;6255.374462553708;6435.8093752655905;6912.516123871482;7143.392811611071;5437.700926449083;6811.352921472452;6890.483213758888;6937.271586483548;6963.8607227854145 04:28:05 INFO - PROCESS | 1698 | |5;yui.html;716.8566286742652;774.554631087125;791.1100012485954;794.1740589786622;800.3397197312219;15353.53939381819;15606.843931560681;15694.76457853133;15728.60678483037;15766.054036757803;14415.279236038183;14478;14495.130292182477;14529.418823247057;14547.781783273233;779.6920216514487;793.4287313134563;936.0686117313282;968.2012339819642;973.4256788494787;955.4362925873733;963.9662611808589;969.7139343893533;970;971.7182017214999;831.9168083191693;1004.2116938203511;1008.6973907827659;1009.0363702663975;1009.4296722351885;1001.1690297053428;1024.2011231239644;1025.067188858143;1029.0892560084342;1029.3875144289136;761.9771406857803;765.0627980723625;766.0080196146005;766.9846603067963;767.1906139023329;15328.846711532853;15372;15396.846031539653;15411.075335479907;15417.074975501506;11465.598704045318;13033.54382596614;13289.667758306023;13379.53171638988;13686.863131368658;10346.793064138676;10384.117350025257;10496.737581560446;10790.082842958358;11112.888711128904;3065.2949821540947;3537.204129070964;3541.557305336833;3627.8911632650797;3708.7589306694977;80108.79836802452;80265;81952.59023704844;88196.5590172045;88554.11445885588;9699.397204180274;9831.75420614476;10034.598616055277;10073.949630251802;10204.030617091365;19246.326378576683;23093.653595196087;23357;23362.53274934492;23508.529829403316;7834.608269586498;7859.253370929752;7867.409944254204;7916.129225785159;7996.600169991477;4267.4238977737605;4329.935050974238;4335.414719012956;4361.171377438277;4407.603315701603;3610.2598967211657;3672.779633222015;3674.595794462607;3675.8345874435713;3677.282929828711;575.7178982298727;576.8817392434624;597.7280337446451;613.2426453330133;676.2628734679223;577.1573502686041;601.3835818286204;605.2071785960406;617.2346290599714;628.8616504369031;8229.588520573947;8270.875936860952;8379.329653627696;8524.70163544273;8654.567271636519;541.9783208671608;590.9835083656104;601.3415310235285;610.6061590274248;647.9718481153958;3826.7512611680154;3969.7816620086173;4058.512978442606;4062.512498500199;4084.5799884464286;94633.5804962926;102328.97671023343;103481.44777828339;103720.48139759254;104182.47908760408;62902.68548657319;78849.60575197202;80172;80681.59659201784;80825.19174808294;55570.332890013364;69894;71333;72039.6398018017;72575.91136132962;7873.37013038944;7950.801229969297;7993.240642138988;8034.799130021796;8055.436119471581;49709.25436118533;51014.7246318845;51640;51889.22166167435;53971;66879.66560167167;66957.66521167557;67768.32231677817;70278.29721702718;73407;10956.890431095588;11313.490892909675;11319.773604528027;11386;11728.12039097054;11980.46087926028;12228.266304021787;12239.510419583474;12345.605167927917;12468.438920248793;11223.438828058728;11468.483918223867;11474.541018359507;11729.941350293195;11895.524179033087;12063.457144428347;12110.576129835414;12157.756844862877;12235.449404776984;12273.202241854251;11300.378479183724;11718.402717079345;11823.586174483851;11887.881121188677;11920;8861.867071993796;9214.58173065003;9788.314817962959;9846.556904939438;9913.909469958444;9928.503574821374;9944.204463643036;9961.153301969414;10240.743981400525;10248.743781405525 04:28:05 INFO - PROCESS | 1698 | __end_tp_report 04:28:05 INFO - PROCESS | 1698 | __start_cc_report 04:28:05 INFO - PROCESS | 1698 | _x_x_mozilla_cycle_collect,1227 04:28:05 INFO - PROCESS | 1698 | __end_cc_report 04:28:05 INFO - PROCESS | 1698 | __startTimestamp1467545285754__endTimestamp 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | ------- Summary: start ------- 04:28:05 INFO - PROCESS | 1698 | Number of tests: 6 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | [#0] dojo.html Cycles:165 Average:5863.92 Median:6159.75 stddev:654.92 (10.6%) stddev-sans-first:617.75 04:28:05 INFO - PROCESS | 1698 | Values: 3019.5 3628.9 3638.0 3654.7 3706.2 5852.8 5871.6 5889.3 5944.6 5979.3 5562.4 5852.6 5944.2 5944.9 5961.5 4556.2 4761.5 5282.8 5284.0 5345.8 5358.9 5392.8 5403.7 5410.4 5425.8 5301.0 5349.9 5359.6 5360.9 5400.1 5355.9 5387.5 5390.6 5411.9 5432.4 4950.9 5189.0 5241.6 5351.6 5355.7 5745.6 5774.4 5790.2 5795.0 5805.4 6261.3 6279.6 6285.7 6295.1 6298.9 6186.8 6249.8 6308.4 6319.9 6327.3 6051.3 6076.7 6085.8 6093.8 6099.1 6389.6 6407.1 6407.9 6415.2 6430.1 5170.7 6254.5 6320.3 6333.2 6357.0 5348.4 6297.4 6303.9 6312.1 6318.4 6205.1 6234.8 6270.3 6277.4 6295.5 6216.8 6239.2 6278.8 6324.3 6349.3 5043.6 5077.3 5084.8 5090.5 5092.2 4582.5 4601.8 4601.9 4615.7 4637.7 5954.0 6021.6 6061.5 6106.7 6133.4 6270.7 6323.2 6324.8 6327.7 6342.9 6061.8 6078.5 6081.6 6100.3 6108.3 5458.9 5471.5 5560.2 5566.3 5588.1 6489.8 6511.7 6544.2 6549.5 6558.0 6291.4 6339.0 6349.0 6349.7 6354.9 6346.0 6433.7 6442.8 6444.6 6456.1 6249.7 6330.4 6346.2 6370.9 6375.2 6312.2 6317.6 6319.0 6326.5 6327.7 6159.8 6259.0 6260.1 6313.9 6336.7 6205.8 6274.6 6288.9 6299.2 6320.1 6184.8 6203.6 6223.3 6227.0 6231.5 6097.4 6112.0 6122.6 6200.8 6280.9 4798.8 4854.5 6249.9 6258.2 6278.4 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | [#1] ext.html Cycles:180 Average:61648.31 Median:3470.18 stddev:134172.28 (3866.4%) stddev-sans-first:134470.16 04:28:05 INFO - PROCESS | 1698 | Values: 513.4 518.4 568.7 591.0 624.9 32600.8 33337.3 33396.7 33491.2 33499.5 40886.8 42061.0 42172.6 42189.0 42252.8 9721.0 9914.5 9930.0 9952.6 9967.3 9319.1 9886.6 9999.7 10044.0 11834.4 11972.6 12017.5 12050.0 12051.9 12052.5 10524.8 11559.9 11935.4 11996.9 12023.5 11700.2 11820.2 11838.2 11843.5 11861.9 39794.6 41704.0 42188.8 42302.2 42310.0 3357.3 3400.8 3855.8 3877.3 3990.3 29361.0 30258.8 30309.5 30318.2 30740.5 2735.0 2750.1 2796.5 2803.4 2818.9 351347.2 354078.0 354895.0 355121.0 355468.0 37618.0 64575.0 65017.7 65159.3 65276.0 36992.4 36998.4 37094.3 37135.6 37162.3 16180.8 16405.8 16439.6 16449.7 16455.6 11735.4 13766.7 13864.0 13887.9 13903.5 8013.6 8198.1 8483.1 8618.9 8675.4 3053.3 3455.0 3485.4 3549.3 3563.5 1068.9 1075.4 1087.0 1094.4 1118.2 29213.4 29899.3 29942.7 30501.0 30538.5 1138.0 1145.7 1170.4 1191.2 1213.3 16028.6 16061.6 16070.8 16365.9 16443.0 653695.0 660235.0 661721.0 662842.5 662911.0 60988.0 61498.0 61558.0 61592.1 61690.0 1258.2 1483.9 1549.2 1558.5 1558.7 28708.1 29883.6 29896.4 29932.7 30632.2 48033.3 48341.0 48831.5 48936.8 48984.0 354383.2 358433.0 359203.0 360389.0 664407.0 27635.3 28576.7 28718.7 28723.4 28750.4 42588.8 46406.0 46618.8 46730.5 47139.8 38119.0 38385.0 40018.2 41241.0 42036.5 36351.6 37001.4 37438.8 37719.2 37744.1 36397.0 37297.8 37775.0 37884.8 37945.0 31677.5 32879.5 33120.3 33122.7 33194.3 25483.6 25793.9 25988.1 26138.9 26235.2 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | [#2] jquery.html Cycles:180 Average:36521.82 Median:11218.74 stddev:109942.59 (980.0%) stddev-sans-first:110217.57 04:28:05 INFO - PROCESS | 1698 | Values: 411.3 411.7 414.5 414.6 422.2 20841.9 21616.0 21629.8 21712.9 22680.5 12214.3 12556.9 17574.7 21702.8 21714.7 5211.1 5332.7 5660.6 6215.5 6243.0 6106.2 6194.4 6214.3 6219.0 6226.0 5964.3 6178.5 6203.8 6236.6 6244.0 6146.9 6207.7 6211.3 6214.7 6220.1 5519.3 5530.1 5838.2 5843.4 5845.3 14181.8 14235.9 14396.9 14442.3 14443.1 2028.2 2069.0 2094.8 2188.6 2752.8 10085.6 12053.9 13153.7 13893.2 15346.3 1708.5 1742.4 1771.2 1775.4 1806.6 78936.2 79906.6 81007.6 104850.0 120970.0 11536.9 11914.4 12085.5 12176.8 12177.9 14489.8 15985.7 16034.5 16055.2 16058.1 8370.3 8784.9 8927.7 9258.0 9300.0 7610.2 9212.2 9359.3 9377.0 9460.0 4716.7 4792.1 4823.1 4837.1 4841.6 1724.9 1763.4 1955.1 2027.3 2041.7 778.7 1008.3 1048.8 1079.9 1088.8 16486.7 19707.6 20395.8 20506.4 20667.8 992.0 1007.0 1053.4 1069.7 1078.8 10868.2 11198.5 11214.9 11248.7 11271.5 600821.0 657769.0 662319.0 684293.0 695877.5 142687.0 145641.3 146846.0 147940.0 152161.5 1023.4 1031.2 1039.3 1041.2 1042.3 18766.7 18910.7 19008.0 19101.5 19311.5 35865.8 49807.0 53184.2 53397.0 57422.4 82132.0 83248.0 84087.6 84625.7 84726.0 8184.8 8301.8 8403.4 8663.4 8891.3 12287.3 12771.5 13017.9 13133.3 13163.4 10754.2 10883.2 11456.8 11489.3 11589.0 10745.2 10826.3 11027.9 11038.8 11424.4 11395.8 11455.0 11536.3 11731.5 11798.7 8463.7 8464.8 8474.6 8479.9 8511.9 10971.1 11380.3 11393.0 11403.0 11632.4 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | [#3] mootools.html Cycles:180 Average:5824.99 Median:5306.01 stddev:3210.58 (60.5%) stddev-sans-first:3203.01 04:28:05 INFO - PROCESS | 1698 | Values: 1483.3 1609.8 1620.7 1885.2 1987.2 8185.7 8842.7 8990.8 9011.1 9036.9 8566.3 8833.9 8845.8 8853.8 8869.5 2506.3 2531.4 2531.4 2534.6 2535.3 2467.2 2531.7 2539.0 2542.1 2544.5 2490.8 2521.6 2522.4 2523.1 2537.5 2482.1 2510.7 2515.7 2534.9 2538.1 2480.0 2517.5 2522.4 2525.9 2530.8 8786.0 8855.4 8958.5 8958.7 8971.2 5497.0 5668.9 5669.9 5679.3 5699.2 3338.9 3516.6 3525.0 3643.0 3678.1 1031.5 1050.5 1052.0 1052.3 1053.2 11957.4 12155.4 12175.2 12198.8 12199.9 4625.4 4748.6 4749.5 4760.5 4829.4 9604.3 9609.4 9615.3 9618.6 9626.0 5455.7 5459.1 5492.6 5507.5 5527.4 4568.1 4668.2 4715.9 4723.0 5159.3 3638.0 3910.6 3986.5 4015.4 4030.7 1187.2 1224.3 1233.6 1235.1 1238.2 921.7 930.2 962.9 983.5 1019.5 5791.4 5886.0 6048.3 6065.4 6188.8 943.5 948.8 952.8 982.2 999.4 3964.4 4013.3 4022.2 4062.8 4121.0 10373.5 10850.2 10953.5 10982.6 10983.4 10728.5 10748.1 10822.8 10840.7 10858.6 8481.0 8484.7 8506.0 8533.8 8537.7 5633.5 5939.5 5956.6 5992.9 6069.9 9843.3 9985.5 10105.0 10123.1 10135.8 9371.2 9834.6 10136.2 10335.7 10375.8 7050.6 7141.3 7164.0 7265.0 7277.8 7430.8 7705.0 7794.2 8605.6 8614.6 7896.1 7907.8 7925.3 8091.3 8126.0 7677.3 7702.9 7775.7 7792.0 7884.0 7045.9 7058.5 7105.5 7108.7 7113.9 5085.4 5152.3 5326.2 5346.6 5355.4 5281.8 5286.7 5325.3 5395.4 5577.3 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | [#4] prototype.html Cycles:180 Average:5825.35 Median:6677.00 stddev:1866.41 (28.0%) stddev-sans-first:1825.36 04:28:05 INFO - PROCESS | 1698 | Values: 321.8 330.2 335.8 338.2 340.9 5477.6 6670.0 6678.3 6698.2 6701.6 5989.9 6557.3 6669.1 6675.7 6679.7 3910.9 4701.5 4772.9 4854.9 4940.6 4808.7 4862.6 4880.3 4885.4 4896.8 4824.1 4831.0 4833.6 4841.5 4850.2 4677.8 4774.7 4871.4 4887.7 4894.3 4205.9 4210.5 4210.8 4213.0 4213.6 5174.4 6348.7 6415.8 6417.6 6440.2 5843.4 5848.9 5853.1 5854.5 5886.9 6814.4 7078.5 7083.9 7083.9 7098.5 4752.4 4758.5 4768.6 4771.7 4782.8 7326.8 7493.8 7510.7 7512.9 7522.9 4822.2 4831.0 4858.4 4860.8 4861.1 4031.0 4912.4 4915.7 4918.0 4939.3 5656.5 5842.4 5849.4 5853.2 5854.2 7072.6 7117.3 7127.8 7139.3 7157.7 1494.8 1649.1 1719.4 1721.8 1723.0 988.8 1040.4 1052.2 1062.0 1098.4 6647.5 6780.6 6788.8 6858.6 6865.9 7398.4 7423.5 7451.7 7458.0 7466.2 6852.6 6853.8 6854.6 6858.8 6868.5 3724.9 3866.4 3900.4 3920.5 3934.5 7351.9 7761.9 7817.9 7822.1 7850.0 7613.3 7616.2 7638.0 7661.7 7666.7 6216.7 7782.2 7786.7 7790.3 7794.8 7028.9 7324.3 7357.1 7377.9 7382.6 7196.3 7232.9 7258.3 7258.5 7289.2 7726.2 7754.4 7756.0 7759.9 7781.5 4608.2 4667.3 4671.4 4674.5 4675.9 7068.6 7335.3 7350.8 7354.0 7393.4 7096.1 7158.5 7177.8 7198.1 7202.5 7141.2 7144.4 7144.9 7151.4 7152.9 6984.0 6985.9 6991.5 7013.8 7026.2 6045.3 6255.4 6435.8 6912.5 7143.4 5437.7 6811.4 6890.5 6937.3 6963.9 04:28:05 INFO - PROCESS | 1698 | 04:28:05 INFO - PROCESS | 1698 | [#5] yui.html Cycles:180 Average:18843.76 Median:4348.29 stddev:26645.89 (612.8%) stddev-sans-first:26685.88 04:28:05 INFO - PROCESS | 1698 | Values: 716.9 774.6 791.1 794.2 800.3 15353.5 15606.8 15694.8 15728.6 15766.1 14415.3 14478.0 14495.1 14529.4 14547.8 779.7 793.4 936.1 968.2 973.4 955.4 964.0 969.7 970.0 971.7 831.9 1004.2 1008.7 1009.0 1009.4 1001.2 1024.2 1025.1 1029.1 1029.4 762.0 765.1 766.0 767.0 767.2 15328.8 15372.0 15396.8 15411.1 15417.1 11465.6 13033.5 13289.7 13379.5 13686.9 10346.8 10384.1 10496.7 10790.1 11112.9 3065.3 3537.2 3541.6 3627.9 3708.8 80108.8 80265.0 81952.6 88196.6 88554.1 9699.4 9831.8 10034.6 10073.9 10204.0 19246.3 23093.7 23357.0 23362.5 23508.5 7834.6 7859.3 7867.4 7916.1 7996.6 4267.4 4329.9 4335.4 4361.2 4407.6 3610.3 3672.8 3674.6 3675.8 3677.3 575.7 576.9 597.7 613.2 676.3 577.2 601.4 605.2 617.2 628.9 8229.6 8270.9 8379.3 8524.7 8654.6 542.0 591.0 601.3 610.6 648.0 3826.8 3969.8 4058.5 4062.5 4084.6 94633.6 102329.0 103481.4 103720.5 104182.5 62902.7 78849.6 80172.0 80681.6 80825.2 55570.3 69894.0 71333.0 72039.6 72575.9 7873.4 7950.8 7993.2 8034.8 8055.4 49709.3 51014.7 51640.0 51889.2 53971.0 66879.7 66957.7 67768.3 70278.3 73407.0 10956.9 11313.5 11319.8 11386.0 11728.1 11980.5 12228.3 12239.5 12345.6 12468.4 11223.4 11468.5 11474.5 11729.9 11895.5 12063.5 12110.6 12157.8 12235.4 12273.2 11300.4 11718.4 11823.6 11887.9 11920.0 8861.9 9214.6 9788.3 9846.6 9913.9 9928.5 9944.2 9961.2 10240.7 10248.7 04:28:05 INFO - PROCESS | 1698 | -------- Summary: end -------- 04:28:05 INFO - PROCESS | 1698 | 04:28:06 INFO - TEST-INFO | 1698: exit 0 04:28:06 INFO - TEST-OK | dromaeo_css | took 1113309ms 04:28:06 INFO - TEST-START | kraken 04:28:06 INFO - operating with platform_type : mac_ 04:28:06 INFO - Initialising browser for kraken test... 04:28:06 INFO - TEST-INFO | started process 1704 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp_IEbwx/profile http://localhost:49269/getInfo.html) 04:28:08 INFO - PROCESS | 1704 | __metrics Screen width/height:1600/1200 04:28:08 INFO - PROCESS | 1704 | colorDepth:24 04:28:08 INFO - PROCESS | 1704 | Browser inner width/height: 1024/689 04:28:08 INFO - PROCESS | 1704 | __metrics 04:28:08 INFO - PROCESS | 1704 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:28:08 ERROR - PROCESS | 1704 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:28:09 INFO - TEST-INFO | 1704: exit 0 04:28:09 INFO - Browser initialized. 04:28:09 INFO - Running cycle 1/1 for kraken test... 04:28:09 INFO - TEST-INFO | started process 1707 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp_IEbwx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:20 INFO - PROCESS | 1707 | RSS: Main: 162045952 04:28:20 INFO - PROCESS | 1707 | 04:28:23 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:24 INFO - PROCESS | 1707 | RSS: Main: 224296960 04:28:24 INFO - PROCESS | 1707 | 04:28:26 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 04:28:27 INFO - PROCESS | 1707 | RSS: Main: 240029696 04:28:27 INFO - PROCESS | 1707 | 04:28:30 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 04:28:31 INFO - PROCESS | 1707 | RSS: Main: 324747264 04:28:31 INFO - PROCESS | 1707 | 04:28:33 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 04:28:33 INFO - PROCESS | 1707 | RSS: Main: 231231488 04:28:33 INFO - PROCESS | 1707 | 04:28:36 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:36 INFO - PROCESS | 1707 | RSS: Main: 232271872 04:28:36 INFO - PROCESS | 1707 | 04:28:39 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:40 INFO - PROCESS | 1707 | RSS: Main: 270659584 04:28:40 INFO - PROCESS | 1707 | 04:28:42 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:43 INFO - PROCESS | 1707 | RSS: Main: 271507456 04:28:43 INFO - PROCESS | 1707 | 04:28:46 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 04:28:46 INFO - PROCESS | 1707 | RSS: Main: 269561856 04:28:46 INFO - PROCESS | 1707 | 04:28:48 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:49 INFO - PROCESS | 1707 | RSS: Main: 261345280 04:28:49 INFO - PROCESS | 1707 | 04:28:51 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:51 INFO - PROCESS | 1707 | RSS: Main: 267866112 04:28:51 INFO - PROCESS | 1707 | 04:28:53 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:54 INFO - PROCESS | 1707 | RSS: Main: 271687680 04:28:54 INFO - PROCESS | 1707 | 04:28:57 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:57 INFO - PROCESS | 1707 | RSS: Main: 278085632 04:28:57 INFO - PROCESS | 1707 | 04:29:00 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:01 INFO - PROCESS | 1707 | RSS: Main: 275165184 04:29:01 INFO - PROCESS | 1707 | 04:29:02 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 04:29:03 INFO - PROCESS | 1707 | RSS: Main: 336838656 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | __start_tp_report 04:29:03 INFO - PROCESS | 1707 | _x_x_mozilla_page_load 04:29:03 INFO - PROCESS | 1707 | _x_x_mozilla_page_load_details 04:29:03 INFO - PROCESS | 1707 | |i|pagename|runs| 04:29:03 INFO - PROCESS | 1707 | |0;ai-astar;113;113;120;112;113;112;113;113;112;134 04:29:03 INFO - PROCESS | 1707 | |1;audio-beat-detection;156;120;140;165;116;140;138;117;165;116 04:29:03 INFO - PROCESS | 1707 | |2;audio-dft;185;186;183;184;185;182;201;264;202;184 04:29:03 INFO - PROCESS | 1707 | |3;audio-fft;72;78;74;151;55;55;56;61;126;55 04:29:03 INFO - PROCESS | 1707 | |4;audio-oscillator;89;88;142;80;79;80;124;79;80;134 04:29:03 INFO - PROCESS | 1707 | |5;imaging-gaussian-blur;90;86;89;87;89;85;90;88;90;86 04:29:03 INFO - PROCESS | 1707 | |6;imaging-darkroom;94;95;95;95;95;94;97;94;92;134 04:29:03 INFO - PROCESS | 1707 | |7;imaging-desaturate;85;84;84;84;86;85;86;85;86;84 04:29:03 INFO - PROCESS | 1707 | |8;json-parse-financial;61;63;64;64;59;63;89;111;94;69 04:29:03 INFO - PROCESS | 1707 | |9;json-stringify-tinderbox;64;62;67;68;73;68;64;65;63;69 04:29:03 INFO - PROCESS | 1707 | |10;stanford-crypto-aes;78;80;79;79;79;78;78;78;74;84 04:29:03 INFO - PROCESS | 1707 | |11;stanford-crypto-ccm;139;148;149;123;123;125;127;124;146;142 04:29:03 INFO - PROCESS | 1707 | |12;stanford-crypto-pbkdf2;161;162;162;175;165;165;171;176;169;162 04:29:03 INFO - PROCESS | 1707 | |13;stanford-crypto-sha256-iterative;67;67;68;66;68;65;68;69;66;65 04:29:03 INFO - PROCESS | 1707 | __end_tp_report 04:29:03 INFO - PROCESS | 1707 | __start_cc_report 04:29:03 INFO - PROCESS | 1707 | _x_x_mozilla_cycle_collect,1942 04:29:03 INFO - PROCESS | 1707 | __end_cc_report 04:29:03 INFO - PROCESS | 1707 | __startTimestamp1467545343178__endTimestamp 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | ------- Summary: start ------- 04:29:03 INFO - PROCESS | 1707 | Number of tests: 14 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#0] ai-astar Cycles:10 Average:115.50 Median:113.00 stddev:6.92 (6.1%) stddev-sans-first:7.28 04:29:03 INFO - PROCESS | 1707 | Values: 113.0 113.0 120.0 112.0 113.0 112.0 113.0 113.0 112.0 134.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:140.00 stddev:19.77 (14.1%) stddev-sans-first:19.78 04:29:03 INFO - PROCESS | 1707 | Values: 156.0 120.0 140.0 165.0 116.0 140.0 138.0 117.0 165.0 116.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#2] audio-dft Cycles:10 Average:195.60 Median:185.50 stddev:25.12 (13.5%) stddev-sans-first:26.35 04:29:03 INFO - PROCESS | 1707 | Values: 185.0 186.0 183.0 184.0 185.0 182.0 201.0 264.0 202.0 184.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#3] audio-fft Cycles:10 Average:78.30 Median:58.50 stddev:33.41 (57.1%) stddev-sans-first:35.36 04:29:03 INFO - PROCESS | 1707 | Values: 72.0 78.0 74.0 151.0 55.0 55.0 56.0 61.0 126.0 55.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:80.00 stddev:25.34 (31.7%) stddev-sans-first:26.69 04:29:03 INFO - PROCESS | 1707 | Values: 89.0 88.0 142.0 80.0 79.0 80.0 124.0 79.0 80.0 134.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:89.00 stddev:1.89 (2.1%) stddev-sans-first:1.86 04:29:03 INFO - PROCESS | 1707 | Values: 90.0 86.0 89.0 87.0 89.0 85.0 90.0 88.0 90.0 86.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:95.00 stddev:12.54 (13.2%) stddev-sans-first:13.19 04:29:03 INFO - PROCESS | 1707 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 97.0 94.0 92.0 134.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.88 (1.0%) stddev-sans-first:0.93 04:29:03 INFO - PROCESS | 1707 | Values: 85.0 84.0 84.0 84.0 86.0 85.0 86.0 85.0 86.0 84.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#8] json-parse-financial Cycles:10 Average:73.70 Median:64.00 stddev:17.81 (27.8%) stddev-sans-first:18.29 04:29:03 INFO - PROCESS | 1707 | Values: 61.0 63.0 64.0 64.0 59.0 63.0 89.0 111.0 94.0 69.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:67.50 stddev:3.33 (4.9%) stddev-sans-first:3.43 04:29:03 INFO - PROCESS | 1707 | Values: 64.0 62.0 67.0 68.0 73.0 68.0 64.0 65.0 63.0 69.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:2.45 (3.1%) stddev-sans-first:2.59 04:29:03 INFO - PROCESS | 1707 | Values: 78.0 80.0 79.0 79.0 79.0 78.0 78.0 78.0 74.0 84.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:140.50 stddev:11.17 (7.9%) stddev-sans-first:11.73 04:29:03 INFO - PROCESS | 1707 | Values: 139.0 148.0 149.0 123.0 123.0 125.0 127.0 124.0 146.0 142.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:5.61 (3.4%) stddev-sans-first:5.55 04:29:03 INFO - PROCESS | 1707 | Values: 161.0 162.0 162.0 175.0 165.0 165.0 171.0 176.0 169.0 162.0 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - PROCESS | 1707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.37 (2.0%) stddev-sans-first:1.45 04:29:03 INFO - PROCESS | 1707 | Values: 67.0 67.0 68.0 66.0 68.0 65.0 68.0 69.0 66.0 65.0 04:29:03 INFO - PROCESS | 1707 | -------- Summary: end -------- 04:29:03 INFO - PROCESS | 1707 | 04:29:03 INFO - TEST-INFO | 1707: exit 0 04:29:03 INFO - TEST-OK | kraken | took 57647ms 04:29:03 INFO - SUITE-END | took 1170s 04:29:04 INFO - Completed test suite (00:19:31) 04:29:04 INFO - javascript benchmark 04:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.5319725442555, 3628.9092772680697, 3637.9818100909492, 3654.744167908246, 3706.2031663192406, 5852.824415267538, 5871.588988770788, 5889.263842019747, 5944.613600115989, 5979.342272350038, 5562.443755624436, 5852.648841069539, 5944.167816505693, 5944.881102377961, 5961.523078153748, 4556.225441674923, 4761.476237613869, 5282.788688452457, 5283.969625922947, 5345.786168553253, 5358.892822143554, 5392.78428862845, 5403.675779453226, 5410.431904649994, 5425.782968681248, 5300.973495132519, 5349.893002139955, 5359.5712343012465, 5360.865978350553, 5400.054990376688, 5355.866103347428, 5387.4612538746205, 5390.595705322116, 5411.864703382407, 5432.402435732066, 4950.87622809429, 5188.9740551297, 5241.580673546107, 5351.598630102719, 5355.705436201008, 5745.569082318842, 5774.422557744234, 5790.247267855194, 5795.014847475939, 5805.390434004453, 6261.27995280544, 6279.591826531307, 6285.748570057238, 6295.087212354183, 6298.874022519524, 6186.7525298987985, 6249.843753906189, 6308.432241098323, 6319.905201421982, 6327.335629758855, 6051.348099780843, 6076.665783381913, 6085.847853803691, 6093.786717464867, 6099.085137229363, 6389.584676995981, 6407.103005579223, 6407.9426894561875, 6415.166028416276, 6430.0676401921455, 5170.663906846043, 6254.468370188585, 6320.336364681734, 6333.2400111985935, 6357.0, 5348.358197016305, 6297.4017468340435, 6303.873922521616, 6312.116303717483, 6318.4313411793155, 6205.100260462208, 6234.844128896814, 6270.31026587075, 6277.435030847246, 6295.527835412271, 6216.782412615627, 6239.1577137085915, 6278.811635650938, 6324.272708638566, 6349.333320001426, 5043.646944713908, 5077.31456253401, 5084.796608135707, 5090.49095090488, 5092.1852503599985, 4582.473015603182, 4601.815927362868, 4601.8849528761375, 4615.746133962664, 4637.698549594265, 5954.0, 6021.608595441282, 6061.4544690977145, 6106.725576339096, 6133.355997620275, 6270.717817698214, 6323.20959880015, 6324.810255692337, 6327.746890124344, 6342.904856427157, 6061.787837425757, 6078.513718902477, 6081.57428979976, 6100.328963813977, 6108.3280839107665, 5458.918116228259, 5471.50756431923, 5560.165975103686, 5566.276384070045, 5588.133839254922, 6489.837754055998, 6511.739530418825, 6544.214694236627, 6549.508786841101, 6558.0, 6291.402316779899, 6339.0, 6348.968255158695, 6349.746010159542, 6354.904676429765, 6346.048092785934, 6433.710483028369, 6442.8389290268115, 6444.581102228341, 6456.063870738811, 6249.687515624291, 6330.39861213184, 6346.2067241594805, 6370.904436433365, 6375.203099612549, 6312.242530896322, 6317.557770955989, 6318.968405158129, 6326.493880489457, 6327.683615819283, 6159.753609855556, 6258.968705156445, 6260.060990851227, 6313.873722525615, 6336.714847831767, 6205.81382558524, 6274.623522588659, 6288.937110629018, 6299.244090709144, 6320.08358787964, 6184.81445556634, 6203.596766210182, 6223.284322302993, 6227.0, 6231.53263505248, 6097.359777223328, 6111.995225780643, 6122.581127188433, 6200.81397558074, 6280.937190628035, 4798.832040878552, 4854.514548545118, 6249.9062514063235, 6258.217722784652, 6278.434940855345], "value": 5824.368108320534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.4172713969643, 518.3883018038713, 568.6929058308513, 590.9793157239498, 624.8625302433466, 32600.836995815018, 33337.333253334946, 33396.66603333969, 33491.16272093199, 33499.49750753741, 40886.7955660222, 42061.0, 42172.578274217245, 42188.99999999992, 42252.788736056355, 9720.9792971738, 9914.454704991223, 9930.006999300085, 9952.601895924154, 9967.302288839785, 9319.089586634758, 9886.555105020256, 9999.650012249573, 10044.0, 11834.408279586029, 11972.580959666413, 12017.459214335377, 12050.0, 12051.879481205207, 12052.457639406248, 10524.842127368096, 11559.884401155965, 11935.403229838474, 11996.880031199707, 12023.458944347438, 11700.23948443357, 11820.23168494045, 11838.230515016583, 11843.526258949632, 11861.881381186164, 39794.60205397967, 41704.0, 42188.78905605483, 42302.153956921, 42310.0, 3357.3285342931513, 3400.829958502065, 3855.8072096395067, 3877.3214687429586, 3990.3216453203027, 29361.0, 30258.84870575655, 30309.545356819664, 30318.242043948856, 30740.53889191664, 2734.986325068382, 2750.0787236275874, 2796.4546913351905, 2803.3972695870284, 2818.9013384531445, 351347.2432637846, 354078.0, 354895.0, 355121.0, 355468.0, 37618.0, 64575.0, 65017.67491162514, 65159.34840651533, 65276.020859687145, 36992.44511332332, 36998.445023324675, 37094.25811483809, 37135.62864371376, 37162.256754865295, 16180.838191618168, 16405.769567282263, 16439.589010274838, 16449.69704241407, 16455.588610284838, 11735.41322933867, 13766.724665506634, 13864.02951793385, 13887.930560347335, 13903.513377031755, 8013.599320033975, 8198.057223419264, 8483.133710583661, 8618.913810861937, 8675.39272250949, 3053.2977415194187, 3454.9654503455145, 3485.390056740111, 3549.343371476285, 3563.483294922222, 1068.9358638481715, 1075.4031512510476, 1086.999960036768, 1094.3871431998107, 1118.1948996722347, 29213.415731685247, 29899.252518687208, 29942.70057299443, 30501.0, 30538.54192187119, 1137.9601713940137, 1145.6505765741529, 1170.4089434835353, 1191.249512806926, 1213.2841623442212, 16028.599285017968, 16061.598460038358, 16070.839291607168, 16365.918170409072, 16443.0, 653695.0, 660235.0, 661721.0, 662842.5436600937, 662911.0, 60988.0, 61498.0, 61558.0, 61592.076118858255, 61690.0, 1258.238765546831, 1483.9183844888419, 1549.2486144220045, 1558.462330495977, 1558.6960542694292, 28708.138755837357, 29883.55174672425, 29896.402071958873, 29932.700672993862, 30632.234194144432, 48033.27950080681, 48341.03317933692, 48831.511684882695, 48936.75531622319, 48984.0, 354383.2280838579, 358433.0, 359203.0, 360389.0, 664407.0, 27635.30911727223, 28576.714232858238, 28718.712812871603, 28723.425531489673, 28750.424991499636, 42588.787056064524, 46406.0, 46618.76690616525, 46730.53269467262, 47139.76430117827, 38119.0, 38385.0, 40018.199636007696, 41241.0, 42036.5287214946, 36351.63648363482, 37001.44497832588, 37438.8128059358, 37719.245615087, 37744.056398590255, 36397.0, 37297.81351093336, 37775.0, 37884.81057594695, 37945.0, 31677.524837127923, 32879.50680739743, 33120.337593248485, 33122.66877331196, 33194.33611327712, 25483.61774573346, 25793.87103064473, 25988.09041683532, 26138.86930565335, 26235.212943610957], "value": 19045.530982321656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.3418530351437, 411.6953454443712, 414.5015767998686, 414.6019820971867, 422.1514755341762, 20841.8536980466, 21616.027278772453, 21629.783702162993, 21712.8914355428, 22680.54638907225, 12214.328211948361, 12556.874431255685, 17574.736378954294, 21702.782972170273, 21714.674279885814, 5211.114110601188, 5332.706701131437, 5660.575456840733, 6215.50275977923, 6242.9687851560675, 6106.175666285061, 6194.442500174983, 6214.3474935131835, 6218.968905155468, 6226.0, 5964.254468191476, 6178.536609754264, 6203.844903877417, 6236.563440559163, 6244.000959846426, 6146.8770624587705, 6207.658578778165, 6211.347808480113, 6214.663847272813, 6220.098085777559, 5519.254900588409, 5530.142827861688, 5838.241028666289, 5843.357230704619, 5845.298564172326, 14181.78727319091, 14235.85764142366, 14396.928015359961, 14442.277886105652, 14443.133411995314, 2028.239410221167, 2068.989655051715, 2094.8219401350902, 2188.6060509108356, 2752.8348299101917, 10085.647002354883, 12053.915147636755, 13153.671158221025, 13893.171668787207, 15346.309416076303, 1708.5216139480965, 1742.3901634427848, 1771.1941066814697, 1775.4407361681158, 1806.6025474395612, 78936.21063789345, 79906.60046699787, 81007.5949620254, 104850.0, 120969.99999999913, 11536.94231528837, 11914.40427978615, 12085.516579336903, 12176.756464870654, 12177.878221217852, 14489.78265326021, 15985.680286394207, 16034.518964431085, 16055.19724013818, 16058.116803575915, 8370.288525475282, 8784.912150878537, 8927.732168034969, 9258.027907069662, 9300.0, 7610.238976102456, 9212.216961558208, 9359.298052645943, 9377.015413381632, 9459.959404465504, 4716.693414928019, 4792.137415265286, 4823.131836269435, 4837.05677392905, 4841.588464980516, 1724.8792584519215, 1763.393070947605, 1955.1201959118453, 2027.2869425335568, 2041.6835390514493, 778.661282342183, 1008.2891561449161, 1048.7535429174138, 1079.8758142813676, 1088.7713580148259, 16486.6702665946, 19707.605847882962, 20395.796042039685, 20506.38480845577, 20667.793322066587, 991.9553620087113, 1006.9697909062739, 1053.4048262731533, 1069.7325668582855, 1078.795028944498, 10868.184886133571, 11198.496067676973, 11214.860582859268, 11248.726502726697, 11271.492782824793, 600821.0, 657769.0, 662319.0, 684293.0, 695877.5206124039, 142687.0, 145641.27179364246, 146846.0, 147940.0, 152161.47838521472, 1023.3859684189426, 1031.185363562792, 1039.26212389203, 1041.193075366597, 1042.2704107124891, 18766.718499222796, 18910.716339254646, 19008.049597519792, 19101.522461938563, 19311.51721206981, 35865.82067089648, 49807.0, 53184.202236965706, 53397.0, 57422.42577574171, 82132.0, 83248.0, 84087.5795621018, 84625.73061403961, 84726.0, 8184.754457366289, 8301.792455188668, 8403.369747268856, 8663.393562450568, 8891.333150013645, 12287.324197168884, 12771.489140434278, 13017.869821302045, 13133.277669728257, 13163.407646655733, 10754.24720269605, 10883.23817332779, 11456.770864582828, 11489.310641361544, 11588.956993870592, 10745.194110441591, 10826.296290741077, 11027.889721102687, 11038.779224415306, 11424.428778561205, 11395.772084558428, 11455.0, 11536.307821530734, 11731.530738770354, 11798.705032374259, 8463.74608761738, 8464.788380290296, 8474.618642160995, 8479.915200847912, 8511.872321915052, 10971.122310215324, 11380.260283081574, 11393.0, 11403.0, 11632.360220187971], "value": 9678.580628227313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.3176738700197, 1609.806823181218, 1620.7244768389369, 1885.1799467231756, 1987.1852540458415, 8185.7135000275, 8842.690505832297, 8990.820183596325, 9011.098890110994, 9036.8644470333, 8566.271866891322, 8833.911660883405, 8845.778855528615, 8853.822923541526, 8869.46783193009, 2506.348349429152, 2531.3798119460666, 2531.405119796846, 2534.556452620793, 2535.277445927911, 2467.1858286765323, 2531.6835395575554, 2538.9873050634815, 2542.1356738708837, 2544.478381931709, 2490.8256422050463, 2521.621756736486, 2522.419843436011, 2523.0538548044483, 2537.4544472938314, 2482.0692240409758, 2510.669345247022, 2515.6855393075866, 2534.9112781052577, 2538.1243471002476, 2479.9876000619884, 2517.471331020488, 2522.4198434360014, 2525.861077640729, 2530.8481491110592, 8785.956070219672, 8855.380123391365, 8958.507282099481, 8958.731238062803, 8971.192592666692, 5496.972515137439, 5668.8866222675315, 5669.886602267931, 5679.261695979538, 5699.173619825144, 3338.9499157512655, 3516.613172551017, 3525.0, 3642.963570364289, 3678.062094165997, 1031.4584842957433, 1050.453764042701, 1051.989480105197, 1052.321252791945, 1053.2153545608571, 11957.402129893557, 12155.392230388534, 12175.208611440228, 12198.756024879453, 12199.878001219962, 4625.421822272216, 4748.601956012191, 4749.4775574686755, 4760.476347601761, 4829.444613869379, 9604.27967902396, 9609.423434593948, 9615.326927115175, 9618.567164477616, 9626.037396260457, 5455.727213639302, 5459.099248624012, 5492.588055895823, 5507.476789704971, 5527.419620939824, 4568.132054909556, 4668.206404911173, 4715.882102947454, 4722.9763851181215, 5159.277701121846, 3637.9818100909856, 3910.631279052309, 3986.5016872890887, 4015.437838702584, 4030.7380020298588, 1187.2045729361348, 1224.3082658298033, 1233.5620854596489, 1235.123062625546, 1238.2013601227159, 921.7234829551107, 930.186087173723, 962.8844538655406, 983.4738414947968, 1019.5310157327564, 5791.449812267828, 5885.970570147208, 6048.274207095089, 6065.363136870565, 6188.845278867974, 943.5235206220815, 948.8339540580371, 952.8046750416148, 982.1504398695077, 999.3803841618243, 3964.385520244367, 4013.3177359848896, 4022.1553473770837, 4062.7968601569805, 4120.958790412057, 10373.481325933673, 10850.186236032328, 10953.452327383598, 10982.560697572168, 10983.39591322485, 10728.517216725266, 10748.140148788078, 10822.837657435144, 10840.728981775519, 10858.619948301772, 8481.0, 8484.745457636282, 8506.0, 8533.786655333543, 8537.701180458778, 5633.492985631149, 5939.465448109518, 5956.612820166675, 5992.850178745566, 6069.9089513656445, 9843.261755368232, 9985.45080020606, 10105.0, 10123.088921997056, 10135.847962280424, 9371.203447707021, 9834.60661573529, 10136.239782016231, 10335.689929302132, 10375.844362334721, 7050.612216328152, 7141.321574450419, 7164.0, 7265.0, 7277.781666550012, 7430.814229644302, 7704.961475192588, 7794.181610930771, 8605.612747426256, 8614.61234244448, 7896.131425543071, 7907.802304942423, 7925.28672419485, 8091.271785539329, 8125.959370203112, 7677.347425468674, 7702.884456733042, 7775.688972441265, 7792.025996750406, 7883.975083239142, 7045.929540704527, 7058.54119482232, 7105.467089968376, 7108.680109395193, 7113.8577228454105, 5085.4406015337545, 5152.252923326172, 5326.227696983993, 5346.625736198429, 5355.357357117015, 5281.815136470205, 5286.682799032071, 5325.334333208349, 5395.406505284494, 5577.330720313588], "value": 4708.584868901414, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.75868098925804, 330.2289154823487, 335.77335298673387, 338.16304646001134, 340.8806917578846, 5477.643953143043, 6670.032845237443, 6678.332166783319, 6698.196216454026, 6701.6261666358405, 5989.940100598993, 6557.278699343068, 6669.066330713692, 6675.66621668917, 6679.699413526391, 3910.921781564367, 4701.50634183411, 4772.880677983044, 4854.854354369375, 4940.629452791037, 4808.711477311355, 4862.610991120702, 4880.267959806022, 4885.36490256268, 4896.755162241891, 4824.0834241494, 4831.033793241349, 4833.589144922686, 4841.467438581753, 4850.248211527219, 4677.789499472515, 4774.737389443597, 4871.391076115486, 4887.682300650446, 4894.265860120975, 4205.8527951521855, 4210.51579068408, 4210.768407737573, 4212.978935105336, 4213.5786421357925, 5174.43081261061, 6348.746050158034, 6415.775447859302, 6417.582857114273, 6440.227172739301, 5843.357230704619, 5848.883022339572, 5853.122031695238, 5854.47309742121, 5886.852828679274, 6814.352636499525, 7078.469114816357, 7083.858322833515, 7083.893741593829, 7098.538594991309, 4752.358431611723, 4758.524147585248, 4768.61851051915, 4771.713697178146, 4782.832600858988, 7326.780196594111, 7493.775186744352, 7510.699572017113, 7512.924870751332, 7522.887156692654, 4822.228443449031, 4831.0096430231715, 4858.392700912386, 4860.8298709545, 4861.076395484846, 4031.0, 4912.354361289008, 4915.729634870045, 4917.975410122926, 4939.3084968104495, 5656.547476201894, 5842.386549412336, 5849.444302791313, 5853.209816674695, 5854.151148083504, 7072.575645461289, 7117.299004517622, 7127.821804454827, 7139.286071392819, 7157.6779044943105, 1494.7593497397133, 1649.0765171503997, 1719.3982106262708, 1721.8364255395718, 1722.991385043092, 988.8318985772436, 1040.4173662748885, 1052.2003277509148, 1061.9893801062044, 1098.417838545572, 6647.534672572873, 6780.559263647847, 6788.811957907346, 6858.554193977476, 6865.897011544831, 7398.371138453184, 7423.480356375002, 7451.664675089634, 7457.962710186414, 7466.2160473150625, 6852.6231057292325, 6853.794386168323, 6854.6229957351825, 6858.828529286808, 6868.450523958071, 3724.906877328034, 3866.420036994417, 3900.414937759302, 3920.5099362579676, 3934.5475270343704, 7351.852962940711, 7761.883571746428, 7817.8827317590285, 7822.1004584472375, 7849.960750196213, 7613.276738709814, 7616.200298968529, 7638.0, 7661.731839385595, 7666.693332266758, 6216.689165541795, 7782.182870798598, 7786.688532458751, 7790.337821285254, 7794.805129871798, 7028.8945665814035, 7324.340809327186, 7357.117145942521, 7377.8524429510035, 7382.5939573323985, 7196.316349946746, 7232.855342893218, 7258.3104605062435, 7258.528195667264, 7289.198188199188, 7726.18875018115, 7754.418418618513, 7756.0, 7759.883601745865, 7781.455298129076, 4608.193566125981, 4667.346571480063, 4671.369365135799, 4674.485806561208, 4675.9064818702755, 7068.5758854468895, 7335.3398194160645, 7350.77947661571, 7354.0, 7393.371563416955, 7096.084057304396, 7158.498905076594, 7177.784666460015, 7198.136223653195, 7202.53183543068, 7141.178764442156, 7144.428445724226, 7144.892826607501, 7151.356377926011, 7152.892706609509, 6984.0, 6985.860282794214, 6991.510594258353, 7013.754518592029, 7026.2271150174465, 6045.274567051806, 6255.374462553708, 6435.8093752655905, 6912.516123871482, 7143.392811611071, 5437.700926449083, 6811.352921472452, 6890.483213758888, 6937.271586483548, 6963.8607227854145], "value": 5199.816051371846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.8566286742652, 774.554631087125, 791.1100012485954, 794.1740589786622, 800.3397197312219, 15353.53939381819, 15606.843931560681, 15694.76457853133, 15728.60678483037, 15766.054036757803, 14415.279236038183, 14478.0, 14495.130292182477, 14529.418823247057, 14547.781783273233, 779.6920216514487, 793.4287313134563, 936.0686117313282, 968.2012339819642, 973.4256788494787, 955.4362925873733, 963.9662611808589, 969.7139343893533, 970.0, 971.7182017214999, 831.9168083191693, 1004.2116938203511, 1008.6973907827659, 1009.0363702663975, 1009.4296722351885, 1001.1690297053428, 1024.2011231239644, 1025.067188858143, 1029.0892560084342, 1029.3875144289136, 761.9771406857803, 765.0627980723625, 766.0080196146005, 766.9846603067963, 767.1906139023329, 15328.846711532853, 15372.0, 15396.846031539653, 15411.075335479907, 15417.074975501506, 11465.598704045318, 13033.54382596614, 13289.667758306023, 13379.53171638988, 13686.863131368658, 10346.793064138676, 10384.117350025257, 10496.737581560446, 10790.082842958358, 11112.888711128904, 3065.2949821540947, 3537.204129070964, 3541.557305336833, 3627.8911632650797, 3708.7589306694977, 80108.79836802452, 80265.0, 81952.59023704844, 88196.5590172045, 88554.11445885588, 9699.397204180274, 9831.75420614476, 10034.598616055277, 10073.949630251802, 10204.030617091365, 19246.326378576683, 23093.653595196087, 23357.0, 23362.53274934492, 23508.529829403316, 7834.608269586498, 7859.253370929752, 7867.409944254204, 7916.129225785159, 7996.600169991477, 4267.4238977737605, 4329.935050974238, 4335.414719012956, 4361.171377438277, 4407.603315701603, 3610.2598967211657, 3672.779633222015, 3674.595794462607, 3675.8345874435713, 3677.282929828711, 575.7178982298727, 576.8817392434624, 597.7280337446451, 613.2426453330133, 676.2628734679223, 577.1573502686041, 601.3835818286204, 605.2071785960406, 617.2346290599714, 628.8616504369031, 8229.588520573947, 8270.875936860952, 8379.329653627696, 8524.70163544273, 8654.567271636519, 541.9783208671608, 590.9835083656104, 601.3415310235285, 610.6061590274248, 647.9718481153958, 3826.7512611680154, 3969.7816620086173, 4058.512978442606, 4062.512498500199, 4084.5799884464286, 94633.5804962926, 102328.97671023343, 103481.44777828339, 103720.48139759254, 104182.47908760408, 62902.68548657319, 78849.60575197202, 80172.0, 80681.59659201784, 80825.19174808294, 55570.332890013364, 69894.0, 71333.0, 72039.6398018017, 72575.91136132962, 7873.37013038944, 7950.801229969297, 7993.240642138988, 8034.799130021796, 8055.436119471581, 49709.25436118533, 51014.7246318845, 51640.0, 51889.22166167435, 53971.0, 66879.66560167167, 66957.66521167557, 67768.32231677817, 70278.29721702718, 73407.0, 10956.890431095588, 11313.490892909675, 11319.773604528027, 11386.0, 11728.12039097054, 11980.46087926028, 12228.266304021787, 12239.510419583474, 12345.605167927917, 12468.438920248793, 11223.438828058728, 11468.483918223867, 11474.541018359507, 11729.941350293195, 11895.524179033087, 12063.457144428347, 12110.576129835414, 12157.756844862877, 12235.449404776984, 12273.202241854251, 11300.378479183724, 11718.402717079345, 11823.586174483851, 11887.881121188677, 11920.0, 8861.867071993796, 9214.58173065003, 9788.314817962959, 9846.556904939438, 9913.909469958444, 9928.503574821374, 9944.204463643036, 9961.153301969414, 10240.743981400525, 10248.743781405525], "value": 7125.08364042955, "unit": "score"}], "name": "dromaeo_css", "value": 7564.137162676462, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 120.0, 112.0, 113.0, 112.0, 113.0, 113.0, 112.0, 134.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 120.0, 140.0, 165.0, 116.0, 140.0, 138.0, 117.0, 165.0, 116.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 183.0, 184.0, 185.0, 182.0, 201.0, 264.0, 202.0, 184.0], "value": 195.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 74.0, 151.0, 55.0, 55.0, 56.0, 61.0, 126.0, 55.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 142.0, 80.0, 79.0, 80.0, 124.0, 79.0, 80.0, 134.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 87.0, 89.0, 85.0, 90.0, 88.0, 90.0, 86.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 97.0, 94.0, 92.0, 134.0], "value": 98.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 86.0, 85.0, 86.0, 85.0, 86.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 64.0, 64.0, 59.0, 63.0, 89.0, 111.0, 94.0, 69.0], "value": 73.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 67.0, 68.0, 73.0, 68.0, 64.0, 65.0, 63.0, 69.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 79.0, 79.0, 78.0, 78.0, 78.0, 74.0, 84.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 148.0, 149.0, 123.0, 123.0, 125.0, 127.0, 124.0, 146.0, 142.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 175.0, 165.0, 165.0, 171.0, 176.0, 169.0, 162.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 68.0, 65.0, 68.0, 69.0, 66.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1482.6, "alertThreshold": 2.0}]} 04:29:04 INFO - Return code: 0 04:29:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:04 ERROR - # TBPL SUCCESS # 04:29:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:29:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:29:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:29:04 INFO - 2016-07-03 04:29:04.520 screenresolution[1711:11826] starting screenresolution argv=screenresolution get 04:29:04 INFO - 2016-07-03 04:29:04.523 screenresolution[1711:11826] Display 0: 1600x1200x32@60 04:29:04 INFO - 2016-07-03 04:29:04.529 screenresolution[1712:11829] starting screenresolution argv=screenresolution list 04:29:04 INFO - Available Modes on Display 0 04:29:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:29:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:29:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:29:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:29:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:29:04 INFO - Intel Iris: 04:29:04 INFO - Chipset Model: Intel Iris 04:29:04 INFO - Type: GPU 04:29:04 INFO - Bus: Built-In 04:29:04 INFO - VRAM (Dynamic, Max): 1536 MB 04:29:04 INFO - Vendor: Intel (0x8086) 04:29:04 INFO - Device ID: 0x0a2e 04:29:04 INFO - Revision ID: 0x0009 04:29:04 INFO - Displays: 04:29:04 INFO - Display: 04:29:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:29:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:29:04 INFO - Display Serial Number: 1600x1200 60 04:29:04 INFO - Main Display: Yes 04:29:04 INFO - Mirror: Off 04:29:04 INFO - Online: Yes 04:29:04 INFO - Rotation: Supported 04:29:04 INFO - Return code: 0 04:29:04 INFO - Running post-action listener: _resource_record_post_action 04:29:04 INFO - Running post-run listener: _resource_record_post_run 04:29:05 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 44143104; Write bytes: 505552896; Read time: 494; Write time: 1610 04:29:05 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 189239808; Write bytes: 186729984; Read time: 17399; Write time: 342 04:29:05 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 42353152; Write bytes: 308034048; Read time: 474; Write time: 1233 04:29:05 INFO - Running post-run listener: _upload_blobber_files 04:29:05 INFO - Blob upload gear active. 04:29:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:05 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 04:29:05 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:29:05 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:29:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:07 INFO - (blobuploader) - INFO - Done attempting. 04:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:08 INFO - (blobuploader) - INFO - Done attempting. 04:29:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:08 INFO - Return code: 0 04:29:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01fb223e67662aff8128133ae9fff7f091a3be783327306ca3c987a1a2e2e9adca1886dd4525163e0daaeda64422a9198172803a57356b60a96f9654111cf2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/17513d51cce514dc71b503096cfb58d5008bc4df9789f5e6c07266bc7b26b974cbb8f736fb98cd7e84d82f660a380d87d67f8dc001874fbd6c192cac1184daf7"} 04:29:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:08 INFO - Contents: 04:29:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01fb223e67662aff8128133ae9fff7f091a3be783327306ca3c987a1a2e2e9adca1886dd4525163e0daaeda64422a9198172803a57356b60a96f9654111cf2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/17513d51cce514dc71b503096cfb58d5008bc4df9789f5e6c07266bc7b26b974cbb8f736fb98cd7e84d82f660a380d87d67f8dc001874fbd6c192cac1184daf7"} 04:29:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:08 INFO - Copying logs to upload dir... 04:29:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.175788 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-03 04:29:08.356779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:29:08.362047) ========= 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.adkAK1amTO/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.DUjeZFMEWB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/Mozilla-Beta/sha512/01fb223e67662aff8128133ae9fff7f091a3be783327306ca3c987a1a2e2e9adca1886dd4525163e0daaeda64422a9198172803a57356b60a96f9654111cf2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/17513d51cce514dc71b503096cfb58d5008bc4df9789f5e6c07266bc7b26b974cbb8f736fb98cd7e84d82f660a380d87d67f8dc001874fbd6c192cac1184daf7"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011385 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01fb223e67662aff8128133ae9fff7f091a3be783327306ca3c987a1a2e2e9adca1886dd4525163e0daaeda64422a9198172803a57356b60a96f9654111cf2ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/17513d51cce514dc71b503096cfb58d5008bc4df9789f5e6c07266bc7b26b974cbb8f736fb98cd7e84d82f660a380d87d67f8dc001874fbd6c192cac1184daf7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:29:08.394818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:29:08.395160) ========= 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.adkAK1amTO/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.DUjeZFMEWB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005188 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:29:08.443190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:29:08.443484) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:29:08.443783) ========= ========= Total master_lag: 0.25 =========