builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0031 starttime: 1475804976.91 results: success (0) buildid: 20161006171100 builduid: b6953620ca644427ac4fa3fdbcab9540 revision: a5510966f80b9b2f5abf59ab32cf4c92d66c60de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:36.911731) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:36.912276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:36.912576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:36.937141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:36.937530) ========= 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.e0nybacOIK/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.wLBAyR0LBi/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:49:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.04M=0.001s 2016-10-06 18:49:37 (8.04 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145132 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:37.105587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:37.106098) ========= 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.e0nybacOIK/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.wLBAyR0LBi/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.020363 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:37.156541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 18:49:37.157142) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5510966f80b9b2f5abf59ab32cf4c92d66c60de --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 a5510966f80b9b2f5abf59ab32cf4c92d66c60de --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e0nybacOIK/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.wLBAyR0LBi/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:49:37,227 truncating revision to first 12 chars 2016-10-06 18:49:37,227 Setting DEBUG logging. 2016-10-06 18:49:37,227 attempt 1/10 2016-10-06 18:49:37,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5510966f80b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 18:49:38,386 unpacking tar archive at: fx-team-a5510966f80b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.156082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-06 18:49:39.338094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:39.338574) ========= script_repo_revision: a5510966f80b9b2f5abf59ab32cf4c92d66c60de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:39.339180) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:39.339674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 18:49:39.359756) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-06 18:49:39.360332) ========= /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.e0nybacOIK/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.wLBAyR0LBi/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:49:39 INFO - MultiFileLogger online at 20161006 18:49:39 in /builds/slave/test 18:49:39 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 18:49:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:49:39 INFO - {'append_to_log': False, 18:49:39 INFO - 'base_work_dir': '/builds/slave/test', 18:49:39 INFO - 'blob_upload_branch': 'Fx-Team', 18:49:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:49:39 INFO - 'branch': 'Fx-Team', 18:49:39 INFO - 'buildbot_json_path': 'buildprops.json', 18:49:39 INFO - 'config_files': ('talos/mac_config.py',), 18:49:39 INFO - 'default_actions': ('clobber', 18:49:39 INFO - 'read-buildbot-config', 18:49:39 INFO - 'download-and-extract', 18:49:39 INFO - 'populate-webroot', 18:49:39 INFO - 'create-virtualenv', 18:49:39 INFO - 'install', 18:49:39 INFO - 'run-tests'), 18:49:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:49:39 INFO - 'download_minidump_stackwalk': True, 18:49:39 INFO - 'download_symbols': 'ondemand', 18:49:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:49:39 INFO - 'tooltool.py': '/tools/tooltool.py', 18:49:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:49:39 INFO - '/tools/misc-python/virtualenv.py')}, 18:49:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:49:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:49:39 INFO - 'installer_path': 'installer.exe', 18:49:39 INFO - 'log_level': 'info', 18:49:39 INFO - 'log_name': 'talos', 18:49:39 INFO - 'log_to_console': True, 18:49:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:49:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:49:39 INFO - 'opt_config_files': (), 18:49:39 INFO - 'pip_index': False, 18:49:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:49:39 INFO - 'cmd': ('bash', 18:49:39 INFO - '-c', 18:49:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:49:39 INFO - 'enabled': True, 18:49:39 INFO - 'halt_on_failure': False, 18:49:39 INFO - 'name': 'check_screen_resolution'},), 18:49:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:49:39 INFO - 'cmd': ('bash', 18:49:39 INFO - '-c', 18:49:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:49:39 INFO - 'enabled': True, 18:49:39 INFO - 'halt_on_failure': False, 18:49:39 INFO - 'name': 'check_screen_resolution'},), 18:49:39 INFO - 'run_cmd_checks_enabled': True, 18:49:39 INFO - 'sps_profile': False, 18:49:39 INFO - 'sps_profile_interval': 0, 18:49:39 INFO - 'suite': 'dromaeojs', 18:49:39 INFO - 'system_bits': '32', 18:49:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:49:39 INFO - 'title': 't-yosemite-r7-0031', 18:49:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:49:39 INFO - 'use_talos_json': True, 18:49:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:49:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:49:39 INFO - 'work_dir': 'build'} 18:49:39 INFO - [mozharness: 2016-10-07 01:49:39.560075Z] Running clobber step. 18:49:39 INFO - Running pre-action listener: _resource_record_pre_action 18:49:39 INFO - Running main action method: clobber 18:49:39 INFO - rmtree: /builds/slave/test/build 18:49:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:49:41 INFO - Running post-action listener: _resource_record_post_action 18:49:41 INFO - [mozharness: 2016-10-07 01:49:41.213770Z] Finished clobber step (success) 18:49:41 INFO - [mozharness: 2016-10-07 01:49:41.213902Z] Running read-buildbot-config step. 18:49:41 INFO - Running pre-action listener: _resource_record_pre_action 18:49:41 INFO - Running main action method: read_buildbot_config 18:49:41 INFO - Using buildbot properties: 18:49:41 INFO - { 18:49:41 INFO - "project": "", 18:49:41 INFO - "product": "firefox", 18:49:41 INFO - "script_repo_revision": "production", 18:49:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:49:41 INFO - "repository": "", 18:49:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:49:41 INFO - "buildid": "20161006171100", 18:49:41 INFO - "pgo_build": "False", 18:49:41 INFO - "basedir": "/builds/slave/test", 18:49:41 INFO - "buildnumber": 857, 18:49:41 INFO - "slavename": "t-yosemite-r7-0031", 18:49:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:49:41 INFO - "platform": "yosemite_r7", 18:49:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:49:41 INFO - "branch": "fx-team", 18:49:41 INFO - "repo_path": "integration/fx-team", 18:49:41 INFO - "revision": "a5510966f80b9b2f5abf59ab32cf4c92d66c60de", 18:49:41 INFO - "stage_platform": "macosx64", 18:49:41 INFO - "builduid": "b6953620ca644427ac4fa3fdbcab9540", 18:49:41 INFO - "slavebuilddir": "test" 18:49:41 INFO - } 18:49:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 18:49:41 INFO - Running post-action listener: _resource_record_post_action 18:49:41 INFO - [mozharness: 2016-10-07 01:49:41.217386Z] Finished read-buildbot-config step (success) 18:49:41 INFO - [mozharness: 2016-10-07 01:49:41.217508Z] Running download-and-extract step. 18:49:41 INFO - Running pre-action listener: _resource_record_pre_action 18:49:41 INFO - Running main action method: download_and_extract 18:49:41 INFO - mkdir: /builds/slave/test/build/tests 18:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:41 INFO - trying https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 18:49:41 INFO - Downloading https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/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 18:49:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/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 18:49:42 INFO - Downloaded 1199 bytes. 18:49:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 18:49:42 INFO - Using the following test package requirements: 18:49:42 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:49:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 18:49:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 18:49:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'jsshell-mac.zip'], 18:49:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 18:49:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:49:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 18:49:42 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 18:49:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 18:49:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:49:42 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 18:49:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:49:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:49:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:49:42 INFO - Fetch https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:49:43 INFO - Http code: 200 18:49:43 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 18:49:43 INFO - x-amz-cf-id: 7v50Rrj0mE3SHmpc1wwbxoOsAZ8Uo0K8tnDmehZfxP7q8Eix3q4lhw== 18:49:43 INFO - x-amz-version-id: 6tDO91zK0xdrVhe.q37yvZmu8HKxhkPe 18:49:43 INFO - Expected file size: 16478188 18:49:43 INFO - Obtained file size: 16478188 18:49:50 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 18:49:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:49:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:49:50 INFO - Fetch https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:49:50 INFO - Http code: 200 18:49:50 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 18:49:50 INFO - x-amz-cf-id: Qd3SDPcPeb_WDblEvJh1ztU89zy4v0TE-Q0zQo6WV2uZONmi5c_9Ug== 18:49:50 INFO - x-amz-version-id: 6tDO91zK0xdrVhe.q37yvZmu8HKxhkPe 18:49:51 INFO - Expected file size: 16478188 18:49:51 INFO - Obtained file size: 16478188 18:49:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 18:49:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:49:57 INFO - Fetch https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 18:49:58 INFO - Http code: 200 18:49:58 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 18:49:58 INFO - x-amz-cf-id: QToK7l9Ng6nO5zeSjWDKdzoO9HMybRR-UmYiCaoR489RY2cS-MZMNQ== 18:49:58 INFO - x-amz-version-id: bQ_rt4QG5Uhyyqy2pd5w8YgjK5MZWtOJ 18:49:58 INFO - Expected file size: 14409006 18:49:58 INFO - Obtained file size: 14409006 18:49: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')]} 18:49:58 INFO - trying https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:49:58 INFO - Downloading https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 18:49:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/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 18:50:01 INFO - Downloaded 111657656 bytes. 18:50:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:50:01 INFO - mkdir: /builds/slave/test/properties 18:50:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:50:01 INFO - Writing to file /builds/slave/test/properties/build_url 18:50:01 INFO - Contents: 18:50:01 INFO - build_url:https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:50:02 INFO - Running post-action listener: _resource_record_post_action 18:50:02 INFO - Running post-action listener: set_extra_try_arguments 18:50:02 INFO - [mozharness: 2016-10-07 01:50:02.127368Z] Finished download-and-extract step (success) 18:50:02 INFO - [mozharness: 2016-10-07 01:50:02.127516Z] Running populate-webroot step. 18:50:02 INFO - Running pre-action listener: _resource_record_pre_action 18:50:02 INFO - Running main action method: populate_webroot 18:50:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:50:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:50:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:50:02 INFO - '--tppagecycles', 18:50:02 INFO - '7'], 18:50:02 INFO - 'tests': ['tsvgm']}}, 18:50:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:50:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:50:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:50:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:50:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['damp', 'tps']}, 18:50:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'tests': ['damp', 'tps']}, 18:50:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['dromaeo_dom']}, 18:50:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:50:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['basic_compositor_video']}, 18:50:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:50:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['a11yr', 18:50:02 INFO - 'ts_paint', 18:50:02 INFO - 'tpaint', 18:50:02 INFO - 'sessionrestore', 18:50:02 INFO - 'sessionrestore_no_auto_restore', 18:50:02 INFO - 'tabpaint']}, 18:50:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:50:02 INFO - 'ts_paint', 18:50:02 INFO - 'tpaint', 18:50:02 INFO - 'sessionrestore', 18:50:02 INFO - 'sessionrestore_no_auto_restore', 18:50:02 INFO - 'tabpaint']}, 18:50:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:50:02 INFO - 'ts_paint', 18:50:02 INFO - 'tpaint', 18:50:02 INFO - 'sessionrestore', 18:50:02 INFO - 'sessionrestore_no_auto_restore', 18:50:02 INFO - 'tabpaint']}, 18:50:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:50:02 INFO - 'ts_paint', 18:50:02 INFO - 'tpaint', 18:50:02 INFO - 'sessionrestore', 18:50:02 INFO - 'sessionrestore_no_auto_restore', 18:50:02 INFO - 'tabpaint']}, 18:50:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['a11yr', 18:50:02 INFO - 'ts_paint', 18:50:02 INFO - 'tpaint', 18:50:02 INFO - 'sessionrestore', 18:50:02 INFO - 'sessionrestore_no_auto_restore', 18:50:02 INFO - 'tabpaint']}, 18:50:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['a11yr', 18:50:02 INFO - 'ts_paint', 18:50:02 INFO - 'tpaint', 18:50:02 INFO - 'sessionrestore', 18:50:02 INFO - 'sessionrestore_no_auto_restore', 18:50:02 INFO - 'tabpaint']}, 18:50:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['tsvgx', 18:50:02 INFO - 'tsvgr_opacity', 18:50:02 INFO - 'tart', 18:50:02 INFO - 'tscrollx', 18:50:02 INFO - 'cart']}, 18:50:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:50:02 INFO - 'tsvgr_opacity', 18:50:02 INFO - 'tart', 18:50:02 INFO - 'tscrollx', 18:50:02 INFO - 'cart']}, 18:50:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'talos_options': ['--disable-e10s'], 18:50:02 INFO - 'tests': ['tp5o']}, 18:50:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'tests': ['tp5o']}, 18:50:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'talos_options': ['--disable-e10s', 18:50:02 INFO - '--xperf_path', 18:50:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:02 INFO - 'tests': ['tp5n']}, 18:50:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:02 INFO - 'talos_options': ['--xperf_path', 18:50:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:02 INFO - 'tests': ['tp5n']}}, 18:50:02 INFO - 'talos.zip': {'path': '', 18:50:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:50:02 INFO - Running post-action listener: _resource_record_post_action 18:50:02 INFO - [mozharness: 2016-10-07 01:50:02.146869Z] Finished populate-webroot step (success) 18:50:02 INFO - [mozharness: 2016-10-07 01:50:02.147006Z] Running create-virtualenv step. 18:50:02 INFO - Running pre-action listener: _resource_record_pre_action 18:50:02 INFO - Running main action method: create_virtualenv 18:50:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:50:02 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 18:50:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:50:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:50:02 INFO - Using real prefix '/tools/python27' 18:50:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:50:02 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:05 INFO - Installing pip.................done. 18:50:05 INFO - Return code: 0 18:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:50:06 INFO - Reading from file tmpfile_stdout 18:50:06 INFO - Output received: 18:50:06 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) 18:50:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:06 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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:06 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 18:50:06 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 18:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:06 INFO - 'HOME': '/Users/cltbld', 18:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:06 INFO - 'LOGNAME': 'cltbld', 18:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:06 INFO - 'MOZ_NO_REMOTE': '1', 18:50:06 INFO - 'NO_EM_RESTART': '1', 18:50:06 INFO - 'PAGER': '/bin/cat', 18:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:06 INFO - 'PWD': '/builds/slave/test', 18:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:06 INFO - 'SHELL': '/bin/bash', 18:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:06 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:06 INFO - 'USER': 'cltbld', 18:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:06 INFO - 'XPC_FLAGS': '0x0', 18:50:06 INFO - 'XPC_SERVICE_NAME': '0', 18:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:06 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 18:50:06 INFO - Cleaning up... 18:50:06 INFO - Return code: 0 18:50:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:06 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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:06 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 18:50:06 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 18:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:06 INFO - 'HOME': '/Users/cltbld', 18:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:06 INFO - 'LOGNAME': 'cltbld', 18:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:06 INFO - 'MOZ_NO_REMOTE': '1', 18:50:06 INFO - 'NO_EM_RESTART': '1', 18:50:06 INFO - 'PAGER': '/bin/cat', 18:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:06 INFO - 'PWD': '/builds/slave/test', 18:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:06 INFO - 'SHELL': '/bin/bash', 18:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:06 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:06 INFO - 'USER': 'cltbld', 18:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:06 INFO - 'XPC_FLAGS': '0x0', 18:50:06 INFO - 'XPC_SERVICE_NAME': '0', 18:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:06 INFO - Downloading/unpacking psutil>=3.1.1 18:50:06 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 18:50:06 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 18:50:06 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 18:50:06 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 18:50:06 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 18:50:06 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 18:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:10 INFO - Installing collected packages: psutil 18:50:10 INFO - Running setup.py install for psutil 18:50:10 INFO - building 'psutil._psutil_osx' extension 18:50:10 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 18:50:10 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 18:50:10 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 18:50:10 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 18:50:10 INFO - building 'psutil._psutil_posix' extension 18:50:10 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 18:50:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:50:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:50:10 INFO - ^ 18:50:11 INFO - 1 warning generated. 18:50:11 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 18:50:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:11 INFO - Successfully installed psutil 18:50:11 INFO - Cleaning up... 18:50:11 INFO - Return code: 0 18:50:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:11 INFO - 'HOME': '/Users/cltbld', 18:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:11 INFO - 'LOGNAME': 'cltbld', 18:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:11 INFO - 'MOZ_NO_REMOTE': '1', 18:50:11 INFO - 'NO_EM_RESTART': '1', 18:50:11 INFO - 'PAGER': '/bin/cat', 18:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:11 INFO - 'PWD': '/builds/slave/test', 18:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:11 INFO - 'SHELL': '/bin/bash', 18:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:11 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:11 INFO - 'USER': 'cltbld', 18:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:11 INFO - 'XPC_FLAGS': '0x0', 18:50:11 INFO - 'XPC_SERVICE_NAME': '0', 18:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:50:11 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 18:50:11 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 18:50:11 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 18:50:11 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 18:50:11 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 18:50:11 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 18:50:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:50:14 INFO - Installing collected packages: mozsystemmonitor 18:50:14 INFO - Running setup.py install for mozsystemmonitor 18:50:14 INFO - Successfully installed mozsystemmonitor 18:50:14 INFO - Cleaning up... 18:50:14 INFO - Return code: 0 18:50:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:14 INFO - 'HOME': '/Users/cltbld', 18:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:14 INFO - 'LOGNAME': 'cltbld', 18:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:14 INFO - 'MOZ_NO_REMOTE': '1', 18:50:14 INFO - 'NO_EM_RESTART': '1', 18:50:14 INFO - 'PAGER': '/bin/cat', 18:50:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:14 INFO - 'PWD': '/builds/slave/test', 18:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:14 INFO - 'SHELL': '/bin/bash', 18:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:14 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:14 INFO - 'USER': 'cltbld', 18:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:14 INFO - 'XPC_FLAGS': '0x0', 18:50:14 INFO - 'XPC_SERVICE_NAME': '0', 18:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:50:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:17 INFO - Downloading functools32-3.2.3-2.tar.gz 18:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:50:17 INFO - warning: no files found matching '*.txt' 18:50:17 INFO - no previously-included directories found matching 'build' 18:50:17 INFO - no previously-included directories found matching 'dist' 18:50:17 INFO - no previously-included directories found matching '.git*' 18:50:17 INFO - Installing collected packages: jsonschema, functools32 18:50:17 INFO - Running setup.py install for functools32 18:50:17 INFO - warning: no files found matching '*.txt' 18:50:17 INFO - no previously-included directories found matching 'build' 18:50:17 INFO - no previously-included directories found matching 'dist' 18:50:17 INFO - no previously-included directories found matching '.git*' 18:50:17 INFO - Successfully installed jsonschema functools32 18:50:17 INFO - Cleaning up... 18:50:17 INFO - Return code: 0 18:50:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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', '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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:50: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 functools32==3.2.3-2 18:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:17 INFO - 'HOME': '/Users/cltbld', 18:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:17 INFO - 'LOGNAME': 'cltbld', 18:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:17 INFO - 'MOZ_NO_REMOTE': '1', 18:50:17 INFO - 'NO_EM_RESTART': '1', 18:50:17 INFO - 'PAGER': '/bin/cat', 18:50:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:17 INFO - 'PWD': '/builds/slave/test', 18:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:17 INFO - 'SHELL': '/bin/bash', 18:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:17 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:17 INFO - 'USER': 'cltbld', 18:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:17 INFO - 'XPC_FLAGS': '0x0', 18:50:17 INFO - 'XPC_SERVICE_NAME': '0', 18:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:50:18 INFO - Cleaning up... 18:50:18 INFO - Return code: 0 18:50:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:18 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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:18 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 18:50:18 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 18:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:18 INFO - 'HOME': '/Users/cltbld', 18:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:18 INFO - 'LOGNAME': 'cltbld', 18:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:18 INFO - 'MOZ_NO_REMOTE': '1', 18:50:18 INFO - 'NO_EM_RESTART': '1', 18:50:18 INFO - 'PAGER': '/bin/cat', 18:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:18 INFO - 'PWD': '/builds/slave/test', 18:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:18 INFO - 'SHELL': '/bin/bash', 18:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:18 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:18 INFO - 'USER': 'cltbld', 18:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:18 INFO - 'XPC_FLAGS': '0x0', 18:50:18 INFO - 'XPC_SERVICE_NAME': '0', 18:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:18 INFO - Downloading/unpacking blobuploader==1.2.4 18:50:18 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 18:50:18 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 18:50:18 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 18:50:18 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 18:50:18 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 18:50:18 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 18:50:20 INFO - Downloading blobuploader-1.2.4.tar.gz 18:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:50:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:50:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:22 INFO - Downloading docopt-0.6.1.tar.gz 18:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:50:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:50:22 INFO - Running setup.py install for blobuploader 18:50:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:50:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:50:22 INFO - Running setup.py install for requests 18:50:22 INFO - Running setup.py install for docopt 18:50:22 INFO - Successfully installed blobuploader requests docopt 18:50:22 INFO - Cleaning up... 18:50:23 INFO - Return code: 0 18:50:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:23 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')]} 18:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:23 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')]} 18:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:23 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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:23 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 18:50:23 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 18:50:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:23 INFO - 'HOME': '/Users/cltbld', 18:50:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:23 INFO - 'LOGNAME': 'cltbld', 18:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:23 INFO - 'MOZ_NO_REMOTE': '1', 18:50:23 INFO - 'NO_EM_RESTART': '1', 18:50:23 INFO - 'PAGER': '/bin/cat', 18:50:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:23 INFO - 'PWD': '/builds/slave/test', 18:50:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:23 INFO - 'SHELL': '/bin/bash', 18:50:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:23 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:23 INFO - 'USER': 'cltbld', 18:50:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:23 INFO - 'XPC_FLAGS': '0x0', 18:50:23 INFO - 'XPC_SERVICE_NAME': '0', 18:50:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:23 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-7zg0lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:23 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-sYXX37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:23 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-0ZcaWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:23 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ZcQbVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:23 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-V6P8aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:23 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-qPWpIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:23 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-7wvcDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-5uPPle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-W1rLsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-xKCci9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-MhBkzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-4gKo9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-PfN0tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-5ThEo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-sYLPkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-U7f4PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:24 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-zyfr0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:50:25 INFO - Running setup.py install for manifestparser 18:50:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozcrash 18:50:25 INFO - Running setup.py install for mozdebug 18:50:25 INFO - Running setup.py install for mozdevice 18:50:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozfile 18:50:25 INFO - Running setup.py install for mozhttpd 18:50:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:50:25 INFO - Running setup.py install for mozinfo 18:50:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Running setup.py install for mozInstall 18:50:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Running setup.py install for mozleak 18:50:26 INFO - Running setup.py install for mozlog 18:50:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Running setup.py install for moznetwork 18:50:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:50:26 INFO - Running setup.py install for mozprocess 18:50:26 INFO - Running setup.py install for mozprofile 18:50:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:50:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:50:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:50:27 INFO - Running setup.py install for mozrunner 18:50:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:50:27 INFO - Running setup.py install for mozscreenshot 18:50:27 INFO - Running setup.py install for moztest 18:50:27 INFO - Running setup.py install for mozversion 18:50:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:50:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:50:27 INFO - Cleaning up... 18:50:27 INFO - Return code: 0 18:50:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:27 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')]} 18:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:27 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')]} 18:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:27 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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:27 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 18:50:27 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 18:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:27 INFO - 'HOME': '/Users/cltbld', 18:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:27 INFO - 'LOGNAME': 'cltbld', 18:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:27 INFO - 'MOZ_NO_REMOTE': '1', 18:50:27 INFO - 'NO_EM_RESTART': '1', 18:50:27 INFO - 'PAGER': '/bin/cat', 18:50:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:27 INFO - 'PWD': '/builds/slave/test', 18:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:27 INFO - 'SHELL': '/bin/bash', 18:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:27 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:27 INFO - 'USER': 'cltbld', 18:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:27 INFO - 'XPC_FLAGS': '0x0', 18:50:27 INFO - 'XPC_SERVICE_NAME': '0', 18:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:27 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-bwZW5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-jLWoH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ry9KPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-1tc7AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-uQdI_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-t2vHzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-btsv5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-yH7oSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-sX6w1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:28 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)) 18:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:28 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-YkHUy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:29 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)) 18:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:29 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-GthamX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:29 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)) 18:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:29 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ZFu3pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:29 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)) 18:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:29 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-P6whSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:29 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)) 18:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:29 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ogbNqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:29 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)) 18:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:29 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-XDOzZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:29 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)) 18:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:29 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-U9sl7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:29 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)) 18:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:29 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-LTE_uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:50:29 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 18:50:29 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 18:50:29 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 18:50:29 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 18:50:29 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 18:50:29 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 18:50:32 INFO - Downloading blessings-1.6.tar.gz 18:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:50:32 INFO - Installing collected packages: blessings 18:50:32 INFO - Running setup.py install for blessings 18:50:32 INFO - Successfully installed blessings 18:50:32 INFO - Cleaning up... 18:50:32 INFO - Return code: 0 18:50:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:50:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:32 INFO - Reading from file tmpfile_stdout 18:50:32 INFO - Current package versions: 18:50:32 INFO - blessings == 1.6 18:50:32 INFO - blobuploader == 1.2.4 18:50:32 INFO - docopt == 0.6.1 18:50:32 INFO - functools32 == 3.2.3-2 18:50:32 INFO - jsonschema == 2.5.1 18:50:32 INFO - manifestparser == 1.1 18:50:32 INFO - mozInstall == 1.12 18:50:32 INFO - mozcrash == 0.17 18:50:32 INFO - mozdebug == 0.1 18:50:32 INFO - mozdevice == 0.48 18:50:32 INFO - mozfile == 1.2 18:50:32 INFO - mozhttpd == 0.7 18:50:32 INFO - mozinfo == 0.9 18:50:32 INFO - mozleak == 0.1 18:50:32 INFO - mozlog == 3.4 18:50:32 INFO - moznetwork == 0.27 18:50:32 INFO - mozprocess == 0.23 18:50:32 INFO - mozprofile == 0.28 18:50:32 INFO - mozrunner == 6.12 18:50:32 INFO - mozscreenshot == 0.1 18:50:32 INFO - mozsystemmonitor == 0.3 18:50:32 INFO - moztest == 0.7 18:50:32 INFO - mozversion == 1.4 18:50:32 INFO - psutil == 3.1.1 18:50:32 INFO - requests == 1.2.3 18:50:32 INFO - wsgiref == 0.1.2 18:50:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:32 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')]} 18:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:32 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')]} 18:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:32 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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:32 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 18:50:32 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 18:50:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:32 INFO - 'HOME': '/Users/cltbld', 18:50:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:32 INFO - 'LOGNAME': 'cltbld', 18:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:32 INFO - 'MOZ_NO_REMOTE': '1', 18:50:32 INFO - 'NO_EM_RESTART': '1', 18:50:32 INFO - 'PAGER': '/bin/cat', 18:50:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:32 INFO - 'PWD': '/builds/slave/test', 18:50:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:32 INFO - 'SHELL': '/bin/bash', 18:50:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:32 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:32 INFO - 'USER': 'cltbld', 18:50:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:32 INFO - 'XPC_FLAGS': '0x0', 18:50:32 INFO - 'XPC_SERVICE_NAME': '0', 18:50:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 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)) 18:50:33 INFO - Cleaning up... 18:50:33 INFO - Return code: 0 18:50:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:33 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 0x10526e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93b256a260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, '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.e0nybacOIK/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.wLBAyR0LBi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 18:50:33 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 18:50:33 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 18:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:33 INFO - 'HOME': '/Users/cltbld', 18:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:33 INFO - 'LOGNAME': 'cltbld', 18:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:33 INFO - 'MOZ_NO_REMOTE': '1', 18:50:33 INFO - 'NO_EM_RESTART': '1', 18:50:33 INFO - 'PAGER': '/bin/cat', 18:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:33 INFO - 'PWD': '/builds/slave/test', 18:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:33 INFO - 'SHELL': '/bin/bash', 18:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:50:33 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:33 INFO - 'USER': 'cltbld', 18:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:33 INFO - 'XPC_FLAGS': '0x0', 18:50:33 INFO - 'XPC_SERVICE_NAME': '0', 18:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:50:33 INFO - Cleaning up... 18:50:33 INFO - Return code: 0 18:50:33 INFO - Running post-action listener: _resource_record_post_action 18:50:33 INFO - Running post-action listener: _start_resource_monitoring 18:50:33 INFO - Starting resource monitoring. 18:50:33 INFO - [mozharness: 2016-10-07 01:50:33.359152Z] Finished create-virtualenv step (success) 18:50:33 INFO - [mozharness: 2016-10-07 01:50:33.359986Z] Running install step. 18:50:33 INFO - Running pre-action listener: _resource_record_pre_action 18:50:33 INFO - Running main action method: install 18:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:33 INFO - Reading from file tmpfile_stdout 18:50:33 INFO - Detecting whether we're running mozinstall >=1.0... 18:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:50:33 INFO - Reading from file tmpfile_stdout 18:50:33 INFO - Output received: 18:50:33 INFO - Usage: mozinstall [options] installer 18:50:33 INFO - Options: 18:50:33 INFO - -h, --help show this help message and exit 18:50:33 INFO - -d DEST, --destination=DEST 18:50:33 INFO - Directory to install application into. [default: 18:50:33 INFO - "/builds/slave/test"] 18:50:33 INFO - --app=APP Application being installed. [default: firefox] 18:50:33 INFO - mkdir: /builds/slave/test/build/application 18:50:33 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'] 18:50:33 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 18:51:08 INFO - Reading from file tmpfile_stdout 18:51:08 INFO - Output received: 18:51:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:51:08 INFO - Running post-action listener: _resource_record_post_action 18:51:08 INFO - [mozharness: 2016-10-07 01:51:08.432782Z] Finished install step (success) 18:51:08 INFO - [mozharness: 2016-10-07 01:51:08.432908Z] Running run-tests step. 18:51:08 INFO - Running pre-action listener: _resource_record_pre_action 18:51:08 INFO - Running main action method: run_tests 18:51:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:08 INFO - 2016-10-06 18:51:08.447 screenresolution[1934:14727] starting screenresolution argv=screenresolution get 18:51:08 INFO - 2016-10-06 18:51:08.450 screenresolution[1934:14727] Display 0: 1600x1200x32@60 18:51:08 INFO - 2016-10-06 18:51:08.456 screenresolution[1935:14729] starting screenresolution argv=screenresolution list 18:51:08 INFO - Available Modes on Display 0 18:51:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:08 INFO - Intel Iris: 18:51:08 INFO - Chipset Model: Intel Iris 18:51:08 INFO - Type: GPU 18:51:08 INFO - Bus: Built-In 18:51:08 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:08 INFO - Vendor: Intel (0x8086) 18:51:08 INFO - Device ID: 0x0a2e 18:51:08 INFO - Revision ID: 0x0009 18:51:08 INFO - Displays: 18:51:08 INFO - Display: 18:51:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:08 INFO - Display Serial Number: 1600x1200 60 18:51:08 INFO - Main Display: Yes 18:51:08 INFO - Mirror: Off 18:51:08 INFO - Online: Yes 18:51:08 INFO - Rotation: Supported 18:51:08 INFO - Return code: 0 18:51:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:51:08 INFO - Python 2.7.3 18:51:08 INFO - Return code: 0 18:51:08 INFO - grabbing minidump binary from tooltool 18:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:08 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 0x105082d30>, '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 0x104ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10507ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:51:08 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 18:51:08 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 18:51:08 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 18:51:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:51:08 INFO - Return code: 0 18:51:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:51:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:51:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:51:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:51:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:51:08 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/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 18:51:08 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/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --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 18:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e0nybacOIK/Render', 18:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:08 INFO - 'HOME': '/Users/cltbld', 18:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:08 INFO - 'LOGNAME': 'cltbld', 18:51:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:51:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:08 INFO - 'MOZ_NO_REMOTE': '1', 18:51:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:51:08 INFO - 'NO_EM_RESTART': '1', 18:51:08 INFO - 'PAGER': '/bin/cat', 18:51:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:08 INFO - 'PWD': '/builds/slave/test', 18:51:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:08 INFO - 'SHELL': '/bin/bash', 18:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wLBAyR0LBi/Listeners', 18:51:08 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 18:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:08 INFO - 'USER': 'cltbld', 18:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:08 INFO - 'XPC_FLAGS': '0x0', 18:51:08 INFO - 'XPC_SERVICE_NAME': '0', 18:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:08 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/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 18:51:09 INFO - mozversion application_buildid: 20161006171100 18:51:09 INFO - mozversion application_changeset: a5510966f80b9b2f5abf59ab32cf4c92d66c60de 18:51:09 INFO - mozversion application_display_name: Nightly 18:51:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:51:09 INFO - mozversion application_name: Firefox 18:51:09 INFO - mozversion application_remotingname: firefox 18:51:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:51:09 INFO - mozversion application_vendor: Mozilla 18:51:09 INFO - mozversion application_version: 52.0a1 18:51:09 INFO - mozversion platform_buildid: 20161006171100 18:51:09 INFO - mozversion platform_changeset: a5510966f80b9b2f5abf59ab32cf4c92d66c60de 18:51:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:51:09 INFO - mozversion platform_version: 52.0a1 18:51:09 INFO - using testdate: 1475805069 18:51:09 INFO - actual date: 1475805069 18:51:09 INFO - starting webserver on 'localhost:51550' 18:51:09 INFO - SUITE-START | Running 2 tests 18:51:09 INFO - TEST-START | dromaeo_css 18:51:09 INFO - operating with platform_type : mac_ 18:51:09 INFO - Initialising browser for dromaeo_css test... 18:51:09 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpY8CMLD/profile http://localhost:51550/getInfo.html) 18:51:11 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 18:51:11 INFO - PROCESS | 1945 | colorDepth:24 18:51:11 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 18:51:11 INFO - PROCESS | 1945 | __metrics 18:51:11 INFO - PROCESS | 1945 | 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" 18:51:11 INFO - PROCESS | 1945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:51:12 INFO - TEST-INFO | 1945: exit 0 18:51:12 INFO - Browser initialized. 18:51:12 INFO - Running cycle 1/1 for dromaeo_css test... 18:51:12 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpY8CMLD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:24 INFO - PROCESS | 1947 | RSS: Main: 236122112 18:51:24 INFO - PROCESS | 1947 | 18:52:15 INFO - PROCESS | 1947 | 1475805135168 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] 18:54:29 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:51550/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51550/tests/dromaeo/cssquery-ext.html) 18:54:30 INFO - PROCESS | 1947 | RSS: Main: 370352128 18:54:30 INFO - PROCESS | 1947 | 18:57:33 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:51550/tests/dromaeo/cssquery-ext.html (next: http://localhost:51550/tests/dromaeo/cssquery-jquery.html) 18:57:34 INFO - PROCESS | 1947 | RSS: Main: 368861184 18:57:34 INFO - PROCESS | 1947 | 19:00:36 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:51550/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51550/tests/dromaeo/cssquery-mootools.html) 19:00:37 INFO - PROCESS | 1947 | RSS: Main: 361406464 19:00:37 INFO - PROCESS | 1947 | 19:03:39 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:51550/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51550/tests/dromaeo/cssquery-prototype.html) 19:03:39 INFO - PROCESS | 1947 | RSS: Main: 339296256 19:03:39 INFO - PROCESS | 1947 | 19:06:43 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:51550/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51550/tests/dromaeo/cssquery-yui.html) 19:06:44 INFO - PROCESS | 1947 | RSS: Main: 327151616 19:06:44 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:51550/tests/dromaeo/cssquery-yui.html (next: http://localhost:51550/tests/dromaeo/cssquery-dojo.html) 19:09:47 INFO - PROCESS | 1947 | RSS: Main: 410587136 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | __start_tp_report 19:09:47 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 19:09:47 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 19:09:47 INFO - PROCESS | 1947 | |i|pagename|runs| 19:09:47 INFO - PROCESS | 1947 | |0;dojo.html;3328.9167770805734;3339.9666003339958;3341.983290083549;3372.0726800129946;3382.0868365541305;5592.972035139818;5712.514436272917;5714.342850572186;5819.010768169416;5840.386759390261;5694.77220911163;5706.087026075828;5806.82579522615;5806.941930580693;5830.06718924971;5122.052420302256;5137.588992880561;5167.9224811627855;5196.792128314863;5271.4464981177;5290.497402746752;5290.761915713783;5298.23175639532;5301.9396120776;5340.012097761926;5241.475852414766;5262.500062494057;5272.683638981654;5302.814401495948;5336.279602253704;5144.279800827887;5195.064888320101;5199.766010529535;5248.0553500369915;5248.71132087735;5159.793608255703;5162.896742065138;5199.012187684328;5205.791768329263;5227.764750586232;5636.210930469738;5647.181158732002;5783.5084017858535;5783.5951483396175;5783.942160578383;6169.383061693839;6227.190465239535;6273.749050037993;6292.4966002719675;6298.401651843067;6278.215223097113;6280.905786413207;6326.145970294044;6345;6351.555391122623;5653;5710.600257981901;5713.228714123623;5722.055860783007;5759.625624334405;6241.095041218998;6293.496520278367;6295.653739044396;6307.716152773044;6311.305756366796;5819.82540523785;6124.387561243929;6157.7229024694;6190.473809726133;6200.751969921243;6037.667928263988;6108.297545782203;6123.9387606124255;6135.7839197735275;6138.296437970319;6131.044463296589;6208.534359923024;6208.906866397007;6234.251889773256;6251.374862513712;6154.661493617805;6264.154339164245;6275.121482992385;6281.3404592518045;6301.684915754194;4203.747775133502;4735.739534325645;4938.827141050046;4939.209726443752;4986.750662466862;4257.1698518788535;4343.52221255668;4372.125574885035;4434.312681534368;4439.533848945879;5816;5820.854478637983;5821.010428227211;5830.533557315404;5855.209546711225;6233.283172435228;6297.149884765589;6306.527010474233;6314.431701146918;6319;5649.322081350264;5720.971395143081;5736.024875771045;5790.652560846363;5808.970955145282;5398.46015398457;5434.021876062347;5435.537979271806;5436.293281873332;5441.102218134043;6239.937600624117;6259.718312675849;6264.718087686065;6293.590916590407;6318.273398559225;6255.530835187288;6266.843328916813;6311.810645680637;6316.431521163117;6332.493400527855;6344;6361;6365.809025729235;6375.203099612549;6379.106925030592;6078.088286757022;6096.254562767794;6112.229929638781;6140.815775526741;6192.783252586138;5162.561182299547;6287.46556542699;6293.307736149111;6305.495560355069;6323.936760632335;6118.174046503843;6149.661768602591;6162.26052873658;6178.721957511832;6179.598326108789;5849.532037436909;5930.11048342752;6122.969385153046;6152.446279834658;6154.876902462015;5831.825045248649;5891.558133139946;5929.9110513341475;5937.821865344046;6024.789132380346;5029.949700502948;6153.661548614869;6156.015037593964;6168.414000669929;6169.81490555284;5189.429162792166;5363.222332761806;5972.13404056418;5995.190649262294;6008.939910600838 19:09:47 INFO - PROCESS | 1947 | |1;ext.html;456.5024123705161;462.90279041401294;464.81872069892745;485.68187836966797;537.1727539589033;30182.09453716389;39383.0154246144;40394;40581.99999999993;40797.18405631893;41647.583524164824;42015.949601259985;42093.36859947103;42102.15795684084;42150.57849421505;9694.66068687596;9872.506374681238;9887.901120988807;9889.406635601887;9897.802043959116;9755.268354873377;9862.50687465624;9863.654772082979;9866.506674666274;9878.506074696272;8490.641497360424;9787.755306117333;9787.951060244688;9900.25748068894;9928.354656947311;9763.902360976406;9829.508524573743;9830.606775728962;9830.803383932282;9844.556994935245;9624.95187524065;9687.41875487473;9696.46669433181;9696.612135514571;9703.854442183372;39552.80223598892;39807.8009609953;39829.80085099556;39896;39940.20119597592;3263.885763998249;3319.2531680371962;3426.1605906552804;3494.912627184315;3571.6964058055096;30133.849330753426;30833.920812771445;31380.529292060637;31484.055478335686;31623.36753264945;3176.428242916274;3245.415825151472;3271.574695289597;3387.7797943133864;3389.57630296213;468713;474010;474504;475143.62428187986;475606;32417;56152.71923640356;56476.152857707166;56500;56564;33086.83456582702;35003;35056.29887402289;35077.47383789245;35089.824550877085;14312.57062288133;14437.278136093153;14464.638384040483;14478.420863165566;14483.275836208359;12257.509699611915;12374.010079193822;12376.876231237753;12383.318917459446;12403.441845116991;7671.194524574951;7717.961410192913;7767.883481747778;7782.338501227459;7783.4162437817395;3165.113768144923;3208.1658768719835;3208.566843476101;3210.5184222366834;3244.221386867182;880.5465185429509;906.2387594420718;922.864876202275;1071.4000159910474;1118.5022664914197;29317.706822931923;29545.704542954725;29765.702342976725;29781.172605133128;29965.550516742267;1035.9015893490107;1084.69628504019;1097.13874608432;1098.7088421568292;1119.339589642115;13924.930375348058;14634;15166.696666066617;15300.846991530165;15646.061236325857;656740;661968;662485;662558;664170;55848.72075639596;56265.71867140638;56296.718516407156;56365.436345636015;56366;1321.7224382879704;1368.6920442900268;1373.6909195430949;1384.9861501384858;1385.7852032934911;28056.43887122287;28870.42259154763;28925.42149156963;29529.557056643738;29770;47992.80017999438;48279.75860120677;48298.51701483081;48361.03277934492;48426.757866211854;552485;553584;554789;554988;555705;25604.23187304384;25891;25938.35154121162;25999.870000649877;26001.95992160368;45808;46177.538224617325;46621;46694.76652616715;46892.29661555147;32219.677803221668;37939.241215176095;38760;38834;39101;36713.44929826001;36934.261314773015;37576;38277;38412.42381364338;32208.677913220567;32635.857744978814;36152;36664.81667591645;37607.2478550422;31101.844490777403;31888.5216721754;34255;34503.30993380068;34592.65407345894;25025.374365641004;25197.622035669847;25294.620580691673;25395.74604254008;25815.255423373288 19:09:47 INFO - PROCESS | 1947 | |2;jquery.html;346.63083815736223;366.50338790938275;366.8037599884063;374.5337055366069;395.4147861165475;14964;15098.924505377472;16039.711859068891;20324.695129573032;20908.477288067807;19345.322913698023;20025.99870006501;20465.488362790937;20505.897470512664;20669.793302067013;5364.222187782789;5845.06478963367;6135.37412585663;6136.171616831737;6145.5390845686525;5976.581639285252;6010.489108425789;6041.124037014631;6063.4239747224165;6094.451499365056;5641.5204707599905;5955.166276721241;6001.849953751169;6010.729517171716;6012.398760123996;5775.306963164448;5808.954388210121;5883;5888.617239879415;5892.96873047215;4461.286194208911;5090.363704536933;5140.948590514122;5146.228065790161;5480.068388373986;12510.18683785551;12554.623361299084;12561.806628370381;12729.936350318281;12737.044721645821;2206.4042708468783;2220.9888950555305;2230.208276061991;2292.209187830196;2331.6852224949585;9550.37922535033;9625.278104142148;9660.565274562661;9973.052560006789;10258.743531411774;1821.8360347568782;1843.0508288231572;1861.4415675297491;1884.302807961063;1937.7190307405488;118863;128845;129444.35277823645;129877.35061324727;130166.3491682545;8677.479351238946;8756.605952732143;11365.69294531123;11382.54469821198;11558.364289963965;14323.14061156334;14344.067635603653;14347.426102955766;14355;14370.568882933529;8226.629801658939;8415.158484151658;8453.239208471266;8472.661093556311;8567.485950842845;8357.791055223668;8397;8523.403361764616;8531.701390451304;8567.443116197428;4399.64802815774;4459.732416055047;4512.52618475062;4547.931781023287;4562.270036794097;1730.3251731824598;1827.5522496988058;1902.335456475584;1902.6099649571804;1919.64486569985;761.5240474703311;778.1323823936383;896.950667713269;958.7746879483316;974.5858010345574;17984.460466186036;20644.277450289468;20648.896755516125;20754.688679669816;20825.583488330147;902.4134312696668;927.7216834949488;932.1517419148543;934.761635782871;1012.2921185828028;9091.727248182566;9405.341626086245;10009.549570269355;10593.993570610779;10785.220438627539;565981;576890;582183;584862;585033;72843.27156728471;90261.54869225743;97350;100189;108621;872.4503562755297;915.1031988651159;950.4677380666849;951.757301888028;963.9759006024765;15109.39562417491;17005.91497042507;17981.741278110407;18343.908280458512;18558.7936784114;47355.23928073318;48100;52273.47726522686;52731.73634131805;53010.46989530209;75983.24016759761;76749;77280;77720;79449.60275198588;7832.295093441618;7851.478441061536;8018.759437216893;8043.959780201061;8262.793430164294;11884;12591.811122832982;12614.36928153607;12773.042021848212;13040.608781736562;10663.306885052758;10669.626563070255;10964.890351096386;11117.666470005914;11201.719957000814;10256.230782691178;10449.9477502612;10675.839862402225;11120;11121;9470.905290947003;10253.794924101625;10739.87231340698;11024.724381890517;11141.16441266892;8094.87857682147;8270;8282.668693252203;8289.792755181168;8432.198941100585;10568.10171135462;11090.944545277222;11207.430959665817;11410.657680269605;11439.885601143882 19:09:47 INFO - PROCESS | 1947 | |3;mootools.html;1310.5020092364903;1511.0329389190913;1663.9168041597918;1821.408042386225;1894.9810501894985;8427.367947403945;8977.461352318865;8980.73057808266;8987.640494380224;8994.32542559309;7848.293653571178;8098.311643510294;8117;8464.492130472176;8684.175003374685;2053.4455696961813;2343.8945247463903;2347.0284960633066;2382.9880850595723;2390.426297688551;1939.534511717192;2357.57563638545;2365.396823809926;2369.9407514812096;2374.7743964323363;2352.2472808701223;2355.8233132515043;2372.6796882420913;2378;2380.75002124777;1995.311617491963;2001.1995201919203;2019.4951262184454;2019.676851703735;2024.7469066366705;2358.775916287967;2358.893849776764;2362.126013375062;2363.2319496163814;2366.1008816649564;8899.110088991114;8982.236509896667;9041.457512549203;9048.321375896834;9058.501782401965;5215.921761173586;5374.247605335257;5398.46015398457;5403.675779453245;5417.106177480711;3445.2592692570965;3555.591107022674;3634.546181527384;3649.6167902370134;3651.8174091295327;1085.180688580117;1098.8406681031286;1106.1758989552834;1113.9777204455866;1120.2830188679252;11724.944754972008;11874.881251187551;11884.821727674178;11885.88114118865;11896.583619573274;4241.172971270573;4487.743431839091;4520.683552151384;4791.760411979387;4836.46798852126;10025.498725063717;10036.297459177933;10044.497775111215;10048.246381521416;10056.64801731936;5324.41431442541;5327.121025030827;5331.44019877915;5337.092694241988;5345.930813837248;4366.104948485553;4407.911841763211;4495.977520112378;4817.494163112893;4888.095702295087;3812.733108682421;3838.5009948707047;3920.2551515212017;3965.72239943207;3967.682585393162;1267.6513958661442;1273.5924504158766;1280.359820089955;1286.4854058376725;1292.2311224821217;814.0044635740413;867.1285358214953;897.6274845938863;912.8356895758827;952.6094301336558;5597.7964737580805;5644.57665675076;5949.9107513387335;5990.101484777319;6053;869.8869147010975;898.9955050224708;911.8814554108056;931.4039015030386;991.8214721350082;3899.8440062397754;3908.8241029153755;3911.6675082618294;4055.4525139105845;4062.898427539276;10786;10999;11108.555657773599;11123.276986995981;11136.832947505794;11042.779144417067;11053.447327633587;11069.169812264112;11074.5570177192;11098.334099954029;5914.733836977346;8145.307648849795;8150.836983260301;8246.463979841292;8254.54599997006;5512.628531496553;5513.972430137824;5881.911771323348;5898.587098903035;6213.37866213375;9221.262299016196;10238;10257.794844103226;10259;10304.227182961458;8634.654613815377;9961.153301969123;10243.590256389662;10343.63797267092;10450.738731531772;5447.400785913625;7278.381337586365;7288.635568221674;7388.593627350548;7599.734009309647;8109.878351824846;8474.1949514796;8485.91514084876;8492.235698787139;8504.44721093127;7618.923810761821;7725.806854828675;7822.4524283299625;7911.604419779103;7916.960415197887;7529.284717951786;7594.468387212842;7607.315341619281;7673.155952845294;7691;6898.413634840894;7052.647367631701;7069.858602828018;7071.717131314896;7073;5067.949320506896;5098.1842905135;5213.40045894727;5231.529162375405;5359.973200133974;4364.781760912006;4959.950400496094;5031.119554078095;5124.1032819257225;5212.582993360598 19:09:47 INFO - PROCESS | 1947 | |4;prototype.html;273.4380847358678;294.7111830406202;304.3836231630947;306.12601024076264;313.1497982976219;4615.676902616814;5099.949000509994;5145.041601079381;5347.41178470368;5364.222187782769;4248.553901840309;4561.266718646918;5037.596992240621;5104.234364845275;5117.488251174881;2993.281612413016;3533.469979503069;3594.5686517617924;4073.755574665515;4079.673626109919;4079.2657321682086;4096.996235922188;4108.815103320343;4113.239050775601;4119.6704263658985;3271.623763267219;3376.9155771105798;3569.3580952761763;3940.7044471664594;4073.777866640011;4012.9197416051516;4018.618231268025;4019.537753158395;4060.8984775380554;4086.3654538184965;3009.458297506448;3517.5226404909745;3560.5193298904574;3572.3034008368377;3575.5888072871694;4877.439094504107;5125.053094470694;5133.230015497668;5178.689278643294;5231.764570594332;3934.960650393488;4643.651726120521;4666.2767271073035;4693.48371679115;4723.551262630044;4851.350540816139;5565.721713914288;5591.217229587861;5596.496315331599;5649.519790817785;3645;3898.9862635714917;3912.845710515376;3920.627540383659;3934.665553427962;4358.869233922987;4376.162011954986;5820.534357251452;5887.528997680175;5896.167491130756;4014.511003178048;4021;4035;4038.273110840018;4061.268971585143;3251.5772949516413;3392.728581713506;4084.571120032413;4094.324436468009;4105.44576482177;3708.85211923731;4014.437978682987;4646.883827904262;4719.882002949954;4732.503087175865;4777.355057067321;4907.33750943618;5536.640118392372;5610.943890561124;5632.408597097327;1197.7305106351;1245.4333278358324;1337.3647517429142;1398.8878841321175;1402.747505449029;699.5278187223604;837.4598384042258;864.9058940440348;928.7120992492349;964.7395203295071;4348.978255108705;4866.7566621668775;5189.299444574934;5243;5277.126620049904;5759.481646651738;5771.027920620883;5803.448672376117;5806.65160090396;5826.067829147316;4110.753354798721;4628.768561571976;4642.328761645805;5131.794028403397;5187.028929007029;2538.7968962482955;2656.9070082547405;2872.1905199724456;2958.1421387797727;2979.703828834464;5367.329083864517;5644.266245388073;5914.99445094335;5924.437178468039;5945.791897283574;5460.761087953999;5823.388544202882;5826.242588463558;5832.329282132524;5856.472917437451;4648.767561621906;5195.246689230041;5335.093034184198;5662.631928924607;5791.797287095016;5494.780208791603;5688.833789073313;5785.718568259374;5852.5317974561085;5871.295444546511;4714.504976977368;4923.89212427201;5650.208970744181;5809.302883653989;5846.503047241032;5697.23087383198;5711;6147.018695932558;6178.567500274938;6186.907196391968;3806.219724956322;3818.8472461102356;3881.7670939743707;3892.3846603659163;3903.0047337928645;5782.826515204551;5812.796552120655;5824.15549745293;5837.854053648693;5845.327787304344;5507.365139008235;5536.979002664079;5650.26546548946;5653.381835625121;5694.551342922583;4282.978585107055;4291.892702682458;5598.244237028112;5641.717914104196;5643.294588176478;5273.841784746463;5366.443731317874;5491.395946445808;5541.473560011793;5546.223528705904;4430.667699922455;5509.724513774376;5629.380768115422;5643.88712225745;5682.857928551819;5290.9735451322495;5555.6666400064505;5564.777408903598;5571.275734154534;5577.358603760619 19:09:47 INFO - PROCESS | 1947 | |5;yui.html;718.8670096032233;719.755283203711;769.5882702754028;796.5260669901414;820.9794755131119;15472.535823925273;15877.444289449872;15893.682126357466;15896.523104306874;15992.440264590741;14449.205293708841;14502.347394367252;14503.274836258197;14508.782368264485;14544.563663090097;672.0993868216589;689.8999645051465;693.6289085339345;824.2046425199682;827.9503229806215;684.4387602166225;723.4827098624509;841.7853447370942;845.1337379186352;845.4673555659956;900.5407242306438;902.3142411767038;902.9277657787394;903.2818908967387;906.6282824042144;829.2619568583965;840.8066144786673;897.4121950122681;899.7525680437866;900.5002223765807;531.4924247343778;548.6324162810927;650.2911826109516;665.5374514712277;671.0504635940139;15087.39650413982;15125.394984200619;15130.092194468258;15135.848641513554;15143.924280378638;13531.458741650322;13885.583432497042;14016.299185040707;14033.78949315761;14299.57101286963;11043.171762117874;12442.191257568229;12703.110782245247;12959.222446653137;13047.86952130476;4513.1650644630845;4519.570640789119;4573.222552166107;4621.907561848778;4760.571548560646;108136.91863081347;109674.90325096727;110020.44989775;110516.1854768154;111632.88367116306;10298.073173414428;10561.524731387106;10928.890711092947;11028.56628638288;11149.554017839195;20481.79518204799;20769.065392057393;20816.167353306002;20819.583608328052;20848.1660733572;7483.438742094365;7820.452568320163;7947.920520794718;7952.125266220711;7961.283484486308;4239.236937351245;4425.446819147606;4450.577195166518;4487.394201782718;4498.527654596221;3305.3058857640167;3379.341028499419;3398.2693720849643;3400.7279417646528;3403.3533628610485;648.6075924065966;653.5490511547113;656.7602824968948;660.385841167709;660.7588230295908;541.2557733116964;598.1745191635603;612.4518555892452;634.7207228819304;636.4590098416402;7792.805179870548;8921.197092261727;10150;10159.898401015895;10305.278630495943;623.9875202495924;634.6826586706646;657.6284399314372;675.5743881354715;690.775497963164;3646.252518233756;4430.556944305608;4466.285394336891;4518.254488009507;4627.722336659811;90425.54787226154;113388;149551.75672364925;157288;163873;88225.11774882297;123154;125202.37398812948;128238.35880820536;128827;115117;117487;120884;122216;127423.36288318684;7658.8085297868;8275.54484503334;8677.783055423664;8741.475511469333;8877.511736854534;48501.5149848497;65943.77871429936;66986.66506667435;67235.65528689302;67424.6628766853;92889.5355523218;101191;103854.48072759587;105115.47442262739;105824.47087764512;10306.690799276033;11981.161318707955;12074.637760867188;12107;12405.069619778733;9928.751781205528;12911.096223264656;13099.934500327437;13166.234371667928;13610.795838062239;11991.940040299743;12110.273383597012;12132.332721700392;12223.388830558259;12286.508539658313;11973.580924667594;12037.819432708342;12342.074344424025;12672.936635316764;12794;12018.939905300418;12054.337011464453;12140.271583705005;12415.193012454161;12621.74756504883;9979.700608981742;10174.263336811053;10335.328203666737;10362.378257304586;10709.143268538654;10461.215408844519;10712.946435267773;10735.355878647306;10739.704118352409;11006.229563930769 19:09:47 INFO - PROCESS | 1947 | __end_tp_report 19:09:47 INFO - PROCESS | 1947 | __start_cc_report 19:09:47 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1364 19:09:47 INFO - PROCESS | 1947 | __end_cc_report 19:09:47 INFO - PROCESS | 1947 | __startTimestamp1475806187695__endTimestamp 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | ------- Summary: start ------- 19:09:47 INFO - PROCESS | 1947 | Number of tests: 6 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5736.74 Median:5891.56 stddev:657.69 (11.2%) stddev-sans-first:632.01 19:09:47 INFO - PROCESS | 1947 | Values: 3328.9 3340.0 3342.0 3372.1 3382.1 5593.0 5712.5 5714.3 5819.0 5840.4 5694.8 5706.1 5806.8 5806.9 5830.1 5122.1 5137.6 5167.9 5196.8 5271.4 5290.5 5290.8 5298.2 5301.9 5340.0 5241.5 5262.5 5272.7 5302.8 5336.3 5144.3 5195.1 5199.8 5248.1 5248.7 5159.8 5162.9 5199.0 5205.8 5227.8 5636.2 5647.2 5783.5 5783.6 5783.9 6169.4 6227.2 6273.7 6292.5 6298.4 6278.2 6280.9 6326.1 6345.0 6351.6 5653.0 5710.6 5713.2 5722.1 5759.6 6241.1 6293.5 6295.7 6307.7 6311.3 5819.8 6124.4 6157.7 6190.5 6200.8 6037.7 6108.3 6123.9 6135.8 6138.3 6131.0 6208.5 6208.9 6234.3 6251.4 6154.7 6264.2 6275.1 6281.3 6301.7 4203.7 4735.7 4938.8 4939.2 4986.8 4257.2 4343.5 4372.1 4434.3 4439.5 5816.0 5820.9 5821.0 5830.5 5855.2 6233.3 6297.1 6306.5 6314.4 6319.0 5649.3 5721.0 5736.0 5790.7 5809.0 5398.5 5434.0 5435.5 5436.3 5441.1 6239.9 6259.7 6264.7 6293.6 6318.3 6255.5 6266.8 6311.8 6316.4 6332.5 6344.0 6361.0 6365.8 6375.2 6379.1 6078.1 6096.3 6112.2 6140.8 6192.8 5162.6 6287.5 6293.3 6305.5 6323.9 6118.2 6149.7 6162.3 6178.7 6179.6 5849.5 5930.1 6123.0 6152.4 6154.9 5831.8 5891.6 5929.9 5937.8 6024.8 5029.9 6153.7 6156.0 6168.4 6169.8 5189.4 5363.2 5972.1 5995.2 6008.9 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:67865.92 Median:38586.21 stddev:152283.29 (394.7%) stddev-sans-first:152626.38 19:09:47 INFO - PROCESS | 1947 | Values: 456.5 462.9 464.8 485.7 537.2 30182.1 39383.0 40394.0 40582.0 40797.2 41647.6 42015.9 42093.4 42102.2 42150.6 9694.7 9872.5 9887.9 9889.4 9897.8 9755.3 9862.5 9863.7 9866.5 9878.5 8490.6 9787.8 9788.0 9900.3 9928.4 9763.9 9829.5 9830.6 9830.8 9844.6 9625.0 9687.4 9696.5 9696.6 9703.9 39552.8 39807.8 39829.8 39896.0 39940.2 3263.9 3319.3 3426.2 3494.9 3571.7 30133.8 30833.9 31380.5 31484.1 31623.4 3176.4 3245.4 3271.6 3387.8 3389.6 468713.0 474010.0 474504.0 475143.6 475606.0 32417.0 56152.7 56476.2 56500.0 56564.0 33086.8 35003.0 35056.3 35077.5 35089.8 14312.6 14437.3 14464.6 14478.4 14483.3 12257.5 12374.0 12376.9 12383.3 12403.4 7671.2 7718.0 7767.9 7782.3 7783.4 3165.1 3208.2 3208.6 3210.5 3244.2 880.5 906.2 922.9 1071.4 1118.5 29317.7 29545.7 29765.7 29781.2 29965.6 1035.9 1084.7 1097.1 1098.7 1119.3 13924.9 14634.0 15166.7 15300.8 15646.1 656740.0 661968.0 662485.0 662558.0 664170.0 55848.7 56265.7 56296.7 56365.4 56366.0 1321.7 1368.7 1373.7 1385.0 1385.8 28056.4 28870.4 28925.4 29529.6 29770.0 47992.8 48279.8 48298.5 48361.0 48426.8 552485.0 553584.0 554789.0 554988.0 555705.0 25604.2 25891.0 25938.4 25999.9 26002.0 45808.0 46177.5 46621.0 46694.8 46892.3 32219.7 37939.2 38760.0 38834.0 39101.0 36713.4 36934.3 37576.0 38277.0 38412.4 32208.7 32635.9 36152.0 36664.8 37607.2 31101.8 31888.5 34255.0 34503.3 34592.7 25025.4 25197.6 25294.6 25395.7 25815.3 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:33117.55 Median:4460.51 stddev:96414.94 (2161.5%) stddev-sans-first:96654.01 19:09:47 INFO - PROCESS | 1947 | Values: 346.6 366.5 366.8 374.5 395.4 14964.0 15098.9 16039.7 20324.7 20908.5 19345.3 20026.0 20465.5 20505.9 20669.8 5364.2 5845.1 6135.4 6136.2 6145.5 5976.6 6010.5 6041.1 6063.4 6094.5 5641.5 5955.2 6001.8 6010.7 6012.4 5775.3 5809.0 5883.0 5888.6 5893.0 4461.3 5090.4 5140.9 5146.2 5480.1 12510.2 12554.6 12561.8 12729.9 12737.0 2206.4 2221.0 2230.2 2292.2 2331.7 9550.4 9625.3 9660.6 9973.1 10258.7 1821.8 1843.1 1861.4 1884.3 1937.7 118863.0 128845.0 129444.4 129877.4 130166.3 8677.5 8756.6 11365.7 11382.5 11558.4 14323.1 14344.1 14347.4 14355.0 14370.6 8226.6 8415.2 8453.2 8472.7 8567.5 8357.8 8397.0 8523.4 8531.7 8567.4 4399.6 4459.7 4512.5 4547.9 4562.3 1730.3 1827.6 1902.3 1902.6 1919.6 761.5 778.1 897.0 958.8 974.6 17984.5 20644.3 20648.9 20754.7 20825.6 902.4 927.7 932.2 934.8 1012.3 9091.7 9405.3 10009.5 10594.0 10785.2 565981.0 576890.0 582183.0 584862.0 585033.0 72843.3 90261.5 97350.0 100189.0 108621.0 872.5 915.1 950.5 951.8 964.0 15109.4 17005.9 17981.7 18343.9 18558.8 47355.2 48100.0 52273.5 52731.7 53010.5 75983.2 76749.0 77280.0 77720.0 79449.6 7832.3 7851.5 8018.8 8044.0 8262.8 11884.0 12591.8 12614.4 12773.0 13040.6 10663.3 10669.6 10964.9 11117.7 11201.7 10256.2 10449.9 10675.8 11120.0 11121.0 9470.9 10253.8 10739.9 11024.7 11141.2 8094.9 8270.0 8282.7 8289.8 8432.2 10568.1 11090.9 11207.4 11410.7 11439.9 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5721.50 Median:4826.98 stddev:3260.20 (67.5%) stddev-sans-first:3252.49 19:09:47 INFO - PROCESS | 1947 | Values: 1310.5 1511.0 1663.9 1821.4 1895.0 8427.4 8977.5 8980.7 8987.6 8994.3 7848.3 8098.3 8117.0 8464.5 8684.2 2053.4 2343.9 2347.0 2383.0 2390.4 1939.5 2357.6 2365.4 2369.9 2374.8 2352.2 2355.8 2372.7 2378.0 2380.8 1995.3 2001.2 2019.5 2019.7 2024.7 2358.8 2358.9 2362.1 2363.2 2366.1 8899.1 8982.2 9041.5 9048.3 9058.5 5215.9 5374.2 5398.5 5403.7 5417.1 3445.3 3555.6 3634.5 3649.6 3651.8 1085.2 1098.8 1106.2 1114.0 1120.3 11724.9 11874.9 11884.8 11885.9 11896.6 4241.2 4487.7 4520.7 4791.8 4836.5 10025.5 10036.3 10044.5 10048.2 10056.6 5324.4 5327.1 5331.4 5337.1 5345.9 4366.1 4407.9 4496.0 4817.5 4888.1 3812.7 3838.5 3920.3 3965.7 3967.7 1267.7 1273.6 1280.4 1286.5 1292.2 814.0 867.1 897.6 912.8 952.6 5597.8 5644.6 5949.9 5990.1 6053.0 869.9 899.0 911.9 931.4 991.8 3899.8 3908.8 3911.7 4055.5 4062.9 10786.0 10999.0 11108.6 11123.3 11136.8 11042.8 11053.4 11069.2 11074.6 11098.3 5914.7 8145.3 8150.8 8246.5 8254.5 5512.6 5514.0 5881.9 5898.6 6213.4 9221.3 10238.0 10257.8 10259.0 10304.2 8634.7 9961.2 10243.6 10343.6 10450.7 5447.4 7278.4 7288.6 7388.6 7599.7 8109.9 8474.2 8485.9 8492.2 8504.4 7618.9 7725.8 7822.5 7911.6 7917.0 7529.3 7594.5 7607.3 7673.2 7691.0 6898.4 7052.6 7069.9 7071.7 7073.0 5067.9 5098.2 5213.4 5231.5 5360.0 4364.8 4960.0 5031.1 5124.1 5212.6 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4499.65 Median:5068.77 stddev:1408.32 (27.8%) stddev-sans-first:1376.08 19:09:47 INFO - PROCESS | 1947 | Values: 273.4 294.7 304.4 306.1 313.1 4615.7 5099.9 5145.0 5347.4 5364.2 4248.6 4561.3 5037.6 5104.2 5117.5 2993.3 3533.5 3594.6 4073.8 4079.7 4079.3 4097.0 4108.8 4113.2 4119.7 3271.6 3376.9 3569.4 3940.7 4073.8 4012.9 4018.6 4019.5 4060.9 4086.4 3009.5 3517.5 3560.5 3572.3 3575.6 4877.4 5125.1 5133.2 5178.7 5231.8 3935.0 4643.7 4666.3 4693.5 4723.6 4851.4 5565.7 5591.2 5596.5 5649.5 3645.0 3899.0 3912.8 3920.6 3934.7 4358.9 4376.2 5820.5 5887.5 5896.2 4014.5 4021.0 4035.0 4038.3 4061.3 3251.6 3392.7 4084.6 4094.3 4105.4 3708.9 4014.4 4646.9 4719.9 4732.5 4777.4 4907.3 5536.6 5610.9 5632.4 1197.7 1245.4 1337.4 1398.9 1402.7 699.5 837.5 864.9 928.7 964.7 4349.0 4866.8 5189.3 5243.0 5277.1 5759.5 5771.0 5803.4 5806.7 5826.1 4110.8 4628.8 4642.3 5131.8 5187.0 2538.8 2656.9 2872.2 2958.1 2979.7 5367.3 5644.3 5915.0 5924.4 5945.8 5460.8 5823.4 5826.2 5832.3 5856.5 4648.8 5195.2 5335.1 5662.6 5791.8 5494.8 5688.8 5785.7 5852.5 5871.3 4714.5 4923.9 5650.2 5809.3 5846.5 5697.2 5711.0 6147.0 6178.6 6186.9 3806.2 3818.8 3881.8 3892.4 3903.0 5782.8 5812.8 5824.2 5837.9 5845.3 5507.4 5537.0 5650.3 5653.4 5694.6 4283.0 4291.9 5598.2 5641.7 5643.3 5273.8 5366.4 5491.4 5541.5 5546.2 4430.7 5509.7 5629.4 5643.9 5682.9 5291.0 5555.7 5564.8 5571.3 5577.4 19:09:47 INFO - PROCESS | 1947 | 19:09:47 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:24551.11 Median:20817.88 stddev:39405.42 (189.3%) stddev-sans-first:39475.33 19:09:47 INFO - PROCESS | 1947 | Values: 718.9 719.8 769.6 796.5 821.0 15472.5 15877.4 15893.7 15896.5 15992.4 14449.2 14502.3 14503.3 14508.8 14544.6 672.1 689.9 693.6 824.2 828.0 684.4 723.5 841.8 845.1 845.5 900.5 902.3 902.9 903.3 906.6 829.3 840.8 897.4 899.8 900.5 531.5 548.6 650.3 665.5 671.1 15087.4 15125.4 15130.1 15135.8 15143.9 13531.5 13885.6 14016.3 14033.8 14299.6 11043.2 12442.2 12703.1 12959.2 13047.9 4513.2 4519.6 4573.2 4621.9 4760.6 108136.9 109674.9 110020.4 110516.2 111632.9 10298.1 10561.5 10928.9 11028.6 11149.6 20481.8 20769.1 20816.2 20819.6 20848.2 7483.4 7820.5 7947.9 7952.1 7961.3 4239.2 4425.4 4450.6 4487.4 4498.5 3305.3 3379.3 3398.3 3400.7 3403.4 648.6 653.5 656.8 660.4 660.8 541.3 598.2 612.5 634.7 636.5 7792.8 8921.2 10150.0 10159.9 10305.3 624.0 634.7 657.6 675.6 690.8 3646.3 4430.6 4466.3 4518.3 4627.7 90425.5 113388.0 149551.8 157288.0 163873.0 88225.1 123154.0 125202.4 128238.4 128827.0 115117.0 117487.0 120884.0 122216.0 127423.4 7658.8 8275.5 8677.8 8741.5 8877.5 48501.5 65943.8 66986.7 67235.7 67424.7 92889.5 101191.0 103854.5 105115.5 105824.5 10306.7 11981.2 12074.6 12107.0 12405.1 9928.8 12911.1 13099.9 13166.2 13610.8 11991.9 12110.3 12132.3 12223.4 12286.5 11973.6 12037.8 12342.1 12672.9 12794.0 12018.9 12054.3 12140.3 12415.2 12621.7 9979.7 10174.3 10335.3 10362.4 10709.1 10461.2 10712.9 10735.4 10739.7 11006.2 19:09:47 INFO - PROCESS | 1947 | -------- Summary: end -------- 19:09:47 INFO - PROCESS | 1947 | 19:09:48 INFO - TEST-INFO | 1947: exit 0 19:09:48 INFO - TEST-OK | dromaeo_css | took 1119246ms 19:09:48 INFO - TEST-START | kraken 19:09:48 INFO - operating with platform_type : mac_ 19:09:48 INFO - Initialising browser for kraken test... 19:09:48 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpKKTJ_o/profile http://localhost:51550/getInfo.html) 19:09:50 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 19:09:50 INFO - PROCESS | 1950 | colorDepth:24 19:09:50 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 19:09:50 INFO - PROCESS | 1950 | __metrics 19:09:50 INFO - PROCESS | 1950 | 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" 19:09:50 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:09:51 INFO - TEST-INFO | 1950: exit 0 19:09:51 INFO - Browser initialized. 19:09:51 INFO - Running cycle 1/1 for kraken test... 19:09:51 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpKKTJ_o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:03 INFO - PROCESS | 1951 | RSS: Main: 236290048 19:10:03 INFO - PROCESS | 1951 | 19:10:06 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51550/tests/kraken/driver.html?testName=audio-beat-detection) 19:10:06 INFO - PROCESS | 1951 | RSS: Main: 294780928 19:10:06 INFO - PROCESS | 1951 | 19:10:09 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51550/tests/kraken/driver.html?testName=audio-dft) 19:10:10 INFO - PROCESS | 1951 | RSS: Main: 293720064 19:10:10 INFO - PROCESS | 1951 | 19:10:13 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51550/tests/kraken/driver.html?testName=audio-fft) 19:10:14 INFO - PROCESS | 1951 | RSS: Main: 383037440 19:10:14 INFO - PROCESS | 1951 | 19:10:16 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51550/tests/kraken/driver.html?testName=audio-oscillator) 19:10:16 INFO - PROCESS | 1951 | RSS: Main: 289157120 19:10:16 INFO - PROCESS | 1951 | 19:10:18 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51550/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:10:19 INFO - PROCESS | 1951 | RSS: Main: 290816000 19:10:19 INFO - PROCESS | 1951 | 19:10:22 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51550/tests/kraken/driver.html?testName=imaging-darkroom) 19:10:22 INFO - PROCESS | 1951 | RSS: Main: 329908224 19:10:22 INFO - PROCESS | 1951 | 19:10:25 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51550/tests/kraken/driver.html?testName=imaging-desaturate) 19:10:26 INFO - PROCESS | 1951 | RSS: Main: 329596928 19:10:26 INFO - PROCESS | 1951 | 19:10:29 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51550/tests/kraken/driver.html?testName=json-parse-financial) 19:10:29 INFO - PROCESS | 1951 | RSS: Main: 326492160 19:10:29 INFO - PROCESS | 1951 | 19:10:31 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51550/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:10:32 INFO - PROCESS | 1951 | RSS: Main: 304091136 19:10:32 INFO - PROCESS | 1951 | 19:10:33 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:10:34 INFO - PROCESS | 1951 | RSS: Main: 305324032 19:10:34 INFO - PROCESS | 1951 | 19:10:36 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:10:37 INFO - PROCESS | 1951 | RSS: Main: 314097664 19:10:37 INFO - PROCESS | 1951 | 19:10:40 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:10:41 INFO - PROCESS | 1951 | RSS: Main: 326742016 19:10:41 INFO - PROCESS | 1951 | 19:10:43 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:10:44 INFO - PROCESS | 1951 | RSS: Main: 320253952 19:10:44 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:51550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51550/tests/kraken/driver.html?testName=ai-astar) 19:10:46 INFO - PROCESS | 1951 | RSS: Main: 364089344 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | __start_tp_report 19:10:46 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 19:10:46 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 19:10:46 INFO - PROCESS | 1951 | |i|pagename|runs| 19:10:46 INFO - PROCESS | 1951 | |0;ai-astar;113;112;112;112;112;112;112;113;113;114 19:10:46 INFO - PROCESS | 1951 | |1;audio-beat-detection;151;116;115;152;118;112;112;116;145;113 19:10:46 INFO - PROCESS | 1951 | |2;audio-dft;183;183;185;200;249;183;178;183;182;183 19:10:46 INFO - PROCESS | 1951 | |3;audio-fft;80;59;59;88;60;61;59;58;84;58 19:10:46 INFO - PROCESS | 1951 | |4;audio-oscillator;87;69;95;70;68;68;93;68;68;89 19:10:46 INFO - PROCESS | 1951 | |5;imaging-gaussian-blur;89;86;89;87;90;87;90;87;90;86 19:10:46 INFO - PROCESS | 1951 | |6;imaging-darkroom;94;94;95;93;93;93;94;94;115;148 19:10:46 INFO - PROCESS | 1951 | |7;imaging-desaturate;86;85;85;83;84;85;84;83;86;83 19:10:46 INFO - PROCESS | 1951 | |8;json-parse-financial;55;53;52;53;54;54;53;54;53;53 19:10:46 INFO - PROCESS | 1951 | |9;json-stringify-tinderbox;66;77;78;75;73;71;69;72;72;71 19:10:46 INFO - PROCESS | 1951 | |10;stanford-crypto-aes;85;87;89;90;86;89;84;89;92;92 19:10:46 INFO - PROCESS | 1951 | |11;stanford-crypto-ccm;145;146;143;144;141;143;144;145;177;144 19:10:46 INFO - PROCESS | 1951 | |12;stanford-crypto-pbkdf2;171;174;170;172;178;170;171;172;174;172 19:10:46 INFO - PROCESS | 1951 | |13;stanford-crypto-sha256-iterative;68;68;70;69;70;82;88;86;86;84 19:10:46 INFO - PROCESS | 1951 | __end_tp_report 19:10:46 INFO - PROCESS | 1951 | __start_cc_report 19:10:46 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,1984 19:10:46 INFO - PROCESS | 1951 | __end_cc_report 19:10:46 INFO - PROCESS | 1951 | __startTimestamp1475806246656__endTimestamp 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | ------- Summary: start ------- 19:10:46 INFO - PROCESS | 1951 | Number of tests: 14 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:10:46 INFO - PROCESS | 1951 | Values: 113.0 112.0 112.0 112.0 112.0 112.0 112.0 113.0 113.0 114.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:117.00 stddev:16.99 (14.5%) stddev-sans-first:15.19 19:10:46 INFO - PROCESS | 1951 | Values: 151.0 116.0 115.0 152.0 118.0 112.0 112.0 116.0 145.0 113.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#2] audio-dft Cycles:10 Average:190.90 Median:183.00 stddev:21.22 (11.6%) stddev-sans-first:22.31 19:10:46 INFO - PROCESS | 1951 | Values: 183.0 183.0 185.0 200.0 249.0 183.0 178.0 183.0 182.0 183.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#3] audio-fft Cycles:10 Average:66.60 Median:60.50 stddev:12.19 (20.1%) stddev-sans-first:11.92 19:10:46 INFO - PROCESS | 1951 | Values: 80.0 59.0 59.0 88.0 60.0 61.0 59.0 58.0 84.0 58.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.50 stddev:11.83 (15.1%) stddev-sans-first:12.03 19:10:46 INFO - PROCESS | 1951 | Values: 87.0 69.0 95.0 70.0 68.0 68.0 93.0 68.0 68.0 89.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:89.00 stddev:1.66 (1.9%) stddev-sans-first:1.73 19:10:46 INFO - PROCESS | 1951 | Values: 89.0 86.0 89.0 87.0 90.0 87.0 90.0 87.0 90.0 86.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.00 stddev:17.73 (18.9%) stddev-sans-first:18.60 19:10:46 INFO - PROCESS | 1951 | Values: 94.0 94.0 95.0 93.0 93.0 93.0 94.0 94.0 115.0 148.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.09 19:10:46 INFO - PROCESS | 1951 | Values: 86.0 85.0 85.0 83.0 84.0 85.0 84.0 83.0 86.0 83.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:0.84 (1.6%) stddev-sans-first:0.67 19:10:46 INFO - PROCESS | 1951 | Values: 55.0 53.0 52.0 53.0 54.0 54.0 53.0 54.0 53.0 53.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.50 stddev:3.60 (5.0%) stddev-sans-first:2.98 19:10:46 INFO - PROCESS | 1951 | Values: 66.0 77.0 78.0 75.0 73.0 71.0 69.0 72.0 72.0 71.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:89.00 stddev:2.75 (3.1%) stddev-sans-first:2.65 19:10:46 INFO - PROCESS | 1951 | Values: 85.0 87.0 89.0 90.0 86.0 89.0 84.0 89.0 92.0 92.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:144.50 stddev:10.56 (7.3%) stddev-sans-first:11.17 19:10:46 INFO - PROCESS | 1951 | Values: 145.0 146.0 143.0 144.0 141.0 143.0 144.0 145.0 177.0 144.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.00 stddev:2.41 (1.4%) stddev-sans-first:2.51 19:10:46 INFO - PROCESS | 1951 | Values: 171.0 174.0 170.0 172.0 178.0 170.0 171.0 172.0 174.0 172.0 19:10:46 INFO - PROCESS | 1951 | 19:10:46 INFO - PROCESS | 1951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:83.00 stddev:8.70 (10.5%) stddev-sans-first:8.58 19:10:46 INFO - PROCESS | 1951 | Values: 68.0 68.0 70.0 69.0 70.0 82.0 88.0 86.0 86.0 84.0 19:10:46 INFO - PROCESS | 1951 | -------- Summary: end -------- 19:10:46 INFO - PROCESS | 1951 | 19:10:47 INFO - TEST-INFO | 1951: exit 0 19:10:47 INFO - TEST-OK | kraken | took 59248ms 19:10:47 INFO - SUITE-END | took 1178s 19:10:47 INFO - Completed test suite (00:19:38) 19:10:47 INFO - javascript benchmark 19:10:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.9167770805734, 3339.9666003339958, 3341.983290083549, 3372.0726800129946, 3382.0868365541305, 5592.972035139818, 5712.514436272917, 5714.342850572186, 5819.010768169416, 5840.386759390261, 5694.77220911163, 5706.087026075828, 5806.82579522615, 5806.941930580693, 5830.06718924971, 5122.052420302256, 5137.588992880561, 5167.9224811627855, 5196.792128314863, 5271.4464981177, 5290.497402746752, 5290.761915713783, 5298.23175639532, 5301.9396120776, 5340.012097761926, 5241.475852414766, 5262.500062494057, 5272.683638981654, 5302.814401495948, 5336.279602253704, 5144.279800827887, 5195.064888320101, 5199.766010529535, 5248.0553500369915, 5248.71132087735, 5159.793608255703, 5162.896742065138, 5199.012187684328, 5205.791768329263, 5227.764750586232, 5636.210930469738, 5647.181158732002, 5783.5084017858535, 5783.5951483396175, 5783.942160578383, 6169.383061693839, 6227.190465239535, 6273.749050037993, 6292.4966002719675, 6298.401651843067, 6278.215223097113, 6280.905786413207, 6326.145970294044, 6345.0, 6351.555391122623, 5653.0, 5710.600257981901, 5713.228714123623, 5722.055860783007, 5759.625624334405, 6241.095041218998, 6293.496520278367, 6295.653739044396, 6307.716152773044, 6311.305756366796, 5819.82540523785, 6124.387561243929, 6157.7229024694, 6190.473809726133, 6200.751969921243, 6037.667928263988, 6108.297545782203, 6123.9387606124255, 6135.7839197735275, 6138.296437970319, 6131.044463296589, 6208.534359923024, 6208.906866397007, 6234.251889773256, 6251.374862513712, 6154.661493617805, 6264.154339164245, 6275.121482992385, 6281.3404592518045, 6301.684915754194, 4203.747775133502, 4735.739534325645, 4938.827141050046, 4939.209726443752, 4986.750662466862, 4257.1698518788535, 4343.52221255668, 4372.125574885035, 4434.312681534368, 4439.533848945879, 5816.0, 5820.854478637983, 5821.010428227211, 5830.533557315404, 5855.209546711225, 6233.283172435228, 6297.149884765589, 6306.527010474233, 6314.431701146918, 6319.0, 5649.322081350264, 5720.971395143081, 5736.024875771045, 5790.652560846363, 5808.970955145282, 5398.46015398457, 5434.021876062347, 5435.537979271806, 5436.293281873332, 5441.102218134043, 6239.937600624117, 6259.718312675849, 6264.718087686065, 6293.590916590407, 6318.273398559225, 6255.530835187288, 6266.843328916813, 6311.810645680637, 6316.431521163117, 6332.493400527855, 6344.0, 6361.0, 6365.809025729235, 6375.203099612549, 6379.106925030592, 6078.088286757022, 6096.254562767794, 6112.229929638781, 6140.815775526741, 6192.783252586138, 5162.561182299547, 6287.46556542699, 6293.307736149111, 6305.495560355069, 6323.936760632335, 6118.174046503843, 6149.661768602591, 6162.26052873658, 6178.721957511832, 6179.598326108789, 5849.532037436909, 5930.11048342752, 6122.969385153046, 6152.446279834658, 6154.876902462015, 5831.825045248649, 5891.558133139946, 5929.9110513341475, 5937.821865344046, 6024.789132380346, 5029.949700502948, 6153.661548614869, 6156.015037593964, 6168.414000669929, 6169.81490555284, 5189.429162792166, 5363.222332761806, 5972.13404056418, 5995.190649262294, 6008.939910600838], "value": 5694.200871451873, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.5024123705161, 462.90279041401294, 464.81872069892745, 485.68187836966797, 537.1727539589033, 30182.09453716389, 39383.0154246144, 40394.0, 40581.99999999993, 40797.18405631893, 41647.583524164824, 42015.949601259985, 42093.36859947103, 42102.15795684084, 42150.57849421505, 9694.66068687596, 9872.506374681238, 9887.901120988807, 9889.406635601887, 9897.802043959116, 9755.268354873377, 9862.50687465624, 9863.654772082979, 9866.506674666274, 9878.506074696272, 8490.641497360424, 9787.755306117333, 9787.951060244688, 9900.25748068894, 9928.354656947311, 9763.902360976406, 9829.508524573743, 9830.606775728962, 9830.803383932282, 9844.556994935245, 9624.95187524065, 9687.41875487473, 9696.46669433181, 9696.612135514571, 9703.854442183372, 39552.80223598892, 39807.8009609953, 39829.80085099556, 39896.0, 39940.20119597592, 3263.885763998249, 3319.2531680371962, 3426.1605906552804, 3494.912627184315, 3571.6964058055096, 30133.849330753426, 30833.920812771445, 31380.529292060637, 31484.055478335686, 31623.36753264945, 3176.428242916274, 3245.415825151472, 3271.574695289597, 3387.7797943133864, 3389.57630296213, 468713.0, 474010.0, 474504.0, 475143.62428187986, 475606.0, 32417.0, 56152.71923640356, 56476.152857707166, 56500.0, 56564.0, 33086.83456582702, 35003.0, 35056.29887402289, 35077.47383789245, 35089.824550877085, 14312.57062288133, 14437.278136093153, 14464.638384040483, 14478.420863165566, 14483.275836208359, 12257.509699611915, 12374.010079193822, 12376.876231237753, 12383.318917459446, 12403.441845116991, 7671.194524574951, 7717.961410192913, 7767.883481747778, 7782.338501227459, 7783.4162437817395, 3165.113768144923, 3208.1658768719835, 3208.566843476101, 3210.5184222366834, 3244.221386867182, 880.5465185429509, 906.2387594420718, 922.864876202275, 1071.4000159910474, 1118.5022664914197, 29317.706822931923, 29545.704542954725, 29765.702342976725, 29781.172605133128, 29965.550516742267, 1035.9015893490107, 1084.69628504019, 1097.13874608432, 1098.7088421568292, 1119.339589642115, 13924.930375348058, 14634.0, 15166.696666066617, 15300.846991530165, 15646.061236325857, 656740.0, 661968.0, 662485.0, 662558.0, 664170.0, 55848.72075639596, 56265.71867140638, 56296.718516407156, 56365.436345636015, 56366.0, 1321.7224382879704, 1368.6920442900268, 1373.6909195430949, 1384.9861501384858, 1385.7852032934911, 28056.43887122287, 28870.42259154763, 28925.42149156963, 29529.557056643738, 29770.0, 47992.80017999438, 48279.75860120677, 48298.51701483081, 48361.03277934492, 48426.757866211854, 552485.0, 553584.0, 554789.0, 554988.0, 555705.0, 25604.23187304384, 25891.0, 25938.35154121162, 25999.870000649877, 26001.95992160368, 45808.0, 46177.538224617325, 46621.0, 46694.76652616715, 46892.29661555147, 32219.677803221668, 37939.241215176095, 38760.0, 38834.0, 39101.0, 36713.44929826001, 36934.261314773015, 37576.0, 38277.0, 38412.42381364338, 32208.677913220567, 32635.857744978814, 36152.0, 36664.81667591645, 37607.2478550422, 31101.844490777403, 31888.5216721754, 34255.0, 34503.30993380068, 34592.65407345894, 25025.374365641004, 25197.622035669847, 25294.620580691673, 25395.74604254008, 25815.255423373288], "value": 18388.88140056153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.63083815736223, 366.50338790938275, 366.8037599884063, 374.5337055366069, 395.4147861165475, 14964.0, 15098.924505377472, 16039.711859068891, 20324.695129573032, 20908.477288067807, 19345.322913698023, 20025.99870006501, 20465.488362790937, 20505.897470512664, 20669.793302067013, 5364.222187782789, 5845.06478963367, 6135.37412585663, 6136.171616831737, 6145.5390845686525, 5976.581639285252, 6010.489108425789, 6041.124037014631, 6063.4239747224165, 6094.451499365056, 5641.5204707599905, 5955.166276721241, 6001.849953751169, 6010.729517171716, 6012.398760123996, 5775.306963164448, 5808.954388210121, 5883.0, 5888.617239879415, 5892.96873047215, 4461.286194208911, 5090.363704536933, 5140.948590514122, 5146.228065790161, 5480.068388373986, 12510.18683785551, 12554.623361299084, 12561.806628370381, 12729.936350318281, 12737.044721645821, 2206.4042708468783, 2220.9888950555305, 2230.208276061991, 2292.209187830196, 2331.6852224949585, 9550.37922535033, 9625.278104142148, 9660.565274562661, 9973.052560006789, 10258.743531411774, 1821.8360347568782, 1843.0508288231572, 1861.4415675297491, 1884.302807961063, 1937.7190307405488, 118863.0, 128845.0, 129444.35277823645, 129877.35061324727, 130166.3491682545, 8677.479351238946, 8756.605952732143, 11365.69294531123, 11382.54469821198, 11558.364289963965, 14323.14061156334, 14344.067635603653, 14347.426102955766, 14355.0, 14370.568882933529, 8226.629801658939, 8415.158484151658, 8453.239208471266, 8472.661093556311, 8567.485950842845, 8357.791055223668, 8397.0, 8523.403361764616, 8531.701390451304, 8567.443116197428, 4399.64802815774, 4459.732416055047, 4512.52618475062, 4547.931781023287, 4562.270036794097, 1730.3251731824598, 1827.5522496988058, 1902.335456475584, 1902.6099649571804, 1919.64486569985, 761.5240474703311, 778.1323823936383, 896.950667713269, 958.7746879483316, 974.5858010345574, 17984.460466186036, 20644.277450289468, 20648.896755516125, 20754.688679669816, 20825.583488330147, 902.4134312696668, 927.7216834949488, 932.1517419148543, 934.761635782871, 1012.2921185828028, 9091.727248182566, 9405.341626086245, 10009.549570269355, 10593.993570610779, 10785.220438627539, 565981.0, 576890.0, 582183.0, 584862.0, 585033.0, 72843.27156728471, 90261.54869225743, 97350.0, 100189.0, 108621.0, 872.4503562755297, 915.1031988651159, 950.4677380666849, 951.757301888028, 963.9759006024765, 15109.39562417491, 17005.91497042507, 17981.741278110407, 18343.908280458512, 18558.7936784114, 47355.23928073318, 48100.0, 52273.47726522686, 52731.73634131805, 53010.46989530209, 75983.24016759761, 76749.0, 77280.0, 77720.0, 79449.60275198588, 7832.295093441618, 7851.478441061536, 8018.759437216893, 8043.959780201061, 8262.793430164294, 11884.0, 12591.811122832982, 12614.36928153607, 12773.042021848212, 13040.608781736562, 10663.306885052758, 10669.626563070255, 10964.890351096386, 11117.666470005914, 11201.719957000814, 10256.230782691178, 10449.9477502612, 10675.839862402225, 11120.0, 11121.0, 9470.905290947003, 10253.794924101625, 10739.87231340698, 11024.724381890517, 11141.16441266892, 8094.87857682147, 8270.0, 8282.668693252203, 8289.792755181168, 8432.198941100585, 10568.10171135462, 11090.944545277222, 11207.430959665817, 11410.657680269605, 11439.885601143882], "value": 9086.901865955113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.5020092364903, 1511.0329389190913, 1663.9168041597918, 1821.408042386225, 1894.9810501894985, 8427.367947403945, 8977.461352318865, 8980.73057808266, 8987.640494380224, 8994.32542559309, 7848.293653571178, 8098.311643510294, 8117.0, 8464.492130472176, 8684.175003374685, 2053.4455696961813, 2343.8945247463903, 2347.0284960633066, 2382.9880850595723, 2390.426297688551, 1939.534511717192, 2357.57563638545, 2365.396823809926, 2369.9407514812096, 2374.7743964323363, 2352.2472808701223, 2355.8233132515043, 2372.6796882420913, 2378.0, 2380.75002124777, 1995.311617491963, 2001.1995201919203, 2019.4951262184454, 2019.676851703735, 2024.7469066366705, 2358.775916287967, 2358.893849776764, 2362.126013375062, 2363.2319496163814, 2366.1008816649564, 8899.110088991114, 8982.236509896667, 9041.457512549203, 9048.321375896834, 9058.501782401965, 5215.921761173586, 5374.247605335257, 5398.46015398457, 5403.675779453245, 5417.106177480711, 3445.2592692570965, 3555.591107022674, 3634.546181527384, 3649.6167902370134, 3651.8174091295327, 1085.180688580117, 1098.8406681031286, 1106.1758989552834, 1113.9777204455866, 1120.2830188679252, 11724.944754972008, 11874.881251187551, 11884.821727674178, 11885.88114118865, 11896.583619573274, 4241.172971270573, 4487.743431839091, 4520.683552151384, 4791.760411979387, 4836.46798852126, 10025.498725063717, 10036.297459177933, 10044.497775111215, 10048.246381521416, 10056.64801731936, 5324.41431442541, 5327.121025030827, 5331.44019877915, 5337.092694241988, 5345.930813837248, 4366.104948485553, 4407.911841763211, 4495.977520112378, 4817.494163112893, 4888.095702295087, 3812.733108682421, 3838.5009948707047, 3920.2551515212017, 3965.72239943207, 3967.682585393162, 1267.6513958661442, 1273.5924504158766, 1280.359820089955, 1286.4854058376725, 1292.2311224821217, 814.0044635740413, 867.1285358214953, 897.6274845938863, 912.8356895758827, 952.6094301336558, 5597.7964737580805, 5644.57665675076, 5949.9107513387335, 5990.101484777319, 6053.0, 869.8869147010975, 898.9955050224708, 911.8814554108056, 931.4039015030386, 991.8214721350082, 3899.8440062397754, 3908.8241029153755, 3911.6675082618294, 4055.4525139105845, 4062.898427539276, 10786.0, 10999.0, 11108.555657773599, 11123.276986995981, 11136.832947505794, 11042.779144417067, 11053.447327633587, 11069.169812264112, 11074.5570177192, 11098.334099954029, 5914.733836977346, 8145.307648849795, 8150.836983260301, 8246.463979841292, 8254.54599997006, 5512.628531496553, 5513.972430137824, 5881.911771323348, 5898.587098903035, 6213.37866213375, 9221.262299016196, 10238.0, 10257.794844103226, 10259.0, 10304.227182961458, 8634.654613815377, 9961.153301969123, 10243.590256389662, 10343.63797267092, 10450.738731531772, 5447.400785913625, 7278.381337586365, 7288.635568221674, 7388.593627350548, 7599.734009309647, 8109.878351824846, 8474.1949514796, 8485.91514084876, 8492.235698787139, 8504.44721093127, 7618.923810761821, 7725.806854828675, 7822.4524283299625, 7911.604419779103, 7916.960415197887, 7529.284717951786, 7594.468387212842, 7607.315341619281, 7673.155952845294, 7691.0, 6898.413634840894, 7052.647367631701, 7069.858602828018, 7071.717131314896, 7073.0, 5067.949320506896, 5098.1842905135, 5213.40045894727, 5231.529162375405, 5359.973200133974, 4364.781760912006, 4959.950400496094, 5031.119554078095, 5124.1032819257225, 5212.582993360598], "value": 4575.342586882348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.4380847358678, 294.7111830406202, 304.3836231630947, 306.12601024076264, 313.1497982976219, 4615.676902616814, 5099.949000509994, 5145.041601079381, 5347.41178470368, 5364.222187782769, 4248.553901840309, 4561.266718646918, 5037.596992240621, 5104.234364845275, 5117.488251174881, 2993.281612413016, 3533.469979503069, 3594.5686517617924, 4073.755574665515, 4079.673626109919, 4079.2657321682086, 4096.996235922188, 4108.815103320343, 4113.239050775601, 4119.6704263658985, 3271.623763267219, 3376.9155771105798, 3569.3580952761763, 3940.7044471664594, 4073.777866640011, 4012.9197416051516, 4018.618231268025, 4019.537753158395, 4060.8984775380554, 4086.3654538184965, 3009.458297506448, 3517.5226404909745, 3560.5193298904574, 3572.3034008368377, 3575.5888072871694, 4877.439094504107, 5125.053094470694, 5133.230015497668, 5178.689278643294, 5231.764570594332, 3934.960650393488, 4643.651726120521, 4666.2767271073035, 4693.48371679115, 4723.551262630044, 4851.350540816139, 5565.721713914288, 5591.217229587861, 5596.496315331599, 5649.519790817785, 3645.0, 3898.9862635714917, 3912.845710515376, 3920.627540383659, 3934.665553427962, 4358.869233922987, 4376.162011954986, 5820.534357251452, 5887.528997680175, 5896.167491130756, 4014.511003178048, 4021.0, 4035.0, 4038.273110840018, 4061.268971585143, 3251.5772949516413, 3392.728581713506, 4084.571120032413, 4094.324436468009, 4105.44576482177, 3708.85211923731, 4014.437978682987, 4646.883827904262, 4719.882002949954, 4732.503087175865, 4777.355057067321, 4907.33750943618, 5536.640118392372, 5610.943890561124, 5632.408597097327, 1197.7305106351, 1245.4333278358324, 1337.3647517429142, 1398.8878841321175, 1402.747505449029, 699.5278187223604, 837.4598384042258, 864.9058940440348, 928.7120992492349, 964.7395203295071, 4348.978255108705, 4866.7566621668775, 5189.299444574934, 5243.0, 5277.126620049904, 5759.481646651738, 5771.027920620883, 5803.448672376117, 5806.65160090396, 5826.067829147316, 4110.753354798721, 4628.768561571976, 4642.328761645805, 5131.794028403397, 5187.028929007029, 2538.7968962482955, 2656.9070082547405, 2872.1905199724456, 2958.1421387797727, 2979.703828834464, 5367.329083864517, 5644.266245388073, 5914.99445094335, 5924.437178468039, 5945.791897283574, 5460.761087953999, 5823.388544202882, 5826.242588463558, 5832.329282132524, 5856.472917437451, 4648.767561621906, 5195.246689230041, 5335.093034184198, 5662.631928924607, 5791.797287095016, 5494.780208791603, 5688.833789073313, 5785.718568259374, 5852.5317974561085, 5871.295444546511, 4714.504976977368, 4923.89212427201, 5650.208970744181, 5809.302883653989, 5846.503047241032, 5697.23087383198, 5711.0, 6147.018695932558, 6178.567500274938, 6186.907196391968, 3806.219724956322, 3818.8472461102356, 3881.7670939743707, 3892.3846603659163, 3903.0047337928645, 5782.826515204551, 5812.796552120655, 5824.15549745293, 5837.854053648693, 5845.327787304344, 5507.365139008235, 5536.979002664079, 5650.26546548946, 5653.381835625121, 5694.551342922583, 4282.978585107055, 4291.892702682458, 5598.244237028112, 5641.717914104196, 5643.294588176478, 5273.841784746463, 5366.443731317874, 5491.395946445808, 5541.473560011793, 5546.223528705904, 4430.667699922455, 5509.724513774376, 5629.380768115422, 5643.88712225745, 5682.857928551819, 5290.9735451322495, 5555.6666400064505, 5564.777408903598, 5571.275734154534, 5577.358603760619], "value": 4051.291543774223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.8670096032233, 719.755283203711, 769.5882702754028, 796.5260669901414, 820.9794755131119, 15472.535823925273, 15877.444289449872, 15893.682126357466, 15896.523104306874, 15992.440264590741, 14449.205293708841, 14502.347394367252, 14503.274836258197, 14508.782368264485, 14544.563663090097, 672.0993868216589, 689.8999645051465, 693.6289085339345, 824.2046425199682, 827.9503229806215, 684.4387602166225, 723.4827098624509, 841.7853447370942, 845.1337379186352, 845.4673555659956, 900.5407242306438, 902.3142411767038, 902.9277657787394, 903.2818908967387, 906.6282824042144, 829.2619568583965, 840.8066144786673, 897.4121950122681, 899.7525680437866, 900.5002223765807, 531.4924247343778, 548.6324162810927, 650.2911826109516, 665.5374514712277, 671.0504635940139, 15087.39650413982, 15125.394984200619, 15130.092194468258, 15135.848641513554, 15143.924280378638, 13531.458741650322, 13885.583432497042, 14016.299185040707, 14033.78949315761, 14299.57101286963, 11043.171762117874, 12442.191257568229, 12703.110782245247, 12959.222446653137, 13047.86952130476, 4513.1650644630845, 4519.570640789119, 4573.222552166107, 4621.907561848778, 4760.571548560646, 108136.91863081347, 109674.90325096727, 110020.44989775, 110516.1854768154, 111632.88367116306, 10298.073173414428, 10561.524731387106, 10928.890711092947, 11028.56628638288, 11149.554017839195, 20481.79518204799, 20769.065392057393, 20816.167353306002, 20819.583608328052, 20848.1660733572, 7483.438742094365, 7820.452568320163, 7947.920520794718, 7952.125266220711, 7961.283484486308, 4239.236937351245, 4425.446819147606, 4450.577195166518, 4487.394201782718, 4498.527654596221, 3305.3058857640167, 3379.341028499419, 3398.2693720849643, 3400.7279417646528, 3403.3533628610485, 648.6075924065966, 653.5490511547113, 656.7602824968948, 660.385841167709, 660.7588230295908, 541.2557733116964, 598.1745191635603, 612.4518555892452, 634.7207228819304, 636.4590098416402, 7792.805179870548, 8921.197092261727, 10150.0, 10159.898401015895, 10305.278630495943, 623.9875202495924, 634.6826586706646, 657.6284399314372, 675.5743881354715, 690.775497963164, 3646.252518233756, 4430.556944305608, 4466.285394336891, 4518.254488009507, 4627.722336659811, 90425.54787226154, 113388.0, 149551.75672364925, 157288.0, 163873.0, 88225.11774882297, 123154.0, 125202.37398812948, 128238.35880820536, 128827.0, 115117.0, 117487.0, 120884.0, 122216.0, 127423.36288318684, 7658.8085297868, 8275.54484503334, 8677.783055423664, 8741.475511469333, 8877.511736854534, 48501.5149848497, 65943.77871429936, 66986.66506667435, 67235.65528689302, 67424.6628766853, 92889.5355523218, 101191.0, 103854.48072759587, 105115.47442262739, 105824.47087764512, 10306.690799276033, 11981.161318707955, 12074.637760867188, 12107.0, 12405.069619778733, 9928.751781205528, 12911.096223264656, 13099.934500327437, 13166.234371667928, 13610.795838062239, 11991.940040299743, 12110.273383597012, 12132.332721700392, 12223.388830558259, 12286.508539658313, 11973.580924667594, 12037.819432708342, 12342.074344424025, 12672.936635316764, 12794.0, 12018.939905300418, 12054.337011464453, 12140.271583705005, 12415.193012454161, 12621.74756504883, 9979.700608981742, 10174.263336811053, 10335.328203666737, 10362.378257304586, 10709.143268538654, 10461.215408844519, 10712.946435267773, 10735.355878647306, 10739.704118352409, 11006.229563930769], "value": 7629.604286077795, "unit": "score"}], "name": "dromaeo_css", "value": 7158.592282676091, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0, 113.0, 113.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 115.0, 152.0, 118.0, 112.0, 112.0, 116.0, 145.0, 113.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 185.0, 200.0, 249.0, 183.0, 178.0, 183.0, 182.0, 183.0], "value": 190.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 88.0, 60.0, 61.0, 59.0, 58.0, 84.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 95.0, 70.0, 68.0, 68.0, 93.0, 68.0, 68.0, 89.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 90.0, 87.0, 90.0, 87.0, 90.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 93.0, 93.0, 93.0, 94.0, 94.0, 115.0, 148.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 83.0, 84.0, 85.0, 84.0, 83.0, 86.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 78.0, 75.0, 73.0, 71.0, 69.0, 72.0, 72.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 89.0, 90.0, 86.0, 89.0, 84.0, 89.0, 92.0, 92.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 143.0, 144.0, 141.0, 143.0, 144.0, 145.0, 177.0, 144.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 170.0, 172.0, 178.0, 170.0, 171.0, 172.0, 174.0, 172.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 69.0, 70.0, 82.0, 88.0, 86.0, 86.0, 84.0], "value": 77.1, "unit": "score"}], "name": "kraken", "value": 1457.1, "alertThreshold": 2.0}]} 19:10:47 INFO - Return code: 0 19:10:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:10:47 INFO - # TBPL SUCCESS # 19:10:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:10:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:10:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:10:47 INFO - 2016-10-06 19:10:47.938 screenresolution[1955:16884] starting screenresolution argv=screenresolution get 19:10:47 INFO - 2016-10-06 19:10:47.940 screenresolution[1955:16884] Display 0: 1600x1200x32@60 19:10:47 INFO - 2016-10-06 19:10:47.947 screenresolution[1956:16887] starting screenresolution argv=screenresolution list 19:10:47 INFO - Available Modes on Display 0 19:10:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:10:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:10:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:10:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:10:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:10:48 INFO - Intel Iris: 19:10:48 INFO - Chipset Model: Intel Iris 19:10:48 INFO - Type: GPU 19:10:48 INFO - Bus: Built-In 19:10:48 INFO - VRAM (Dynamic, Max): 1536 MB 19:10:48 INFO - Vendor: Intel (0x8086) 19:10:48 INFO - Device ID: 0x0a2e 19:10:48 INFO - Revision ID: 0x0009 19:10:48 INFO - Displays: 19:10:48 INFO - Display: 19:10:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:10:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:10:48 INFO - Display Serial Number: 1600x1200 60 19:10:48 INFO - Main Display: Yes 19:10:48 INFO - Mirror: Off 19:10:48 INFO - Online: Yes 19:10:48 INFO - Rotation: Supported 19:10:48 INFO - Return code: 0 19:10:48 INFO - Running post-action listener: _resource_record_post_action 19:10:48 INFO - [mozharness: 2016-10-07 02:10:48.185601Z] Finished run-tests step (success) 19:10:48 INFO - Running post-run listener: _resource_record_post_run 19:10:48 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 651264; Write bytes: 706269696; Read time: 7; Write time: 2080 19:10:48 INFO - TinderboxPrint: CPU usage
53.4% 19:10:48 INFO - TinderboxPrint: I/O read bytes / time
651,264 / 7 19:10:48 INFO - TinderboxPrint: I/O write bytes / time
706,269,696 / 2,080 19:10:48 INFO - TinderboxPrint: CPU idle
2,262.0 (46.6%) 19:10:48 INFO - TinderboxPrint: CPU system
974.1 (20.1%) 19:10:48 INFO - TinderboxPrint: CPU user
1,621.6 (33.4%) 19:10:48 INFO - TinderboxPrint: Swap in / out
407,912,448 / 0 19:10:48 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 408459776; Write bytes: 410035712; Read time: 31022; Write time: 756 19:10:48 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 577536; Write bytes: 294689792; Read time: 5; Write time: 1319 19:10:48 INFO - Running post-run listener: _upload_blobber_files 19:10:48 INFO - Blob upload gear active. 19:10:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:10:48 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 19:10:48 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'] 19:10:48 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 19:10:49 INFO - (blobuploader) - INFO - Open directory for files ... 19:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:49 INFO - (blobuploader) - INFO - Done attempting. 19:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:10:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:50 INFO - (blobuploader) - INFO - Done attempting. 19:10:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:10:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:53 INFO - (blobuploader) - INFO - Done attempting. 19:10:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:10:53 INFO - Return code: 0 19:10:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:10:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:10:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/210aa82d345e59e1cc9f8add6f66139b2201b2a48a262a3ddc7b2ec92fb4b159a9123a4fcf4348b81027fc0c7b9288f7bb2257055c3fe2056abbeef3ffeedc35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/982349157524d83c3ecb03be55c5c2b1088d64cb68611c4dbc77e8a76cf1e59797d456d0a19dd8ae40ff4fbf64abed6fc5d41396d0d119b3ae088d49fdb5b7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd693deebc5f06d3a3c76a8eed60fabe701fb7b0588a8fdf3a6549c3dd7ca92727a6d816c1af8a2581ae2f14ea5d2de26550172fc1c5e8d6fb919b0dabb2aae9"} 19:10:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:10:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:10:53 INFO - Contents: 19:10:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/210aa82d345e59e1cc9f8add6f66139b2201b2a48a262a3ddc7b2ec92fb4b159a9123a4fcf4348b81027fc0c7b9288f7bb2257055c3fe2056abbeef3ffeedc35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/982349157524d83c3ecb03be55c5c2b1088d64cb68611c4dbc77e8a76cf1e59797d456d0a19dd8ae40ff4fbf64abed6fc5d41396d0d119b3ae088d49fdb5b7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd693deebc5f06d3a3c76a8eed60fabe701fb7b0588a8fdf3a6549c3dd7ca92727a6d816c1af8a2581ae2f14ea5d2de26550172fc1c5e8d6fb919b0dabb2aae9"} 19:10:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:10:53 INFO - Copying logs to upload dir... 19:10:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:10:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.703121 ========= master_lag: 2.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-06 19:10:55.306717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 19:10:55.310630) ========= 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.e0nybacOIK/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.wLBAyR0LBi/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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/210aa82d345e59e1cc9f8add6f66139b2201b2a48a262a3ddc7b2ec92fb4b159a9123a4fcf4348b81027fc0c7b9288f7bb2257055c3fe2056abbeef3ffeedc35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/982349157524d83c3ecb03be55c5c2b1088d64cb68611c4dbc77e8a76cf1e59797d456d0a19dd8ae40ff4fbf64abed6fc5d41396d0d119b3ae088d49fdb5b7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd693deebc5f06d3a3c76a8eed60fabe701fb7b0588a8fdf3a6549c3dd7ca92727a6d816c1af8a2581ae2f14ea5d2de26550172fc1c5e8d6fb919b0dabb2aae9"} build_url:https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/M5DtNsJzQniqUVmozqxhRQ/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/210aa82d345e59e1cc9f8add6f66139b2201b2a48a262a3ddc7b2ec92fb4b159a9123a4fcf4348b81027fc0c7b9288f7bb2257055c3fe2056abbeef3ffeedc35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/982349157524d83c3ecb03be55c5c2b1088d64cb68611c4dbc77e8a76cf1e59797d456d0a19dd8ae40ff4fbf64abed6fc5d41396d0d119b3ae088d49fdb5b7a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd693deebc5f06d3a3c76a8eed60fabe701fb7b0588a8fdf3a6549c3dd7ca92727a6d816c1af8a2581ae2f14ea5d2de26550172fc1c5e8d6fb919b0dabb2aae9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 19:10:55.345517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 19:10:55.345870) ========= 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.e0nybacOIK/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.wLBAyR0LBi/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005249 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 19:10:55.395361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 19:10:55.395721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 19:10:55.396061) ========= ========= Total master_lag: 2.39 =========