builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0309 starttime: 1475753660.96 results: success (0) buildid: 20161006020801 builduid: d958a888ff4246baabc1a52522858be4 revision: 089590fd275493af8294e2603c589d114f2a311a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:20.960244) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:20.960697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:20.960996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:20.992951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:20.993489) ========= 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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-10-06 04:34:21-- 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% 7.73M=0.001s 2016-10-06 04:34:21 (7.73 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135211 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:21.151204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:21.151520) ========= 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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.021104 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:21.199703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 04:34:21.200065) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 089590fd275493af8294e2603c589d114f2a311a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 089590fd275493af8294e2603c589d114f2a311a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-10-06 04:34:21,277 truncating revision to first 12 chars 2016-10-06 04:34:21,277 Setting DEBUG logging. 2016-10-06 04:34:21,278 attempt 1/10 2016-10-06 04:34:21,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/089590fd2754?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 04:34:23,440 unpacking tar archive at: fx-team-089590fd2754/testing/mozharness/ program finished with exit code 0 elapsedTime=2.444041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 04:34:23.665947) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:23.666268) ========= script_repo_revision: 089590fd275493af8294e2603c589d114f2a311a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:23.666656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:23.666939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:34:23.684889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 04:34:23.685164) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:34:23 INFO - MultiFileLogger online at 20161006 04:34:23 in /builds/slave/test 04:34:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:34:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:34:23 INFO - {'append_to_log': False, 04:34:23 INFO - 'base_work_dir': '/builds/slave/test', 04:34:23 INFO - 'blob_upload_branch': 'Fx-Team', 04:34:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:34:23 INFO - 'branch': 'Fx-Team', 04:34:23 INFO - 'buildbot_json_path': 'buildprops.json', 04:34:23 INFO - 'config_files': ('talos/mac_config.py',), 04:34:23 INFO - 'default_actions': ('clobber', 04:34:23 INFO - 'read-buildbot-config', 04:34:23 INFO - 'download-and-extract', 04:34:23 INFO - 'populate-webroot', 04:34:23 INFO - 'create-virtualenv', 04:34:23 INFO - 'install', 04:34:23 INFO - 'run-tests'), 04:34:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:34:23 INFO - 'download_minidump_stackwalk': True, 04:34:23 INFO - 'download_symbols': 'ondemand', 04:34:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:34:23 INFO - 'tooltool.py': '/tools/tooltool.py', 04:34:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:34:23 INFO - '/tools/misc-python/virtualenv.py')}, 04:34:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:34:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:34:23 INFO - 'installer_path': 'installer.exe', 04:34:23 INFO - 'log_level': 'info', 04:34:23 INFO - 'log_name': 'talos', 04:34:23 INFO - 'log_to_console': True, 04:34:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:34:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:34:23 INFO - 'opt_config_files': (), 04:34:23 INFO - 'pip_index': False, 04:34:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:23 INFO - 'cmd': ('bash', 04:34:23 INFO - '-c', 04:34:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:23 INFO - 'enabled': True, 04:34:23 INFO - 'halt_on_failure': False, 04:34:23 INFO - 'name': 'check_screen_resolution'},), 04:34:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:23 INFO - 'cmd': ('bash', 04:34:23 INFO - '-c', 04:34:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:23 INFO - 'enabled': True, 04:34:23 INFO - 'halt_on_failure': False, 04:34:23 INFO - 'name': 'check_screen_resolution'},), 04:34:23 INFO - 'run_cmd_checks_enabled': True, 04:34:23 INFO - 'sps_profile': False, 04:34:23 INFO - 'sps_profile_interval': 0, 04:34:23 INFO - 'suite': 'dromaeojs', 04:34:23 INFO - 'system_bits': '32', 04:34:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:34:23 INFO - 'title': 't-yosemite-r7-0309', 04:34:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:34:23 INFO - 'use_talos_json': True, 04:34:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:34:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:34:23 INFO - 'work_dir': 'build'} 04:34:23 INFO - [mozharness: 2016-10-06 11:34:23.897458Z] Running clobber step. 04:34:23 INFO - Running pre-action listener: _resource_record_pre_action 04:34:23 INFO - Running main action method: clobber 04:34:23 INFO - rmtree: /builds/slave/test/build 04:34:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:25 INFO - Running post-action listener: _resource_record_post_action 04:34:25 INFO - [mozharness: 2016-10-06 11:34:25.505031Z] Finished clobber step (success) 04:34:25 INFO - [mozharness: 2016-10-06 11:34:25.505206Z] Running read-buildbot-config step. 04:34:25 INFO - Running pre-action listener: _resource_record_pre_action 04:34:25 INFO - Running main action method: read_buildbot_config 04:34:25 INFO - Using buildbot properties: 04:34:25 INFO - { 04:34:25 INFO - "project": "", 04:34:25 INFO - "product": "firefox", 04:34:25 INFO - "script_repo_revision": "production", 04:34:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:34:25 INFO - "repository": "", 04:34:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:34:25 INFO - "buildid": "20161006020801", 04:34:25 INFO - "pgo_build": "False", 04:34:25 INFO - "basedir": "/builds/slave/test", 04:34:25 INFO - "buildnumber": 166, 04:34:25 INFO - "slavename": "t-yosemite-r7-0309", 04:34:25 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:34:25 INFO - "platform": "yosemite_r7", 04:34:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:34:25 INFO - "branch": "fx-team", 04:34:25 INFO - "repo_path": "integration/fx-team", 04:34:25 INFO - "revision": "089590fd275493af8294e2603c589d114f2a311a", 04:34:25 INFO - "stage_platform": "macosx64", 04:34:25 INFO - "builduid": "d958a888ff4246baabc1a52522858be4", 04:34:25 INFO - "slavebuilddir": "test" 04:34:25 INFO - } 04:34:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:34:25 INFO - Running post-action listener: _resource_record_post_action 04:34:25 INFO - [mozharness: 2016-10-06 11:34:25.508627Z] Finished read-buildbot-config step (success) 04:34:25 INFO - [mozharness: 2016-10-06 11:34:25.508750Z] Running download-and-extract step. 04:34:25 INFO - Running pre-action listener: _resource_record_pre_action 04:34:25 INFO - Running main action method: download_and_extract 04:34:25 INFO - mkdir: /builds/slave/test/build/tests 04:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:25 INFO - trying https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:34:25 INFO - Downloading https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 04:34:26 INFO - Downloaded 1199 bytes. 04:34:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:34:26 INFO - Using the following test package requirements: 04:34:26 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:34:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:34:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:34:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'jsshell-mac.zip'], 04:34:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:34:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:34:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:34:26 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:34:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:34:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:34:26 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:34:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:34:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:34:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:26 INFO - Fetch https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:34:27 INFO - Http code: 200 04:34:27 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 04:34:27 INFO - x-amz-cf-id: 83sg9a_yOM9hkXKq04IB6JFYjVjUJ_M-I_ovGq89KQlkoI2bOg63EA== 04:34:27 INFO - x-amz-version-id: ILsSuCdpzWFdI.yEL3S365Lw3nmgJmJg 04:34:27 INFO - Expected file size: 16477138 04:34:27 INFO - Obtained file size: 16477138 04:34:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:34:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:34:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:34 INFO - Fetch https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:34:34 INFO - Http code: 200 04:34:34 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 04:34:34 INFO - x-amz-cf-id: vMIZVIP7B0_kQsYsRgUb-nuk-z0jxNVoGYP5Mods7awv-wPYq_eROQ== 04:34:34 INFO - x-amz-version-id: ILsSuCdpzWFdI.yEL3S365Lw3nmgJmJg 04:34:35 INFO - Expected file size: 16477138 04:34:35 INFO - Obtained file size: 16477138 04:34:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:34:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:34:41 INFO - Fetch https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:34:42 INFO - Http code: 200 04:34:42 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 04:34:42 INFO - x-amz-cf-id: _yfFIw_bAkGmSY5TpdCACzWUt5e6gGvFyLloMLhbv237uEO71F1HeA== 04:34:42 INFO - x-amz-version-id: 7CC3XeB6wfKUHYhitmqS2A_KAp4fYmEj 04:34:42 INFO - Expected file size: 14409006 04:34:42 INFO - Obtained file size: 14409006 04:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:43 INFO - trying https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:34:43 INFO - Downloading https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 04:34:45 INFO - Downloaded 111663827 bytes. 04:34:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:34:45 INFO - mkdir: /builds/slave/test/properties 04:34:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:45 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:45 INFO - Contents: 04:34:45 INFO - build_url:https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:34:46 INFO - Running post-action listener: _resource_record_post_action 04:34:46 INFO - Running post-action listener: set_extra_try_arguments 04:34:46 INFO - [mozharness: 2016-10-06 11:34:46.499931Z] Finished download-and-extract step (success) 04:34:46 INFO - [mozharness: 2016-10-06 11:34:46.500035Z] Running populate-webroot step. 04:34:46 INFO - Running pre-action listener: _resource_record_pre_action 04:34:46 INFO - Running main action method: populate_webroot 04:34:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:46 INFO - '--tppagecycles', 04:34:46 INFO - '7'], 04:34:46 INFO - 'tests': ['tsvgm']}}, 04:34:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['damp', 'tps']}, 04:34:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'tests': ['damp', 'tps']}, 04:34:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['dromaeo_dom']}, 04:34:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['basic_compositor_video']}, 04:34:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['a11yr', 04:34:46 INFO - 'ts_paint', 04:34:46 INFO - 'tpaint', 04:34:46 INFO - 'sessionrestore', 04:34:46 INFO - 'sessionrestore_no_auto_restore', 04:34:46 INFO - 'tabpaint']}, 04:34:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tsvgx', 04:34:46 INFO - 'tsvgr_opacity', 04:34:46 INFO - 'tart', 04:34:46 INFO - 'tscrollx', 04:34:46 INFO - 'cart']}, 04:34:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:46 INFO - 'tsvgr_opacity', 04:34:46 INFO - 'tart', 04:34:46 INFO - 'tscrollx', 04:34:46 INFO - 'cart']}, 04:34:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s'], 04:34:46 INFO - 'tests': ['tp5o']}, 04:34:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'tests': ['tp5o']}, 04:34:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--disable-e10s', 04:34:46 INFO - '--xperf_path', 04:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:46 INFO - 'tests': ['tp5n']}, 04:34:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:46 INFO - 'talos_options': ['--xperf_path', 04:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:46 INFO - 'tests': ['tp5n']}}, 04:34:46 INFO - 'talos.zip': {'path': '', 04:34:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:46 INFO - Running post-action listener: _resource_record_post_action 04:34:46 INFO - [mozharness: 2016-10-06 11:34:46.518749Z] Finished populate-webroot step (success) 04:34:46 INFO - [mozharness: 2016-10-06 11:34:46.518876Z] Running create-virtualenv step. 04:34:46 INFO - Running pre-action listener: _resource_record_pre_action 04:34:46 INFO - Running main action method: create_virtualenv 04:34:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:46 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:34:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:46 INFO - Using real prefix '/tools/python27' 04:34:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:50 INFO - Installing pip.................done. 04:34:50 INFO - Return code: 0 04:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:34:50 INFO - Reading from file tmpfile_stdout 04:34:50 INFO - Output received: 04:34:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:34:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:50 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 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:34:50 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:34:50 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:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:50 INFO - 'HOME': '/Users/cltbld', 04:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:50 INFO - 'LOGNAME': 'cltbld', 04:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:50 INFO - 'MOZ_NO_REMOTE': '1', 04:34:50 INFO - 'NO_EM_RESTART': '1', 04:34:50 INFO - 'PAGER': '/bin/cat', 04:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:50 INFO - 'PWD': '/builds/slave/test', 04:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:50 INFO - 'SHELL': '/bin/bash', 04:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:34:50 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:50 INFO - 'USER': 'cltbld', 04:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:50 INFO - 'XPC_FLAGS': '0x0', 04:34:50 INFO - 'XPC_SERVICE_NAME': '0', 04:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:50 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:34:50 INFO - Cleaning up... 04:34:50 INFO - Return code: 0 04:34:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:50 INFO - 'HOME': '/Users/cltbld', 04:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:50 INFO - 'LOGNAME': 'cltbld', 04:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:50 INFO - 'MOZ_NO_REMOTE': '1', 04:34:50 INFO - 'NO_EM_RESTART': '1', 04:34:50 INFO - 'PAGER': '/bin/cat', 04:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:50 INFO - 'PWD': '/builds/slave/test', 04:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:50 INFO - 'SHELL': '/bin/bash', 04:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:34:50 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:50 INFO - 'USER': 'cltbld', 04:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:50 INFO - 'XPC_FLAGS': '0x0', 04:34:50 INFO - 'XPC_SERVICE_NAME': '0', 04:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:51 INFO - Downloading/unpacking psutil>=3.1.1 04:34:51 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:34:51 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:34:51 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:34:51 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:34:51 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:34:51 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:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:54 INFO - Installing collected packages: psutil 04:34:54 INFO - Running setup.py install for psutil 04:34:54 INFO - building 'psutil._psutil_osx' extension 04:34:54 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:34:54 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:34:54 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:34:54 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:34:54 INFO - building 'psutil._psutil_posix' extension 04:34:54 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:34:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:34:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:34:55 INFO - ^ 04:34:55 INFO - 1 warning generated. 04:34:55 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:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:55 INFO - Successfully installed psutil 04:34:55 INFO - Cleaning up... 04:34:55 INFO - Return code: 0 04:34:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:34:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:34:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:55 INFO - 'HOME': '/Users/cltbld', 04:34:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:55 INFO - 'LOGNAME': 'cltbld', 04:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:55 INFO - 'MOZ_NO_REMOTE': '1', 04:34:55 INFO - 'NO_EM_RESTART': '1', 04:34:55 INFO - 'PAGER': '/bin/cat', 04:34:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:55 INFO - 'PWD': '/builds/slave/test', 04:34:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:55 INFO - 'SHELL': '/bin/bash', 04:34:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:34:55 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:34:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:55 INFO - 'USER': 'cltbld', 04:34:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:55 INFO - 'XPC_FLAGS': '0x0', 04:34:55 INFO - 'XPC_SERVICE_NAME': '0', 04:34:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:58 INFO - Installing collected packages: mozsystemmonitor 04:34:58 INFO - Running setup.py install for mozsystemmonitor 04:34:58 INFO - Successfully installed mozsystemmonitor 04:34:58 INFO - Cleaning up... 04:34:58 INFO - Return code: 0 04:34:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:58 INFO - 'HOME': '/Users/cltbld', 04:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:58 INFO - 'LOGNAME': 'cltbld', 04:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:58 INFO - 'MOZ_NO_REMOTE': '1', 04:34:58 INFO - 'NO_EM_RESTART': '1', 04:34:58 INFO - 'PAGER': '/bin/cat', 04:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:58 INFO - 'PWD': '/builds/slave/test', 04:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:58 INFO - 'SHELL': '/bin/bash', 04:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:34:58 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:58 INFO - 'USER': 'cltbld', 04:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:58 INFO - 'XPC_FLAGS': '0x0', 04:34:58 INFO - 'XPC_SERVICE_NAME': '0', 04:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:58 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:35: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:35: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:35: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:35: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:35: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:35: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:35:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:01 INFO - warning: no files found matching '*.txt' 04:35:01 INFO - no previously-included directories found matching 'build' 04:35:01 INFO - no previously-included directories found matching 'dist' 04:35:01 INFO - no previously-included directories found matching '.git*' 04:35:01 INFO - Installing collected packages: jsonschema, functools32 04:35:01 INFO - Running setup.py install for functools32 04:35:01 INFO - warning: no files found matching '*.txt' 04:35:01 INFO - no previously-included directories found matching 'build' 04:35:01 INFO - no previously-included directories found matching 'dist' 04:35:01 INFO - no previously-included directories found matching '.git*' 04:35:01 INFO - Successfully installed jsonschema functools32 04:35:01 INFO - Cleaning up... 04:35:01 INFO - Return code: 0 04:35:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:35: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:35: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 functools32==3.2.3-2 04:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:01 INFO - 'HOME': '/Users/cltbld', 04:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:01 INFO - 'LOGNAME': 'cltbld', 04:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:01 INFO - 'MOZ_NO_REMOTE': '1', 04:35:01 INFO - 'NO_EM_RESTART': '1', 04:35:01 INFO - 'PAGER': '/bin/cat', 04:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:01 INFO - 'PWD': '/builds/slave/test', 04:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:01 INFO - 'SHELL': '/bin/bash', 04:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:35:01 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:01 INFO - 'USER': 'cltbld', 04:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:01 INFO - 'XPC_FLAGS': '0x0', 04:35:01 INFO - 'XPC_SERVICE_NAME': '0', 04:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:35:02 INFO - Cleaning up... 04:35:02 INFO - Return code: 0 04:35:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:02 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 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:35:02 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:35:02 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:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:02 INFO - 'HOME': '/Users/cltbld', 04:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:02 INFO - 'LOGNAME': 'cltbld', 04:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:02 INFO - 'MOZ_NO_REMOTE': '1', 04:35:02 INFO - 'NO_EM_RESTART': '1', 04:35:02 INFO - 'PAGER': '/bin/cat', 04:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:02 INFO - 'PWD': '/builds/slave/test', 04:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:02 INFO - 'SHELL': '/bin/bash', 04:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:35:02 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:02 INFO - 'USER': 'cltbld', 04:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:02 INFO - 'XPC_FLAGS': '0x0', 04:35:02 INFO - 'XPC_SERVICE_NAME': '0', 04:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35: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:35: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:35: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:35: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:35: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:35: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:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:05 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:35:05 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:35:05 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:35:05 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:35:05 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:35:05 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:35:06 INFO - Downloading docopt-0.6.1.tar.gz 04:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:06 INFO - Running setup.py install for blobuploader 04:35:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:06 INFO - Running setup.py install for requests 04:35:06 INFO - Running setup.py install for docopt 04:35:06 INFO - Successfully installed blobuploader requests docopt 04:35:06 INFO - Cleaning up... 04:35:06 INFO - Return code: 0 04:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 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 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:35:06 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:35:06 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:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:06 INFO - 'HOME': '/Users/cltbld', 04:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:06 INFO - 'LOGNAME': 'cltbld', 04:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:06 INFO - 'MOZ_NO_REMOTE': '1', 04:35:06 INFO - 'NO_EM_RESTART': '1', 04:35:06 INFO - 'PAGER': '/bin/cat', 04:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:06 INFO - 'PWD': '/builds/slave/test', 04:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:06 INFO - 'SHELL': '/bin/bash', 04:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:35:06 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:06 INFO - 'USER': 'cltbld', 04:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:06 INFO - 'XPC_FLAGS': '0x0', 04:35:06 INFO - 'XPC_SERVICE_NAME': '0', 04:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:07 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Dz0V2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:07 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-FobBGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:07 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-M50ZSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:07 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-B3CDXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:07 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-kHYEh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:07 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-PDcvbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:07 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dBBhfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-mNtwg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-TehROc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ATh63g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Jwnyxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-t0tOT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-oQvHdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-KDbfYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tZbCpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-6sQnS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:08 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-MyYrpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:09 INFO - Running setup.py install for manifestparser 04:35:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:09 INFO - Running setup.py install for mozcrash 04:35:09 INFO - Running setup.py install for mozdebug 04:35:09 INFO - Running setup.py install for mozdevice 04:35:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:09 INFO - Running setup.py install for mozfile 04:35:09 INFO - Running setup.py install for mozhttpd 04:35:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:09 INFO - Running setup.py install for mozinfo 04:35:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:10 INFO - Running setup.py install for mozInstall 04:35:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:10 INFO - Running setup.py install for mozleak 04:35:10 INFO - Running setup.py install for mozlog 04:35:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:10 INFO - Running setup.py install for moznetwork 04:35:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:10 INFO - Running setup.py install for mozprocess 04:35:10 INFO - Running setup.py install for mozprofile 04:35:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Running setup.py install for mozrunner 04:35:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Running setup.py install for mozscreenshot 04:35:11 INFO - Running setup.py install for moztest 04:35:11 INFO - Running setup.py install for mozversion 04:35:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:11 INFO - Cleaning up... 04:35:11 INFO - Return code: 0 04:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:11 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 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:35:11 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:35:11 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:35:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:35:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:11 INFO - 'HOME': '/Users/cltbld', 04:35:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:11 INFO - 'LOGNAME': 'cltbld', 04:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:11 INFO - 'MOZ_NO_REMOTE': '1', 04:35:11 INFO - 'NO_EM_RESTART': '1', 04:35:11 INFO - 'PAGER': '/bin/cat', 04:35:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:11 INFO - 'PWD': '/builds/slave/test', 04:35:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:11 INFO - 'SHELL': '/bin/bash', 04:35:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:35:11 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:35:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:11 INFO - 'USER': 'cltbld', 04:35:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:11 INFO - 'XPC_FLAGS': '0x0', 04:35:11 INFO - 'XPC_SERVICE_NAME': '0', 04:35:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:11 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-3X0S5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-QChi3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-0j260j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-15VQSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-5JF3iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-YZgyTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-JnLyO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-m0fJRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-AcNiAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:12 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:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:12 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-YozJcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Y1mqla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:13 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:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-rYbiYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-TBeJYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:13 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:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-lN8PP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-d52JtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:13 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:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-IvoN6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:13 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:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-rbGTnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:16 INFO - Downloading blessings-1.6.tar.gz 04:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:16 INFO - Installing collected packages: blessings 04:35:16 INFO - Running setup.py install for blessings 04:35:16 INFO - Successfully installed blessings 04:35:16 INFO - Cleaning up... 04:35:16 INFO - Return code: 0 04:35:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:16 INFO - Reading from file tmpfile_stdout 04:35:16 INFO - Current package versions: 04:35:16 INFO - blessings == 1.6 04:35:16 INFO - blobuploader == 1.2.4 04:35:16 INFO - docopt == 0.6.1 04:35:16 INFO - functools32 == 3.2.3-2 04:35:16 INFO - jsonschema == 2.5.1 04:35:16 INFO - manifestparser == 1.1 04:35:16 INFO - mozInstall == 1.12 04:35:16 INFO - mozcrash == 0.17 04:35:16 INFO - mozdebug == 0.1 04:35:16 INFO - mozdevice == 0.48 04:35:16 INFO - mozfile == 1.2 04:35:16 INFO - mozhttpd == 0.7 04:35:16 INFO - mozinfo == 0.9 04:35:16 INFO - mozleak == 0.1 04:35:16 INFO - mozlog == 3.4 04:35:16 INFO - moznetwork == 0.27 04:35:16 INFO - mozprocess == 0.23 04:35:16 INFO - mozprofile == 0.28 04:35:16 INFO - mozrunner == 6.12 04:35:16 INFO - mozscreenshot == 0.1 04:35:16 INFO - mozsystemmonitor == 0.3 04:35:16 INFO - moztest == 0.7 04:35:16 INFO - mozversion == 1.4 04:35:16 INFO - psutil == 3.1.1 04:35:16 INFO - requests == 1.2.3 04:35:16 INFO - wsgiref == 0.1.2 04:35:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:16 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 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:35:16 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:35:16 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:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:16 INFO - 'HOME': '/Users/cltbld', 04:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:16 INFO - 'LOGNAME': 'cltbld', 04:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:16 INFO - 'MOZ_NO_REMOTE': '1', 04:35:16 INFO - 'NO_EM_RESTART': '1', 04:35:16 INFO - 'PAGER': '/bin/cat', 04:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:16 INFO - 'PWD': '/builds/slave/test', 04:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:16 INFO - 'SHELL': '/bin/bash', 04:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:35:16 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:16 INFO - 'USER': 'cltbld', 04:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:16 INFO - 'XPC_FLAGS': '0x0', 04:35:16 INFO - 'XPC_SERVICE_NAME': '0', 04:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 INFO - Cleaning up... 04:35:17 INFO - Return code: 0 04:35:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10402a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fa0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7305a2390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, '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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:17 INFO - 'HOME': '/Users/cltbld', 04:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:17 INFO - 'LOGNAME': 'cltbld', 04:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:17 INFO - 'MOZ_NO_REMOTE': '1', 04:35:17 INFO - 'NO_EM_RESTART': '1', 04:35:17 INFO - 'PAGER': '/bin/cat', 04:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:17 INFO - 'PWD': '/builds/slave/test', 04:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:17 INFO - 'SHELL': '/bin/bash', 04:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:35:17 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:17 INFO - 'USER': 'cltbld', 04:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:17 INFO - 'XPC_FLAGS': '0x0', 04:35:17 INFO - 'XPC_SERVICE_NAME': '0', 04:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:35:17 INFO - Cleaning up... 04:35:17 INFO - Return code: 0 04:35:17 INFO - Running post-action listener: _resource_record_post_action 04:35:17 INFO - Running post-action listener: _start_resource_monitoring 04:35:17 INFO - Starting resource monitoring. 04:35:17 INFO - [mozharness: 2016-10-06 11:35:17.499791Z] Finished create-virtualenv step (success) 04:35:17 INFO - [mozharness: 2016-10-06 11:35:17.500876Z] Running install step. 04:35:17 INFO - Running pre-action listener: _resource_record_pre_action 04:35:17 INFO - Running main action method: install 04:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:17 INFO - Reading from file tmpfile_stdout 04:35:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:17 INFO - Reading from file tmpfile_stdout 04:35:17 INFO - Output received: 04:35:17 INFO - Usage: mozinstall [options] installer 04:35:17 INFO - Options: 04:35:17 INFO - -h, --help show this help message and exit 04:35:17 INFO - -d DEST, --destination=DEST 04:35:17 INFO - Directory to install application into. [default: 04:35:17 INFO - "/builds/slave/test"] 04:35:17 INFO - --app=APP Application being installed. [default: firefox] 04:35:17 INFO - mkdir: /builds/slave/test/build/application 04:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:35:52 INFO - Reading from file tmpfile_stdout 04:35:52 INFO - Output received: 04:35:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:35:52 INFO - Running post-action listener: _resource_record_post_action 04:35:52 INFO - [mozharness: 2016-10-06 11:35:52.998967Z] Finished install step (success) 04:35:52 INFO - [mozharness: 2016-10-06 11:35:52.999101Z] Running run-tests step. 04:35:52 INFO - Running pre-action listener: _resource_record_pre_action 04:35:52 INFO - Running main action method: run_tests 04:35:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:53 INFO - 2016-10-06 04:35:53.013 screenresolution[1936:16343] starting screenresolution argv=screenresolution get 04:35:53 INFO - 2016-10-06 04:35:53.016 screenresolution[1936:16343] Display 0: 1600x1200x32@60 04:35:53 INFO - 2016-10-06 04:35:53.022 screenresolution[1937:16346] starting screenresolution argv=screenresolution list 04:35:53 INFO - Available Modes on Display 0 04:35:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:53 INFO - Intel Iris: 04:35:53 INFO - Chipset Model: Intel Iris 04:35:53 INFO - Type: GPU 04:35:53 INFO - Bus: Built-In 04:35:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:53 INFO - Vendor: Intel (0x8086) 04:35:53 INFO - Device ID: 0x0a2e 04:35:53 INFO - Revision ID: 0x0009 04:35:53 INFO - Displays: 04:35:53 INFO - Display: 04:35:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:53 INFO - Display Serial Number: 1600x1200 60 04:35:53 INFO - Main Display: Yes 04:35:53 INFO - Mirror: Off 04:35:53 INFO - Online: Yes 04:35:53 INFO - Rotation: Supported 04:35:53 INFO - Return code: 0 04:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:53 INFO - Python 2.7.3 04:35:53 INFO - Return code: 0 04:35:53 INFO - grabbing minidump binary from tooltool 04:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e3ed30>, '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 0x103c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e36b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:53 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:35:53 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:35:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:35:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:53 INFO - Return code: 0 04:35:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:35:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:35:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --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:35:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TKDTrZIucU/Render', 04:35:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:53 INFO - 'HOME': '/Users/cltbld', 04:35:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:53 INFO - 'LOGNAME': 'cltbld', 04:35:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:53 INFO - 'MOZ_NO_REMOTE': '1', 04:35:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:53 INFO - 'NO_EM_RESTART': '1', 04:35:53 INFO - 'PAGER': '/bin/cat', 04:35:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:53 INFO - 'PWD': '/builds/slave/test', 04:35:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:53 INFO - 'SHELL': '/bin/bash', 04:35:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk3C8IJAQ7/Listeners', 04:35:53 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 04:35:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:53 INFO - 'USER': 'cltbld', 04:35:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:53 INFO - 'XPC_FLAGS': '0x0', 04:35:53 INFO - 'XPC_SERVICE_NAME': '0', 04:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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:35:53 INFO - mozversion application_buildid: 20161006020801 04:35:53 INFO - mozversion application_changeset: 089590fd275493af8294e2603c589d114f2a311a 04:35:53 INFO - mozversion application_display_name: Nightly 04:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:53 INFO - mozversion application_name: Firefox 04:35:53 INFO - mozversion application_remotingname: firefox 04:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:35:53 INFO - mozversion application_vendor: Mozilla 04:35:53 INFO - mozversion application_version: 52.0a1 04:35:53 INFO - mozversion platform_buildid: 20161006020801 04:35:53 INFO - mozversion platform_changeset: 089590fd275493af8294e2603c589d114f2a311a 04:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:35:53 INFO - mozversion platform_version: 52.0a1 04:35:53 INFO - using testdate: 1475753753 04:35:53 INFO - actual date: 1475753753 04:35:53 INFO - starting webserver on 'localhost:53454' 04:35:53 INFO - SUITE-START | Running 2 tests 04:35:53 INFO - TEST-START | dromaeo_css 04:35:53 INFO - operating with platform_type : mac_ 04:35:53 INFO - Initialising browser for dromaeo_css test... 04:35:53 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpF49rty/profile http://localhost:53454/getInfo.html) 04:35:55 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 04:35:55 INFO - PROCESS | 1947 | colorDepth:24 04:35:55 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 04:35:55 INFO - PROCESS | 1947 | __metrics 04:35:56 INFO - PROCESS | 1947 | 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:35:56 INFO - PROCESS | 1947 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:56 INFO - TEST-INFO | 1947: exit 0 04:35:56 INFO - Browser initialized. 04:35:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:56 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpF49rty/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:08 INFO - PROCESS | 1949 | RSS: Main: 235720704 04:36:08 INFO - PROCESS | 1949 | 04:36:59 INFO - PROCESS | 1949 | 1475753819793 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:39:13 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53454/tests/dromaeo/cssquery-ext.html) 04:39:15 INFO - PROCESS | 1949 | RSS: Main: 391897088 04:39:15 INFO - PROCESS | 1949 | 04:42:18 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-ext.html (next: http://localhost:53454/tests/dromaeo/cssquery-jquery.html) 04:42:18 INFO - PROCESS | 1949 | RSS: Main: 391380992 04:42:18 INFO - PROCESS | 1949 | 04:45:21 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53454/tests/dromaeo/cssquery-mootools.html) 04:45:21 INFO - PROCESS | 1949 | RSS: Main: 348745728 04:45:21 INFO - PROCESS | 1949 | 04:48:23 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53454/tests/dromaeo/cssquery-prototype.html) 04:48:24 INFO - PROCESS | 1949 | RSS: Main: 352661504 04:48:24 INFO - PROCESS | 1949 | 04:51:27 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53454/tests/dromaeo/cssquery-yui.html) 04:51:28 INFO - PROCESS | 1949 | RSS: Main: 339369984 04:51:28 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53454/tests/dromaeo/cssquery-yui.html (next: http://localhost:53454/tests/dromaeo/cssquery-dojo.html) 04:54:31 INFO - PROCESS | 1949 | RSS: Main: 384368640 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | __start_tp_report 04:54:31 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 04:54:31 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 04:54:31 INFO - PROCESS | 1949 | |i|pagename|runs| 04:54:31 INFO - PROCESS | 1949 | |0;dojo.html;3274.9672503274974;3281.5898012748407;3302.983485082575;3330.7002369786715;3365.915852103697;5551.278333816608;5586.944130558693;5660.320761508615;5669.574781891359;5677.37548869624;5593.133064375028;5607.158926161078;5678.6024978251535;5705.65766054036;5715.628484148517;5046.520580544842;5073.7463126843695;5100.260462232993;5138.820141295056;5155.896882062357;5237.135872581039;5252.054630166568;5267.341582302212;5269.8155564555245;5307.310049693554;5065.366829146356;5194.610404219679;5196.32447781786;5205.245239440298;5303.681779093247;5112.130937740556;5173.922391164136;5177.301064356301;5189.6886186828915;5190.584753219733;5049.671771334852;5132.615053870974;5137.897242055175;5145.228215767665;5148.150555158394;5458.4814442627885;5602.24369710088;5607.915881261743;5611.0741727614895;5620.747066381981;6159.599626024339;6175.07373893915;6175.69121543921;6190.442860142609;6194.442500175006;6207.099970504251;6268.561200715952;6275.7489700411925;6277.937220627781;6281.434670879643;5482.479164479368;5641.9435805641415;5644.971775141098;5648.971755141239;5661.575381846378;5542.808296216333;6116.816495505142;6320.55756097078;6330.620162790247;6370.426661600385;6022.518198544106;6034.306054803666;6050.515958723292;6053;6057.18228039209;6033.758649653964;6094.421030002142;6117.816465506042;6198.752049917953;6206.441420272197;6070.575059745775;6073.423024812636;6084.421979911901;6092.390760923872;6093.360197179232;6112.327643959161;6118.969405152946;6120.020796672511;6121.540884433685;6125.693715314216;4812.446568644651;4850.054239423349;4856.80572777092;4860.4896485869185;4867.951320486821;4269.87190384289;4289.013526888771;4295.22685916538;4415.470143582726;4422.248217802981;5457.945420545823;5552.500274975271;5620.747066382022;5622.072358060874;5634.60557760961;5121.718305493159;5646.3788983212635;5713.143028545752;6119.80722507659;6286.214223222098;5718.628289161191;5722.971385143131;5724.656520608777;5742.712864356766;5744.569157313218;4503.369528266046;5209.426963034063;5339.11904535755;5343.251944727741;5394.271773310553;5446.945530544644;6203.069539569101;6257.124002639634;6289.276733175743;6323.936760632519;6211.503079753699;6232.314445410911;6237.1891654084675;6242.687865606792;6263.592866463665;6293.40212679813;6308.747650093945;6318.462930650946;6340.587861788969;6351.841203969938;5917.1715959766525;5951.077582974646;5989.5507836913275;5995.940040599713;6031.125486804301;6163.322034576283;6215.81352559424;6221.844453888689;6251.218597675291;6263.655498947602;5632.5775566831835;6025.0661147522205;6042.607230530001;6044.21775457961;6053.848653783691;5830.82507524775;5913.645181289136;5920.348761636131;5977.3424923257535;5993.520518358608;5777.133429985536;5830.708464576839;5834.18321435008;5848.824535263949;5907.99564074117;5999.130126131774;6004.759809607742;6016.398360163948;6028.0355143176885;6042.939570604238;4944.851654450372;5706.942930570641;5823.068309070529;5842.152887831326;5863.501602363847 04:54:31 INFO - PROCESS | 1949 | |1;ext.html;478.8459811853434;509.42180624990635;518.1761000009985;519.2185760430551;551.5339538090312;30873.536896946564;40409;41561;41647.375289370684;41848.58151418485;42378.78810605943;42750;42762.786186069025;42884.71345859629;42905.35641965373;9331.346805723602;9627.999999999982;9816.852747208797;9835.262355323344;9844.163246124088;8763.255123314526;9575.377600455948;9689.612415503372;9739.172170365491;9741.415515069084;9673.56468958895;9725.708228753114;9740.318177727526;9749.26880483963;9764.560594773253;9675.612975480972;9717.61129554817;9723.978982206909;9734.075262850089;9738.756531086708;9672.854907176397;9754.804903901953;9757.756056098655;9773.120419162238;9774.12032917041;40652.796736016426;41033;41076.8384742288;41106;41136.38295425571;3200.18395309197;3386.136535183537;3633.5821380541047;3831;3932.921341573181;25351.74648253531;30943.38113237745;31143.688563114305;32093.839530802197;32464.513032304534;2666.839989600611;2868.3832975910072;3227.4836026235926;3342.7325813934826;3347.41420251455;463217;467698;468000.65999669785;468175;469295;59893.70053149707;60079.79840403167;60192.39807601868;60264.39735602588;60270;63277;63441.68279158575;63443.68278158672;63470.43149174802;63550;16174.838251617568;16432.589185270463;16435;16436.1781910904;16496.587585310463;12645.178063425848;12706.174098683556;12712.872871271355;12734;12739;16651.50045498637;17103.74344384835;17121.404505054077;17135;17180;6144;6155.415235552616;6244.65654389013;6263.4362907337645;6276.748930042839;856.6530555125184;926.3237836379346;959.1080295325274;1030.3972176276961;1048.433845723301;28826.71173288282;29682.10953671393;30047.098587042423;30636.234094147825;30947.69052309493;1010.5736872498557;1018.7402212435929;1041.2190856857358;1042.5360714481983;1055.3087727538475;15161.696766064617;15162.772558411632;15515.301811418512;15705.307262569695;15925.894450582256;606471;611874;612000;612706;614686;56722.43277567172;57043.42956570381;57119.71440142773;57170.85658286811;57197.71401142968;1306.7255876265901;1344.1397505596426;1358.4362489567113;1363.0186265888346;1363.9727205455836;29621.66702498436;29868.61037674364;29894.701052989192;30072.69927300699;30118.57668075108;50319.74840125776;50923.2361514585;50930.49069509257;51004.23493647524;51079.744601276754;556086.2195688996;559127;559591;559765;560261;40055.99860003523;40642.59357406388;41041.384379233736;41113.58886411098;41168.79415602903;45967.77016115032;46627.83430414267;46772;47493.05013899633;47658.04683906372;38659;38913.610863891;39472.605273946894;39590.40614390844;40529;37911.81044094762;38912;38927.6983056077;38970.61029389783;39653.60346396499;31995.72017119289;32663.836680816443;37876.431853521666;38769.61230387773;39073.41389879211;27244.597519582487;31088.378232435676;33968.830155849064;34325.313493730486;34389;24952.251432457055;25330.493390132462;25339;25376.11183608565;25993 04:54:31 INFO - PROCESS | 1949 | |2;jquery.html;344.9375922159748;365.331443458471;366.6443549756736;374.28511542952964;396.2016536678593;14776.487997040502;15419.922900385496;16263.349466021346;20558.177672893067;21093.26173583925;20067;20232;20680.586388272262;20898;21159.47101322464;5595.832125036255;5616.466435688613;5900.852478688024;5907.0548712206055;5911.674857882815;4744.97627511862;6019.789307374221;6092.177556029924;6097.26832780067;6111;5755.913661295084;5791.333996590382;6028.969855150718;6046.002409602433;6052.667103309316;5875.324337701155;5932.3474417814;5934.940650593482;5939.821805345803;5940.940590594104;4921.384826896638;5105.2086926526445;5179.404368497596;5186.533212010937;5212.817551385721;25535.48929021428;25706.357341066436;25763.098291559705;25964.610530842052;26199;2243.080337061797;2330.6270996640455;2384.0463814474174;2458.053649344997;2816.8732407041734;15148.394064237416;15556;15879.36482540697;16130.75803862943;16149.919250403791;1785.4223534482269;1813.6191399806057;1823.5076529337136;1824.7044598335199;1830.2678928428736;107833;109566;118261.49561774099;119701;122549.38725306405;10500.894991049992;10612.893871061346;10647.361158330525;10678.305910115818;10997.61508347204;13680.52118175879;13691.520796772065;13710.52013179534;13716.931415342859;13730.382132804049;8366.372522060748;8509.914900850912;8550.273226775793;8583.236303851298;8701;7573.697052117964;8040.638171282307;8536.530490822941;8724.43291186071;8737.21365077146;6447.451966582799;6465.64438955862;6601.864114545649;6602.689058829467;6624.6025238485845;1763.9647207055787;1777.7777777777778;1779.6796576616075;1786.0623172834366;1810.8370246677598;838.8070743728977;849.562475325208;875.5447167472878;958.3579002068631;962.831504486712;21353.679694804592;22223.777762222493;22234.55530889373;22244.110235590397;22328.330150095524;916.9312301577409;934.4206591912922;966.246327864267;968.2350942755286;998.3560603410759;8585.111101144603;8949.642014319485;11602.372849168147;11623.535058597561;11916.761664766656;490738;590768;596257;610814;611338;59243.70378148081;68939.65530172316;93916.06083939073;116077;122208.38895805464;901.7384958362132;950.3205208275978;1007.315025782475;1009.8687170667766;1010.2625083688802;18813.90593047026;19617.117229724412;20006.49983750418;20028.198872045537;20096.59806803885;50695.49304507055;52493.7375313121;52744.472555273955;52809.88760449539;53969;70984.64507677428;73237.1410287165;73690;74937.25062749302;75751;5457.890842183214;5810.970945145247;7496.850062998818;8103.756887293391;8219.9589002057;8135.67457301725;12247.69380765488;12832;13153.671158221121;13409.932950335186;11091.500882460146;11486.425678716198;11574.074074073886;11760.059195264188;11769;10926.726831829268;10974.780504390028;11174.385408802595;11437.02785263262;11646.359450230319;9893.159081478156;10304.742381440225;11227;11620.709482263012;11998.460069297078;7912.58666106843;7954.522728636301;8200.507969521848;8338.207870252316;8408.621612027351;7948.801279968047;9606;10900.618478353219;11562.479688413874;11647.242929209913 04:54:31 INFO - PROCESS | 1949 | |3;mootools.html;1512.6218445388654;1531.8391568885268;1545.6908618276343;1640.5570495966097;1932.458911504779;8513.702020429286;9073.047330030351;9074.954625226874;9087.591058402371;9090.090990900922;7984.165621204476;8253.752387428372;8259.876101858463;8365;8850.247728943048;2133.4026472587702;2186.267600353883;2301.620232661617;2373.32360277321;2377.3462297868136;2363.2083252110565;2374.169040835702;2376.251480783548;2378.001239479414;2382.332946774897;2281.6007198740235;2325.5697695926306;2326.697529321186;2329.685492458522;2329.813614910803;2326.2090889097617;2329.196427232602;2363.6218205087102;2366.077229880348;2366.621340585515;2283.5889539882814;2299;2306.331163962449;2339.7660233976635;2349.1308215960034;8881.511516866569;8939;8939.68711095115;8952.462852228888;8969.955150224272;5217.087009773274;5397.676139431646;5400.216968539579;5403.946230485057;5416;3531.682148606638;3639.1266096137;3723.6276372362818;3724.1434470072036;3735.906602334936;1016.6238491758023;1059.0362769879373;1063.489525027983;1064.1008347946051;1091.2688498705807;11851.703707407383;11926.46330915111;11932.88067119335;11940.761184776342;11943.94028029863;3968.3849003404516;4409.779511024436;4569.474510431343;4747.881302967385;4754.643401744883;10085.647002354883;10108.747281318027;10111.988801119976;10113.494325283706;10116.54475548602;5372.140457526855;5385.703786291791;5388.54197393226;5391.056565101092;5391.919121213185;4775.379200703886;4859.538343857328;4932.28481870134;4936.851894443173;4953.925691114636;3606.3148001880086;3727.981360093182;3728.5712143103347;3779.149691319486;3779.3764028935466;1226.45422786859;1263.6524955637274;1281.6923938254752;1285.2481298440516;1287.3820566128124;713.6824113269545;850.3537311643196;858.2490320969152;876.9254613357808;897.156672727647;5288.629795914326;5594.272744543265;5596.860078497989;5612.663240205601;5735.713214339266;828.5815663090222;915.231205787142;928.9535523223811;946.4037656276502;966.3718582921158;3621.370383327513;3715.108373990223;3719.795411252407;3819.1406933440308;3823.9808800955816;10424.426656533811;10956.616518421977;10974.396408197466;10992.835107473235;11003.119750419946;10878;10889.0199882011;10941.398223097805;10954.890451095387;10981.286216395909;6890;7747.070351557962;8322.375821813388;8340.666373344999;8343.45767525109;5786.566007549366;5925.170476133431;5959.718660488016;5992.43071908168;6000.159977603052;9672.129508344282;9896.010398960334;10051.849222261526;10091.646792362231;10288.228382871464;9935.850962235427;10303;10360.274780765576;10439.11267542237;10488.528016239441;7528.887066693895;7581.6209189541405;7597.810054748676;7642.885356719765;7698.384129269757;7537.9623101884135;8271.669133234844;8344.582770861554;8354.916450835413;8399.95800020996;6802.217744959393;7187.928120718726;7250.129984401906;7371.705131794883;7395.112586489656;6120.479759220516;7362.411007119311;7378.631068446663;7419;7430.777076687708;6020.608660437233;6109.419605137505;6407.070974708734;6565.507586930904;6567.671616419256;4708.340832283415;4783.521647835328;5020.071286811952;5030.547250747451;5033.521815427529;4913.385826771653;4995.450500444876;5077.898442031064;5112.412072611549;5196.558292545024 04:54:31 INFO - PROCESS | 1949 | |4;prototype.html;295.1558542568254;295.40770754636964;304.5538286410408;309.19146432080106;312.5312031952072;5361.490658387452;5361.731913404334;5402.945970540299;5425.907232877262;5464.453554644539;5003.924941125886;5089.949100508994;5147.356580427447;5165.431802501722;5279.366476022883;3538.3630946429635;3601.2977469393477;3930.5086864142054;4028.6374226319626;4049.8177582008734;4004.1991601679633;4015.3575427931537;4019.658329042035;4028.3353246714255;4052.675785937118;3322.0033989803082;3435.364457575344;3983.1237127831973;3996.1208534122447;4004.4983131325753;3349.7822641528223;4019.6333246696117;4036.7577945323374;4049.9672583491315;4074.6536544393466;2947.985260073707;3505.491703702974;3511.262634846685;3512.543369361992;3520.679745095589;4348.630366418858;5003.59899228213;5162.535371816517;5208.817691380784;5212.4266330703595;3949.7037722170953;4210.59999300066;4557.248054071074;4567.246404343279;4622.56085671864;4140.308799280461;4618.261078227468;4831.855044348676;5610.24261724666;5617.9719101404235;3320.1533608929567;3711.3319602471543;3796.0509872531866;3847.9230415391535;3847.9230415391817;5608.747606357683;5679.630823996427;5825.417458254141;5856.130496056944;5927.281088484335;3166.4300425923093;3801.790901500389;3819.350710379242;3835.175437280998;3861.227754449121;3959.762414255154;3967.8809635710977;3969.8412063517135;3975.185087057146;4032.354823228269;3654.6162652921594;3778.962210377916;4617.1069861357355;4642.86428243012;4642.953570464252;5539.473749993825;5542.944570554243;5554.1946417769195;5598.860028499239;5604.187392828017;1153.6193056291404;1234.9814752778716;1266.5630357526638;1340.805583190432;1341.6176389729076;719.399301583184;831.2850948184556;834.6035633074363;844.4300097434208;900.4552245891273;4337.479502459725;4773.570378665937;5169.327987361619;5229.111051121243;5253.23828044939;5620.466055724782;5624.3813180550105;5647.943520564824;5725.828225153252;5735.426457354315;4863.051704917507;4980.676256043345;5103.438621751604;5196.506331898464;5248.186531087687;2775.5836624506082;2975.664103678602;2976.866041028159;2985.9850700746792;2998;5363.785448582091;5835.978703726831;5836.358000619928;5841.415858414124;5878.855406938098;4828.334224692476;5696.601237913306;5735.397783232784;5823.650580965071;5825.50483208932;4805.198050730976;5340.465953404706;5593.161025846074;5828.708564571839;5846.239988801513;4462.4868140163;4601.332806742937;5257.8159764408065;5386.343684437577;5604.411536788579;5525.861853453695;5537.169424586345;5555.972220139035;5571.7492712828835;5653.971730141323;5541.695206763667;5647.265855438766;5825.70871456434;5836.453339865024;5884.882302354014;2983.970160298369;3371.5448414464713;3793.2223894102194;3796.4814074370474;3804.4483549885667;5559.2217089606675;5630.493255607015;5639.971800140973;5653.943460565341;5659.971700141473;4443.600075993176;4920.6801557898625;5199.55803756685;5234.790608375774;5546.751980804287;5148.510891465305;5488.670679759068;5532.640378375393;5556.16657501378;5605.439456054362;4501.9420436198125;5288.259643649969;5462.399136095106;5465.289512363367;5520.641158324696;4824.8793780155775;5031.213919058681;5365.570754339566;5594.496495315441;5659.320881494247;5487.533559647474;5494.472542630435;5518.089515229942;5550.028744969695;5585.69278689676 04:54:31 INFO - PROCESS | 1949 | |5;yui.html;608.3885694876649;742.3133601418688;759.6429678051318;790.367705835332;813.4062134641707;14679.70640587189;15832.76250856238;16073.357065717371;16104.83895161048;16475.258613362428;14522.419103235885;14592.124472531656;14632.34154463049;14645.487407940724;14651.267436628179;830.754927296449;845.0282175498196;849.2908421468081;858.9699360522383;863.5509535041774;856.7858035491128;857.7169534053778;861.9525926074064;863.9697610583631;864.5288317866778;775.6276987046222;865.091653763549;891.2112780189514;900.7027680865332;902.5306840442965;891.5809569502323;891.6210610490516;893.7720881175323;893.9329550283722;895.3106108296607;665.7869481765837;666.1207206487438;666.2305037681485;667.0461240426189;667.6728403082503;13322.333883305893;13559.864401356057;13583.320833958263;13585.456581736718;13598.86401135986;11947.402629868471;11991.28052316855;12083.57707480234;12113.33376664283;12591.748165036648;10605.416702081382;10738.409387483685;10828.837567436494;11073;11080.05819505343;3617.276544691072;3702.8518859245596;3771.69826413889;3807.1433927366397;3810.447485114643;104450;109846;110795;111552;111803;9147.2682185425;9206.309526785519;9331.253499720005;9519.857202141973;9523.000084991114;19289.8071019288;19524.316648917218;19552.608947820965;19601.607967840562;19613.90193049054;7502.512336698097;7625.046869141357;7759.68961241544;7865.921340786634;8184.099749027602;4291.206126866539;4407.382966384709;4435.401220835146;4456.442944631921;4603.447586289667;3387.61042480113;3529.576450825866;3537.0803591066506;3540.185757275841;3541.557305336833;649.2987573420694;659.6569783712539;662.8342914271432;663.7842701122155;666.0442265349143;505.7471264367816;532.97068661224;536.2331865432391;546.5436360638831;606.1544145916422;8627.309815214769;8836.337274704423;8984.68553600634;9030.86453703195;9041.412308199946;550.2571528436658;568.5338022821247;623.5043140703152;636.5607730665826;638.9137466442064;4037.6769858411844;4344.761038142932;4366.934495982563;4394.068552623751;4402.911941761211;93422;93602;121280.78719212872;127922;166955;143550;144528;146066;146738;149730;119871;121294.18058729127;121510.99999999822;121973;123272.38363808124;8361.331093512383;8474.74575762728;8500.192481714228;8611.268042216481;8719.084496127814;67743;68607;69476.30523694698;69876;70351.64824175846;97151;98775.50612246893;99642;99798;100648.99351006396;11057.889421105687;11100.61147859821;11204.39780109945;11371.31772093677;11701.88298117042;12088.576899808464;12092.758144836878;12144.939275303921;12257.664142981259;12385.62843114708;11386.601468948547;11446.255993360404;11488.299872506681;11684.88315116872;11927.761444770882;11045.558177672803;11288.20982531215;11288.322700637988;11686;12111.273323600612;11184.94407527957;11230.21388502797;11523.308601483937;11584.652460426201;11610.419479026184;8778.34162437807;8971.91028089737;8983.505907175168;9026.218160994107;9450.574724137292;8359.58202089881;9571.1864491519;9582.616695332108;9635.470049147365;9699.9030009699 04:54:31 INFO - PROCESS | 1949 | __end_tp_report 04:54:31 INFO - PROCESS | 1949 | __start_cc_report 04:54:31 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1474 04:54:31 INFO - PROCESS | 1949 | __end_cc_report 04:54:31 INFO - PROCESS | 1949 | __startTimestamp1475754871837__endTimestamp 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | ------- Summary: start ------- 04:54:31 INFO - PROCESS | 1949 | Number of tests: 6 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | [#0] dojo.html Cycles:165 Average:5644.88 Median:5744.57 stddev:639.61 (11.1%) stddev-sans-first:613.96 04:54:31 INFO - PROCESS | 1949 | Values: 3275.0 3281.6 3303.0 3330.7 3365.9 5551.3 5586.9 5660.3 5669.6 5677.4 5593.1 5607.2 5678.6 5705.7 5715.6 5046.5 5073.7 5100.3 5138.8 5155.9 5237.1 5252.1 5267.3 5269.8 5307.3 5065.4 5194.6 5196.3 5205.2 5303.7 5112.1 5173.9 5177.3 5189.7 5190.6 5049.7 5132.6 5137.9 5145.2 5148.2 5458.5 5602.2 5607.9 5611.1 5620.7 6159.6 6175.1 6175.7 6190.4 6194.4 6207.1 6268.6 6275.7 6277.9 6281.4 5482.5 5641.9 5645.0 5649.0 5661.6 5542.8 6116.8 6320.6 6330.6 6370.4 6022.5 6034.3 6050.5 6053.0 6057.2 6033.8 6094.4 6117.8 6198.8 6206.4 6070.6 6073.4 6084.4 6092.4 6093.4 6112.3 6119.0 6120.0 6121.5 6125.7 4812.4 4850.1 4856.8 4860.5 4868.0 4269.9 4289.0 4295.2 4415.5 4422.2 5457.9 5552.5 5620.7 5622.1 5634.6 5121.7 5646.4 5713.1 6119.8 6286.2 5718.6 5723.0 5724.7 5742.7 5744.6 4503.4 5209.4 5339.1 5343.3 5394.3 5446.9 6203.1 6257.1 6289.3 6323.9 6211.5 6232.3 6237.2 6242.7 6263.6 6293.4 6308.7 6318.5 6340.6 6351.8 5917.2 5951.1 5989.6 5995.9 6031.1 6163.3 6215.8 6221.8 6251.2 6263.7 5632.6 6025.1 6042.6 6044.2 6053.8 5830.8 5913.6 5920.3 5977.3 5993.5 5777.1 5830.7 5834.2 5848.8 5908.0 5999.1 6004.8 6016.4 6028.0 6042.9 4944.9 5706.9 5823.1 5842.2 5863.5 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | [#1] ext.html Cycles:180 Average:68586.08 Median:41109.79 stddev:146481.52 (356.3%) stddev-sans-first:146803.18 04:54:31 INFO - PROCESS | 1949 | Values: 478.8 509.4 518.2 519.2 551.5 30873.5 40409.0 41561.0 41647.4 41848.6 42378.8 42750.0 42762.8 42884.7 42905.4 9331.3 9628.0 9816.9 9835.3 9844.2 8763.3 9575.4 9689.6 9739.2 9741.4 9673.6 9725.7 9740.3 9749.3 9764.6 9675.6 9717.6 9724.0 9734.1 9738.8 9672.9 9754.8 9757.8 9773.1 9774.1 40652.8 41033.0 41076.8 41106.0 41136.4 3200.2 3386.1 3633.6 3831.0 3932.9 25351.7 30943.4 31143.7 32093.8 32464.5 2666.8 2868.4 3227.5 3342.7 3347.4 463217.0 467698.0 468000.7 468175.0 469295.0 59893.7 60079.8 60192.4 60264.4 60270.0 63277.0 63441.7 63443.7 63470.4 63550.0 16174.8 16432.6 16435.0 16436.2 16496.6 12645.2 12706.2 12712.9 12734.0 12739.0 16651.5 17103.7 17121.4 17135.0 17180.0 6144.0 6155.4 6244.7 6263.4 6276.7 856.7 926.3 959.1 1030.4 1048.4 28826.7 29682.1 30047.1 30636.2 30947.7 1010.6 1018.7 1041.2 1042.5 1055.3 15161.7 15162.8 15515.3 15705.3 15925.9 606471.0 611874.0 612000.0 612706.0 614686.0 56722.4 57043.4 57119.7 57170.9 57197.7 1306.7 1344.1 1358.4 1363.0 1364.0 29621.7 29868.6 29894.7 30072.7 30118.6 50319.7 50923.2 50930.5 51004.2 51079.7 556086.2 559127.0 559591.0 559765.0 560261.0 40056.0 40642.6 41041.4 41113.6 41168.8 45967.8 46627.8 46772.0 47493.1 47658.0 38659.0 38913.6 39472.6 39590.4 40529.0 37911.8 38912.0 38927.7 38970.6 39653.6 31995.7 32663.8 37876.4 38769.6 39073.4 27244.6 31088.4 33968.8 34325.3 34389.0 24952.3 25330.5 25339.0 25376.1 25993.0 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | [#2] jquery.html Cycles:180 Average:33415.11 Median:365.99 stddev:96445.09 (26352.0%) stddev-sans-first:96683.68 04:54:31 INFO - PROCESS | 1949 | Values: 344.9 365.3 366.6 374.3 396.2 14776.5 15419.9 16263.3 20558.2 21093.3 20067.0 20232.0 20680.6 20898.0 21159.5 5595.8 5616.5 5900.9 5907.1 5911.7 4745.0 6019.8 6092.2 6097.3 6111.0 5755.9 5791.3 6029.0 6046.0 6052.7 5875.3 5932.3 5934.9 5939.8 5940.9 4921.4 5105.2 5179.4 5186.5 5212.8 25535.5 25706.4 25763.1 25964.6 26199.0 2243.1 2330.6 2384.0 2458.1 2816.9 15148.4 15556.0 15879.4 16130.8 16149.9 1785.4 1813.6 1823.5 1824.7 1830.3 107833.0 109566.0 118261.5 119701.0 122549.4 10500.9 10612.9 10647.4 10678.3 10997.6 13680.5 13691.5 13710.5 13716.9 13730.4 8366.4 8509.9 8550.3 8583.2 8701.0 7573.7 8040.6 8536.5 8724.4 8737.2 6447.5 6465.6 6601.9 6602.7 6624.6 1764.0 1777.8 1779.7 1786.1 1810.8 838.8 849.6 875.5 958.4 962.8 21353.7 22223.8 22234.6 22244.1 22328.3 916.9 934.4 966.2 968.2 998.4 8585.1 8949.6 11602.4 11623.5 11916.8 490738.0 590768.0 596257.0 610814.0 611338.0 59243.7 68939.7 93916.1 116077.0 122208.4 901.7 950.3 1007.3 1009.9 1010.3 18813.9 19617.1 20006.5 20028.2 20096.6 50695.5 52493.7 52744.5 52809.9 53969.0 70984.6 73237.1 73690.0 74937.3 75751.0 5457.9 5811.0 7496.9 8103.8 8220.0 8135.7 12247.7 12832.0 13153.7 13409.9 11091.5 11486.4 11574.1 11760.1 11769.0 10926.7 10974.8 11174.4 11437.0 11646.4 9893.2 10304.7 11227.0 11620.7 11998.5 7912.6 7954.5 8200.5 8338.2 8408.6 7948.8 9606.0 10900.6 11562.5 11647.2 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | [#3] mootools.html Cycles:180 Average:5690.81 Median:4886.46 stddev:3245.95 (66.4%) stddev-sans-first:3239.87 04:54:31 INFO - PROCESS | 1949 | Values: 1512.6 1531.8 1545.7 1640.6 1932.5 8513.7 9073.0 9075.0 9087.6 9090.1 7984.2 8253.8 8259.9 8365.0 8850.2 2133.4 2186.3 2301.6 2373.3 2377.3 2363.2 2374.2 2376.3 2378.0 2382.3 2281.6 2325.6 2326.7 2329.7 2329.8 2326.2 2329.2 2363.6 2366.1 2366.6 2283.6 2299.0 2306.3 2339.8 2349.1 8881.5 8939.0 8939.7 8952.5 8970.0 5217.1 5397.7 5400.2 5403.9 5416.0 3531.7 3639.1 3723.6 3724.1 3735.9 1016.6 1059.0 1063.5 1064.1 1091.3 11851.7 11926.5 11932.9 11940.8 11943.9 3968.4 4409.8 4569.5 4747.9 4754.6 10085.6 10108.7 10112.0 10113.5 10116.5 5372.1 5385.7 5388.5 5391.1 5391.9 4775.4 4859.5 4932.3 4936.9 4953.9 3606.3 3728.0 3728.6 3779.1 3779.4 1226.5 1263.7 1281.7 1285.2 1287.4 713.7 850.4 858.2 876.9 897.2 5288.6 5594.3 5596.9 5612.7 5735.7 828.6 915.2 929.0 946.4 966.4 3621.4 3715.1 3719.8 3819.1 3824.0 10424.4 10956.6 10974.4 10992.8 11003.1 10878.0 10889.0 10941.4 10954.9 10981.3 6890.0 7747.1 8322.4 8340.7 8343.5 5786.6 5925.2 5959.7 5992.4 6000.2 9672.1 9896.0 10051.8 10091.6 10288.2 9935.9 10303.0 10360.3 10439.1 10488.5 7528.9 7581.6 7597.8 7642.9 7698.4 7538.0 8271.7 8344.6 8354.9 8400.0 6802.2 7187.9 7250.1 7371.7 7395.1 6120.5 7362.4 7378.6 7419.0 7430.8 6020.6 6109.4 6407.1 6565.5 6567.7 4708.3 4783.5 5020.1 5030.5 5033.5 4913.4 4995.5 5077.9 5112.4 5196.6 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | [#4] prototype.html Cycles:180 Average:4466.59 Median:5125.40 stddev:1393.07 (27.2%) stddev-sans-first:1361.34 04:54:31 INFO - PROCESS | 1949 | Values: 295.2 295.4 304.6 309.2 312.5 5361.5 5361.7 5402.9 5425.9 5464.5 5003.9 5089.9 5147.4 5165.4 5279.4 3538.4 3601.3 3930.5 4028.6 4049.8 4004.2 4015.4 4019.7 4028.3 4052.7 3322.0 3435.4 3983.1 3996.1 4004.5 3349.8 4019.6 4036.8 4050.0 4074.7 2948.0 3505.5 3511.3 3512.5 3520.7 4348.6 5003.6 5162.5 5208.8 5212.4 3949.7 4210.6 4557.2 4567.2 4622.6 4140.3 4618.3 4831.9 5610.2 5618.0 3320.2 3711.3 3796.1 3847.9 3847.9 5608.7 5679.6 5825.4 5856.1 5927.3 3166.4 3801.8 3819.4 3835.2 3861.2 3959.8 3967.9 3969.8 3975.2 4032.4 3654.6 3779.0 4617.1 4642.9 4643.0 5539.5 5542.9 5554.2 5598.9 5604.2 1153.6 1235.0 1266.6 1340.8 1341.6 719.4 831.3 834.6 844.4 900.5 4337.5 4773.6 5169.3 5229.1 5253.2 5620.5 5624.4 5647.9 5725.8 5735.4 4863.1 4980.7 5103.4 5196.5 5248.2 2775.6 2975.7 2976.9 2986.0 2998.0 5363.8 5836.0 5836.4 5841.4 5878.9 4828.3 5696.6 5735.4 5823.7 5825.5 4805.2 5340.5 5593.2 5828.7 5846.2 4462.5 4601.3 5257.8 5386.3 5604.4 5525.9 5537.2 5556.0 5571.7 5654.0 5541.7 5647.3 5825.7 5836.5 5884.9 2984.0 3371.5 3793.2 3796.5 3804.4 5559.2 5630.5 5640.0 5653.9 5660.0 4443.6 4920.7 5199.6 5234.8 5546.8 5148.5 5488.7 5532.6 5556.2 5605.4 4501.9 5288.3 5462.4 5465.3 5520.6 4824.9 5031.2 5365.6 5594.5 5659.3 5487.5 5494.5 5518.1 5550.0 5585.7 04:54:31 INFO - PROCESS | 1949 | 04:54:31 INFO - PROCESS | 1949 | [#5] yui.html Cycles:180 Average:24627.57 Median:4421.39 stddev:40517.77 (916.4%) stddev-sans-first:40591.30 04:54:31 INFO - PROCESS | 1949 | Values: 608.4 742.3 759.6 790.4 813.4 14679.7 15832.8 16073.4 16104.8 16475.3 14522.4 14592.1 14632.3 14645.5 14651.3 830.8 845.0 849.3 859.0 863.6 856.8 857.7 862.0 864.0 864.5 775.6 865.1 891.2 900.7 902.5 891.6 891.6 893.8 893.9 895.3 665.8 666.1 666.2 667.0 667.7 13322.3 13559.9 13583.3 13585.5 13598.9 11947.4 11991.3 12083.6 12113.3 12591.7 10605.4 10738.4 10828.8 11073.0 11080.1 3617.3 3702.9 3771.7 3807.1 3810.4 104450.0 109846.0 110795.0 111552.0 111803.0 9147.3 9206.3 9331.3 9519.9 9523.0 19289.8 19524.3 19552.6 19601.6 19613.9 7502.5 7625.0 7759.7 7865.9 8184.1 4291.2 4407.4 4435.4 4456.4 4603.4 3387.6 3529.6 3537.1 3540.2 3541.6 649.3 659.7 662.8 663.8 666.0 505.7 533.0 536.2 546.5 606.2 8627.3 8836.3 8984.7 9030.9 9041.4 550.3 568.5 623.5 636.6 638.9 4037.7 4344.8 4366.9 4394.1 4402.9 93422.0 93602.0 121280.8 127922.0 166955.0 143550.0 144528.0 146066.0 146738.0 149730.0 119871.0 121294.2 121511.0 121973.0 123272.4 8361.3 8474.7 8500.2 8611.3 8719.1 67743.0 68607.0 69476.3 69876.0 70351.6 97151.0 98775.5 99642.0 99798.0 100649.0 11057.9 11100.6 11204.4 11371.3 11701.9 12088.6 12092.8 12144.9 12257.7 12385.6 11386.6 11446.3 11488.3 11684.9 11927.8 11045.6 11288.2 11288.3 11686.0 12111.3 11184.9 11230.2 11523.3 11584.7 11610.4 8778.3 8971.9 8983.5 9026.2 9450.6 8359.6 9571.2 9582.6 9635.5 9699.9 04:54:31 INFO - PROCESS | 1949 | -------- Summary: end -------- 04:54:31 INFO - PROCESS | 1949 | 04:54:32 INFO - TEST-INFO | 1949: exit 0 04:54:32 INFO - TEST-OK | dromaeo_css | took 1118895ms 04:54:32 INFO - TEST-START | kraken 04:54:32 INFO - operating with platform_type : mac_ 04:54:32 INFO - Initialising browser for kraken test... 04:54:32 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpCawNAq/profile http://localhost:53454/getInfo.html) 04:54:34 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 04:54:34 INFO - PROCESS | 1953 | colorDepth:24 04:54:34 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 04:54:34 INFO - PROCESS | 1953 | __metrics 04:54:34 INFO - PROCESS | 1953 | 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:54:34 INFO - PROCESS | 1953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:35 INFO - TEST-INFO | 1953: exit 0 04:54:35 INFO - Browser initialized. 04:54:35 INFO - Running cycle 1/1 for kraken test... 04:54:35 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpCawNAq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:47 INFO - PROCESS | 1954 | RSS: Main: 235790336 04:54:47 INFO - PROCESS | 1954 | 04:54:50 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:51 INFO - PROCESS | 1954 | RSS: Main: 294453248 04:54:51 INFO - PROCESS | 1954 | 04:54:53 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-dft) 04:54:54 INFO - PROCESS | 1954 | RSS: Main: 293859328 04:54:54 INFO - PROCESS | 1954 | 04:54:58 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-fft) 04:54:58 INFO - PROCESS | 1954 | RSS: Main: 384126976 04:54:58 INFO - PROCESS | 1954 | 04:55:00 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53454/tests/kraken/driver.html?testName=audio-oscillator) 04:55:01 INFO - PROCESS | 1954 | RSS: Main: 285106176 04:55:01 INFO - PROCESS | 1954 | 04:55:03 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:03 INFO - PROCESS | 1954 | RSS: Main: 289177600 04:55:03 INFO - PROCESS | 1954 | 04:55:06 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53454/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:07 INFO - PROCESS | 1954 | RSS: Main: 327434240 04:55:07 INFO - PROCESS | 1954 | 04:55:10 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53454/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:10 INFO - PROCESS | 1954 | RSS: Main: 326516736 04:55:10 INFO - PROCESS | 1954 | 04:55:13 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53454/tests/kraken/driver.html?testName=json-parse-financial) 04:55:14 INFO - PROCESS | 1954 | RSS: Main: 329179136 04:55:14 INFO - PROCESS | 1954 | 04:55:15 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:16 INFO - PROCESS | 1954 | RSS: Main: 301465600 04:55:16 INFO - PROCESS | 1954 | 04:55:18 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:18 INFO - PROCESS | 1954 | RSS: Main: 306900992 04:55:18 INFO - PROCESS | 1954 | 04:55:21 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:21 INFO - PROCESS | 1954 | RSS: Main: 308641792 04:55:21 INFO - PROCESS | 1954 | 04:55:24 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:25 INFO - PROCESS | 1954 | RSS: Main: 318341120 04:55:25 INFO - PROCESS | 1954 | 04:55:28 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:29 INFO - PROCESS | 1954 | RSS: Main: 317841408 04:55:29 INFO - PROCESS | 1954 | 04:55:30 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:53454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53454/tests/kraken/driver.html?testName=ai-astar) 04:55:31 INFO - PROCESS | 1954 | RSS: Main: 361725952 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | __start_tp_report 04:55:31 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 04:55:31 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 04:55:31 INFO - PROCESS | 1954 | |i|pagename|runs| 04:55:31 INFO - PROCESS | 1954 | |0;ai-astar;113;115;113;113;114;115;114;114;115;113 04:55:31 INFO - PROCESS | 1954 | |1;audio-beat-detection;152;115;118;181;145;117;115;114;147;112 04:55:31 INFO - PROCESS | 1954 | |2;audio-dft;183;180;182;185;185;186;182;183;184;184 04:55:31 INFO - PROCESS | 1954 | |3;audio-fft;81;60;59;89;62;60;58;61;83;58 04:55:31 INFO - PROCESS | 1954 | |4;audio-oscillator;91;74;114;102;99;73;91;68;69;90 04:55:31 INFO - PROCESS | 1954 | |5;imaging-gaussian-blur;91;87;91;88;90;87;91;88;91;86 04:55:31 INFO - PROCESS | 1954 | |6;imaging-darkroom;96;94;95;95;95;95;95;95;96;94 04:55:31 INFO - PROCESS | 1954 | |7;imaging-desaturate;87;86;86;87;83;84;86;83;86;87 04:55:31 INFO - PROCESS | 1954 | |8;json-parse-financial;57;55;54;53;54;55;55;54;53;52 04:55:31 INFO - PROCESS | 1954 | |9;json-stringify-tinderbox;69;74;80;72;73;68;70;70;70;72 04:55:31 INFO - PROCESS | 1954 | |10;stanford-crypto-aes;87;88;88;89;87;93;105;89;87;91 04:55:31 INFO - PROCESS | 1954 | |11;stanford-crypto-ccm;147;147;149;145;142;146;152;132;193;158 04:55:31 INFO - PROCESS | 1954 | |12;stanford-crypto-pbkdf2;174;173;174;172;175;174;174;172;175;176 04:55:31 INFO - PROCESS | 1954 | |13;stanford-crypto-sha256-iterative;71;68;70;72;67;61;75;89;86;89 04:55:31 INFO - PROCESS | 1954 | __end_tp_report 04:55:31 INFO - PROCESS | 1954 | __start_cc_report 04:55:31 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,1939 04:55:31 INFO - PROCESS | 1954 | __end_cc_report 04:55:31 INFO - PROCESS | 1954 | __startTimestamp1475754931121__endTimestamp 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | ------- Summary: start ------- 04:55:31 INFO - PROCESS | 1954 | Number of tests: 14 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 04:55:31 INFO - PROCESS | 1954 | Values: 113.0 115.0 113.0 113.0 114.0 115.0 114.0 114.0 115.0 113.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:131.50 stddev:23.37 (17.8%) stddev-sans-first:23.60 04:55:31 INFO - PROCESS | 1954 | Values: 152.0 115.0 118.0 181.0 145.0 117.0 115.0 114.0 147.0 112.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.78 (1.0%) stddev-sans-first:1.88 04:55:31 INFO - PROCESS | 1954 | Values: 183.0 180.0 182.0 185.0 185.0 186.0 182.0 183.0 184.0 184.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#3] audio-fft Cycles:10 Average:67.10 Median:61.50 stddev:12.11 (19.7%) stddev-sans-first:11.76 04:55:31 INFO - PROCESS | 1954 | Values: 81.0 60.0 59.0 89.0 62.0 60.0 58.0 61.0 83.0 58.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:82.00 stddev:15.60 (19.0%) stddev-sans-first:16.48 04:55:31 INFO - PROCESS | 1954 | Values: 91.0 74.0 114.0 102.0 99.0 73.0 91.0 68.0 69.0 90.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:90.50 stddev:2.00 (2.2%) stddev-sans-first:1.99 04:55:31 INFO - PROCESS | 1954 | Values: 91.0 87.0 91.0 88.0 90.0 87.0 91.0 88.0 91.0 86.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 04:55:31 INFO - PROCESS | 1954 | Values: 96.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.58 04:55:31 INFO - PROCESS | 1954 | Values: 87.0 86.0 86.0 87.0 83.0 84.0 86.0 83.0 86.0 87.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.40 (2.6%) stddev-sans-first:1.05 04:55:31 INFO - PROCESS | 1954 | Values: 57.0 55.0 54.0 53.0 54.0 55.0 55.0 54.0 53.0 52.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:3.43 (4.8%) stddev-sans-first:3.48 04:55:31 INFO - PROCESS | 1954 | Values: 69.0 74.0 80.0 72.0 73.0 68.0 70.0 70.0 70.0 72.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:88.50 stddev:5.48 (6.2%) stddev-sans-first:5.67 04:55:31 INFO - PROCESS | 1954 | Values: 87.0 88.0 88.0 89.0 87.0 93.0 105.0 89.0 87.0 91.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:148.00 stddev:16.17 (10.9%) stddev-sans-first:17.08 04:55:31 INFO - PROCESS | 1954 | Values: 147.0 147.0 149.0 145.0 142.0 146.0 152.0 132.0 193.0 158.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:1.29 (0.7%) stddev-sans-first:1.36 04:55:31 INFO - PROCESS | 1954 | Values: 174.0 173.0 174.0 172.0 175.0 174.0 174.0 172.0 175.0 176.0 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - PROCESS | 1954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:73.50 stddev:9.84 (13.4%) stddev-sans-first:10.34 04:55:31 INFO - PROCESS | 1954 | Values: 71.0 68.0 70.0 72.0 67.0 61.0 75.0 89.0 86.0 89.0 04:55:31 INFO - PROCESS | 1954 | -------- Summary: end -------- 04:55:31 INFO - PROCESS | 1954 | 04:55:31 INFO - TEST-INFO | 1954: exit 0 04:55:32 INFO - TEST-OK | kraken | took 59545ms 04:55:32 INFO - SUITE-END | took 1178s 04:55:32 INFO - Completed test suite (00:19:38) 04:55:32 INFO - javascript benchmark 04:55:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.9672503274974, 3281.5898012748407, 3302.983485082575, 3330.7002369786715, 3365.915852103697, 5551.278333816608, 5586.944130558693, 5660.320761508615, 5669.574781891359, 5677.37548869624, 5593.133064375028, 5607.158926161078, 5678.6024978251535, 5705.65766054036, 5715.628484148517, 5046.520580544842, 5073.7463126843695, 5100.260462232993, 5138.820141295056, 5155.896882062357, 5237.135872581039, 5252.054630166568, 5267.341582302212, 5269.8155564555245, 5307.310049693554, 5065.366829146356, 5194.610404219679, 5196.32447781786, 5205.245239440298, 5303.681779093247, 5112.130937740556, 5173.922391164136, 5177.301064356301, 5189.6886186828915, 5190.584753219733, 5049.671771334852, 5132.615053870974, 5137.897242055175, 5145.228215767665, 5148.150555158394, 5458.4814442627885, 5602.24369710088, 5607.915881261743, 5611.0741727614895, 5620.747066381981, 6159.599626024339, 6175.07373893915, 6175.69121543921, 6190.442860142609, 6194.442500175006, 6207.099970504251, 6268.561200715952, 6275.7489700411925, 6277.937220627781, 6281.434670879643, 5482.479164479368, 5641.9435805641415, 5644.971775141098, 5648.971755141239, 5661.575381846378, 5542.808296216333, 6116.816495505142, 6320.55756097078, 6330.620162790247, 6370.426661600385, 6022.518198544106, 6034.306054803666, 6050.515958723292, 6053.0, 6057.18228039209, 6033.758649653964, 6094.421030002142, 6117.816465506042, 6198.752049917953, 6206.441420272197, 6070.575059745775, 6073.423024812636, 6084.421979911901, 6092.390760923872, 6093.360197179232, 6112.327643959161, 6118.969405152946, 6120.020796672511, 6121.540884433685, 6125.693715314216, 4812.446568644651, 4850.054239423349, 4856.80572777092, 4860.4896485869185, 4867.951320486821, 4269.87190384289, 4289.013526888771, 4295.22685916538, 4415.470143582726, 4422.248217802981, 5457.945420545823, 5552.500274975271, 5620.747066382022, 5622.072358060874, 5634.60557760961, 5121.718305493159, 5646.3788983212635, 5713.143028545752, 6119.80722507659, 6286.214223222098, 5718.628289161191, 5722.971385143131, 5724.656520608777, 5742.712864356766, 5744.569157313218, 4503.369528266046, 5209.426963034063, 5339.11904535755, 5343.251944727741, 5394.271773310553, 5446.945530544644, 6203.069539569101, 6257.124002639634, 6289.276733175743, 6323.936760632519, 6211.503079753699, 6232.314445410911, 6237.1891654084675, 6242.687865606792, 6263.592866463665, 6293.40212679813, 6308.747650093945, 6318.462930650946, 6340.587861788969, 6351.841203969938, 5917.1715959766525, 5951.077582974646, 5989.5507836913275, 5995.940040599713, 6031.125486804301, 6163.322034576283, 6215.81352559424, 6221.844453888689, 6251.218597675291, 6263.655498947602, 5632.5775566831835, 6025.0661147522205, 6042.607230530001, 6044.21775457961, 6053.848653783691, 5830.82507524775, 5913.645181289136, 5920.348761636131, 5977.3424923257535, 5993.520518358608, 5777.133429985536, 5830.708464576839, 5834.18321435008, 5848.824535263949, 5907.99564074117, 5999.130126131774, 6004.759809607742, 6016.398360163948, 6028.0355143176885, 6042.939570604238, 4944.851654450372, 5706.942930570641, 5823.068309070529, 5842.152887831326, 5863.501602363847], "value": 5604.213199216597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.8459811853434, 509.42180624990635, 518.1761000009985, 519.2185760430551, 551.5339538090312, 30873.536896946564, 40409.0, 41561.0, 41647.375289370684, 41848.58151418485, 42378.78810605943, 42750.0, 42762.786186069025, 42884.71345859629, 42905.35641965373, 9331.346805723602, 9627.999999999982, 9816.852747208797, 9835.262355323344, 9844.163246124088, 8763.255123314526, 9575.377600455948, 9689.612415503372, 9739.172170365491, 9741.415515069084, 9673.56468958895, 9725.708228753114, 9740.318177727526, 9749.26880483963, 9764.560594773253, 9675.612975480972, 9717.61129554817, 9723.978982206909, 9734.075262850089, 9738.756531086708, 9672.854907176397, 9754.804903901953, 9757.756056098655, 9773.120419162238, 9774.12032917041, 40652.796736016426, 41033.0, 41076.8384742288, 41106.0, 41136.38295425571, 3200.18395309197, 3386.136535183537, 3633.5821380541047, 3831.0, 3932.921341573181, 25351.74648253531, 30943.38113237745, 31143.688563114305, 32093.839530802197, 32464.513032304534, 2666.839989600611, 2868.3832975910072, 3227.4836026235926, 3342.7325813934826, 3347.41420251455, 463217.0, 467698.0, 468000.65999669785, 468175.0, 469295.0, 59893.70053149707, 60079.79840403167, 60192.39807601868, 60264.39735602588, 60270.0, 63277.0, 63441.68279158575, 63443.68278158672, 63470.43149174802, 63550.0, 16174.838251617568, 16432.589185270463, 16435.0, 16436.1781910904, 16496.587585310463, 12645.178063425848, 12706.174098683556, 12712.872871271355, 12734.0, 12739.0, 16651.50045498637, 17103.74344384835, 17121.404505054077, 17135.0, 17180.0, 6144.0, 6155.415235552616, 6244.65654389013, 6263.4362907337645, 6276.748930042839, 856.6530555125184, 926.3237836379346, 959.1080295325274, 1030.3972176276961, 1048.433845723301, 28826.71173288282, 29682.10953671393, 30047.098587042423, 30636.234094147825, 30947.69052309493, 1010.5736872498557, 1018.7402212435929, 1041.2190856857358, 1042.5360714481983, 1055.3087727538475, 15161.696766064617, 15162.772558411632, 15515.301811418512, 15705.307262569695, 15925.894450582256, 606471.0, 611874.0, 612000.0, 612706.0, 614686.0, 56722.43277567172, 57043.42956570381, 57119.71440142773, 57170.85658286811, 57197.71401142968, 1306.7255876265901, 1344.1397505596426, 1358.4362489567113, 1363.0186265888346, 1363.9727205455836, 29621.66702498436, 29868.61037674364, 29894.701052989192, 30072.69927300699, 30118.57668075108, 50319.74840125776, 50923.2361514585, 50930.49069509257, 51004.23493647524, 51079.744601276754, 556086.2195688996, 559127.0, 559591.0, 559765.0, 560261.0, 40055.99860003523, 40642.59357406388, 41041.384379233736, 41113.58886411098, 41168.79415602903, 45967.77016115032, 46627.83430414267, 46772.0, 47493.05013899633, 47658.04683906372, 38659.0, 38913.610863891, 39472.605273946894, 39590.40614390844, 40529.0, 37911.81044094762, 38912.0, 38927.6983056077, 38970.61029389783, 39653.60346396499, 31995.72017119289, 32663.836680816443, 37876.431853521666, 38769.61230387773, 39073.41389879211, 27244.597519582487, 31088.378232435676, 33968.830155849064, 34325.313493730486, 34389.0, 24952.251432457055, 25330.493390132462, 25339.0, 25376.11183608565, 25993.0], "value": 19964.953935375757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9375922159748, 365.331443458471, 366.6443549756736, 374.28511542952964, 396.2016536678593, 14776.487997040502, 15419.922900385496, 16263.349466021346, 20558.177672893067, 21093.26173583925, 20067.0, 20232.0, 20680.586388272262, 20898.0, 21159.47101322464, 5595.832125036255, 5616.466435688613, 5900.852478688024, 5907.0548712206055, 5911.674857882815, 4744.97627511862, 6019.789307374221, 6092.177556029924, 6097.26832780067, 6111.0, 5755.913661295084, 5791.333996590382, 6028.969855150718, 6046.002409602433, 6052.667103309316, 5875.324337701155, 5932.3474417814, 5934.940650593482, 5939.821805345803, 5940.940590594104, 4921.384826896638, 5105.2086926526445, 5179.404368497596, 5186.533212010937, 5212.817551385721, 25535.48929021428, 25706.357341066436, 25763.098291559705, 25964.610530842052, 26199.0, 2243.080337061797, 2330.6270996640455, 2384.0463814474174, 2458.053649344997, 2816.8732407041734, 15148.394064237416, 15556.0, 15879.36482540697, 16130.75803862943, 16149.919250403791, 1785.4223534482269, 1813.6191399806057, 1823.5076529337136, 1824.7044598335199, 1830.2678928428736, 107833.0, 109566.0, 118261.49561774099, 119701.0, 122549.38725306405, 10500.894991049992, 10612.893871061346, 10647.361158330525, 10678.305910115818, 10997.61508347204, 13680.52118175879, 13691.520796772065, 13710.52013179534, 13716.931415342859, 13730.382132804049, 8366.372522060748, 8509.914900850912, 8550.273226775793, 8583.236303851298, 8701.0, 7573.697052117964, 8040.638171282307, 8536.530490822941, 8724.43291186071, 8737.21365077146, 6447.451966582799, 6465.64438955862, 6601.864114545649, 6602.689058829467, 6624.6025238485845, 1763.9647207055787, 1777.7777777777778, 1779.6796576616075, 1786.0623172834366, 1810.8370246677598, 838.8070743728977, 849.562475325208, 875.5447167472878, 958.3579002068631, 962.831504486712, 21353.679694804592, 22223.777762222493, 22234.55530889373, 22244.110235590397, 22328.330150095524, 916.9312301577409, 934.4206591912922, 966.246327864267, 968.2350942755286, 998.3560603410759, 8585.111101144603, 8949.642014319485, 11602.372849168147, 11623.535058597561, 11916.761664766656, 490738.0, 590768.0, 596257.0, 610814.0, 611338.0, 59243.70378148081, 68939.65530172316, 93916.06083939073, 116077.0, 122208.38895805464, 901.7384958362132, 950.3205208275978, 1007.315025782475, 1009.8687170667766, 1010.2625083688802, 18813.90593047026, 19617.117229724412, 20006.49983750418, 20028.198872045537, 20096.59806803885, 50695.49304507055, 52493.7375313121, 52744.472555273955, 52809.88760449539, 53969.0, 70984.64507677428, 73237.1410287165, 73690.0, 74937.25062749302, 75751.0, 5457.890842183214, 5810.970945145247, 7496.850062998818, 8103.756887293391, 8219.9589002057, 8135.67457301725, 12247.69380765488, 12832.0, 13153.671158221121, 13409.932950335186, 11091.500882460146, 11486.425678716198, 11574.074074073886, 11760.059195264188, 11769.0, 10926.726831829268, 10974.780504390028, 11174.385408802595, 11437.02785263262, 11646.359450230319, 9893.159081478156, 10304.742381440225, 11227.0, 11620.709482263012, 11998.460069297078, 7912.58666106843, 7954.522728636301, 8200.507969521848, 8338.207870252316, 8408.621612027351, 7948.801279968047, 9606.0, 10900.618478353219, 11562.479688413874, 11647.242929209913], "value": 9514.79453230391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.6218445388654, 1531.8391568885268, 1545.6908618276343, 1640.5570495966097, 1932.458911504779, 8513.702020429286, 9073.047330030351, 9074.954625226874, 9087.591058402371, 9090.090990900922, 7984.165621204476, 8253.752387428372, 8259.876101858463, 8365.0, 8850.247728943048, 2133.4026472587702, 2186.267600353883, 2301.620232661617, 2373.32360277321, 2377.3462297868136, 2363.2083252110565, 2374.169040835702, 2376.251480783548, 2378.001239479414, 2382.332946774897, 2281.6007198740235, 2325.5697695926306, 2326.697529321186, 2329.685492458522, 2329.813614910803, 2326.2090889097617, 2329.196427232602, 2363.6218205087102, 2366.077229880348, 2366.621340585515, 2283.5889539882814, 2299.0, 2306.331163962449, 2339.7660233976635, 2349.1308215960034, 8881.511516866569, 8939.0, 8939.68711095115, 8952.462852228888, 8969.955150224272, 5217.087009773274, 5397.676139431646, 5400.216968539579, 5403.946230485057, 5416.0, 3531.682148606638, 3639.1266096137, 3723.6276372362818, 3724.1434470072036, 3735.906602334936, 1016.6238491758023, 1059.0362769879373, 1063.489525027983, 1064.1008347946051, 1091.2688498705807, 11851.703707407383, 11926.46330915111, 11932.88067119335, 11940.761184776342, 11943.94028029863, 3968.3849003404516, 4409.779511024436, 4569.474510431343, 4747.881302967385, 4754.643401744883, 10085.647002354883, 10108.747281318027, 10111.988801119976, 10113.494325283706, 10116.54475548602, 5372.140457526855, 5385.703786291791, 5388.54197393226, 5391.056565101092, 5391.919121213185, 4775.379200703886, 4859.538343857328, 4932.28481870134, 4936.851894443173, 4953.925691114636, 3606.3148001880086, 3727.981360093182, 3728.5712143103347, 3779.149691319486, 3779.3764028935466, 1226.45422786859, 1263.6524955637274, 1281.6923938254752, 1285.2481298440516, 1287.3820566128124, 713.6824113269545, 850.3537311643196, 858.2490320969152, 876.9254613357808, 897.156672727647, 5288.629795914326, 5594.272744543265, 5596.860078497989, 5612.663240205601, 5735.713214339266, 828.5815663090222, 915.231205787142, 928.9535523223811, 946.4037656276502, 966.3718582921158, 3621.370383327513, 3715.108373990223, 3719.795411252407, 3819.1406933440308, 3823.9808800955816, 10424.426656533811, 10956.616518421977, 10974.396408197466, 10992.835107473235, 11003.119750419946, 10878.0, 10889.0199882011, 10941.398223097805, 10954.890451095387, 10981.286216395909, 6890.0, 7747.070351557962, 8322.375821813388, 8340.666373344999, 8343.45767525109, 5786.566007549366, 5925.170476133431, 5959.718660488016, 5992.43071908168, 6000.159977603052, 9672.129508344282, 9896.010398960334, 10051.849222261526, 10091.646792362231, 10288.228382871464, 9935.850962235427, 10303.0, 10360.274780765576, 10439.11267542237, 10488.528016239441, 7528.887066693895, 7581.6209189541405, 7597.810054748676, 7642.885356719765, 7698.384129269757, 7537.9623101884135, 8271.669133234844, 8344.582770861554, 8354.916450835413, 8399.95800020996, 6802.217744959393, 7187.928120718726, 7250.129984401906, 7371.705131794883, 7395.112586489656, 6120.479759220516, 7362.411007119311, 7378.631068446663, 7419.0, 7430.777076687708, 6020.608660437233, 6109.419605137505, 6407.070974708734, 6565.507586930904, 6567.671616419256, 4708.340832283415, 4783.521647835328, 5020.071286811952, 5030.547250747451, 5033.521815427529, 4913.385826771653, 4995.450500444876, 5077.898442031064, 5112.412072611549, 5196.558292545024], "value": 4549.975815346526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.1558542568254, 295.40770754636964, 304.5538286410408, 309.19146432080106, 312.5312031952072, 5361.490658387452, 5361.731913404334, 5402.945970540299, 5425.907232877262, 5464.453554644539, 5003.924941125886, 5089.949100508994, 5147.356580427447, 5165.431802501722, 5279.366476022883, 3538.3630946429635, 3601.2977469393477, 3930.5086864142054, 4028.6374226319626, 4049.8177582008734, 4004.1991601679633, 4015.3575427931537, 4019.658329042035, 4028.3353246714255, 4052.675785937118, 3322.0033989803082, 3435.364457575344, 3983.1237127831973, 3996.1208534122447, 4004.4983131325753, 3349.7822641528223, 4019.6333246696117, 4036.7577945323374, 4049.9672583491315, 4074.6536544393466, 2947.985260073707, 3505.491703702974, 3511.262634846685, 3512.543369361992, 3520.679745095589, 4348.630366418858, 5003.59899228213, 5162.535371816517, 5208.817691380784, 5212.4266330703595, 3949.7037722170953, 4210.59999300066, 4557.248054071074, 4567.246404343279, 4622.56085671864, 4140.308799280461, 4618.261078227468, 4831.855044348676, 5610.24261724666, 5617.9719101404235, 3320.1533608929567, 3711.3319602471543, 3796.0509872531866, 3847.9230415391535, 3847.9230415391817, 5608.747606357683, 5679.630823996427, 5825.417458254141, 5856.130496056944, 5927.281088484335, 3166.4300425923093, 3801.790901500389, 3819.350710379242, 3835.175437280998, 3861.227754449121, 3959.762414255154, 3967.8809635710977, 3969.8412063517135, 3975.185087057146, 4032.354823228269, 3654.6162652921594, 3778.962210377916, 4617.1069861357355, 4642.86428243012, 4642.953570464252, 5539.473749993825, 5542.944570554243, 5554.1946417769195, 5598.860028499239, 5604.187392828017, 1153.6193056291404, 1234.9814752778716, 1266.5630357526638, 1340.805583190432, 1341.6176389729076, 719.399301583184, 831.2850948184556, 834.6035633074363, 844.4300097434208, 900.4552245891273, 4337.479502459725, 4773.570378665937, 5169.327987361619, 5229.111051121243, 5253.23828044939, 5620.466055724782, 5624.3813180550105, 5647.943520564824, 5725.828225153252, 5735.426457354315, 4863.051704917507, 4980.676256043345, 5103.438621751604, 5196.506331898464, 5248.186531087687, 2775.5836624506082, 2975.664103678602, 2976.866041028159, 2985.9850700746792, 2998.0, 5363.785448582091, 5835.978703726831, 5836.358000619928, 5841.415858414124, 5878.855406938098, 4828.334224692476, 5696.601237913306, 5735.397783232784, 5823.650580965071, 5825.50483208932, 4805.198050730976, 5340.465953404706, 5593.161025846074, 5828.708564571839, 5846.239988801513, 4462.4868140163, 4601.332806742937, 5257.8159764408065, 5386.343684437577, 5604.411536788579, 5525.861853453695, 5537.169424586345, 5555.972220139035, 5571.7492712828835, 5653.971730141323, 5541.695206763667, 5647.265855438766, 5825.70871456434, 5836.453339865024, 5884.882302354014, 2983.970160298369, 3371.5448414464713, 3793.2223894102194, 3796.4814074370474, 3804.4483549885667, 5559.2217089606675, 5630.493255607015, 5639.971800140973, 5653.943460565341, 5659.971700141473, 4443.600075993176, 4920.6801557898625, 5199.55803756685, 5234.790608375774, 5546.751980804287, 5148.510891465305, 5488.670679759068, 5532.640378375393, 5556.16657501378, 5605.439456054362, 4501.9420436198125, 5288.259643649969, 5462.399136095106, 5465.289512363367, 5520.641158324696, 4824.8793780155775, 5031.213919058681, 5365.570754339566, 5594.496495315441, 5659.320881494247, 5487.533559647474, 5494.472542630435, 5518.089515229942, 5550.028744969695, 5585.69278689676], "value": 4019.15784046873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.3885694876649, 742.3133601418688, 759.6429678051318, 790.367705835332, 813.4062134641707, 14679.70640587189, 15832.76250856238, 16073.357065717371, 16104.83895161048, 16475.258613362428, 14522.419103235885, 14592.124472531656, 14632.34154463049, 14645.487407940724, 14651.267436628179, 830.754927296449, 845.0282175498196, 849.2908421468081, 858.9699360522383, 863.5509535041774, 856.7858035491128, 857.7169534053778, 861.9525926074064, 863.9697610583631, 864.5288317866778, 775.6276987046222, 865.091653763549, 891.2112780189514, 900.7027680865332, 902.5306840442965, 891.5809569502323, 891.6210610490516, 893.7720881175323, 893.9329550283722, 895.3106108296607, 665.7869481765837, 666.1207206487438, 666.2305037681485, 667.0461240426189, 667.6728403082503, 13322.333883305893, 13559.864401356057, 13583.320833958263, 13585.456581736718, 13598.86401135986, 11947.402629868471, 11991.28052316855, 12083.57707480234, 12113.33376664283, 12591.748165036648, 10605.416702081382, 10738.409387483685, 10828.837567436494, 11073.0, 11080.05819505343, 3617.276544691072, 3702.8518859245596, 3771.69826413889, 3807.1433927366397, 3810.447485114643, 104450.0, 109846.0, 110795.0, 111552.0, 111803.0, 9147.2682185425, 9206.309526785519, 9331.253499720005, 9519.857202141973, 9523.000084991114, 19289.8071019288, 19524.316648917218, 19552.608947820965, 19601.607967840562, 19613.90193049054, 7502.512336698097, 7625.046869141357, 7759.68961241544, 7865.921340786634, 8184.099749027602, 4291.206126866539, 4407.382966384709, 4435.401220835146, 4456.442944631921, 4603.447586289667, 3387.61042480113, 3529.576450825866, 3537.0803591066506, 3540.185757275841, 3541.557305336833, 649.2987573420694, 659.6569783712539, 662.8342914271432, 663.7842701122155, 666.0442265349143, 505.7471264367816, 532.97068661224, 536.2331865432391, 546.5436360638831, 606.1544145916422, 8627.309815214769, 8836.337274704423, 8984.68553600634, 9030.86453703195, 9041.412308199946, 550.2571528436658, 568.5338022821247, 623.5043140703152, 636.5607730665826, 638.9137466442064, 4037.6769858411844, 4344.761038142932, 4366.934495982563, 4394.068552623751, 4402.911941761211, 93422.0, 93602.0, 121280.78719212872, 127922.0, 166955.0, 143550.0, 144528.0, 146066.0, 146738.0, 149730.0, 119871.0, 121294.18058729127, 121510.99999999822, 121973.0, 123272.38363808124, 8361.331093512383, 8474.74575762728, 8500.192481714228, 8611.268042216481, 8719.084496127814, 67743.0, 68607.0, 69476.30523694698, 69876.0, 70351.64824175846, 97151.0, 98775.50612246893, 99642.0, 99798.0, 100648.99351006396, 11057.889421105687, 11100.61147859821, 11204.39780109945, 11371.31772093677, 11701.88298117042, 12088.576899808464, 12092.758144836878, 12144.939275303921, 12257.664142981259, 12385.62843114708, 11386.601468948547, 11446.255993360404, 11488.299872506681, 11684.88315116872, 11927.761444770882, 11045.558177672803, 11288.20982531215, 11288.322700637988, 11686.0, 12111.273323600612, 11184.94407527957, 11230.21388502797, 11523.308601483937, 11584.652460426201, 11610.419479026184, 8778.34162437807, 8971.91028089737, 8983.505907175168, 9026.218160994107, 9450.574724137292, 8359.58202089881, 9571.1864491519, 9582.616695332108, 9635.470049147365, 9699.9030009699], "value": 7401.268331519369, "unit": "score"}], "name": "dromaeo_css", "value": 7240.690375250416, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 115.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 118.0, 181.0, 145.0, 117.0, 115.0, 114.0, 147.0, 112.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 182.0, 185.0, 185.0, 186.0, 182.0, 183.0, 184.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 89.0, 62.0, 60.0, 58.0, 61.0, 83.0, 58.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 74.0, 114.0, 102.0, 99.0, 73.0, 91.0, 68.0, 69.0, 90.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 91.0, 88.0, 90.0, 87.0, 91.0, 88.0, 91.0, 86.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 83.0, 84.0, 86.0, 83.0, 86.0, 87.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 54.0, 55.0, 55.0, 54.0, 53.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 80.0, 72.0, 73.0, 68.0, 70.0, 70.0, 70.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 89.0, 87.0, 93.0, 105.0, 89.0, 87.0, 91.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 145.0, 142.0, 146.0, 152.0, 132.0, 193.0, 158.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 174.0, 172.0, 175.0, 174.0, 174.0, 172.0, 175.0, 176.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 72.0, 67.0, 61.0, 75.0, 89.0, 86.0, 89.0], "value": 74.8, "unit": "score"}], "name": "kraken", "value": 1468.8, "alertThreshold": 2.0}]} 04:55:32 INFO - Return code: 0 04:55:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:32 INFO - # TBPL SUCCESS # 04:55:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:32 INFO - 2016-10-06 04:55:32.406 screenresolution[1958:18394] starting screenresolution argv=screenresolution get 04:55:32 INFO - 2016-10-06 04:55:32.409 screenresolution[1958:18394] Display 0: 1600x1200x32@60 04:55:32 INFO - 2016-10-06 04:55:32.415 screenresolution[1959:18398] starting screenresolution argv=screenresolution list 04:55:32 INFO - Available Modes on Display 0 04:55:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:32 INFO - Intel Iris: 04:55:32 INFO - Chipset Model: Intel Iris 04:55:32 INFO - Type: GPU 04:55:32 INFO - Bus: Built-In 04:55:32 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:32 INFO - Vendor: Intel (0x8086) 04:55:32 INFO - Device ID: 0x0a2e 04:55:32 INFO - Revision ID: 0x0009 04:55:32 INFO - Displays: 04:55:32 INFO - Display: 04:55:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:32 INFO - Display Serial Number: 1600x1200 60 04:55:32 INFO - Main Display: Yes 04:55:32 INFO - Mirror: Off 04:55:32 INFO - Online: Yes 04:55:32 INFO - Rotation: Supported 04:55:32 INFO - Return code: 0 04:55:32 INFO - Running post-action listener: _resource_record_post_action 04:55:32 INFO - [mozharness: 2016-10-06 11:55:32.656351Z] Finished run-tests step (success) 04:55:32 INFO - Running post-run listener: _resource_record_post_run 04:55:32 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 606208; Write bytes: 707549696; Read time: 8; Write time: 1981 04:55:32 INFO - TinderboxPrint: CPU usage
53.4% 04:55:32 INFO - TinderboxPrint: I/O read bytes / time
606,208 / 8 04:55:32 INFO - TinderboxPrint: I/O write bytes / time
707,549,696 / 1,981 04:55:32 INFO - TinderboxPrint: CPU idle
2,264.0 (46.6%) 04:55:32 INFO - TinderboxPrint: CPU system
970.7 (20.0%) 04:55:32 INFO - TinderboxPrint: CPU user
1,623.0 (33.4%) 04:55:32 INFO - TinderboxPrint: Swap in / out
408,502,272 / 0 04:55:32 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 399919616; Write bytes: 394668032; Read time: 30616; Write time: 807 04:55:32 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 606208; Write bytes: 296038912; Read time: 8; Write time: 1129 04:55:33 INFO - Running post-run listener: _upload_blobber_files 04:55:33 INFO - Blob upload gear active. 04:55:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:33 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:55:33 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:55:33 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:55:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:34 INFO - (blobuploader) - INFO - Done attempting. 04:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:35 INFO - (blobuploader) - INFO - Done attempting. 04:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:37 INFO - (blobuploader) - INFO - Done attempting. 04:55:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:55:37 INFO - Return code: 0 04:55:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:55:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:55:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bfa346f7af4172cf89c2d725a2218dd19ddff83bb26a35a103b504bc032fdf877c3a3a79effc2de47917ec4acda40d8d57d193f1ec63b4f57d878cf6c00e4d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cf2f929d30a167d128d58f1b87bf72f6283236a33d6a2512565bc4e77e57140e739f59d324704c5c4ff649ab217230f59de105a217affc056a01b68559a148a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5db367f869b12f45b9870c1a70b1815b114627947d32c344f4b61feb3bd0c24e7d5262c65842c9d751ea23ff1ba732c3ee595e89d9bb0f8de4e942c9d82712fe"} 04:55:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:55:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:55:37 INFO - Contents: 04:55:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bfa346f7af4172cf89c2d725a2218dd19ddff83bb26a35a103b504bc032fdf877c3a3a79effc2de47917ec4acda40d8d57d193f1ec63b4f57d878cf6c00e4d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cf2f929d30a167d128d58f1b87bf72f6283236a33d6a2512565bc4e77e57140e739f59d324704c5c4ff649ab217230f59de105a217affc056a01b68559a148a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5db367f869b12f45b9870c1a70b1815b114627947d32c344f4b61feb3bd0c24e7d5262c65842c9d751ea23ff1ba732c3ee595e89d9bb0f8de4e942c9d82712fe"} 04:55:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:55:37 INFO - Copying logs to upload dir... 04:55:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:55:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.206153 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 04:55:37.927398) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:55:37.931334) ========= 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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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/Fx-Team/sha512/7bfa346f7af4172cf89c2d725a2218dd19ddff83bb26a35a103b504bc032fdf877c3a3a79effc2de47917ec4acda40d8d57d193f1ec63b4f57d878cf6c00e4d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cf2f929d30a167d128d58f1b87bf72f6283236a33d6a2512565bc4e77e57140e739f59d324704c5c4ff649ab217230f59de105a217affc056a01b68559a148a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5db367f869b12f45b9870c1a70b1815b114627947d32c344f4b61feb3bd0c24e7d5262c65842c9d751ea23ff1ba732c3ee595e89d9bb0f8de4e942c9d82712fe"} build_url:https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/eDpplPR5Ql2XhzRPsS_p1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bfa346f7af4172cf89c2d725a2218dd19ddff83bb26a35a103b504bc032fdf877c3a3a79effc2de47917ec4acda40d8d57d193f1ec63b4f57d878cf6c00e4d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6cf2f929d30a167d128d58f1b87bf72f6283236a33d6a2512565bc4e77e57140e739f59d324704c5c4ff649ab217230f59de105a217affc056a01b68559a148a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5db367f869b12f45b9870c1a70b1815b114627947d32c344f4b61feb3bd0c24e7d5262c65842c9d751ea23ff1ba732c3ee595e89d9bb0f8de4e942c9d82712fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:55:37.964391) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:55:37.964732) ========= 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.TKDTrZIucU/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.Jk3C8IJAQ7/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.004417 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:55:38.014682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:55:38.015101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:55:38.015473) ========= ========= Total master_lag: 0.17 =========