builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0090 starttime: 1475529742.37 results: success (0) buildid: 20161003122159 builduid: 43bcc9a87e384a6d9a5ca31fddf95756 revision: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.370286) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.370754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.371066) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.398174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.398543) ========= 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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-03 14:22:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.94M=0.001s 2016-10-03 14:22:22 (9.94 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.584746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.588082) ========= 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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.028775 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:22.636487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 14:22:22.636874) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e8f4dc9c44cc79fcc35913c8d87063dfabbe127e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e8f4dc9c44cc79fcc35913c8d87063dfabbe127e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CsvLgfNg1d/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.1ZndQfrhfH/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-03 14:22:22,708 truncating revision to first 12 chars 2016-10-03 14:22:22,708 Setting DEBUG logging. 2016-10-03 14:22:22,708 attempt 1/10 2016-10-03 14:22:22,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e8f4dc9c44cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 14:22:23,537 unpacking tar archive at: autoland-e8f4dc9c44cc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.105322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 14:22:23.766137) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:23.766463) ========= script_repo_revision: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:23.769894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:23.770176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 14:22:23.787907) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-03 14:22:23.788234) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CsvLgfNg1d/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.1ZndQfrhfH/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:22:23 INFO - MultiFileLogger online at 20161003 14:22:23 in /builds/slave/test 14:22:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:22:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:22:23 INFO - {'append_to_log': False, 14:22:23 INFO - 'base_work_dir': '/builds/slave/test', 14:22:23 INFO - 'blob_upload_branch': 'Autoland', 14:22:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:22:23 INFO - 'branch': 'Autoland', 14:22:23 INFO - 'buildbot_json_path': 'buildprops.json', 14:22:23 INFO - 'config_files': ('talos/mac_config.py',), 14:22:23 INFO - 'default_actions': ('clobber', 14:22:23 INFO - 'read-buildbot-config', 14:22:23 INFO - 'download-and-extract', 14:22:23 INFO - 'populate-webroot', 14:22:23 INFO - 'create-virtualenv', 14:22:23 INFO - 'install', 14:22:23 INFO - 'run-tests'), 14:22:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:22:23 INFO - 'download_minidump_stackwalk': True, 14:22:23 INFO - 'download_symbols': 'ondemand', 14:22:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:22:23 INFO - 'tooltool.py': '/tools/tooltool.py', 14:22:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:22:23 INFO - '/tools/misc-python/virtualenv.py')}, 14:22:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:22:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:22:23 INFO - 'installer_path': 'installer.exe', 14:22:23 INFO - 'log_level': 'info', 14:22:23 INFO - 'log_name': 'talos', 14:22:23 INFO - 'log_to_console': True, 14:22:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:22:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:22:23 INFO - 'opt_config_files': (), 14:22:23 INFO - 'pip_index': False, 14:22:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:22:23 INFO - 'cmd': ('bash', 14:22:23 INFO - '-c', 14:22:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:22:23 INFO - 'enabled': True, 14:22:23 INFO - 'halt_on_failure': False, 14:22:23 INFO - 'name': 'check_screen_resolution'},), 14:22:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:22:23 INFO - 'cmd': ('bash', 14:22:23 INFO - '-c', 14:22:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:22:23 INFO - 'enabled': True, 14:22:23 INFO - 'halt_on_failure': False, 14:22:23 INFO - 'name': 'check_screen_resolution'},), 14:22:23 INFO - 'run_cmd_checks_enabled': True, 14:22:23 INFO - 'sps_profile': False, 14:22:23 INFO - 'sps_profile_interval': 0, 14:22:23 INFO - 'suite': 'dromaeojs', 14:22:23 INFO - 'system_bits': '32', 14:22:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:22:23 INFO - 'title': 't-yosemite-r7-0090', 14:22:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:22:23 INFO - 'use_talos_json': True, 14:22:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:22:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:22:23 INFO - 'work_dir': 'build'} 14:22:23 INFO - [mozharness: 2016-10-03 21:22:23.983068Z] Running clobber step. 14:22:23 INFO - Running pre-action listener: _resource_record_pre_action 14:22:23 INFO - Running main action method: clobber 14:22:23 INFO - rmtree: /builds/slave/test/build 14:22:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:22:26 INFO - Running post-action listener: _resource_record_post_action 14:22:26 INFO - [mozharness: 2016-10-03 21:22:26.194318Z] Finished clobber step (success) 14:22:26 INFO - [mozharness: 2016-10-03 21:22:26.194479Z] Running read-buildbot-config step. 14:22:26 INFO - Running pre-action listener: _resource_record_pre_action 14:22:26 INFO - Running main action method: read_buildbot_config 14:22:26 INFO - Using buildbot properties: 14:22:26 INFO - { 14:22:26 INFO - "project": "", 14:22:26 INFO - "product": "firefox", 14:22:26 INFO - "script_repo_revision": "production", 14:22:26 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:22:26 INFO - "repository": "", 14:22:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:22:26 INFO - "buildid": "20161003122159", 14:22:26 INFO - "pgo_build": "False", 14:22:26 INFO - "basedir": "/builds/slave/test", 14:22:26 INFO - "buildnumber": 328, 14:22:26 INFO - "slavename": "t-yosemite-r7-0090", 14:22:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:22:26 INFO - "platform": "yosemite_r7", 14:22:26 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:22:26 INFO - "branch": "autoland", 14:22:26 INFO - "repo_path": "integration/autoland", 14:22:26 INFO - "revision": "e8f4dc9c44cc79fcc35913c8d87063dfabbe127e", 14:22:26 INFO - "stage_platform": "macosx64", 14:22:26 INFO - "builduid": "43bcc9a87e384a6d9a5ca31fddf95756", 14:22:26 INFO - "slavebuilddir": "test" 14:22:26 INFO - } 14:22:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:22:26 INFO - Running post-action listener: _resource_record_post_action 14:22:26 INFO - [mozharness: 2016-10-03 21:22:26.197913Z] Finished read-buildbot-config step (success) 14:22:26 INFO - [mozharness: 2016-10-03 21:22:26.198043Z] Running download-and-extract step. 14:22:26 INFO - Running pre-action listener: _resource_record_pre_action 14:22:26 INFO - Running main action method: download_and_extract 14:22:26 INFO - mkdir: /builds/slave/test/build/tests 14:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:26 INFO - trying https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:22:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/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 14:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/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 14:22:27 INFO - Downloaded 1199 bytes. 14:22:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:22:27 INFO - Using the following test package requirements: 14:22:27 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:22:27 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:22:27 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:22:27 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'jsshell-mac.zip'], 14:22:27 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:22:27 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:22:27 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:22:27 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:22:27 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:22:27 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:27 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:22:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:22:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:22:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:22:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:22:28 INFO - Http code: 200 14:22:28 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 14:22:28 INFO - x-amz-cf-id: 3uZ_fFqYdWvV89aaDy1GPE3wa0AIfrshedqgElrB6SWZ4ebz453vQg== 14:22:28 INFO - x-amz-version-id: .wr6PpqjAkJ1gbkPNWzBM7E02P8HR6jz 14:22:28 INFO - Expected file size: 16476317 14:22:28 INFO - Obtained file size: 16476317 14:22:35 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 14:22:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:22:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:22:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:22:35 INFO - Http code: 200 14:22:35 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 14:22:35 INFO - x-amz-cf-id: cczoh_Bmq2GFXLZtkZfc_hM2_Jb9SVg6-xYpNKUMQwyEu2T1Q4tgww== 14:22:35 INFO - x-amz-version-id: .wr6PpqjAkJ1gbkPNWzBM7E02P8HR6jz 14:22:36 INFO - Expected file size: 16476317 14:22:36 INFO - Obtained file size: 16476317 14:22:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:22:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:22:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:22:43 INFO - Http code: 200 14:22:43 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 14:22:43 INFO - x-amz-cf-id: pVSqZ8PA0yFzPmWiJD83T73iLGQuMdQrbWBXWniD726W8oKVu35p2A== 14:22:43 INFO - x-amz-version-id: ghcwxt4m2yL1tioNdpBKCnLhY7tejGh1 14:22:43 INFO - Expected file size: 14408522 14:22:43 INFO - Obtained file size: 14408522 14:22:44 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')]} 14:22:44 INFO - trying https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:22:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/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 14:22:46 INFO - Downloaded 111743909 bytes. 14:22:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:22:46 INFO - mkdir: /builds/slave/test/properties 14:22:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:22:46 INFO - Writing to file /builds/slave/test/properties/build_url 14:22:46 INFO - Contents: 14:22:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:22:47 INFO - Running post-action listener: _resource_record_post_action 14:22:47 INFO - Running post-action listener: set_extra_try_arguments 14:22:47 INFO - [mozharness: 2016-10-03 21:22:47.630400Z] Finished download-and-extract step (success) 14:22:47 INFO - [mozharness: 2016-10-03 21:22:47.630552Z] Running populate-webroot step. 14:22:47 INFO - Running pre-action listener: _resource_record_pre_action 14:22:47 INFO - Running main action method: populate_webroot 14:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:22:47 INFO - '--tppagecycles', 14:22:47 INFO - '7'], 14:22:47 INFO - 'tests': ['tsvgm']}}, 14:22:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:22:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:22:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:22:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['damp', 'tps']}, 14:22:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'tests': ['damp', 'tps']}, 14:22:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['dromaeo_dom']}, 14:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:22:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['basic_compositor_video']}, 14:22:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:22:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['a11yr', 14:22:47 INFO - 'ts_paint', 14:22:47 INFO - 'tpaint', 14:22:47 INFO - 'sessionrestore', 14:22:47 INFO - 'sessionrestore_no_auto_restore', 14:22:47 INFO - 'tabpaint']}, 14:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 14:22:47 INFO - 'ts_paint', 14:22:47 INFO - 'tpaint', 14:22:47 INFO - 'sessionrestore', 14:22:47 INFO - 'sessionrestore_no_auto_restore', 14:22:47 INFO - 'tabpaint']}, 14:22:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:22:47 INFO - 'ts_paint', 14:22:47 INFO - 'tpaint', 14:22:47 INFO - 'sessionrestore', 14:22:47 INFO - 'sessionrestore_no_auto_restore', 14:22:47 INFO - 'tabpaint']}, 14:22:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:22:47 INFO - 'ts_paint', 14:22:47 INFO - 'tpaint', 14:22:47 INFO - 'sessionrestore', 14:22:47 INFO - 'sessionrestore_no_auto_restore', 14:22:47 INFO - 'tabpaint']}, 14:22:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['a11yr', 14:22:47 INFO - 'ts_paint', 14:22:47 INFO - 'tpaint', 14:22:47 INFO - 'sessionrestore', 14:22:47 INFO - 'sessionrestore_no_auto_restore', 14:22:47 INFO - 'tabpaint']}, 14:22:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['a11yr', 14:22:47 INFO - 'ts_paint', 14:22:47 INFO - 'tpaint', 14:22:47 INFO - 'sessionrestore', 14:22:47 INFO - 'sessionrestore_no_auto_restore', 14:22:47 INFO - 'tabpaint']}, 14:22:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['tsvgx', 14:22:47 INFO - 'tsvgr_opacity', 14:22:47 INFO - 'tart', 14:22:47 INFO - 'tscrollx', 14:22:47 INFO - 'cart']}, 14:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:22:47 INFO - 'tsvgr_opacity', 14:22:47 INFO - 'tart', 14:22:47 INFO - 'tscrollx', 14:22:47 INFO - 'cart']}, 14:22:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'talos_options': ['--disable-e10s'], 14:22:47 INFO - 'tests': ['tp5o']}, 14:22:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'tests': ['tp5o']}, 14:22:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'talos_options': ['--disable-e10s', 14:22:47 INFO - '--xperf_path', 14:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:47 INFO - 'tests': ['tp5n']}, 14:22:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:47 INFO - 'talos_options': ['--xperf_path', 14:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:47 INFO - 'tests': ['tp5n']}}, 14:22:47 INFO - 'talos.zip': {'path': '', 14:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:22:47 INFO - Running post-action listener: _resource_record_post_action 14:22:47 INFO - [mozharness: 2016-10-03 21:22:47.649241Z] Finished populate-webroot step (success) 14:22:47 INFO - [mozharness: 2016-10-03 21:22:47.649382Z] Running create-virtualenv step. 14:22:47 INFO - Running pre-action listener: _resource_record_pre_action 14:22:47 INFO - Running main action method: create_virtualenv 14:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 14:22:47 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 14:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:22:47 INFO - Using real prefix '/tools/python27' 14:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:22:48 INFO - Installing distribute.............................................................................................................................................................................................done. 14:22:51 INFO - Installing pip.................done. 14:22:51 INFO - Return code: 0 14:22:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:22:51 INFO - Reading from file tmpfile_stdout 14:22:51 INFO - Output received: 14:22:51 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) 14:22:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:51 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:22:51 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 14:22:51 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 14:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:51 INFO - 'HOME': '/Users/cltbld', 14:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:51 INFO - 'LOGNAME': 'cltbld', 14:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:51 INFO - 'MOZ_NO_REMOTE': '1', 14:22:51 INFO - 'NO_EM_RESTART': '1', 14:22:51 INFO - 'PAGER': '/bin/cat', 14:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:51 INFO - 'PWD': '/builds/slave/test', 14:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:51 INFO - 'SHELL': '/bin/bash', 14:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:22:51 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:51 INFO - 'USER': 'cltbld', 14:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:51 INFO - 'XPC_FLAGS': '0x0', 14:22:51 INFO - 'XPC_SERVICE_NAME': '0', 14:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:51 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 14:22:51 INFO - Cleaning up... 14:22:51 INFO - Return code: 0 14:22:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:51 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:22:51 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 14:22:51 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 14:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:51 INFO - 'HOME': '/Users/cltbld', 14:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:51 INFO - 'LOGNAME': 'cltbld', 14:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:51 INFO - 'MOZ_NO_REMOTE': '1', 14:22:51 INFO - 'NO_EM_RESTART': '1', 14:22:51 INFO - 'PAGER': '/bin/cat', 14:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:51 INFO - 'PWD': '/builds/slave/test', 14:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:51 INFO - 'SHELL': '/bin/bash', 14:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:22:51 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:51 INFO - 'USER': 'cltbld', 14:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:51 INFO - 'XPC_FLAGS': '0x0', 14:22:51 INFO - 'XPC_SERVICE_NAME': '0', 14:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:52 INFO - Downloading/unpacking psutil>=3.1.1 14:22:52 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 14:22:52 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 14:22:52 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 14:22:52 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 14:22:52 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 14:22:52 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 14:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:55 INFO - Installing collected packages: psutil 14:22:55 INFO - Running setup.py install for psutil 14:22:55 INFO - building 'psutil._psutil_osx' extension 14:22:55 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 14:22:56 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 14:22:56 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 14:22:56 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 14:22:56 INFO - building 'psutil._psutil_posix' extension 14:22:56 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 14:22:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:22:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:22:56 INFO - ^ 14:22:56 INFO - 1 warning generated. 14:22:56 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 14:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:56 INFO - Successfully installed psutil 14:22:56 INFO - Cleaning up... 14:22:56 INFO - Return code: 0 14:22:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:22:56 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')]} 14:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:56 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')]} 14:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:56 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:22:56 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 14:22:56 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 14:22:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:22:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:56 INFO - 'HOME': '/Users/cltbld', 14:22:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:56 INFO - 'LOGNAME': 'cltbld', 14:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:56 INFO - 'MOZ_NO_REMOTE': '1', 14:22:56 INFO - 'NO_EM_RESTART': '1', 14:22:56 INFO - 'PAGER': '/bin/cat', 14:22:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:56 INFO - 'PWD': '/builds/slave/test', 14:22:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:56 INFO - 'SHELL': '/bin/bash', 14:22:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:22:56 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:22:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:56 INFO - 'USER': 'cltbld', 14:22:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:56 INFO - 'XPC_FLAGS': '0x0', 14:22:56 INFO - 'XPC_SERVICE_NAME': '0', 14:22:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:22:59 INFO - Installing collected packages: mozsystemmonitor 14:22:59 INFO - Running setup.py install for mozsystemmonitor 14:22:59 INFO - Successfully installed mozsystemmonitor 14:22:59 INFO - Cleaning up... 14:22:59 INFO - Return code: 0 14:22:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:22:59 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')]} 14:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:59 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')]} 14:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:59 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:22:59 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 14:22:59 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 14:22:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:22:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:59 INFO - 'HOME': '/Users/cltbld', 14:22:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:59 INFO - 'LOGNAME': 'cltbld', 14:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:59 INFO - 'MOZ_NO_REMOTE': '1', 14:22:59 INFO - 'NO_EM_RESTART': '1', 14:22:59 INFO - 'PAGER': '/bin/cat', 14:22:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:59 INFO - 'PWD': '/builds/slave/test', 14:22:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:59 INFO - 'SHELL': '/bin/bash', 14:22:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:22:59 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:22:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:59 INFO - 'USER': 'cltbld', 14:22:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:59 INFO - 'XPC_FLAGS': '0x0', 14:22:59 INFO - 'XPC_SERVICE_NAME': '0', 14:22:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:00 INFO - Downloading/unpacking jsonschema==2.5.1 14:23:00 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 14:23:00 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 14:23:00 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 14:23:00 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 14:23:00 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 14:23:00 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 14:23:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:02 INFO - warning: no files found matching '*.txt' 14:23:02 INFO - no previously-included directories found matching 'build' 14:23:02 INFO - no previously-included directories found matching 'dist' 14:23:02 INFO - no previously-included directories found matching '.git*' 14:23:03 INFO - Installing collected packages: jsonschema, functools32 14:23:03 INFO - Running setup.py install for functools32 14:23:03 INFO - warning: no files found matching '*.txt' 14:23:03 INFO - no previously-included directories found matching 'build' 14:23:03 INFO - no previously-included directories found matching 'dist' 14:23:03 INFO - no previously-included directories found matching '.git*' 14:23:03 INFO - Successfully installed jsonschema functools32 14:23:03 INFO - Cleaning up... 14:23:03 INFO - Return code: 0 14:23:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:23:03 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')]} 14:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:03 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')]} 14:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:03 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:23:03 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 14:23:03 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 14:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:03 INFO - 'HOME': '/Users/cltbld', 14:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:03 INFO - 'LOGNAME': 'cltbld', 14:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:03 INFO - 'MOZ_NO_REMOTE': '1', 14:23:03 INFO - 'NO_EM_RESTART': '1', 14:23:03 INFO - 'PAGER': '/bin/cat', 14:23:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:03 INFO - 'PWD': '/builds/slave/test', 14:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:03 INFO - 'SHELL': '/bin/bash', 14:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:23:03 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:03 INFO - 'USER': 'cltbld', 14:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:03 INFO - 'XPC_FLAGS': '0x0', 14:23:03 INFO - 'XPC_SERVICE_NAME': '0', 14:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:23:03 INFO - Cleaning up... 14:23:03 INFO - Return code: 0 14:23:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:03 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')]} 14:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:03 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')]} 14:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:03 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:23:03 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 14:23:03 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 14:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:03 INFO - 'HOME': '/Users/cltbld', 14:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:03 INFO - 'LOGNAME': 'cltbld', 14:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:03 INFO - 'MOZ_NO_REMOTE': '1', 14:23:03 INFO - 'NO_EM_RESTART': '1', 14:23:03 INFO - 'PAGER': '/bin/cat', 14:23:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:03 INFO - 'PWD': '/builds/slave/test', 14:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:03 INFO - 'SHELL': '/bin/bash', 14:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:23:03 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:03 INFO - 'USER': 'cltbld', 14:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:03 INFO - 'XPC_FLAGS': '0x0', 14:23:03 INFO - 'XPC_SERVICE_NAME': '0', 14:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 14:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:07 INFO - Downloading docopt-0.6.1.tar.gz 14:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:07 INFO - Running setup.py install for blobuploader 14:23:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:07 INFO - Running setup.py install for requests 14:23:08 INFO - Running setup.py install for docopt 14:23:08 INFO - Successfully installed blobuploader requests docopt 14:23:08 INFO - Cleaning up... 14:23:08 INFO - Return code: 0 14:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:08 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:23:08 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 14:23:08 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 14:23:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:23:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:08 INFO - 'HOME': '/Users/cltbld', 14:23:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:08 INFO - 'LOGNAME': 'cltbld', 14:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:08 INFO - 'MOZ_NO_REMOTE': '1', 14:23:08 INFO - 'NO_EM_RESTART': '1', 14:23:08 INFO - 'PAGER': '/bin/cat', 14:23:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:08 INFO - 'PWD': '/builds/slave/test', 14:23:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:08 INFO - 'SHELL': '/bin/bash', 14:23:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:23:08 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:23:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:08 INFO - 'USER': 'cltbld', 14:23:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:08 INFO - 'XPC_FLAGS': '0x0', 14:23:08 INFO - 'XPC_SERVICE_NAME': '0', 14:23:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ur32tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-p0jk_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-4LkDC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-kL8q9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ZbAJbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-6zAR7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rHOxsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-W252sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-BwsMht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-vORAFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jABfXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-DvYw2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ntHSgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-a7PklE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-qcLk8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-PiwCrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:10 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-XDNLGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:10 INFO - Running setup.py install for manifestparser 14:23:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:10 INFO - Running setup.py install for mozcrash 14:23:10 INFO - Running setup.py install for mozdebug 14:23:10 INFO - Running setup.py install for mozdevice 14:23:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Running setup.py install for mozfile 14:23:11 INFO - Running setup.py install for mozhttpd 14:23:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Running setup.py install for mozinfo 14:23:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Running setup.py install for mozInstall 14:23:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:11 INFO - Running setup.py install for mozleak 14:23:11 INFO - Running setup.py install for mozlog 14:23:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:12 INFO - Running setup.py install for moznetwork 14:23:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:12 INFO - Running setup.py install for mozprocess 14:23:12 INFO - Running setup.py install for mozprofile 14:23:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:12 INFO - Running setup.py install for mozrunner 14:23:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:12 INFO - Running setup.py install for mozscreenshot 14:23:12 INFO - Running setup.py install for moztest 14:23:12 INFO - Running setup.py install for mozversion 14:23:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:13 INFO - Cleaning up... 14:23:13 INFO - Return code: 0 14:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:13 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:23:13 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 14:23:13 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 14:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:13 INFO - 'HOME': '/Users/cltbld', 14:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:13 INFO - 'LOGNAME': 'cltbld', 14:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:13 INFO - 'MOZ_NO_REMOTE': '1', 14:23:13 INFO - 'NO_EM_RESTART': '1', 14:23:13 INFO - 'PAGER': '/bin/cat', 14:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:13 INFO - 'PWD': '/builds/slave/test', 14:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:13 INFO - 'SHELL': '/bin/bash', 14:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:23:13 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:13 INFO - 'USER': 'cltbld', 14:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:13 INFO - 'XPC_FLAGS': '0x0', 14:23:13 INFO - 'XPC_SERVICE_NAME': '0', 14:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-e61nce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:13 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)) 14:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-YtSMTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:13 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)) 14:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-WLf0xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:13 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)) 14:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-0WHWm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:13 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)) 14:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-3pBSYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:13 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)) 14:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:13 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-njuyTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-8QUDpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-PWKgf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-HC_g_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-1hEDxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-UtpQfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-9oz5mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-5v6yMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-8bJkAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Pe9hP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:14 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)) 14:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:14 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-zcVdzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:15 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)) 14:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:15 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-52446b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:15 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)) 14:23:15 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)) 14:23:15 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)) 14:23:15 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)) 14:23:15 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)) 14:23:15 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)) 14:23:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:15 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 14:23:15 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 14:23:15 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 14:23:15 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 14:23:15 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 14:23:15 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 14:23:17 INFO - Downloading blessings-1.6.tar.gz 14:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:18 INFO - Installing collected packages: blessings 14:23:18 INFO - Running setup.py install for blessings 14:23:18 INFO - Successfully installed blessings 14:23:18 INFO - Cleaning up... 14:23:18 INFO - Return code: 0 14:23:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:18 INFO - Reading from file tmpfile_stdout 14:23:18 INFO - Current package versions: 14:23:18 INFO - blessings == 1.6 14:23:18 INFO - blobuploader == 1.2.4 14:23:18 INFO - docopt == 0.6.1 14:23:18 INFO - functools32 == 3.2.3-2 14:23:18 INFO - jsonschema == 2.5.1 14:23:18 INFO - manifestparser == 1.1 14:23:18 INFO - mozInstall == 1.12 14:23:18 INFO - mozcrash == 0.17 14:23:18 INFO - mozdebug == 0.1 14:23:18 INFO - mozdevice == 0.48 14:23:18 INFO - mozfile == 1.2 14:23:18 INFO - mozhttpd == 0.7 14:23:18 INFO - mozinfo == 0.9 14:23:18 INFO - mozleak == 0.1 14:23:18 INFO - mozlog == 3.4 14:23:18 INFO - moznetwork == 0.27 14:23:18 INFO - mozprocess == 0.23 14:23:18 INFO - mozprofile == 0.28 14:23:18 INFO - mozrunner == 6.12 14:23:18 INFO - mozscreenshot == 0.1 14:23:18 INFO - mozsystemmonitor == 0.3 14:23:18 INFO - moztest == 0.7 14:23:18 INFO - mozversion == 1.4 14:23:18 INFO - psutil == 3.1.1 14:23:18 INFO - requests == 1.2.3 14:23:18 INFO - wsgiref == 0.1.2 14:23:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:18 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:23:18 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 14:23:18 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 14:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:19 INFO - 'HOME': '/Users/cltbld', 14:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:19 INFO - 'LOGNAME': 'cltbld', 14:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:19 INFO - 'MOZ_NO_REMOTE': '1', 14:23:19 INFO - 'NO_EM_RESTART': '1', 14:23:19 INFO - 'PAGER': '/bin/cat', 14:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:19 INFO - 'PWD': '/builds/slave/test', 14:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:19 INFO - 'SHELL': '/bin/bash', 14:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:23:19 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:19 INFO - 'USER': 'cltbld', 14:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:19 INFO - 'XPC_FLAGS': '0x0', 14:23:19 INFO - 'XPC_SERVICE_NAME': '0', 14:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 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)) 14:23:19 INFO - Cleaning up... 14:23:19 INFO - Return code: 0 14:23:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:19 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')]} 14:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:19 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')]} 14:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:19 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 0x10e1e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e156570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2e0c9e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, '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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 14:23:19 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 14:23:19 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 14:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:19 INFO - 'HOME': '/Users/cltbld', 14:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:19 INFO - 'LOGNAME': 'cltbld', 14:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:19 INFO - 'MOZ_NO_REMOTE': '1', 14:23:19 INFO - 'NO_EM_RESTART': '1', 14:23:19 INFO - 'PAGER': '/bin/cat', 14:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:19 INFO - 'PWD': '/builds/slave/test', 14:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:19 INFO - 'SHELL': '/bin/bash', 14:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:23:19 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:19 INFO - 'USER': 'cltbld', 14:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:19 INFO - 'XPC_FLAGS': '0x0', 14:23:19 INFO - 'XPC_SERVICE_NAME': '0', 14:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:23:19 INFO - Cleaning up... 14:23:19 INFO - Return code: 0 14:23:19 INFO - Running post-action listener: _resource_record_post_action 14:23:19 INFO - Running post-action listener: _start_resource_monitoring 14:23:19 INFO - Starting resource monitoring. 14:23:19 INFO - [mozharness: 2016-10-03 21:23:19.571161Z] Finished create-virtualenv step (success) 14:23:19 INFO - [mozharness: 2016-10-03 21:23:19.572136Z] Running install step. 14:23:19 INFO - Running pre-action listener: _resource_record_pre_action 14:23:19 INFO - Running main action method: install 14:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:19 INFO - Reading from file tmpfile_stdout 14:23:19 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:19 INFO - Reading from file tmpfile_stdout 14:23:19 INFO - Output received: 14:23:19 INFO - Usage: mozinstall [options] installer 14:23:19 INFO - Options: 14:23:19 INFO - -h, --help show this help message and exit 14:23:19 INFO - -d DEST, --destination=DEST 14:23:19 INFO - Directory to install application into. [default: 14:23:19 INFO - "/builds/slave/test"] 14:23:19 INFO - --app=APP Application being installed. [default: firefox] 14:23:19 INFO - mkdir: /builds/slave/test/build/application 14:23:19 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'] 14:23:19 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 14:23:54 INFO - Reading from file tmpfile_stdout 14:23:54 INFO - Output received: 14:23:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:23:54 INFO - Running post-action listener: _resource_record_post_action 14:23:54 INFO - [mozharness: 2016-10-03 21:23:54.453324Z] Finished install step (success) 14:23:54 INFO - [mozharness: 2016-10-03 21:23:54.453480Z] Running run-tests step. 14:23:54 INFO - Running pre-action listener: _resource_record_pre_action 14:23:54 INFO - Running main action method: run_tests 14:23:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:23:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:23:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:23:54 INFO - 2016-10-03 14:23:54.465 screenresolution[1637:7628] starting screenresolution argv=screenresolution get 14:23:54 INFO - 2016-10-03 14:23:54.468 screenresolution[1637:7628] Display 0: 1600x1200x32@60 14:23:54 INFO - 2016-10-03 14:23:54.473 screenresolution[1638:7631] starting screenresolution argv=screenresolution list 14:23:54 INFO - Available Modes on Display 0 14:23:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:23:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:23:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:23:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:23:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:23:54 INFO - Intel Iris: 14:23:54 INFO - Chipset Model: Intel Iris 14:23:54 INFO - Type: GPU 14:23:54 INFO - Bus: Built-In 14:23:54 INFO - VRAM (Dynamic, Max): 1536 MB 14:23:54 INFO - Vendor: Intel (0x8086) 14:23:54 INFO - Device ID: 0x0a2e 14:23:54 INFO - Revision ID: 0x0009 14:23:54 INFO - Displays: 14:23:54 INFO - Display: 14:23:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:23:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:23:54 INFO - Display Serial Number: 1600x1200 60 14:23:54 INFO - Main Display: Yes 14:23:54 INFO - Mirror: Off 14:23:54 INFO - Online: Yes 14:23:54 INFO - Rotation: Supported 14:23:54 INFO - Return code: 0 14:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:54 INFO - Python 2.7.3 14:23:54 INFO - Return code: 0 14:23:54 INFO - grabbing minidump binary from tooltool 14:23:54 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')]} 14:23:54 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 0x10dff4d30>, '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 0x10de1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfecb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:54 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 14:23:54 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 14:23:54 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 14:23:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:54 INFO - Return code: 0 14:23:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:23:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:23:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 14:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 14:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsvLgfNg1d/Render', 14:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:54 INFO - 'HOME': '/Users/cltbld', 14:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:54 INFO - 'LOGNAME': 'cltbld', 14:23:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:54 INFO - 'MOZ_NO_REMOTE': '1', 14:23:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:54 INFO - 'NO_EM_RESTART': '1', 14:23:54 INFO - 'PAGER': '/bin/cat', 14:23:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:54 INFO - 'PWD': '/builds/slave/test', 14:23:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:54 INFO - 'SHELL': '/bin/bash', 14:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1ZndQfrhfH/Listeners', 14:23:54 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 14:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:54 INFO - 'USER': 'cltbld', 14:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:54 INFO - 'XPC_FLAGS': '0x0', 14:23:54 INFO - 'XPC_SERVICE_NAME': '0', 14:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 14:23:55 INFO - mozversion application_buildid: 20161003122159 14:23:55 INFO - mozversion application_changeset: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e 14:23:55 INFO - mozversion application_display_name: Nightly 14:23:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:55 INFO - mozversion application_name: Firefox 14:23:55 INFO - mozversion application_remotingname: firefox 14:23:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:23:55 INFO - mozversion application_vendor: Mozilla 14:23:55 INFO - mozversion application_version: 52.0a1 14:23:55 INFO - mozversion platform_buildid: 20161003122159 14:23:55 INFO - mozversion platform_changeset: e8f4dc9c44cc79fcc35913c8d87063dfabbe127e 14:23:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:23:55 INFO - mozversion platform_version: 52.0a1 14:23:55 INFO - using testdate: 1475529835 14:23:55 INFO - actual date: 1475529835 14:23:55 INFO - starting webserver on 'localhost:49272' 14:23:55 INFO - SUITE-START | Running 2 tests 14:23:55 INFO - TEST-START | dromaeo_css 14:23:55 INFO - operating with platform_type : mac_ 14:23:55 INFO - Initialising browser for dromaeo_css test... 14:23:55 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpabKZ6r/profile http://localhost:49272/getInfo.html) 14:23:57 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 14:23:57 INFO - PROCESS | 1648 | colorDepth:24 14:23:57 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 14:23:57 INFO - PROCESS | 1648 | __metrics 14:23:57 INFO - PROCESS | 1648 | 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" 14:23:57 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:58 INFO - TEST-INFO | 1648: exit 0 14:23:58 INFO - Browser initialized. 14:23:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:23:58 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpabKZ6r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:10 INFO - PROCESS | 1650 | RSS: Main: 235974656 14:24:10 INFO - PROCESS | 1650 | 14:25:01 INFO - PROCESS | 1650 | 1475529901922 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] 14:27:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 14:27:16 INFO - PROCESS | 1650 | RSS: Main: 440131584 14:27:16 INFO - PROCESS | 1650 | 14:30:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 14:30:20 INFO - PROCESS | 1650 | RSS: Main: 373202944 14:30:20 INFO - PROCESS | 1650 | 14:33:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 14:33:23 INFO - PROCESS | 1650 | RSS: Main: 358907904 14:33:23 INFO - PROCESS | 1650 | 14:36:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 14:36:26 INFO - PROCESS | 1650 | RSS: Main: 337588224 14:36:26 INFO - PROCESS | 1650 | 14:39:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 14:39:30 INFO - PROCESS | 1650 | RSS: Main: 334536704 14:39:30 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 14:42:33 INFO - PROCESS | 1650 | RSS: Main: 372944896 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | __start_tp_report 14:42:33 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 14:42:33 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 14:42:33 INFO - PROCESS | 1650 | |i|pagename|runs| 14:42:33 INFO - PROCESS | 1650 | |0;dojo.html;2923.9415211695755;3331.050650564588;3334.216459132104;3346.665333466652;3394.864205431783;5636.070048442002;5742.138679198117;5778.451047150525;5813.098969659699;5818.709064546777;5740.253767010293;5762.971185144069;5895.587308888369;5920.733566989485;5924.58527903047;5073;5120.4623514530995;5177.249298851664;5206.531412172903;5240.082985477527;5302.469753024705;5306.7611957462;5313.867153321159;5326.094563924123;5327.227552004957;5264.447233040514;5268.683878967274;5310.203469479589;5358.705271210082;5371.946280537184;5098.617603679739;5174.586033117342;5193.1171700810955;5232.110541207966;5237.921431178497;5153.175491921274;5163.760697432626;5176.275321454999;5206.219067139959;5206.297149884755;5731.168980497846;5741.081426971707;5760.8847823043725;5775.1337299405;5788.6816225107605;6100.066499260575;6123.069409073481;6134.314131579348;6147.692615369214;6177.351378105324;6080.726367313481;6084.087386891957;6089.6041757286075;6099.451049405575;6117.694115294262;5635.351934527582;5802.767889284381;5853.619514731571;5865.944130056588;5876.412358764175;5426.294581704353;6189.721462534197;6190.721417536221;6193.876122477525;6254.21822272216;6116.969415152896;6119.173911521976;6131.448169664752;6135.662538560422;6137.84655383619;6221.129041934133;6278.4035516625845;6281.152044474029;6282.905756413657;6285.685715714196;6022.789202377983;6093.177421048191;6101.267847858286;6102.084687296941;6158.3841615838055;6199.876002479925;6241.251049874044;6248.156498872594;6253.906191407133;6270.122182894398;4917.262410638433;4924.778384972685;4933.235348520985;4935.679180853233;4966.205407134841;4365.03969126798;4367.890802729958;4376.299792033259;4404.6256068233915;4444.644428445717;5700.144978253295;5711.086226203787;5712.285964254468;5719.542436605062;5729.1119876419225;6180.443760061616;6187.628742275478;6204.038374052029;6221.09794079865;6225.533085018642;5725.627834190765;5730.799422020293;5735.913961290584;5740.54075673945;5743.741531631086;5330.200469929541;5359;5365.382980957162;5367;5381.811636592701;6080.14877917092;6148.493619063358;6223.751049957951;6236.594621349598;6237.937620623736;6172.907406388818;6201.96899015502;6206.224221972254;6206.410391012847;6268.874622507616;5552.139418390156;6220.502359811114;6249.750009999549;6265;6267.310595834363;6138.57051894304;6166.753329866934;6176.042713379434;6186.072089186658;6204.751809927552;5090.185570308733;6087.117367981707;6133.854967164949;6157.815265542041;6220.937790622217;6056.031035034373;6088.086786981989;6130.846728831815;6132.509399247961;6140.447359737466;5930.52555795544;6059.848503787441;6087.026075827846;6092.482139018233;6097.054956481752;5744.597878148489;5803.042497987784;5819.330776960534;5917.940820591739;5931.851703707442;6008.489278411384;6012.969935150296;6039.486643635164;6049.243844519435;6052.243469566304;5873;5889;5892.234009578728;5898.174255604305;5909.52723782105 14:42:33 INFO - PROCESS | 1650 | |1;ext.html;457.82373786092364;479.47018544508296;501.6012270245155;503.3280570438465;535.6491498068766;34522;39805.805825825235;39817.60182398182;39905.401418978705;41801.372979405256;40380.394294085614;40597.797011014976;40601.59398406015;40708.77873663795;40760.79619601905;8657.740267791976;8843;9592.424454532733;9767.462789546573;9790.21678265737;10499.947500262526;11623.6512904613;11869.703257418547;11921.225120367191;12036.157468977131;11735.354555499443;11739.823902641467;11831.526738930432;11889.940550297237;11917.284962902253;8703.52130632815;8951.104889511062;11734.589289374873;11784.234024788404;11814.17300788945;11471.942640286745;11811.822822657667;11813.822792658117;11925.522979080826;11926.58256961011;38918;39303;39355.80322098371;39368.80315598404;39431.802840985896;3232.498962660791;3301.983490082558;3329.5338652588416;3353.916152096217;3453.620101788801;30119.548206776915;30437.543436848464;31423.05730828079;31612.36775264505;31812.6818731812;3202.455582550972;3232.305054413289;3236.0453666168537;3268.4116858965376;3368.7473439492137;466355;467361;470982.12723409577;471092.99999999657;476850;58590;58853.70573147193;58886.705566471894;58906.11640825391;58973;59335.40664593299;59394;59408.405915941155;59434.811303773684;59518.40481595129;15736.527904162893;15926.76109858353;15949.840501594836;15959.962602430805;15974.440894568634;11193.104551636012;11499.827502587468;11517.963383295544;12409.875901241052;12456.501739930483;12018.218815776947;14318;14424.639384015483;15405;15831.050136991817;6219.471344935731;7226.6386680665755;7310.744123955742;7379.7048118075745;7383.593902335423;878.2534845381375;906.9183773460288;929.9767505812409;940.1867384712311;962.711186644004;26313.21060368192;29984.25039374033;30119.548206776915;30718;31443.528347074356;1014.9289549731448;1023.9641612543526;1025.6922423909425;1039.1946241662772;1101.9944900275607;14296.427392986763;14843.554693359216;14858.03422777516;14864.554063378117;15235.390584376722;614969;624502;625902;628935;630392;54319.18521222185;54590;54671.45328546743;54745.72627136918;54760.72619636876;1315.046591221357;1356.5794603672894;1370.164199838078;1371.8079468874366;1373.0731756064617;28208;28478.715212848434;28533.571996419654;28972.275693106996;29125;47654.52345476639;48087.75956120197;48091.03817923552;48102.27846582234;48146.03707925892;458327;459506;459694;460921.39078608784;461453;24434.51130977406;24589.262322130366;24789.380265493506;24889.128880489097;24972.375690607154;37637.81181094077;37654.62345376511;37888.242235155696;38264.426033608965;45522.54477455183;33870.66129338675;36366.63633363633;37353.879383618536;38547;38741.806290968365;36659.63340366669;36909.446358305184;37056;37884.81057594695;37954.051148721504;36646.816765916;37345.626543734215;37496.43755343727;37715.43426848654;37910.43134353042;28640.57039144373;28822.42355152843;29497.082689625106;33085.33829323448;33631;21324.680129798377;22850.31449056531;23521.52956940886;25129.623055654545;25143.582643119957 14:42:33 INFO - PROCESS | 1650 | |2;jquery.html;362.2664105186996;368.1422286073449;378.8181672797057;390.1027636436196;400.9679225661947;19298.421047368585;21620;21860.048893399387;22192.88903555482;22310.996005179764;20511.589768204663;20657.967101644896;21147.788522114774;21241.93790310486;21473.892630536866;5836.649423000394;5985.521158307347;6105;6152.0464328029;6172.4444799968;5671.489565939065;6016.33820279771;6158.599691020092;6163.876722465548;6174.166487524171;5987.072003839412;6087.939120608804;6090.786822461215;6091.725872335734;6105.877882442371;5864.325602555697;6008.849778755566;6082.9391706082815;6084.2090528231265;6086;5912.3496415394275;5916.201312822757;5918.526517878602;5930;5936.5250779937505;13282.269475178862;13321.333933303393;13575.321233938363;13670.93164534171;13764.31178441074;2164.729408823897;2206.7903549162966;2245.977540224593;2255.988720056406;2337.4740683346113;9590.42457452555;9937.602495900155;10198.541065652063;10373.273870829045;10513.948605139502;1754.9385771498064;1817.9454616361531;1837.1640903388925;1841.383136649224;1858.1916866163263;96713;123583.3820830899;124002;126913.36543317317;127769.36115319456;10884.61903833362;11235.15736319763;11349;11376.488058037408;11592.710182245512;14531.128132312095;14556.63608409777;14560.126392416489;14564.053336533092;14566.324872639781;8199.467034642728;8464.44981076228;8522.70170544028;8585.527795971282;8601.096884827128;7162.4986250962975;8424.957875210708;8425.060332465597;8428.4942903426;8631.611577478903;3844.615538446133;4370.890727731832;4491.1915855145735;4503.977480112579;4538.092381523708;1710.1192885663893;1846.6491366640296;1888.3202047262973;1896.459509039917;1916.1856211110223;717.5443593318281;745.3105877063695;833.6707000734676;912.2929729459589;1009.3893194617151;18361.540961475803;20250.392488225083;21558;21725.45686357822;21957.67063494049;895.6238379880335;949.4635530925005;955.1785464500524;977.9168770654431;1009.5406590001531;10654.242664552066;11171.16216283782;11237.157213209042;11249.66251012471;11272.380019099028;592877;597410;600134;607942;614059;76201;129053;131307;133477.99783003263;138408.30795845957;959.8128364968765;968.9370190937567;1013.4679293370892;1013.9797204056025;1014.1430491234747;14810.925945370203;18933.90533047326;19171.616567668847;19678.622496425687;19824.504387390432;51142;52654.73672631766;55151.79392824403;55878.44121558895;57639.423605763404;73860;74561;76426.23573764414;79684;79838;7643.273888980538;7772.727954521791;7775.22247775218;7941.324987376138;8160.8775868360835;8786.16531429513;9901.653442129491;11390.544378224778;11996.16026878145;12673.493060277486;10210.183185345006;10508.632197873038;10883.564657413615;11162.888371116509;11194.160437967023;10904.672859814218;10916.727081823017;10939.45302734876;11122.165837562054;11513.424328783694;9650.420974741539;10004.399736015863;11046.502907369348;11396.886031139915;11598.71003224926;6880.311968803079;7273.199948005821;7317.231690672403;7449.813754656177;8108.918910810817;9674.823164787866;10937.507812148631;10942.124630029737;11175.161862860155;11305.26515776472 14:42:33 INFO - PROCESS | 1650 | |3;mootools.html;1394.456162096782;1509.1473317575565;1704.5227336345827;1859.172668162668;1917.7602799650053;8119.14748951359;8611.009733880606;9118.908810911906;9133.451992880431;9148.359614826964;8078.111407745143;8571;8831.558422078902;8832.160944710258;8962.462252264868;2359.8230132740027;2387.85672859629;2392.425817803732;2392.736798952114;2396.940076498084;2046.5599896022352;2088.049937278542;2330.2892617751577;2382.0828980842416;2387.033251533132;1924.393815947979;2159.3198142585115;2196.6595177747477;2198.7141671582754;2272.749997500274;2344.4607740219676;2375.4180225844607;2375.4892698069825;2376.9049238030457;2377.702787151606;2339.5905716499715;2346.272655476808;2369.5497855407416;2372.0986025310444;2377.8216633752363;8856.911430885673;8943.329250306253;8951;8957.104289571056;8964.955175224082;5304.045271851065;5381.300430943952;5450.073487507133;5465.945340546623;5467.507924286793;3266.934661306784;3375.7468189885612;3411.8635254589785;3416.0776590320474;3422.401079811023;1046.9057784799404;1094.316052467208;1112.8775834658181;1115.4924509348227;1119.054399032816;11638.883611163865;11816.527338906433;11826.586069487526;11831.053515718722;11832.112591555582;4615.330777037311;4709.576138147583;4875.585575226075;4928.043174095514;4953.455119936804;9291.907080929239;9355.53222338894;9369.156775890066;9372.1565059145;9393.483358415353;5319.069162896478;5320.946790532123;5328.200769884471;5333.653312534673;5335.62650614461;4670.486246512881;4783.402074740658;4867.7322747249245;4967.40391153064;4971.005798840247;3750.7562008469363;3814.6376094271;3832.885013449601;3874.6900247980093;3901.5318161820765;1167;1175.1010476985114;1176.423552459306;1179.8053321201905;1181.1023622047305;763.7785042337771;836.3267569606404;894.6779159502574;908.2597682888425;938.7512309238058;5303.840884773463;5711.628744131618;5735.705717712948;5910.645361278337;6091.51267898567;882.6337070115958;890.4612709310774;890.670451932789;938.2634631813993;989.9109080182674;3629.8003609801713;3787.4318852172396;3915.275674000319;3938.15329704115;4038.0510580013674;10587.735306617242;10845.620403285848;10973.945130274456;10977.012068913837;11017.83473247902;10924.289921155258;10928.180386471047;10949.233553651167;10949.726256843483;10974.615888444026;8216.589170541449;8348.457350272212;8350.70772522971;8353.540555269397;8369.832603347899;5520.392756796829;5747.683877386784;5880.558958078247;5915.58590898633;5975.37258587842;9968.800623987625;9995.700558927292;10207.387556746618;10243.33418327836;10259.84610230862;9906.900930990598;10270.845937310796;10281.074703276741;10285;10293.74265643365;7069.434445244471;7196.028536147763;7198.964005179941;7200.171980222132;7203.459740519377;8198.1391953844;8318.667253310043;8324.458910170819;8330.708425205088;8367.372447066373;5086;7173.784786456415;7217.566945983048;7370.22612625688;7657.310842024244;6071.787487437919;7115.67979440916;7261.745838895613;7263.455240856852;7309.4152467803515;7038.718451262097;7137.464690148364;7138.85722285541;7144.714211431692;7156.785296441115;4869.756512174306;4909.4354149273295;5033.597312215087;5046.84859454217;5211.973940130427;4939.333190019445;5027.321311622884;5083.38999320084;5142.948570514247;5190.40310364313 14:42:33 INFO - PROCESS | 1650 | |4;prototype.html;293.8868535613789;298.7072668784591;307.1063206070334;307.41897813133176;310.0466066844454;5039;5169.276301317814;5192;5220.791168353261;5222.4255331913555;4633.467151277604;4697.365855609501;4901.852944411665;5077.593792496601;5180.430152683211;3429.828508574574;4017.9307656556825;4037.7375470594466;4061.390791381287;4093.5087789465306;3534.399152144129;4061.3704875744306;4062.817173227197;4084.775337356444;4097.836086556535;3867.0471411936933;4004.3192657248337;4023.3964905264297;4032.1935612877396;4051.3315302974975;3400.7449441291756;3401.29935032485;4011.498562679665;4014.598540145991;4044.2315959967514;3102.8758849645988;3502.2470168913806;3504.8773292934625;3518.612952575215;3555.1690879197236;4715.858524244278;5079.282583817677;5081.415637201732;5103.362079740033;5169.767360468788;4371.650267978586;4557.376885376134;4570.451545814491;4597.885052873705;4690.530946905316;4618.745968971705;4726.621870250372;5211.0359583477175;5346.893062138735;5483.7806487740445;3358.8488518016748;3441.6558344165633;3862.7102967277565;3867.400552914303;3871.264459752638;5257.737113144328;5749;5751.878383715219;5774.855628609276;5809.622374545641;3352.1452029732263;3398.2863598644562;3874.6097164980642;3884.2425726983533;3893.649571538575;3704.814759262026;3758.677520851043;3970.285348637273;4013.5585085640555;4019.698522610757;3951.6443520082757;4451.287793952952;4608.631309495232;4643.117807616542;4675.205215113371;4766.976165119152;5541.473560011793;5586.022446071921;5641.73061061258;5655.0103731847585;1370.6019859743005;1381.5648070857649;1381.675306303018;1384.9612790407195;1385.9653508662363;862.4911302331654;889.7508697564692;898.6315610599622;917.5870858113742;932.3520153493392;5046.899062018812;5054.292399064134;5087.211482220262;5093.745312734349;5112.872178195575;4564.497905230422;4792.305115758196;5553.8333849984565;5579.721013949286;5670.994372982326;4786.319660989857;5003.649744517848;5062.974685126551;5076.451682236953;5178.585713142939;2829.066408085327;2950.9819112406617;2952.940941181207;2954.9113526594238;2964.333025069342;5215.921761173586;5440.3743569489225;5698.914516282259;5776.393478684761;5893.557983151195;5114.43741188469;5521.199426083276;5675.943240567542;5720.2849643794525;5744.253247077853;5718.3695500070435;5725.997950358754;5758.280214973129;5786.858862220921;5829.621074630136;5177.611679124006;5202.661826981234;5378.784848606012;5586;5619.466150715675;5253.579713622978;5492.340919089735;5498.642588231752;5500.86450723084;5534.861628459321;5187.351581052369;5750.827475175752;5765.971170144123;5771.509421699203;5801.477866991991;3350.782199157047;3471.461923401877;3617.764845285048;3819.3698039823116;3872.6252180476654;5614.361250212393;5672.376038635829;5759.46583503274;5765.019946609171;5804.804699793745;4982.327385802871;5529.33647962231;5533.612647114664;5546.4453554645825;5621.9156712650165;4342.956570434381;5181.53366197029;5309.973450132725;5506.843562851846;5513.476219759116;4926.802927882988;5360.16917377807;5385.676859388449;5410.458954104715;5417.268668729671;4933.284673722362;5426.321709786277;5457.754401051883;5570.805021824217;5627.296587926509;5514.2004409359615;5530.640508366943;5535.197396377584;5538.280023596906;5591.356993945748 14:42:33 INFO - PROCESS | 1650 | |5;yui.html;718.9676464559094;752.0411475368904;764.9196834332398;776.1081595432559;821.2608652213007;15168.317425715843;15944.282507287171;15952.52142435726;15989.200539973013;15993.960392574489;13553.390097445614;13560;13579.253141077237;13691;13725.45098196071;676.6650507998547;700.9929900701004;703.8416356319839;842.0232530264894;880.0451510111504;696.7805141380449;700.6531766775428;702.0872865275147;835.9832803343929;871.4945331707626;910.8497097978826;920.2453987730031;920.7928216151379;923.2706162131908;927.0312523413016;916.4363916191561;917.9495127767971;918.2562124678998;918.545320066568;918.7978644698155;529.5260741636253;687.3470203306829;687.5462194951358;688.1088989758275;689.4622194688151;12199;14140.575782726535;14723.263836808117;14731.852681473156;15014.699706005928;14176.645583860485;14798.852011479963;14853.183074930874;14889.329980150918;14895.10629362231;11729.648110556696;11783.94108029463;11791.11566632506;11800.527978880835;12033.92431886487;3799.67702745267;3806.2958352704836;3819.8281077351585;3901.590333015021;3955.208958208341;108665.45667271613;110668.4466577662;111445.88554114437;112231.99999999919;113846;11292.37891915936;11450.713732156597;11531.481083351102;11656.18406711522;11929;23420.414489637897;23452.413689657555;23462;23494.060237590646;23534.176303829285;7001.439884809305;7846.607669616496;7929.088154862149;7933.682652693943;8069.556174410346;4396.450443694538;4423.20382331177;4491.214037543416;4600.60894823937;4606.447226332862;3557.6975957043423;3680.0063982724514;3683.889483315505;3691.206390626028;3701.9629803702155;575.2119596153296;632.6299115017674;638.5849198021231;647.5467172978933;664.8603793203384;611.2695329081794;638.6008744534665;641.2337256977867;654.9815037616457;657.5692921136567;8140.715074972466;9389.436633801994;9392.577334019985;9433.811323773623;9447.811043779086;487.68056922715675;592.570386469806;643.3950702694111;648.8377905523619;679.1510611735331;4289.871303860889;4509.977450112794;4538.72767633943;4552.476465206478;4657.6273898088075;91460;118829.21756173664;150486;151466;156513;130876;130965;133704.33147834393;135216.32391837979;136586.317068416;111414.88585114207;113403.43298283455;113995;115455.42272288585;119108;8853.778655533662;8869.866951995855;8910.86633700508;9073.31950103758;9082;60970;61089;61164.77670446477;62903.6854815723;63163.36836631575;81392;88673;92441.07558924594;93058;93433.5328323354;10514.737131571772;11946.342951137423;11965.341906195243;11981.460834262305;12059;12903.870961290642;13081.215127092404;13186.934065329611;13215.933920330337;13404.597862064154;12081.531195625155;12170.208936419105;12197.390130493617;12408.937955310526;12574.497020119094;11718.88281117212;12183.208091474025;12260.75478490443;12295.631131066082;12499.437525311565;11698.76602467929;12057.336846473178;12063.879361206627;12192;12462.5014999399;10145.391276523433;10155.492225388552;10241.18070554339;10694.19793515505;10706.411147386969;10178.592856285666;10505.107065899485;10518.263721539419;10518.842217366899;10576.259661823906 14:42:33 INFO - PROCESS | 1650 | __end_tp_report 14:42:33 INFO - PROCESS | 1650 | __start_cc_report 14:42:33 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2176 14:42:33 INFO - PROCESS | 1650 | __end_cc_report 14:42:33 INFO - PROCESS | 1650 | __startTimestamp1475530953591__endTimestamp 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | ------- Summary: start ------- 14:42:33 INFO - PROCESS | 1650 | Number of tests: 6 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5712.47 Median:5898.17 stddev:629.94 (10.7%) stddev-sans-first:592.68 14:42:33 INFO - PROCESS | 1650 | Values: 2923.9 3331.1 3334.2 3346.7 3394.9 5636.1 5742.1 5778.5 5813.1 5818.7 5740.3 5763.0 5895.6 5920.7 5924.6 5073.0 5120.5 5177.2 5206.5 5240.1 5302.5 5306.8 5313.9 5326.1 5327.2 5264.4 5268.7 5310.2 5358.7 5371.9 5098.6 5174.6 5193.1 5232.1 5237.9 5153.2 5163.8 5176.3 5206.2 5206.3 5731.2 5741.1 5760.9 5775.1 5788.7 6100.1 6123.1 6134.3 6147.7 6177.4 6080.7 6084.1 6089.6 6099.5 6117.7 5635.4 5802.8 5853.6 5865.9 5876.4 5426.3 6189.7 6190.7 6193.9 6254.2 6117.0 6119.2 6131.4 6135.7 6137.8 6221.1 6278.4 6281.2 6282.9 6285.7 6022.8 6093.2 6101.3 6102.1 6158.4 6199.9 6241.3 6248.2 6253.9 6270.1 4917.3 4924.8 4933.2 4935.7 4966.2 4365.0 4367.9 4376.3 4404.6 4444.6 5700.1 5711.1 5712.3 5719.5 5729.1 6180.4 6187.6 6204.0 6221.1 6225.5 5725.6 5730.8 5735.9 5740.5 5743.7 5330.2 5359.0 5365.4 5367.0 5381.8 6080.1 6148.5 6223.8 6236.6 6237.9 6172.9 6202.0 6206.2 6206.4 6268.9 5552.1 6220.5 6249.8 6265.0 6267.3 6138.6 6166.8 6176.0 6186.1 6204.8 5090.2 6087.1 6133.9 6157.8 6220.9 6056.0 6088.1 6130.8 6132.5 6140.4 5930.5 6059.8 6087.0 6092.5 6097.1 5744.6 5803.0 5819.3 5917.9 5931.9 6008.5 6013.0 6039.5 6049.2 6052.2 5873.0 5889.0 5892.2 5898.2 5909.5 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:65127.78 Median:36506.73 stddev:139824.21 (383.0%) stddev-sans-first:140132.14 14:42:33 INFO - PROCESS | 1650 | Values: 457.8 479.5 501.6 503.3 535.6 34522.0 39805.8 39817.6 39905.4 41801.4 40380.4 40597.8 40601.6 40708.8 40760.8 8657.7 8843.0 9592.4 9767.5 9790.2 10499.9 11623.7 11869.7 11921.2 12036.2 11735.4 11739.8 11831.5 11889.9 11917.3 8703.5 8951.1 11734.6 11784.2 11814.2 11471.9 11811.8 11813.8 11925.5 11926.6 38918.0 39303.0 39355.8 39368.8 39431.8 3232.5 3302.0 3329.5 3353.9 3453.6 30119.5 30437.5 31423.1 31612.4 31812.7 3202.5 3232.3 3236.0 3268.4 3368.7 466355.0 467361.0 470982.1 471093.0 476850.0 58590.0 58853.7 58886.7 58906.1 58973.0 59335.4 59394.0 59408.4 59434.8 59518.4 15736.5 15926.8 15949.8 15960.0 15974.4 11193.1 11499.8 11518.0 12409.9 12456.5 12018.2 14318.0 14424.6 15405.0 15831.1 6219.5 7226.6 7310.7 7379.7 7383.6 878.3 906.9 930.0 940.2 962.7 26313.2 29984.3 30119.5 30718.0 31443.5 1014.9 1024.0 1025.7 1039.2 1102.0 14296.4 14843.6 14858.0 14864.6 15235.4 614969.0 624502.0 625902.0 628935.0 630392.0 54319.2 54590.0 54671.5 54745.7 54760.7 1315.0 1356.6 1370.2 1371.8 1373.1 28208.0 28478.7 28533.6 28972.3 29125.0 47654.5 48087.8 48091.0 48102.3 48146.0 458327.0 459506.0 459694.0 460921.4 461453.0 24434.5 24589.3 24789.4 24889.1 24972.4 37637.8 37654.6 37888.2 38264.4 45522.5 33870.7 36366.6 37353.9 38547.0 38741.8 36659.6 36909.4 37056.0 37884.8 37954.1 36646.8 37345.6 37496.4 37715.4 37910.4 28640.6 28822.4 29497.1 33085.3 33631.0 21324.7 22850.3 23521.5 25129.6 25143.6 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34653.61 Median:2296.73 stddev:100560.15 (4378.4%) stddev-sans-first:100809.28 14:42:33 INFO - PROCESS | 1650 | Values: 362.3 368.1 378.8 390.1 401.0 19298.4 21620.0 21860.0 22192.9 22311.0 20511.6 20658.0 21147.8 21241.9 21473.9 5836.6 5985.5 6105.0 6152.0 6172.4 5671.5 6016.3 6158.6 6163.9 6174.2 5987.1 6087.9 6090.8 6091.7 6105.9 5864.3 6008.8 6082.9 6084.2 6086.0 5912.3 5916.2 5918.5 5930.0 5936.5 13282.3 13321.3 13575.3 13670.9 13764.3 2164.7 2206.8 2246.0 2256.0 2337.5 9590.4 9937.6 10198.5 10373.3 10513.9 1754.9 1817.9 1837.2 1841.4 1858.2 96713.0 123583.4 124002.0 126913.4 127769.4 10884.6 11235.2 11349.0 11376.5 11592.7 14531.1 14556.6 14560.1 14564.1 14566.3 8199.5 8464.4 8522.7 8585.5 8601.1 7162.5 8425.0 8425.1 8428.5 8631.6 3844.6 4370.9 4491.2 4504.0 4538.1 1710.1 1846.6 1888.3 1896.5 1916.2 717.5 745.3 833.7 912.3 1009.4 18361.5 20250.4 21558.0 21725.5 21957.7 895.6 949.5 955.2 977.9 1009.5 10654.2 11171.2 11237.2 11249.7 11272.4 592877.0 597410.0 600134.0 607942.0 614059.0 76201.0 129053.0 131307.0 133478.0 138408.3 959.8 968.9 1013.5 1014.0 1014.1 14810.9 18933.9 19171.6 19678.6 19824.5 51142.0 52654.7 55151.8 55878.4 57639.4 73860.0 74561.0 76426.2 79684.0 79838.0 7643.3 7772.7 7775.2 7941.3 8160.9 8786.2 9901.7 11390.5 11996.2 12673.5 10210.2 10508.6 10883.6 11162.9 11194.2 10904.7 10916.7 10939.5 11122.2 11513.4 9650.4 10004.4 11046.5 11396.9 11598.7 6880.3 7273.2 7317.2 7449.8 8108.9 9674.8 10937.5 10942.1 11175.2 11305.3 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5693.16 Median:5030.46 stddev:3228.30 (64.2%) stddev-sans-first:3221.20 14:42:33 INFO - PROCESS | 1650 | Values: 1394.5 1509.1 1704.5 1859.2 1917.8 8119.1 8611.0 9118.9 9133.5 9148.4 8078.1 8571.0 8831.6 8832.2 8962.5 2359.8 2387.9 2392.4 2392.7 2396.9 2046.6 2088.0 2330.3 2382.1 2387.0 1924.4 2159.3 2196.7 2198.7 2272.7 2344.5 2375.4 2375.5 2376.9 2377.7 2339.6 2346.3 2369.5 2372.1 2377.8 8856.9 8943.3 8951.0 8957.1 8965.0 5304.0 5381.3 5450.1 5465.9 5467.5 3266.9 3375.7 3411.9 3416.1 3422.4 1046.9 1094.3 1112.9 1115.5 1119.1 11638.9 11816.5 11826.6 11831.1 11832.1 4615.3 4709.6 4875.6 4928.0 4953.5 9291.9 9355.5 9369.2 9372.2 9393.5 5319.1 5320.9 5328.2 5333.7 5335.6 4670.5 4783.4 4867.7 4967.4 4971.0 3750.8 3814.6 3832.9 3874.7 3901.5 1167.0 1175.1 1176.4 1179.8 1181.1 763.8 836.3 894.7 908.3 938.8 5303.8 5711.6 5735.7 5910.6 6091.5 882.6 890.5 890.7 938.3 989.9 3629.8 3787.4 3915.3 3938.2 4038.1 10587.7 10845.6 10973.9 10977.0 11017.8 10924.3 10928.2 10949.2 10949.7 10974.6 8216.6 8348.5 8350.7 8353.5 8369.8 5520.4 5747.7 5880.6 5915.6 5975.4 9968.8 9995.7 10207.4 10243.3 10259.8 9906.9 10270.8 10281.1 10285.0 10293.7 7069.4 7196.0 7199.0 7200.2 7203.5 8198.1 8318.7 8324.5 8330.7 8367.4 5086.0 7173.8 7217.6 7370.2 7657.3 6071.8 7115.7 7261.7 7263.5 7309.4 7038.7 7137.5 7138.9 7144.7 7156.8 4869.8 4909.4 5033.6 5046.8 5212.0 4939.3 5027.3 5083.4 5142.9 5190.4 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4476.30 Median:5078.44 stddev:1361.25 (26.8%) stddev-sans-first:1328.38 14:42:33 INFO - PROCESS | 1650 | Values: 293.9 298.7 307.1 307.4 310.0 5039.0 5169.3 5192.0 5220.8 5222.4 4633.5 4697.4 4901.9 5077.6 5180.4 3429.8 4017.9 4037.7 4061.4 4093.5 3534.4 4061.4 4062.8 4084.8 4097.8 3867.0 4004.3 4023.4 4032.2 4051.3 3400.7 3401.3 4011.5 4014.6 4044.2 3102.9 3502.2 3504.9 3518.6 3555.2 4715.9 5079.3 5081.4 5103.4 5169.8 4371.7 4557.4 4570.5 4597.9 4690.5 4618.7 4726.6 5211.0 5346.9 5483.8 3358.8 3441.7 3862.7 3867.4 3871.3 5257.7 5749.0 5751.9 5774.9 5809.6 3352.1 3398.3 3874.6 3884.2 3893.6 3704.8 3758.7 3970.3 4013.6 4019.7 3951.6 4451.3 4608.6 4643.1 4675.2 4767.0 5541.5 5586.0 5641.7 5655.0 1370.6 1381.6 1381.7 1385.0 1386.0 862.5 889.8 898.6 917.6 932.4 5046.9 5054.3 5087.2 5093.7 5112.9 4564.5 4792.3 5553.8 5579.7 5671.0 4786.3 5003.6 5063.0 5076.5 5178.6 2829.1 2951.0 2952.9 2954.9 2964.3 5215.9 5440.4 5698.9 5776.4 5893.6 5114.4 5521.2 5675.9 5720.3 5744.3 5718.4 5726.0 5758.3 5786.9 5829.6 5177.6 5202.7 5378.8 5586.0 5619.5 5253.6 5492.3 5498.6 5500.9 5534.9 5187.4 5750.8 5766.0 5771.5 5801.5 3350.8 3471.5 3617.8 3819.4 3872.6 5614.4 5672.4 5759.5 5765.0 5804.8 4982.3 5529.3 5533.6 5546.4 5621.9 4343.0 5181.5 5310.0 5506.8 5513.5 4926.8 5360.2 5385.7 5410.5 5417.3 4933.3 5426.3 5457.8 5570.8 5627.3 5514.2 5530.6 5535.2 5538.3 5591.4 14:42:33 INFO - PROCESS | 1650 | 14:42:33 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:24485.01 Median:3681.95 stddev:39259.00 (1066.3%) stddev-sans-first:39328.58 14:42:33 INFO - PROCESS | 1650 | Values: 719.0 752.0 764.9 776.1 821.3 15168.3 15944.3 15952.5 15989.2 15994.0 13553.4 13560.0 13579.3 13691.0 13725.5 676.7 701.0 703.8 842.0 880.0 696.8 700.7 702.1 836.0 871.5 910.8 920.2 920.8 923.3 927.0 916.4 917.9 918.3 918.5 918.8 529.5 687.3 687.5 688.1 689.5 12199.0 14140.6 14723.3 14731.9 15014.7 14176.6 14798.9 14853.2 14889.3 14895.1 11729.6 11783.9 11791.1 11800.5 12033.9 3799.7 3806.3 3819.8 3901.6 3955.2 108665.5 110668.4 111445.9 112232.0 113846.0 11292.4 11450.7 11531.5 11656.2 11929.0 23420.4 23452.4 23462.0 23494.1 23534.2 7001.4 7846.6 7929.1 7933.7 8069.6 4396.5 4423.2 4491.2 4600.6 4606.4 3557.7 3680.0 3683.9 3691.2 3702.0 575.2 632.6 638.6 647.5 664.9 611.3 638.6 641.2 655.0 657.6 8140.7 9389.4 9392.6 9433.8 9447.8 487.7 592.6 643.4 648.8 679.2 4289.9 4510.0 4538.7 4552.5 4657.6 91460.0 118829.2 150486.0 151466.0 156513.0 130876.0 130965.0 133704.3 135216.3 136586.3 111414.9 113403.4 113995.0 115455.4 119108.0 8853.8 8869.9 8910.9 9073.3 9082.0 60970.0 61089.0 61164.8 62903.7 63163.4 81392.0 88673.0 92441.1 93058.0 93433.5 10514.7 11946.3 11965.3 11981.5 12059.0 12903.9 13081.2 13186.9 13215.9 13404.6 12081.5 12170.2 12197.4 12408.9 12574.5 11718.9 12183.2 12260.8 12295.6 12499.4 11698.8 12057.3 12063.9 12192.0 12462.5 10145.4 10155.5 10241.2 10694.2 10706.4 10178.6 10505.1 10518.3 10518.8 10576.3 14:42:33 INFO - PROCESS | 1650 | -------- Summary: end -------- 14:42:33 INFO - PROCESS | 1650 | 14:42:34 INFO - TEST-INFO | 1650: exit 0 14:42:34 INFO - TEST-OK | dromaeo_css | took 1119134ms 14:42:34 INFO - TEST-START | kraken 14:42:34 INFO - operating with platform_type : mac_ 14:42:34 INFO - Initialising browser for kraken test... 14:42:34 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpkvh16Z/profile http://localhost:49272/getInfo.html) 14:42:36 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 14:42:36 INFO - PROCESS | 1661 | colorDepth:24 14:42:36 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 14:42:36 INFO - PROCESS | 1661 | __metrics 14:42:36 INFO - PROCESS | 1661 | 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" 14:42:36 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:37 INFO - TEST-INFO | 1661: exit 0 14:42:37 INFO - Browser initialized. 14:42:37 INFO - Running cycle 1/1 for kraken test... 14:42:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpkvh16Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:49 INFO - PROCESS | 1662 | RSS: Main: 236032000 14:42:49 INFO - PROCESS | 1662 | 14:42:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 14:42:53 INFO - PROCESS | 1662 | RSS: Main: 294883328 14:42:53 INFO - PROCESS | 1662 | 14:42:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 14:42:56 INFO - PROCESS | 1662 | RSS: Main: 295206912 14:42:56 INFO - PROCESS | 1662 | 14:42:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 14:43:00 INFO - PROCESS | 1662 | RSS: Main: 384626688 14:43:00 INFO - PROCESS | 1662 | 14:43:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 14:43:03 INFO - PROCESS | 1662 | RSS: Main: 285446144 14:43:03 INFO - PROCESS | 1662 | 14:43:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:05 INFO - PROCESS | 1662 | RSS: Main: 290660352 14:43:05 INFO - PROCESS | 1662 | 14:43:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:09 INFO - PROCESS | 1662 | RSS: Main: 327233536 14:43:09 INFO - PROCESS | 1662 | 14:43:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:13 INFO - PROCESS | 1662 | RSS: Main: 329027584 14:43:13 INFO - PROCESS | 1662 | 14:43:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 14:43:16 INFO - PROCESS | 1662 | RSS: Main: 328097792 14:43:16 INFO - PROCESS | 1662 | 14:43:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:18 INFO - PROCESS | 1662 | RSS: Main: 303063040 14:43:18 INFO - PROCESS | 1662 | 14:43:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:21 INFO - PROCESS | 1662 | RSS: Main: 305975296 14:43:21 INFO - PROCESS | 1662 | 14:43:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:24 INFO - PROCESS | 1662 | RSS: Main: 313827328 14:43:24 INFO - PROCESS | 1662 | 14:43:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:27 INFO - PROCESS | 1662 | RSS: Main: 318238720 14:43:27 INFO - PROCESS | 1662 | 14:43:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:31 INFO - PROCESS | 1662 | RSS: Main: 319467520 14:43:31 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 14:43:33 INFO - PROCESS | 1662 | RSS: Main: 363552768 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | __start_tp_report 14:43:33 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 14:43:33 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 14:43:33 INFO - PROCESS | 1662 | |i|pagename|runs| 14:43:33 INFO - PROCESS | 1662 | |0;ai-astar;114;114;114;114;114;115;114;111;113;113 14:43:33 INFO - PROCESS | 1662 | |1;audio-beat-detection;150;115;114;149;115;136;133;116;143;113 14:43:33 INFO - PROCESS | 1662 | |2;audio-dft;183;186;209;254;188;183;182;182;183;179 14:43:33 INFO - PROCESS | 1662 | |3;audio-fft;79;60;59;88;65;67;78;77;102;76 14:43:33 INFO - PROCESS | 1662 | |4;audio-oscillator;87;72;92;70;68;70;92;68;69;91 14:43:33 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;88;87;87;87;88;85;120;116;88;86 14:43:33 INFO - PROCESS | 1662 | |6;imaging-darkroom;95;94;95;95;94;102;137;137;93;106 14:43:33 INFO - PROCESS | 1662 | |7;imaging-desaturate;90;86;88;86;88;88;86;88;89;91 14:43:33 INFO - PROCESS | 1662 | |8;json-parse-financial;56;53;53;53;55;56;54;54;56;55 14:43:33 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;70;83;77;74;71;69;81;98;98 14:43:33 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;90;87;85;89;89;89;90;90;91;107 14:43:33 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;144;146;144;145;143;146;146;143;160;150 14:43:33 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;168;163;216;194;172;169;175;174;168;172 14:43:33 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;70;68;69;69;70;71;70;78;81;83 14:43:33 INFO - PROCESS | 1662 | __end_tp_report 14:43:33 INFO - PROCESS | 1662 | __start_cc_report 14:43:33 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2006 14:43:33 INFO - PROCESS | 1662 | __end_cc_report 14:43:33 INFO - PROCESS | 1662 | __startTimestamp1475531013382__endTimestamp 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | ------- Summary: start ------- 14:43:33 INFO - PROCESS | 1662 | Number of tests: 14 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 14:43:33 INFO - PROCESS | 1662 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 114.0 111.0 113.0 113.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:134.50 stddev:15.42 (11.5%) stddev-sans-first:14.24 14:43:33 INFO - PROCESS | 1662 | Values: 150.0 115.0 114.0 149.0 115.0 136.0 133.0 116.0 143.0 113.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:192.90 Median:184.50 stddev:23.07 (12.5%) stddev-sans-first:24.19 14:43:33 INFO - PROCESS | 1662 | Values: 183.0 186.0 209.0 254.0 188.0 183.0 182.0 182.0 183.0 179.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:75.10 Median:76.50 stddev:13.22 (17.3%) stddev-sans-first:13.95 14:43:33 INFO - PROCESS | 1662 | Values: 79.0 60.0 59.0 88.0 65.0 67.0 78.0 77.0 102.0 76.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:10.99 (13.8%) stddev-sans-first:11.15 14:43:33 INFO - PROCESS | 1662 | Values: 87.0 72.0 92.0 70.0 68.0 70.0 92.0 68.0 69.0 91.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:87.00 stddev:13.14 (15.1%) stddev-sans-first:13.80 14:43:33 INFO - PROCESS | 1662 | Values: 88.0 87.0 87.0 87.0 88.0 85.0 120.0 116.0 88.0 86.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:94.00 stddev:17.46 (18.6%) stddev-sans-first:18.16 14:43:33 INFO - PROCESS | 1662 | Values: 95.0 94.0 95.0 95.0 94.0 102.0 137.0 137.0 93.0 106.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:88.00 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.64 14:43:33 INFO - PROCESS | 1662 | Values: 90.0 86.0 88.0 86.0 88.0 88.0 86.0 88.0 89.0 91.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.27 (2.3%) stddev-sans-first:1.22 14:43:33 INFO - PROCESS | 1662 | Values: 56.0 53.0 53.0 53.0 55.0 56.0 54.0 54.0 56.0 55.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:78.60 Median:79.00 stddev:11.60 (14.7%) stddev-sans-first:11.21 14:43:33 INFO - PROCESS | 1662 | Values: 65.0 70.0 83.0 77.0 74.0 71.0 69.0 81.0 98.0 98.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:89.50 stddev:5.98 (6.7%) stddev-sans-first:6.34 14:43:33 INFO - PROCESS | 1662 | Values: 90.0 87.0 85.0 89.0 89.0 89.0 90.0 90.0 91.0 107.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:146.00 stddev:5.10 (3.5%) stddev-sans-first:5.32 14:43:33 INFO - PROCESS | 1662 | Values: 144.0 146.0 144.0 145.0 143.0 146.0 146.0 143.0 160.0 150.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:173.00 stddev:15.97 (9.2%) stddev-sans-first:16.59 14:43:33 INFO - PROCESS | 1662 | Values: 168.0 163.0 216.0 194.0 172.0 169.0 175.0 174.0 168.0 172.0 14:43:33 INFO - PROCESS | 1662 | 14:43:33 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:70.50 stddev:5.55 (7.9%) stddev-sans-first:5.78 14:43:33 INFO - PROCESS | 1662 | Values: 70.0 68.0 69.0 69.0 70.0 71.0 70.0 78.0 81.0 83.0 14:43:33 INFO - PROCESS | 1662 | -------- Summary: end -------- 14:43:33 INFO - PROCESS | 1662 | 14:43:34 INFO - TEST-INFO | 1662: exit 0 14:43:34 INFO - TEST-OK | kraken | took 60091ms 14:43:34 INFO - SUITE-END | took 1179s 14:43:34 INFO - Completed test suite (00:19:39) 14:43:34 INFO - javascript benchmark 14:43:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2923.9415211695755, 3331.050650564588, 3334.216459132104, 3346.665333466652, 3394.864205431783, 5636.070048442002, 5742.138679198117, 5778.451047150525, 5813.098969659699, 5818.709064546777, 5740.253767010293, 5762.971185144069, 5895.587308888369, 5920.733566989485, 5924.58527903047, 5073.0, 5120.4623514530995, 5177.249298851664, 5206.531412172903, 5240.082985477527, 5302.469753024705, 5306.7611957462, 5313.867153321159, 5326.094563924123, 5327.227552004957, 5264.447233040514, 5268.683878967274, 5310.203469479589, 5358.705271210082, 5371.946280537184, 5098.617603679739, 5174.586033117342, 5193.1171700810955, 5232.110541207966, 5237.921431178497, 5153.175491921274, 5163.760697432626, 5176.275321454999, 5206.219067139959, 5206.297149884755, 5731.168980497846, 5741.081426971707, 5760.8847823043725, 5775.1337299405, 5788.6816225107605, 6100.066499260575, 6123.069409073481, 6134.314131579348, 6147.692615369214, 6177.351378105324, 6080.726367313481, 6084.087386891957, 6089.6041757286075, 6099.451049405575, 6117.694115294262, 5635.351934527582, 5802.767889284381, 5853.619514731571, 5865.944130056588, 5876.412358764175, 5426.294581704353, 6189.721462534197, 6190.721417536221, 6193.876122477525, 6254.21822272216, 6116.969415152896, 6119.173911521976, 6131.448169664752, 6135.662538560422, 6137.84655383619, 6221.129041934133, 6278.4035516625845, 6281.152044474029, 6282.905756413657, 6285.685715714196, 6022.789202377983, 6093.177421048191, 6101.267847858286, 6102.084687296941, 6158.3841615838055, 6199.876002479925, 6241.251049874044, 6248.156498872594, 6253.906191407133, 6270.122182894398, 4917.262410638433, 4924.778384972685, 4933.235348520985, 4935.679180853233, 4966.205407134841, 4365.03969126798, 4367.890802729958, 4376.299792033259, 4404.6256068233915, 4444.644428445717, 5700.144978253295, 5711.086226203787, 5712.285964254468, 5719.542436605062, 5729.1119876419225, 6180.443760061616, 6187.628742275478, 6204.038374052029, 6221.09794079865, 6225.533085018642, 5725.627834190765, 5730.799422020293, 5735.913961290584, 5740.54075673945, 5743.741531631086, 5330.200469929541, 5359.0, 5365.382980957162, 5367.0, 5381.811636592701, 6080.14877917092, 6148.493619063358, 6223.751049957951, 6236.594621349598, 6237.937620623736, 6172.907406388818, 6201.96899015502, 6206.224221972254, 6206.410391012847, 6268.874622507616, 5552.139418390156, 6220.502359811114, 6249.750009999549, 6265.0, 6267.310595834363, 6138.57051894304, 6166.753329866934, 6176.042713379434, 6186.072089186658, 6204.751809927552, 5090.185570308733, 6087.117367981707, 6133.854967164949, 6157.815265542041, 6220.937790622217, 6056.031035034373, 6088.086786981989, 6130.846728831815, 6132.509399247961, 6140.447359737466, 5930.52555795544, 6059.848503787441, 6087.026075827846, 6092.482139018233, 6097.054956481752, 5744.597878148489, 5803.042497987784, 5819.330776960534, 5917.940820591739, 5931.851703707442, 6008.489278411384, 6012.969935150296, 6039.486643635164, 6049.243844519435, 6052.243469566304, 5873.0, 5889.0, 5892.234009578728, 5898.174255604305, 5909.52723782105], "value": 5671.633395755611, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.82373786092364, 479.47018544508296, 501.6012270245155, 503.3280570438465, 535.6491498068766, 34522.0, 39805.805825825235, 39817.60182398182, 39905.401418978705, 41801.372979405256, 40380.394294085614, 40597.797011014976, 40601.59398406015, 40708.77873663795, 40760.79619601905, 8657.740267791976, 8843.0, 9592.424454532733, 9767.462789546573, 9790.21678265737, 10499.947500262526, 11623.6512904613, 11869.703257418547, 11921.225120367191, 12036.157468977131, 11735.354555499443, 11739.823902641467, 11831.526738930432, 11889.940550297237, 11917.284962902253, 8703.52130632815, 8951.104889511062, 11734.589289374873, 11784.234024788404, 11814.17300788945, 11471.942640286745, 11811.822822657667, 11813.822792658117, 11925.522979080826, 11926.58256961011, 38918.0, 39303.0, 39355.80322098371, 39368.80315598404, 39431.802840985896, 3232.498962660791, 3301.983490082558, 3329.5338652588416, 3353.916152096217, 3453.620101788801, 30119.548206776915, 30437.543436848464, 31423.05730828079, 31612.36775264505, 31812.6818731812, 3202.455582550972, 3232.305054413289, 3236.0453666168537, 3268.4116858965376, 3368.7473439492137, 466355.0, 467361.0, 470982.12723409577, 471092.99999999657, 476850.0, 58590.0, 58853.70573147193, 58886.705566471894, 58906.11640825391, 58973.0, 59335.40664593299, 59394.0, 59408.405915941155, 59434.811303773684, 59518.40481595129, 15736.527904162893, 15926.76109858353, 15949.840501594836, 15959.962602430805, 15974.440894568634, 11193.104551636012, 11499.827502587468, 11517.963383295544, 12409.875901241052, 12456.501739930483, 12018.218815776947, 14318.0, 14424.639384015483, 15405.0, 15831.050136991817, 6219.471344935731, 7226.6386680665755, 7310.744123955742, 7379.7048118075745, 7383.593902335423, 878.2534845381375, 906.9183773460288, 929.9767505812409, 940.1867384712311, 962.711186644004, 26313.21060368192, 29984.25039374033, 30119.548206776915, 30718.0, 31443.528347074356, 1014.9289549731448, 1023.9641612543526, 1025.6922423909425, 1039.1946241662772, 1101.9944900275607, 14296.427392986763, 14843.554693359216, 14858.03422777516, 14864.554063378117, 15235.390584376722, 614969.0, 624502.0, 625902.0, 628935.0, 630392.0, 54319.18521222185, 54590.0, 54671.45328546743, 54745.72627136918, 54760.72619636876, 1315.046591221357, 1356.5794603672894, 1370.164199838078, 1371.8079468874366, 1373.0731756064617, 28208.0, 28478.715212848434, 28533.571996419654, 28972.275693106996, 29125.0, 47654.52345476639, 48087.75956120197, 48091.03817923552, 48102.27846582234, 48146.03707925892, 458327.0, 459506.0, 459694.0, 460921.39078608784, 461453.0, 24434.51130977406, 24589.262322130366, 24789.380265493506, 24889.128880489097, 24972.375690607154, 37637.81181094077, 37654.62345376511, 37888.242235155696, 38264.426033608965, 45522.54477455183, 33870.66129338675, 36366.63633363633, 37353.879383618536, 38547.0, 38741.806290968365, 36659.63340366669, 36909.446358305184, 37056.0, 37884.81057594695, 37954.051148721504, 36646.816765916, 37345.626543734215, 37496.43755343727, 37715.43426848654, 37910.43134353042, 28640.57039144373, 28822.42355152843, 29497.082689625106, 33085.33829323448, 33631.0, 21324.680129798377, 22850.31449056531, 23521.52956940886, 25129.623055654545, 25143.582643119957], "value": 19425.550847695944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2664105186996, 368.1422286073449, 378.8181672797057, 390.1027636436196, 400.9679225661947, 19298.421047368585, 21620.0, 21860.048893399387, 22192.88903555482, 22310.996005179764, 20511.589768204663, 20657.967101644896, 21147.788522114774, 21241.93790310486, 21473.892630536866, 5836.649423000394, 5985.521158307347, 6105.0, 6152.0464328029, 6172.4444799968, 5671.489565939065, 6016.33820279771, 6158.599691020092, 6163.876722465548, 6174.166487524171, 5987.072003839412, 6087.939120608804, 6090.786822461215, 6091.725872335734, 6105.877882442371, 5864.325602555697, 6008.849778755566, 6082.9391706082815, 6084.2090528231265, 6086.0, 5912.3496415394275, 5916.201312822757, 5918.526517878602, 5930.0, 5936.5250779937505, 13282.269475178862, 13321.333933303393, 13575.321233938363, 13670.93164534171, 13764.31178441074, 2164.729408823897, 2206.7903549162966, 2245.977540224593, 2255.988720056406, 2337.4740683346113, 9590.42457452555, 9937.602495900155, 10198.541065652063, 10373.273870829045, 10513.948605139502, 1754.9385771498064, 1817.9454616361531, 1837.1640903388925, 1841.383136649224, 1858.1916866163263, 96713.0, 123583.3820830899, 124002.0, 126913.36543317317, 127769.36115319456, 10884.61903833362, 11235.15736319763, 11349.0, 11376.488058037408, 11592.710182245512, 14531.128132312095, 14556.63608409777, 14560.126392416489, 14564.053336533092, 14566.324872639781, 8199.467034642728, 8464.44981076228, 8522.70170544028, 8585.527795971282, 8601.096884827128, 7162.4986250962975, 8424.957875210708, 8425.060332465597, 8428.4942903426, 8631.611577478903, 3844.615538446133, 4370.890727731832, 4491.1915855145735, 4503.977480112579, 4538.092381523708, 1710.1192885663893, 1846.6491366640296, 1888.3202047262973, 1896.459509039917, 1916.1856211110223, 717.5443593318281, 745.3105877063695, 833.6707000734676, 912.2929729459589, 1009.3893194617151, 18361.540961475803, 20250.392488225083, 21558.0, 21725.45686357822, 21957.67063494049, 895.6238379880335, 949.4635530925005, 955.1785464500524, 977.9168770654431, 1009.5406590001531, 10654.242664552066, 11171.16216283782, 11237.157213209042, 11249.66251012471, 11272.380019099028, 592877.0, 597410.0, 600134.0, 607942.0, 614059.0, 76201.0, 129053.0, 131307.0, 133477.99783003263, 138408.30795845957, 959.8128364968765, 968.9370190937567, 1013.4679293370892, 1013.9797204056025, 1014.1430491234747, 14810.925945370203, 18933.90533047326, 19171.616567668847, 19678.622496425687, 19824.504387390432, 51142.0, 52654.73672631766, 55151.79392824403, 55878.44121558895, 57639.423605763404, 73860.0, 74561.0, 76426.23573764414, 79684.0, 79838.0, 7643.273888980538, 7772.727954521791, 7775.22247775218, 7941.324987376138, 8160.8775868360835, 8786.16531429513, 9901.653442129491, 11390.544378224778, 11996.16026878145, 12673.493060277486, 10210.183185345006, 10508.632197873038, 10883.564657413615, 11162.888371116509, 11194.160437967023, 10904.672859814218, 10916.727081823017, 10939.45302734876, 11122.165837562054, 11513.424328783694, 9650.420974741539, 10004.399736015863, 11046.502907369348, 11396.886031139915, 11598.71003224926, 6880.311968803079, 7273.199948005821, 7317.231690672403, 7449.813754656177, 8108.918910810817, 9674.823164787866, 10937.507812148631, 10942.124630029737, 11175.161862860155, 11305.26515776472], "value": 9317.14808774862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1394.456162096782, 1509.1473317575565, 1704.5227336345827, 1859.172668162668, 1917.7602799650053, 8119.14748951359, 8611.009733880606, 9118.908810911906, 9133.451992880431, 9148.359614826964, 8078.111407745143, 8571.0, 8831.558422078902, 8832.160944710258, 8962.462252264868, 2359.8230132740027, 2387.85672859629, 2392.425817803732, 2392.736798952114, 2396.940076498084, 2046.5599896022352, 2088.049937278542, 2330.2892617751577, 2382.0828980842416, 2387.033251533132, 1924.393815947979, 2159.3198142585115, 2196.6595177747477, 2198.7141671582754, 2272.749997500274, 2344.4607740219676, 2375.4180225844607, 2375.4892698069825, 2376.9049238030457, 2377.702787151606, 2339.5905716499715, 2346.272655476808, 2369.5497855407416, 2372.0986025310444, 2377.8216633752363, 8856.911430885673, 8943.329250306253, 8951.0, 8957.104289571056, 8964.955175224082, 5304.045271851065, 5381.300430943952, 5450.073487507133, 5465.945340546623, 5467.507924286793, 3266.934661306784, 3375.7468189885612, 3411.8635254589785, 3416.0776590320474, 3422.401079811023, 1046.9057784799404, 1094.316052467208, 1112.8775834658181, 1115.4924509348227, 1119.054399032816, 11638.883611163865, 11816.527338906433, 11826.586069487526, 11831.053515718722, 11832.112591555582, 4615.330777037311, 4709.576138147583, 4875.585575226075, 4928.043174095514, 4953.455119936804, 9291.907080929239, 9355.53222338894, 9369.156775890066, 9372.1565059145, 9393.483358415353, 5319.069162896478, 5320.946790532123, 5328.200769884471, 5333.653312534673, 5335.62650614461, 4670.486246512881, 4783.402074740658, 4867.7322747249245, 4967.40391153064, 4971.005798840247, 3750.7562008469363, 3814.6376094271, 3832.885013449601, 3874.6900247980093, 3901.5318161820765, 1167.0, 1175.1010476985114, 1176.423552459306, 1179.8053321201905, 1181.1023622047305, 763.7785042337771, 836.3267569606404, 894.6779159502574, 908.2597682888425, 938.7512309238058, 5303.840884773463, 5711.628744131618, 5735.705717712948, 5910.645361278337, 6091.51267898567, 882.6337070115958, 890.4612709310774, 890.670451932789, 938.2634631813993, 989.9109080182674, 3629.8003609801713, 3787.4318852172396, 3915.275674000319, 3938.15329704115, 4038.0510580013674, 10587.735306617242, 10845.620403285848, 10973.945130274456, 10977.012068913837, 11017.83473247902, 10924.289921155258, 10928.180386471047, 10949.233553651167, 10949.726256843483, 10974.615888444026, 8216.589170541449, 8348.457350272212, 8350.70772522971, 8353.540555269397, 8369.832603347899, 5520.392756796829, 5747.683877386784, 5880.558958078247, 5915.58590898633, 5975.37258587842, 9968.800623987625, 9995.700558927292, 10207.387556746618, 10243.33418327836, 10259.84610230862, 9906.900930990598, 10270.845937310796, 10281.074703276741, 10285.0, 10293.74265643365, 7069.434445244471, 7196.028536147763, 7198.964005179941, 7200.171980222132, 7203.459740519377, 8198.1391953844, 8318.667253310043, 8324.458910170819, 8330.708425205088, 8367.372447066373, 5086.0, 7173.784786456415, 7217.566945983048, 7370.22612625688, 7657.310842024244, 6071.787487437919, 7115.67979440916, 7261.745838895613, 7263.455240856852, 7309.4152467803515, 7038.718451262097, 7137.464690148364, 7138.85722285541, 7144.714211431692, 7156.785296441115, 4869.756512174306, 4909.4354149273295, 5033.597312215087, 5046.84859454217, 5211.973940130427, 4939.333190019445, 5027.321311622884, 5083.38999320084, 5142.948570514247, 5190.40310364313], "value": 4554.979596594669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.8868535613789, 298.7072668784591, 307.1063206070334, 307.41897813133176, 310.0466066844454, 5039.0, 5169.276301317814, 5192.0, 5220.791168353261, 5222.4255331913555, 4633.467151277604, 4697.365855609501, 4901.852944411665, 5077.593792496601, 5180.430152683211, 3429.828508574574, 4017.9307656556825, 4037.7375470594466, 4061.390791381287, 4093.5087789465306, 3534.399152144129, 4061.3704875744306, 4062.817173227197, 4084.775337356444, 4097.836086556535, 3867.0471411936933, 4004.3192657248337, 4023.3964905264297, 4032.1935612877396, 4051.3315302974975, 3400.7449441291756, 3401.29935032485, 4011.498562679665, 4014.598540145991, 4044.2315959967514, 3102.8758849645988, 3502.2470168913806, 3504.8773292934625, 3518.612952575215, 3555.1690879197236, 4715.858524244278, 5079.282583817677, 5081.415637201732, 5103.362079740033, 5169.767360468788, 4371.650267978586, 4557.376885376134, 4570.451545814491, 4597.885052873705, 4690.530946905316, 4618.745968971705, 4726.621870250372, 5211.0359583477175, 5346.893062138735, 5483.7806487740445, 3358.8488518016748, 3441.6558344165633, 3862.7102967277565, 3867.400552914303, 3871.264459752638, 5257.737113144328, 5749.0, 5751.878383715219, 5774.855628609276, 5809.622374545641, 3352.1452029732263, 3398.2863598644562, 3874.6097164980642, 3884.2425726983533, 3893.649571538575, 3704.814759262026, 3758.677520851043, 3970.285348637273, 4013.5585085640555, 4019.698522610757, 3951.6443520082757, 4451.287793952952, 4608.631309495232, 4643.117807616542, 4675.205215113371, 4766.976165119152, 5541.473560011793, 5586.022446071921, 5641.73061061258, 5655.0103731847585, 1370.6019859743005, 1381.5648070857649, 1381.675306303018, 1384.9612790407195, 1385.9653508662363, 862.4911302331654, 889.7508697564692, 898.6315610599622, 917.5870858113742, 932.3520153493392, 5046.899062018812, 5054.292399064134, 5087.211482220262, 5093.745312734349, 5112.872178195575, 4564.497905230422, 4792.305115758196, 5553.8333849984565, 5579.721013949286, 5670.994372982326, 4786.319660989857, 5003.649744517848, 5062.974685126551, 5076.451682236953, 5178.585713142939, 2829.066408085327, 2950.9819112406617, 2952.940941181207, 2954.9113526594238, 2964.333025069342, 5215.921761173586, 5440.3743569489225, 5698.914516282259, 5776.393478684761, 5893.557983151195, 5114.43741188469, 5521.199426083276, 5675.943240567542, 5720.2849643794525, 5744.253247077853, 5718.3695500070435, 5725.997950358754, 5758.280214973129, 5786.858862220921, 5829.621074630136, 5177.611679124006, 5202.661826981234, 5378.784848606012, 5586.0, 5619.466150715675, 5253.579713622978, 5492.340919089735, 5498.642588231752, 5500.86450723084, 5534.861628459321, 5187.351581052369, 5750.827475175752, 5765.971170144123, 5771.509421699203, 5801.477866991991, 3350.782199157047, 3471.461923401877, 3617.764845285048, 3819.3698039823116, 3872.6252180476654, 5614.361250212393, 5672.376038635829, 5759.46583503274, 5765.019946609171, 5804.804699793745, 4982.327385802871, 5529.33647962231, 5533.612647114664, 5546.4453554645825, 5621.9156712650165, 4342.956570434381, 5181.53366197029, 5309.973450132725, 5506.843562851846, 5513.476219759116, 4926.802927882988, 5360.16917377807, 5385.676859388449, 5410.458954104715, 5417.268668729671, 4933.284673722362, 5426.321709786277, 5457.754401051883, 5570.805021824217, 5627.296587926509, 5514.2004409359615, 5530.640508366943, 5535.197396377584, 5538.280023596906, 5591.356993945748], "value": 4045.2962693489426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.9676464559094, 752.0411475368904, 764.9196834332398, 776.1081595432559, 821.2608652213007, 15168.317425715843, 15944.282507287171, 15952.52142435726, 15989.200539973013, 15993.960392574489, 13553.390097445614, 13560.0, 13579.253141077237, 13691.0, 13725.45098196071, 676.6650507998547, 700.9929900701004, 703.8416356319839, 842.0232530264894, 880.0451510111504, 696.7805141380449, 700.6531766775428, 702.0872865275147, 835.9832803343929, 871.4945331707626, 910.8497097978826, 920.2453987730031, 920.7928216151379, 923.2706162131908, 927.0312523413016, 916.4363916191561, 917.9495127767971, 918.2562124678998, 918.545320066568, 918.7978644698155, 529.5260741636253, 687.3470203306829, 687.5462194951358, 688.1088989758275, 689.4622194688151, 12199.0, 14140.575782726535, 14723.263836808117, 14731.852681473156, 15014.699706005928, 14176.645583860485, 14798.852011479963, 14853.183074930874, 14889.329980150918, 14895.10629362231, 11729.648110556696, 11783.94108029463, 11791.11566632506, 11800.527978880835, 12033.92431886487, 3799.67702745267, 3806.2958352704836, 3819.8281077351585, 3901.590333015021, 3955.208958208341, 108665.45667271613, 110668.4466577662, 111445.88554114437, 112231.99999999919, 113846.0, 11292.37891915936, 11450.713732156597, 11531.481083351102, 11656.18406711522, 11929.0, 23420.414489637897, 23452.413689657555, 23462.0, 23494.060237590646, 23534.176303829285, 7001.439884809305, 7846.607669616496, 7929.088154862149, 7933.682652693943, 8069.556174410346, 4396.450443694538, 4423.20382331177, 4491.214037543416, 4600.60894823937, 4606.447226332862, 3557.6975957043423, 3680.0063982724514, 3683.889483315505, 3691.206390626028, 3701.9629803702155, 575.2119596153296, 632.6299115017674, 638.5849198021231, 647.5467172978933, 664.8603793203384, 611.2695329081794, 638.6008744534665, 641.2337256977867, 654.9815037616457, 657.5692921136567, 8140.715074972466, 9389.436633801994, 9392.577334019985, 9433.811323773623, 9447.811043779086, 487.68056922715675, 592.570386469806, 643.3950702694111, 648.8377905523619, 679.1510611735331, 4289.871303860889, 4509.977450112794, 4538.72767633943, 4552.476465206478, 4657.6273898088075, 91460.0, 118829.21756173664, 150486.0, 151466.0, 156513.0, 130876.0, 130965.0, 133704.33147834393, 135216.32391837979, 136586.317068416, 111414.88585114207, 113403.43298283455, 113995.0, 115455.42272288585, 119108.0, 8853.778655533662, 8869.866951995855, 8910.86633700508, 9073.31950103758, 9082.0, 60970.0, 61089.0, 61164.77670446477, 62903.6854815723, 63163.36836631575, 81392.0, 88673.0, 92441.07558924594, 93058.0, 93433.5328323354, 10514.737131571772, 11946.342951137423, 11965.341906195243, 11981.460834262305, 12059.0, 12903.870961290642, 13081.215127092404, 13186.934065329611, 13215.933920330337, 13404.597862064154, 12081.531195625155, 12170.208936419105, 12197.390130493617, 12408.937955310526, 12574.497020119094, 11718.88281117212, 12183.208091474025, 12260.75478490443, 12295.631131066082, 12499.437525311565, 11698.76602467929, 12057.336846473178, 12063.879361206627, 12192.0, 12462.5014999399, 10145.391276523433, 10155.492225388552, 10241.18070554339, 10694.19793515505, 10706.411147386969, 10178.592856285666, 10505.107065899485, 10518.263721539419, 10518.842217366899, 10576.259661823906], "value": 7640.901232303774, "unit": "score"}], "name": "dromaeo_css", "value": 7244.335196266127, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 111.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 114.0, 149.0, 115.0, 136.0, 133.0, 116.0, 143.0, 113.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 209.0, 254.0, 188.0, 183.0, 182.0, 182.0, 183.0, 179.0], "value": 192.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 88.0, 65.0, 67.0, 78.0, 77.0, 102.0, 76.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 92.0, 70.0, 68.0, 70.0, 92.0, 68.0, 69.0, 91.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 87.0, 88.0, 85.0, 120.0, 116.0, 88.0, 86.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 102.0, 137.0, 137.0, 93.0, 106.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 86.0, 88.0, 88.0, 86.0, 88.0, 89.0, 91.0], "value": 88.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 55.0, 56.0, 54.0, 54.0, 56.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 83.0, 77.0, 74.0, 71.0, 69.0, 81.0, 98.0, 98.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 85.0, 89.0, 89.0, 89.0, 90.0, 90.0, 91.0, 107.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 146.0, 144.0, 145.0, 143.0, 146.0, 146.0, 143.0, 160.0, 150.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 216.0, 194.0, 172.0, 169.0, 175.0, 174.0, 168.0, 172.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 69.0, 70.0, 71.0, 70.0, 78.0, 81.0, 83.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1494.4, "alertThreshold": 2.0}]} 14:43:34 INFO - Return code: 0 14:43:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:43:34 INFO - # TBPL SUCCESS # 14:43:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:43:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:43:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:43:34 INFO - 2016-10-03 14:43:34.676 screenresolution[1666:10197] starting screenresolution argv=screenresolution get 14:43:34 INFO - 2016-10-03 14:43:34.679 screenresolution[1666:10197] Display 0: 1600x1200x32@60 14:43:34 INFO - 2016-10-03 14:43:34.686 screenresolution[1667:10200] starting screenresolution argv=screenresolution list 14:43:34 INFO - Available Modes on Display 0 14:43:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:43:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:43:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:43:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:43:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:43:34 INFO - Intel Iris: 14:43:34 INFO - Chipset Model: Intel Iris 14:43:34 INFO - Type: GPU 14:43:34 INFO - Bus: Built-In 14:43:34 INFO - VRAM (Dynamic, Max): 1536 MB 14:43:34 INFO - Vendor: Intel (0x8086) 14:43:34 INFO - Device ID: 0x0a2e 14:43:34 INFO - Revision ID: 0x0009 14:43:34 INFO - Displays: 14:43:34 INFO - Display: 14:43:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:43:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:43:34 INFO - Display Serial Number: 1600x1200 60 14:43:34 INFO - Main Display: Yes 14:43:34 INFO - Mirror: Off 14:43:34 INFO - Online: Yes 14:43:34 INFO - Rotation: Supported 14:43:34 INFO - Return code: 0 14:43:34 INFO - Running post-action listener: _resource_record_post_action 14:43:34 INFO - [mozharness: 2016-10-03 21:43:34.921840Z] Finished run-tests step (success) 14:43:34 INFO - Running post-run listener: _resource_record_post_run 14:43:34 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 38532096; Write bytes: 705550336; Read time: 376; Write time: 1953 14:43:34 INFO - TinderboxPrint: CPU usage
53.8% 14:43:34 INFO - TinderboxPrint: I/O read bytes / time
38,532,096 / 376 14:43:34 INFO - TinderboxPrint: I/O write bytes / time
705,550,336 / 1,953 14:43:34 INFO - TinderboxPrint: CPU idle
2,243.3 (46.2%) 14:43:34 INFO - TinderboxPrint: CPU system
973.5 (20.0%) 14:43:34 INFO - TinderboxPrint: CPU user
1,640.8 (33.8%) 14:43:34 INFO - TinderboxPrint: Swap in / out
446,033,920 / 0 14:43:34 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387504640; Write bytes: 381335040; Read time: 28953; Write time: 686 14:43:35 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37569536; Write bytes: 295715328; Read time: 362; Write time: 1211 14:43:35 INFO - Running post-run listener: _upload_blobber_files 14:43:35 INFO - Blob upload gear active. 14:43:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:35 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 14:43:35 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:43:35 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:43:35 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:43:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:37 INFO - (blobuploader) - INFO - Done attempting. 14:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:43:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:39 INFO - (blobuploader) - INFO - Done attempting. 14:43:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:43:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:41 INFO - (blobuploader) - INFO - Done attempting. 14:43:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:41 INFO - Return code: 0 14:43:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b5eb4546f7125765bdd5a23ac669c604edd6edaa7963e0fc78e4ea45bdb240f8b368140c81059f70a328b93c70ac057411d775fbd6ea7bd6abe13a2e4d548fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a980a1512c9f81b109534a4f2d6b1bfbd8447611b00b5a0424b96a28fa3a16050a6188c7fd9fe044043ff5efa994edf427a1200b68af598477abfe334f12a209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f84e337f6d5f449fab61aca2a6a057ba4520a7f10dae99091c2b2173ea5eec18cbbcb7f9d50ff94fe62cd51f83c62ad5ed29a093590eac8202c2d76ac6b6975"} 14:43:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:41 INFO - Contents: 14:43:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b5eb4546f7125765bdd5a23ac669c604edd6edaa7963e0fc78e4ea45bdb240f8b368140c81059f70a328b93c70ac057411d775fbd6ea7bd6abe13a2e4d548fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a980a1512c9f81b109534a4f2d6b1bfbd8447611b00b5a0424b96a28fa3a16050a6188c7fd9fe044043ff5efa994edf427a1200b68af598477abfe334f12a209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f84e337f6d5f449fab61aca2a6a057ba4520a7f10dae99091c2b2173ea5eec18cbbcb7f9d50ff94fe62cd51f83c62ad5ed29a093590eac8202c2d76ac6b6975"} 14:43:41 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:41 INFO - Copying logs to upload dir... 14:43:41 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.032577 ========= master_lag: 2.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-03 14:43:43.902914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-10-03 14:43:43.907187) ========= 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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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/Autoland/sha512/b5eb4546f7125765bdd5a23ac669c604edd6edaa7963e0fc78e4ea45bdb240f8b368140c81059f70a328b93c70ac057411d775fbd6ea7bd6abe13a2e4d548fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a980a1512c9f81b109534a4f2d6b1bfbd8447611b00b5a0424b96a28fa3a16050a6188c7fd9fe044043ff5efa994edf427a1200b68af598477abfe334f12a209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f84e337f6d5f449fab61aca2a6a057ba4520a7f10dae99091c2b2173ea5eec18cbbcb7f9d50ff94fe62cd51f83c62ad5ed29a093590eac8202c2d76ac6b6975"} build_url:https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011088 build_url: 'https://queue.taskcluster.net/v1/task/Og6ESw9fSAOJT-MtyedzYA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b5eb4546f7125765bdd5a23ac669c604edd6edaa7963e0fc78e4ea45bdb240f8b368140c81059f70a328b93c70ac057411d775fbd6ea7bd6abe13a2e4d548fb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a980a1512c9f81b109534a4f2d6b1bfbd8447611b00b5a0424b96a28fa3a16050a6188c7fd9fe044043ff5efa994edf427a1200b68af598477abfe334f12a209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f84e337f6d5f449fab61aca2a6a057ba4520a7f10dae99091c2b2173ea5eec18cbbcb7f9d50ff94fe62cd51f83c62ad5ed29a093590eac8202c2d76ac6b6975"}' ========= master_lag: 3.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-10-03 14:43:46.945665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 14:43:46.949034) ========= 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.CsvLgfNg1d/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.1ZndQfrhfH/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005848 ========= master_lag: 1.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 14:43:48.018157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 14:43:48.018475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 14:43:48.019204) ========= ========= Total master_lag: 6.24 =========