builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0064 starttime: 1480218364.8 results: success (0) buildid: 20161126175719 builduid: dcfcb404b91b467886609cce5ad68379 revision: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:04.803167) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:04.803620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:04.803896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:04.879408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:04.879768) ========= 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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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-11-26 19:46:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 137M=0s 2016-11-26 19:46:05 (137 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.548678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:05.452992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:05.453310) ========= 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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.026329 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:05.501747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 19:46:05.502140) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a0abcff5cfce087c12f3e4820b5e8b773cffaca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2a0abcff5cfce087c12f3e4820b5e8b773cffaca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qWn4JOsT3g/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.XO23nR8ilZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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-11-26 19:46:05,598 truncating revision to first 12 chars 2016-11-26 19:46:05,598 Setting DEBUG logging. 2016-11-26 19:46:05,598 attempt 1/10 2016-11-26 19:46:05,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a0abcff5cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 19:46:06,736 unpacking tar archive at: mozilla-central-2a0abcff5cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.410537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 19:46:06.936201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:06.936526) ========= script_repo_revision: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:06.936975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:06.937245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 19:46:06.957479) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-26 19:46:06.957943) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qWn4JOsT3g/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.XO23nR8ilZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:07 INFO - MultiFileLogger online at 20161126 19:46:07 in /builds/slave/test 19:46:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:46:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:46:07 INFO - {'append_to_log': False, 19:46:07 INFO - 'base_work_dir': '/builds/slave/test', 19:46:07 INFO - 'blob_upload_branch': 'Firefox', 19:46:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:46:07 INFO - 'branch': 'Firefox', 19:46:07 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:07 INFO - 'config_files': ('talos/mac_config.py',), 19:46:07 INFO - 'default_actions': ('clobber', 19:46:07 INFO - 'read-buildbot-config', 19:46:07 INFO - 'download-and-extract', 19:46:07 INFO - 'populate-webroot', 19:46:07 INFO - 'create-virtualenv', 19:46:07 INFO - 'install', 19:46:07 INFO - 'run-tests'), 19:46:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:07 INFO - 'download_minidump_stackwalk': True, 19:46:07 INFO - 'download_symbols': 'ondemand', 19:46:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:07 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:07 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:07 INFO - 'installer_path': 'installer.exe', 19:46:07 INFO - 'log_level': 'info', 19:46:07 INFO - 'log_name': 'talos', 19:46:07 INFO - 'log_to_console': True, 19:46:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:46:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:46:07 INFO - 'opt_config_files': (), 19:46:07 INFO - 'pip_index': False, 19:46:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:07 INFO - 'cmd': ('bash', 19:46:07 INFO - '-c', 19:46:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:07 INFO - 'enabled': True, 19:46:07 INFO - 'halt_on_failure': False, 19:46:07 INFO - 'name': 'check_screen_resolution'},), 19:46:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:07 INFO - 'cmd': ('bash', 19:46:07 INFO - '-c', 19:46:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:07 INFO - 'enabled': True, 19:46:07 INFO - 'halt_on_failure': False, 19:46:07 INFO - 'name': 'check_screen_resolution'},), 19:46:07 INFO - 'run_cmd_checks_enabled': True, 19:46:07 INFO - 'sps_profile': False, 19:46:07 INFO - 'sps_profile_interval': 0, 19:46:07 INFO - 'suite': 'dromaeojs', 19:46:07 INFO - 'system_bits': '32', 19:46:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:07 INFO - 'title': 't-yosemite-r7-0064', 19:46:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:07 INFO - 'use_talos_json': True, 19:46:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:46:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:07 INFO - 'work_dir': 'build'} 19:46:07 INFO - [mozharness: 2016-11-27 03:46:07.168234Z] Running clobber step. 19:46:07 INFO - Running pre-action listener: _resource_record_pre_action 19:46:07 INFO - Running main action method: clobber 19:46:07 INFO - rmtree: /builds/slave/test/build 19:46:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:46:09 INFO - Running post-action listener: _resource_record_post_action 19:46:09 INFO - [mozharness: 2016-11-27 03:46:09.473258Z] Finished clobber step (success) 19:46:09 INFO - [mozharness: 2016-11-27 03:46:09.473382Z] Running read-buildbot-config step. 19:46:09 INFO - Running pre-action listener: _resource_record_pre_action 19:46:09 INFO - Running main action method: read_buildbot_config 19:46:09 INFO - Using buildbot properties: 19:46:09 INFO - { 19:46:09 INFO - "project": "", 19:46:09 INFO - "product": "firefox", 19:46:09 INFO - "script_repo_revision": "production", 19:46:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:46:09 INFO - "repository": "", 19:46:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:46:09 INFO - "buildid": "20161126175719", 19:46:09 INFO - "pgo_build": "False", 19:46:09 INFO - "basedir": "/builds/slave/test", 19:46:09 INFO - "buildnumber": 33, 19:46:09 INFO - "slavename": "t-yosemite-r7-0064", 19:46:09 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 19:46:09 INFO - "platform": "yosemite_r7", 19:46:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:46:09 INFO - "branch": "mozilla-central", 19:46:09 INFO - "repo_path": "mozilla-central", 19:46:09 INFO - "revision": "2a0abcff5cfce087c12f3e4820b5e8b773cffaca", 19:46:09 INFO - "stage_platform": "macosx64", 19:46:09 INFO - "builduid": "dcfcb404b91b467886609cce5ad68379", 19:46:09 INFO - "slavebuilddir": "test" 19:46:09 INFO - } 19:46:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:46:09 INFO - Running post-action listener: _resource_record_post_action 19:46:09 INFO - [mozharness: 2016-11-27 03:46:09.476752Z] Finished read-buildbot-config step (success) 19:46:09 INFO - [mozharness: 2016-11-27 03:46:09.476888Z] Running download-and-extract step. 19:46:09 INFO - Running pre-action listener: _resource_record_pre_action 19:46:09 INFO - Running main action method: download_and_extract 19:46:09 INFO - mkdir: /builds/slave/test/build/tests 19:46:09 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')]} 19:46:09 INFO - trying https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:46:09 INFO - Downloading https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 19:46:10 INFO - Downloaded 1199 bytes. 19:46:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:46:10 INFO - Using the following test package requirements: 19:46:10 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:46:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:46:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:46:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'jsshell-mac.zip'], 19:46:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:46:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:46:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:46:10 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:46:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:46:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:46:10 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:46:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:46:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:46:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:46:10 INFO - Fetch https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:46:11 INFO - Http code: 200 19:46:11 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 19:46:11 INFO - x-amz-cf-id: Xs4Qs3osgnXsHIH1C3_nn0I_0i17go356XPjUtyp96e7KYbwBFyObw== 19:46:11 INFO - x-amz-version-id: RPv6nTSohFI6Dpc12jmu9etOORSlfnhl 19:46:11 INFO - Expected file size: 16282582 19:46:11 INFO - Obtained file size: 16282582 19:46:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:46:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:46:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:46:18 INFO - Fetch https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:46:19 INFO - Http code: 200 19:46:19 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 19:46:19 INFO - x-amz-cf-id: BNxKH0h_dfMjMysxQ2tkf7jPdy2xnTQ7PyWfaJK6HvV1qeAYxmPB_A== 19:46:19 INFO - x-amz-version-id: RPv6nTSohFI6Dpc12jmu9etOORSlfnhl 19:46:19 INFO - Expected file size: 16282582 19:46:19 INFO - Obtained file size: 16282582 19:46:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:46:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:46:25 INFO - Fetch https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:46:26 INFO - Http code: 200 19:46:26 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 19:46:26 INFO - x-amz-cf-id: 5L2sYawzduLfkQ-tmwwVSS30aSBF2vVtddbCEl28bl6Tvfzxlew-5w== 19:46:26 INFO - x-amz-version-id: a_v4O.ojt2jsWGhmCjFEAgEv2WwXfVlI 19:46:28 INFO - Expected file size: 14409702 19:46:28 INFO - Obtained file size: 14409702 19:46:28 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')]} 19:46:28 INFO - trying https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:46:28 INFO - Downloading https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 19:46:32 INFO - Downloaded 107574125 bytes. 19:46:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:46:32 INFO - mkdir: /builds/slave/test/properties 19:46:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:46:32 INFO - Writing to file /builds/slave/test/properties/build_url 19:46:32 INFO - Contents: 19:46:32 INFO - build_url:https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:46:33 INFO - Running post-action listener: _resource_record_post_action 19:46:33 INFO - Running post-action listener: set_extra_try_arguments 19:46:33 INFO - [mozharness: 2016-11-27 03:46:33.219300Z] Finished download-and-extract step (success) 19:46:33 INFO - [mozharness: 2016-11-27 03:46:33.219443Z] Running populate-webroot step. 19:46:33 INFO - Running pre-action listener: _resource_record_pre_action 19:46:33 INFO - Running main action method: populate_webroot 19:46:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:46:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:46:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:46:33 INFO - '--tppagecycles', 19:46:33 INFO - '7'], 19:46:33 INFO - 'tests': ['tsvgm']}}, 19:46:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:46:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:46:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:46:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:46:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:46:33 INFO - 'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:46:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:46:33 INFO - 'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['damp', 'tps']}, 19:46:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:46:33 INFO - 'tests': ['damp', 'tps']}, 19:46:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['dromaeo_dom']}, 19:46:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:46:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['basic_compositor_video']}, 19:46:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:46:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['a11yr', 19:46:33 INFO - 'ts_paint', 19:46:33 INFO - 'tpaint', 19:46:33 INFO - 'sessionrestore', 19:46:33 INFO - 'sessionrestore_no_auto_restore', 19:46:33 INFO - 'tabpaint']}, 19:46:33 INFO - 'other-e10s': {'tests': ['a11yr', 19:46:33 INFO - 'ts_paint', 19:46:33 INFO - 'tpaint', 19:46:33 INFO - 'sessionrestore', 19:46:33 INFO - 'sessionrestore_no_auto_restore', 19:46:33 INFO - 'tabpaint']}, 19:46:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:46:33 INFO - 'ts_paint', 19:46:33 INFO - 'tpaint', 19:46:33 INFO - 'sessionrestore', 19:46:33 INFO - 'sessionrestore_no_auto_restore', 19:46:33 INFO - 'tabpaint']}, 19:46:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:46:33 INFO - 'ts_paint', 19:46:33 INFO - 'tpaint', 19:46:33 INFO - 'sessionrestore', 19:46:33 INFO - 'sessionrestore_no_auto_restore', 19:46:33 INFO - 'tabpaint']}, 19:46:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['a11yr', 19:46:33 INFO - 'ts_paint', 19:46:33 INFO - 'tpaint', 19:46:33 INFO - 'sessionrestore', 19:46:33 INFO - 'sessionrestore_no_auto_restore', 19:46:33 INFO - 'tabpaint']}, 19:46:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['a11yr', 19:46:33 INFO - 'ts_paint', 19:46:33 INFO - 'tpaint', 19:46:33 INFO - 'sessionrestore', 19:46:33 INFO - 'sessionrestore_no_auto_restore', 19:46:33 INFO - 'tabpaint']}, 19:46:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['tsvgx', 19:46:33 INFO - 'tsvgr_opacity', 19:46:33 INFO - 'tart', 19:46:33 INFO - 'tscrollx', 19:46:33 INFO - 'cart', 19:46:33 INFO - 'tsvg_static']}, 19:46:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:46:33 INFO - 'tsvgr_opacity', 19:46:33 INFO - 'tart', 19:46:33 INFO - 'tscrollx', 19:46:33 INFO - 'cart', 19:46:33 INFO - 'tsvg_static']}, 19:46:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:46:33 INFO - 'talos_options': ['--disable-e10s'], 19:46:33 INFO - 'tests': ['tp5o']}, 19:46:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:46:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:46:33 INFO - 'talos_options': ['--disable-e10s', 19:46:33 INFO - '--xperf_path', 19:46:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:33 INFO - 'tests': ['tp5n']}, 19:46:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:46:33 INFO - 'talos_options': ['--xperf_path', 19:46:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:33 INFO - 'tests': ['tp5n']}}, 19:46:33 INFO - 'talos.zip': {'path': '', 19:46:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:33 INFO - Running post-action listener: _resource_record_post_action 19:46:33 INFO - [mozharness: 2016-11-27 03:46:33.238129Z] Finished populate-webroot step (success) 19:46:33 INFO - [mozharness: 2016-11-27 03:46:33.238239Z] Running create-virtualenv step. 19:46:33 INFO - Running pre-action listener: _resource_record_pre_action 19:46:33 INFO - Running main action method: create_virtualenv 19:46:33 INFO - Creating virtualenv /builds/slave/test/build/venv 19:46:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:46:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:46:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:46:33 INFO - Using real prefix '/tools/python27' 19:46:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:46:34 INFO - Installing distribute.............................................................................................................................................................................................done. 19:46:36 INFO - Installing pip.................done. 19:46:36 INFO - Return code: 0 19:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:46:37 INFO - Reading from file tmpfile_stdout 19:46:37 INFO - Output received: 19:46:37 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) 19:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:37 INFO - 'HOME': '/Users/cltbld', 19:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:37 INFO - 'LOGNAME': 'cltbld', 19:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:37 INFO - 'MOZ_NO_REMOTE': '1', 19:46:37 INFO - 'NO_EM_RESTART': '1', 19:46:37 INFO - 'PAGER': '/bin/cat', 19:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:37 INFO - 'PWD': '/builds/slave/test', 19:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:37 INFO - 'SHELL': '/bin/bash', 19:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:37 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:37 INFO - 'USER': 'cltbld', 19:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:37 INFO - 'XPC_FLAGS': '0x0', 19:46:37 INFO - 'XPC_SERVICE_NAME': '0', 19:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:46:37 INFO - Cleaning up... 19:46:37 INFO - Return code: 0 19:46:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:37 INFO - 'HOME': '/Users/cltbld', 19:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:37 INFO - 'LOGNAME': 'cltbld', 19:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:37 INFO - 'MOZ_NO_REMOTE': '1', 19:46:37 INFO - 'NO_EM_RESTART': '1', 19:46:37 INFO - 'PAGER': '/bin/cat', 19:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:37 INFO - 'PWD': '/builds/slave/test', 19:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:37 INFO - 'SHELL': '/bin/bash', 19:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:37 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:37 INFO - 'USER': 'cltbld', 19:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:37 INFO - 'XPC_FLAGS': '0x0', 19:46:37 INFO - 'XPC_SERVICE_NAME': '0', 19:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:37 INFO - Downloading/unpacking psutil>=3.1.1 19:46:37 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 19:46:37 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 19:46:37 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 19:46:37 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 19:46:37 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 19:46:37 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 19:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:46:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:41 INFO - Installing collected packages: psutil 19:46:41 INFO - Running setup.py install for psutil 19:46:41 INFO - building 'psutil._psutil_osx' extension 19:46:41 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 19:46:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:46:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:46:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:46:42 INFO - building 'psutil._psutil_posix' extension 19:46:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:46:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:46:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:46:42 INFO - ^ 19:46:42 INFO - 1 warning generated. 19:46:42 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 19:46:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:42 INFO - Successfully installed psutil 19:46:42 INFO - Cleaning up... 19:46:42 INFO - Return code: 0 19:46:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:46:42 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')]} 19:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:42 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')]} 19:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:42 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 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:42 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 19:46:42 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 19:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:42 INFO - 'HOME': '/Users/cltbld', 19:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:42 INFO - 'LOGNAME': 'cltbld', 19:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:42 INFO - 'MOZ_NO_REMOTE': '1', 19:46:42 INFO - 'NO_EM_RESTART': '1', 19:46:42 INFO - 'PAGER': '/bin/cat', 19:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:42 INFO - 'PWD': '/builds/slave/test', 19:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:42 INFO - 'SHELL': '/bin/bash', 19:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:42 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:42 INFO - 'USER': 'cltbld', 19:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:42 INFO - 'XPC_FLAGS': '0x0', 19:46:42 INFO - 'XPC_SERVICE_NAME': '0', 19:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:46:45 INFO - Installing collected packages: mozsystemmonitor 19:46:45 INFO - Running setup.py install for mozsystemmonitor 19:46:45 INFO - Successfully installed mozsystemmonitor 19:46:45 INFO - Cleaning up... 19:46:46 INFO - Return code: 0 19:46:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:46:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:46 INFO - 'HOME': '/Users/cltbld', 19:46:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:46 INFO - 'LOGNAME': 'cltbld', 19:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:46 INFO - 'MOZ_NO_REMOTE': '1', 19:46:46 INFO - 'NO_EM_RESTART': '1', 19:46:46 INFO - 'PAGER': '/bin/cat', 19:46:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:46 INFO - 'PWD': '/builds/slave/test', 19:46:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:46 INFO - 'SHELL': '/bin/bash', 19:46:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:46 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:46 INFO - 'USER': 'cltbld', 19:46:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:46 INFO - 'XPC_FLAGS': '0x0', 19:46:46 INFO - 'XPC_SERVICE_NAME': '0', 19:46:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:46 INFO - Downloading/unpacking jsonschema==2.5.1 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:46:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:46:49 INFO - warning: no files found matching '*.txt' 19:46:49 INFO - no previously-included directories found matching 'build' 19:46:49 INFO - no previously-included directories found matching 'dist' 19:46:49 INFO - no previously-included directories found matching '.git*' 19:46:49 INFO - Installing collected packages: jsonschema, functools32 19:46:49 INFO - Running setup.py install for functools32 19:46:49 INFO - warning: no files found matching '*.txt' 19:46:49 INFO - no previously-included directories found matching 'build' 19:46:49 INFO - no previously-included directories found matching 'dist' 19:46:49 INFO - no previously-included directories found matching '.git*' 19:46:49 INFO - Successfully installed jsonschema functools32 19:46:49 INFO - Cleaning up... 19:46:49 INFO - Return code: 0 19:46:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:46:49 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')]} 19:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:49 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')]} 19:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:49 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 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:49 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 19:46:49 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 19:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:49 INFO - 'HOME': '/Users/cltbld', 19:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:49 INFO - 'LOGNAME': 'cltbld', 19:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:49 INFO - 'MOZ_NO_REMOTE': '1', 19:46:49 INFO - 'NO_EM_RESTART': '1', 19:46:49 INFO - 'PAGER': '/bin/cat', 19:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:49 INFO - 'PWD': '/builds/slave/test', 19:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:49 INFO - 'SHELL': '/bin/bash', 19:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:49 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:49 INFO - 'USER': 'cltbld', 19:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:49 INFO - 'XPC_FLAGS': '0x0', 19:46:49 INFO - 'XPC_SERVICE_NAME': '0', 19:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:46:49 INFO - Cleaning up... 19:46:49 INFO - Return code: 0 19:46:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:46:49 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')]} 19:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:49 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')]} 19:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:49 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 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:49 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 19:46:49 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 19:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:49 INFO - 'HOME': '/Users/cltbld', 19:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:49 INFO - 'LOGNAME': 'cltbld', 19:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:49 INFO - 'MOZ_NO_REMOTE': '1', 19:46:49 INFO - 'NO_EM_RESTART': '1', 19:46:49 INFO - 'PAGER': '/bin/cat', 19:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:49 INFO - 'PWD': '/builds/slave/test', 19:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:49 INFO - 'SHELL': '/bin/bash', 19:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:49 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:49 INFO - 'USER': 'cltbld', 19:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:49 INFO - 'XPC_FLAGS': '0x0', 19:46:49 INFO - 'XPC_SERVICE_NAME': '0', 19:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:50 INFO - Downloading/unpacking blobuploader==1.2.4 19:46:50 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 19:46:50 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 19:46:50 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 19:46:50 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 19:46:50 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 19:46:50 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 19:46:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:46:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46:53 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 19:46:53 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 19:46:53 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 19:46:53 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 19:46:53 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 19:46:53 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 19:46:53 INFO - Downloading docopt-0.6.1.tar.gz 19:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:54 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:54 INFO - Running setup.py install for blobuploader 19:46:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:46:54 INFO - Running setup.py install for requests 19:46:54 INFO - Running setup.py install for docopt 19:46:54 INFO - Successfully installed blobuploader requests docopt 19:46:54 INFO - Cleaning up... 19:46:54 INFO - Return code: 0 19:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:54 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 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:54 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 19:46:54 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 19:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:54 INFO - 'HOME': '/Users/cltbld', 19:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:54 INFO - 'LOGNAME': 'cltbld', 19:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:54 INFO - 'MOZ_NO_REMOTE': '1', 19:46:54 INFO - 'NO_EM_RESTART': '1', 19:46:54 INFO - 'PAGER': '/bin/cat', 19:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:54 INFO - 'PWD': '/builds/slave/test', 19:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:54 INFO - 'SHELL': '/bin/bash', 19:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:54 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:54 INFO - 'USER': 'cltbld', 19:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:54 INFO - 'XPC_FLAGS': '0x0', 19:46:54 INFO - 'XPC_SERVICE_NAME': '0', 19:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-28A65o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-C_SsQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Z7j7TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-o8rEHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-i_bzvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-VwlVWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-M6bYNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:55 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-8SluQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-m9fYMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-O5_CFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-cnETiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-3XMw7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-EXPEe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-t6dlq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Y7vy__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Hp5hVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:56 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-W7GAKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:56 INFO - Running setup.py install for manifestparser 19:46:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:46:57 INFO - Running setup.py install for mozcrash 19:46:57 INFO - Running setup.py install for mozdebug 19:46:57 INFO - Running setup.py install for mozdevice 19:46:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:46:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:46:57 INFO - Running setup.py install for mozfile 19:46:57 INFO - Running setup.py install for mozhttpd 19:46:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:46:57 INFO - Running setup.py install for mozinfo 19:46:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:46:57 INFO - Running setup.py install for mozInstall 19:46:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Running setup.py install for mozleak 19:46:58 INFO - Running setup.py install for mozlog 19:46:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Running setup.py install for moznetwork 19:46:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Running setup.py install for mozprocess 19:46:58 INFO - Running setup.py install for mozprofile 19:46:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:46:58 INFO - Running setup.py install for mozrunner 19:46:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:46:59 INFO - Running setup.py install for mozscreenshot 19:46:59 INFO - Running setup.py install for moztest 19:46:59 INFO - Running setup.py install for mozversion 19:46:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:46:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:46:59 INFO - Cleaning up... 19:46:59 INFO - Return code: 0 19:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:59 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 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:46:59 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 19:46:59 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 19:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:59 INFO - 'HOME': '/Users/cltbld', 19:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:59 INFO - 'LOGNAME': 'cltbld', 19:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:59 INFO - 'MOZ_NO_REMOTE': '1', 19:46:59 INFO - 'NO_EM_RESTART': '1', 19:46:59 INFO - 'PAGER': '/bin/cat', 19:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:59 INFO - 'PWD': '/builds/slave/test', 19:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:59 INFO - 'SHELL': '/bin/bash', 19:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:46:59 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:59 INFO - 'USER': 'cltbld', 19:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:59 INFO - 'XPC_FLAGS': '0x0', 19:46:59 INFO - 'XPC_SERVICE_NAME': '0', 19:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:59 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-AO0jNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:59 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)) 19:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:59 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-7xsDd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-9IrOLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-3LByXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-JWhkx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-n3LXNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-q76zde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-oLY5r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-HnuuIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-mYFCUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-PNcgQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:47:00 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-uiUolw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:47:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-hjlo7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:47:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-cp3xqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-tw2aPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:47:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Gh1Qbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:47:01 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-uz4use-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:47:01 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)) 19:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:47:01 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)) 19:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:47:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:04 INFO - Downloading blessings-1.6.tar.gz 19:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:47:04 INFO - Installing collected packages: blessings 19:47:04 INFO - Running setup.py install for blessings 19:47:04 INFO - Successfully installed blessings 19:47:04 INFO - Cleaning up... 19:47:04 INFO - Return code: 0 19:47:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:47:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:47:04 INFO - Reading from file tmpfile_stdout 19:47:04 INFO - Current package versions: 19:47:04 INFO - blessings == 1.6 19:47:04 INFO - blobuploader == 1.2.4 19:47:04 INFO - docopt == 0.6.1 19:47:04 INFO - functools32 == 3.2.3-2 19:47:04 INFO - jsonschema == 2.5.1 19:47:04 INFO - manifestparser == 1.1 19:47:04 INFO - mozInstall == 1.12 19:47:04 INFO - mozcrash == 1.0 19:47:04 INFO - mozdebug == 0.1 19:47:04 INFO - mozdevice == 0.49 19:47:04 INFO - mozfile == 1.2 19:47:04 INFO - mozhttpd == 0.7 19:47:04 INFO - mozinfo == 0.9 19:47:04 INFO - mozleak == 0.1 19:47:04 INFO - mozlog == 3.4 19:47:04 INFO - moznetwork == 0.27 19:47:04 INFO - mozprocess == 0.23 19:47:04 INFO - mozprofile == 0.28 19:47:04 INFO - mozrunner == 6.13 19:47:04 INFO - mozscreenshot == 0.1 19:47:04 INFO - mozsystemmonitor == 0.3 19:47:04 INFO - moztest == 0.7 19:47:04 INFO - mozversion == 1.4 19:47:04 INFO - psutil == 3.1.1 19:47:04 INFO - requests == 1.2.3 19:47:04 INFO - wsgiref == 0.1.2 19:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:04 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 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:47:04 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 19:47:04 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 19:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:04 INFO - 'HOME': '/Users/cltbld', 19:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:04 INFO - 'LOGNAME': 'cltbld', 19:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:04 INFO - 'MOZ_NO_REMOTE': '1', 19:47:04 INFO - 'NO_EM_RESTART': '1', 19:47:04 INFO - 'PAGER': '/bin/cat', 19:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:04 INFO - 'PWD': '/builds/slave/test', 19:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:04 INFO - 'SHELL': '/bin/bash', 19:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:47:04 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:04 INFO - 'USER': 'cltbld', 19:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:04 INFO - 'XPC_FLAGS': '0x0', 19:47:04 INFO - 'XPC_SERVICE_NAME': '0', 19:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 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)) 19:47:04 INFO - Cleaning up... 19:47:04 INFO - Return code: 0 19:47:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10883c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7eb5d67a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, '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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 19:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:04 INFO - 'HOME': '/Users/cltbld', 19:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:04 INFO - 'LOGNAME': 'cltbld', 19:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:04 INFO - 'MOZ_NO_REMOTE': '1', 19:47:04 INFO - 'NO_EM_RESTART': '1', 19:47:04 INFO - 'PAGER': '/bin/cat', 19:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:04 INFO - 'PWD': '/builds/slave/test', 19:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:04 INFO - 'SHELL': '/bin/bash', 19:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:47:04 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:04 INFO - 'USER': 'cltbld', 19:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:04 INFO - 'XPC_FLAGS': '0x0', 19:47:04 INFO - 'XPC_SERVICE_NAME': '0', 19:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:47:05 INFO - Cleaning up... 19:47:05 INFO - Return code: 0 19:47:05 INFO - Running post-action listener: _resource_record_post_action 19:47:05 INFO - Running post-action listener: _start_resource_monitoring 19:47:05 INFO - Starting resource monitoring. 19:47:05 INFO - [mozharness: 2016-11-27 03:47:05.264084Z] Finished create-virtualenv step (success) 19:47:05 INFO - [mozharness: 2016-11-27 03:47:05.265099Z] Running install step. 19:47:05 INFO - Running pre-action listener: _resource_record_pre_action 19:47:05 INFO - Running main action method: install 19:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:47:05 INFO - Reading from file tmpfile_stdout 19:47:05 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:47:05 INFO - Reading from file tmpfile_stdout 19:47:05 INFO - Output received: 19:47:05 INFO - Usage: mozinstall [options] installer 19:47:05 INFO - Options: 19:47:05 INFO - -h, --help show this help message and exit 19:47:05 INFO - -d DEST, --destination=DEST 19:47:05 INFO - Directory to install application into. [default: 19:47:05 INFO - "/builds/slave/test"] 19:47:05 INFO - --app=APP Application being installed. [default: firefox] 19:47:05 INFO - mkdir: /builds/slave/test/build/application 19:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:47:38 INFO - Reading from file tmpfile_stdout 19:47:38 INFO - Output received: 19:47:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:47:38 INFO - Running post-action listener: _resource_record_post_action 19:47:38 INFO - [mozharness: 2016-11-27 03:47:38.396165Z] Finished install step (success) 19:47:38 INFO - [mozharness: 2016-11-27 03:47:38.396294Z] Running run-tests step. 19:47:38 INFO - Running pre-action listener: _resource_record_pre_action 19:47:38 INFO - Running main action method: run_tests 19:47:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:47:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:47:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:47:38 INFO - 2016-11-26 19:47:38.410 screenresolution[1629:8072] starting screenresolution argv=screenresolution get 19:47:38 INFO - 2016-11-26 19:47:38.413 screenresolution[1629:8072] Display 0: 1600x1200x32@60 19:47:38 INFO - 2016-11-26 19:47:38.419 screenresolution[1630:8074] starting screenresolution argv=screenresolution list 19:47:38 INFO - Available Modes on Display 0 19:47:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:47:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:47:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:47:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:47:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:47:38 INFO - Intel Iris: 19:47:38 INFO - Chipset Model: Intel Iris 19:47:38 INFO - Type: GPU 19:47:38 INFO - Bus: Built-In 19:47:38 INFO - VRAM (Dynamic, Max): 1536 MB 19:47:38 INFO - Vendor: Intel (0x8086) 19:47:38 INFO - Device ID: 0x0a2e 19:47:38 INFO - Revision ID: 0x0009 19:47:38 INFO - Displays: 19:47:38 INFO - Display: 19:47:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:47:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:47:38 INFO - Display Serial Number: 1600x1200 60 19:47:38 INFO - Main Display: Yes 19:47:38 INFO - Mirror: Off 19:47:38 INFO - Online: Yes 19:47:38 INFO - Rotation: Supported 19:47:38 INFO - Return code: 0 19:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:47:38 INFO - Python 2.7.3 19:47:38 INFO - Return code: 0 19:47:38 INFO - grabbing minidump binary from tooltool 19:47:38 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')]} 19:47:38 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 0x1086dcd30>, '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 0x108543db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086d4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:47:38 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 19:47:38 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 19:47:38 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 19:47:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:38 INFO - Return code: 0 19:47:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:47:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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 19:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0064 --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 19:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qWn4JOsT3g/Render', 19:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:38 INFO - 'HOME': '/Users/cltbld', 19:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:38 INFO - 'LOGNAME': 'cltbld', 19:47:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:47:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:38 INFO - 'MOZ_NO_REMOTE': '1', 19:47:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:47:38 INFO - 'NO_EM_RESTART': '1', 19:47:38 INFO - 'PAGER': '/bin/cat', 19:47:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:38 INFO - 'PWD': '/builds/slave/test', 19:47:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:38 INFO - 'SHELL': '/bin/bash', 19:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XO23nR8ilZ/Listeners', 19:47:38 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 19:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:38 INFO - 'USER': 'cltbld', 19:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:38 INFO - 'XPC_FLAGS': '0x0', 19:47:38 INFO - 'XPC_SERVICE_NAME': '0', 19:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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 19:47:39 INFO - mozversion application_buildid: 20161126175719 19:47:39 INFO - mozversion application_changeset: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca 19:47:39 INFO - mozversion application_display_name: Nightly 19:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:39 INFO - mozversion application_name: Firefox 19:47:39 INFO - mozversion application_remotingname: firefox 19:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:47:39 INFO - mozversion application_vendor: Mozilla 19:47:39 INFO - mozversion application_version: 53.0a1 19:47:39 INFO - mozversion platform_buildid: 20161126175719 19:47:39 INFO - mozversion platform_changeset: 2a0abcff5cfce087c12f3e4820b5e8b773cffaca 19:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:47:39 INFO - mozversion platform_version: 53.0a1 19:47:39 INFO - using testdate: 1480218459 19:47:39 INFO - actual date: 1480218459 19:47:39 INFO - starting webserver on 'localhost:49247' 19:47:39 INFO - SUITE-START | Running 2 tests 19:47:39 INFO - TEST-START | dromaeo_css 19:47:39 INFO - operating with platform_type : mac_ 19:47:39 INFO - Initialising browser for dromaeo_css test... 19:47:39 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmptEvBl7/profile http://localhost:49247/getInfo.html) 19:47:41 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 19:47:41 INFO - PROCESS | 1640 | colorDepth:24 19:47:41 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 19:47:41 INFO - PROCESS | 1640 | __metrics 19:47:41 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:47:41 INFO - PROCESS | 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:42 INFO - TEST-INFO | 1640: exit 0 19:47:42 INFO - Browser initialized. 19:47:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:47:42 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmptEvBl7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:54 INFO - PROCESS | 1643 | RSS: Main: 244695040 19:47:54 INFO - PROCESS | 1643 | 19:48:45 INFO - PROCESS | 1643 | 1480218525557 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] 19:50:58 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 19:51:00 INFO - PROCESS | 1643 | RSS: Main: 384622592 19:51:00 INFO - PROCESS | 1643 | 19:54:04 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 19:54:04 INFO - PROCESS | 1643 | RSS: Main: 377143296 19:54:04 INFO - PROCESS | 1643 | 19:57:07 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 19:57:07 INFO - PROCESS | 1643 | RSS: Main: 350535680 19:57:07 INFO - PROCESS | 1643 | 20:00:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 20:00:10 INFO - PROCESS | 1643 | RSS: Main: 352763904 20:00:10 INFO - PROCESS | 1643 | 20:03:14 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 20:03:14 INFO - PROCESS | 1643 | RSS: Main: 341372928 20:03:14 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 20:06:18 INFO - PROCESS | 1643 | RSS: Main: 429338624 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | __start_tp_report 20:06:18 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 20:06:18 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 20:06:18 INFO - PROCESS | 1643 | |i|pagename|runs| 20:06:18 INFO - PROCESS | 1643 | |0;dojo.html;2702.918912432627;3286.1291757684203;3289.967100328997;3313.370459612675;3353.295807880345;5541.33503979522;5553.666779993198;5603.719814009293;5612.0178968680475;5612.186232996213;5591.6365436246615;5620.185073164389;5622.269105016342;5632.35227948786;5646.237757902682;4260.233158031569;5104.33643626328;5129.666571672829;5150.948490515103;5224.686518808883;4183.372494125891;5143.53708166265;5160.122779127539;5213.139831927728;5232.372115346164;5214.661047031931;5223.6343455958095;5225.921611175835;5235.424103348629;5269.341332333458;5186.896262074756;5237.659552129137;5242.97378513105;5247.658902171384;5284.735763211824;4097.85657501986;4979.377577802775;5131.461196574381;5136.666116702402;5199.168133098686;5549.223108764776;5578.191162281447;5661.377248502661;5665.575081868835;5674.177244299594;5918.644881307136;5922.170896074553;5938.703064846741;5956.106584012389;5972.134040564138;6057.454829065361;6075.119107729354;6137.877242455126;6144.433169541783;6147.493864003303;5694.174344719992;5702.572307076985;5722.2561067061015;5742.59801813869;5782.624129431573;6219.129321894939;6224.782132625336;6242.750289988349;6242.875142497124;6250.874982500324;5878.412158784173;6056.303525094582;6059.272887253558;6059.697015149225;6067.423594758491;6115.088229002436;6125.816225513242;6131.69422353494;6134.00801433197;6136.570440069152;6082.543809214327;6126;6128.938710612926;6132.233470816148;6134.4172303631085;6118.445944600367;6134.130457564626;6143.139960405547;6154.076888466766;6155.169052177988;4885.071836351082;4893.535114164149;4897.8285759998225;4925.285833554115;4947.158982972831;4128.483939507561;4246.8725938221905;4377.387165796791;4398.73607583546;4413.602775750198;5494.697791621499;5540.889182216414;5545.7781688732;5596.076647353141;5726.570507211893;6076.75692972285;6088.939110608926;6093.146959425684;6113.663748493786;6116.633002019893;5572.164175373645;5576.052071147915;5580.330360356783;5584.413636568183;5598.748056337475;5202.739863006835;5218.9739051304505;5221.034108689904;5229.215617657305;5232.058229518723;6117.027903893791;6186.628802271878;6201.410865967816;6206;6229.12792209082;6107.4922612924165;6144.849302744004;6154.815355539341;6194.163787888578;6245.0632405139595;6243.282022567281;6248.031555108965;6254.906176407449;6256.7810126645345;6261.718222680081;5588.239704493071;6055.1522786809;6075.392460753889;6076.088586712029;6076.3012253591405;5026.74866256693;5893.616914900518;5921.082232254007;5932.228810254639;6143.112737013596;6017.759289628366;6026.879462410815;6027.065804800263;6029.095635654687;6047.758089676364;6011.098335249572;6015.2781666200335;6025.126356678169;6029.427204415573;6030.246219222598;5705.144228365778;5734.311882574118;5746.195532625352;5852.4147585241135;5869.06095024794;5142.202958541432;5818.679972601548;5889.263842019747;5962.19510366095;5999.100134979788;5769.990251705851;5782.10377391505;5783.595148339576;5813.56398270123;5855.063189889597 20:06:18 INFO - PROCESS | 1643 | |1;ext.html;486.817443458703;517.0099259917257;540.4973374761475;541.4720647368816;562.783328418559;29950.700492995064;31174.753009879605;38566.99999999996;39594.40608390876;39659.60340396595;40879.79560102203;41071.79464102683;41093;41173.7941310293;41175.58824411755;9216.49309287989;9231.353805233653;9364.11040951112;9385.343025988184;9390.765230869249;8450.57747112645;8659.69691060813;9269.212116970066;10995;11303.604373846916;10897.83653245202;10989.725256868562;10993.560257589726;10998.175136864727;11010.724731881726;11135.498902549365;11192.776144477064;11215.046721028722;11218.719532011683;11221.831672524837;8054.114047454776;8278.958605206935;8286.917130828675;8385.371097167737;11037.061849742782;31304.53043204354;38261.42607860884;38883;38914.61085389138;40048.59951400507;3254.9096052822333;3357.748168887343;3377.5609170807884;3610.151614370621;3616.764910280823;28711.85644071787;29763.70236297631;29956.400871982656;29977;30002.649615805585;3144.748420126384;3259.8044117353033;3285.4414749492644;3299.5710557627353;3336.099253201646;479543;493555.9999999964;497577;501088;501174;55771.88456230853;56102.719486402304;56112.15831762527;56156;56247;58189.8362032757;58201.12698309529;58348.70825645845;58374;58410.415895841346;13276.800847987288;14909.478168264059;15050;15205.771913421308;15545.455909043356;12094.939525302494;12182.512699492097;12185.512579496899;12186;12203.267803931793;13028.739425211632;13331.33343332849;14354.066985645899;14793.334299956528;14799.334029968677;5503.6147469677535;5968.418948630787;6063.211782468339;6098.316740634195;6134.539909506805;849.5794581682106;912.2018234045211;915.6566287642135;939.2673714502699;1008.0725732326277;22573.774262257168;29192.854035729684;29578.40843183124;29591.704082959324;30444.54333185004;970.7815741458115;996.0487734213808;1026.1893104447552;1075.1184029096223;1144.9427528623535;14025.509107181404;14589.124652520883;14614.415423383158;14852.331645075998;14860.5541833743;650103;654638;655420;655927.0851040381;656163;45155.096898061856;46036.76981615071;51763;52578;52653.683657908856;1320.7028418605928;1349.284879014124;1369.5754316162022;1371.4171477122384;1377.4696741754296;28847.711522884503;28906;28976.7102328974;29428.705712943454;29806.70193298039;47625.285620715025;47821.04357912752;47959.5204047969;47964.32570788657;48021.519784801705;579030;580228;581239;583278;584705;24178.637320439855;24482.877585611957;42091;44088.77955610202;44108.558914410445;41355.7932210337;45516.31725524054;46755.76622116868;47050.117995279805;48171.5182848167;39394.803025984686;39863.80408587747;40515.1896962065;40602.79698601488;41695;38802.6419075331;38943.805280973414;39458.80270598629;40458.79770601128;40645.983850402794;37199.81400092982;37526.43710344402;37960.62039379571;38218.617813821504;38616.80691596524;32941.67058329386;34260.82869585636;34267.98391500789;34380.31239375148;34603.30793384169;20511.589768204853;25387;25425.61861572115;25668.74331256738;26167.607485888107 20:06:18 INFO - PROCESS | 1643 | |2;jquery.html;347.7565704007194;352.7107771627267;367.665424463738;370.11727031030983;378.1661436532446;14513.419463221471;14852.554423367303;15621.84378156218;19698.606027879432;20166.395008149742;16472.929259598117;18656.160472778723;19450.61098778027;20347.69478457824;20357.185712571518;5134.435212126672;5399.946000540003;5418.539424148932;5418.647787893794;5419.674819510842;4573.405457290564;5351.839444816662;5914.260717410324;5954.612950158247;5978.461938425541;5794.130880367937;5909.704514774266;5918.4673379395845;5921.703914804264;5932.584719069645;5332.33345831771;5395.919061214085;5406.810761623364;5411.621186516945;5519.199716041172;5225;5228.032813929435;5231.110711179109;5235.869103272411;5248.0553500369915;23317.883410583006;24312.756872431404;24433.778311084374;24927.750722492907;25016.874915625307;2139.486523234428;2148.3232781673723;2245.62947113726;2272.4659704969317;2372.7068747532635;9573.712788616353;9917.066172096444;10348.154257579226;14423.711525769531;14747;1740.3560682547538;1760.128736275539;1771.5393997560727;1814.2833580735535;1840.1811194018667;124088.37955810253;125598;126123;126251.36874315569;126934;11065.668029959113;11248.493817778219;11296.458296883136;11356.261842980344;11535.653930382103;14051.71896562063;14061.648458788408;14446.566603001927;14449.78325325121;14462.566123016326;6535.738570457223;8262.710805121791;8282.627281772335;8315.792105197419;8433.367497437717;8148.10370859205;8148.470349427387;8325.916740832636;8339.12439193876;8343.332533397313;4340.52254252032;4381.846635367747;4443.6889417741095;4490.236659767847;4615.976920115445;1680.3698613020117;1860.3767737807716;1875.1842948317526;1890.6481865466258;1914.6457905287566;638.9361712748315;801.2828518476048;864.7708357285325;954.3367359684952;974.7660561465198;19443.22227110928;20202.494937626678;20338.79661203369;20359.77841329525;20496.795032049788;934.1545900959643;937.1846493550654;948.83869742144;949.8955114937352;970.1414248390225;10170;10629.149668026539;10656.20078494116;10678.145748340114;10721.927807219372;584852;585949;592694;598843;603521;119791;127623;128203.07695384577;139824;145000;845.7758693946109;962.841131213356;986.4919566423298;986.7779749556436;991.1228562722043;18037.639247215244;18345.72481412753;18408.447746567625;18435.53911152232;18451.630967380308;49394.012119758125;50208.24687629615;51600.74199629128;51834.22248666197;52660.73669631627;72675.27324726686;72841;73472.6326368386;73801;75930.62034689791;6249.0626406039455;7602.771916842504;7861.449698521049;7888.092869320101;8128.0246370435925;10122.418783210234;11956.58151964677;12127.75744485123;12305.753884922431;12375.195612285173;10444.529996150039;10453.581856725647;10688.144948403953;10856.837147442637;10942.343459392461;8747.256483198998;10212.846807297748;10328.277020608786;10599.258051936598;10689.625863094754;7406.07424071991;7672.8849067265155;7934.523928564305;8107.06768721581;10576.418296993432;7945.761627151194;10831.51258193399;11199.832002519806;11337.716557086138;11356.205065645325;10513.211509136692;10696.358218506915;11285.943570282096;11325.32048077118;11426.885731142582 20:06:18 INFO - PROCESS | 1643 | |3;mootools.html;1314.664760486076;1456.7887656289838;1473.99263003685;1642.1296712742244;1845.5386153461634;7253.963730181348;7667.769966900988;7998.200179981999;8143.022837259522;8168.67325306987;8084.878726819103;8176.182381761821;8176.38677099217;8177.509349439038;8179.222973817493;2265.1958554713087;2305.0664480885184;2308.4459729664845;2312.9530365626374;2314.259436980167;2073.295079672911;2133.957320853582;2240.182333448288;2326.7789559991775;2343.285297984114;2257.7967982881537;2308.088305119477;2309.6535519672016;2310.595645761993;2315.2938353802083;2274.943126421844;2310.699609050813;2313.8264630152808;2315.4674424882373;2318.5594736999915;2275.465265662568;2285.611446054158;2302.792748652629;2303.389601755536;2304.8040916522114;8108.797280067986;8168.714095006706;8177.427580069398;8190;8200.466969646954;4906.509349065101;5106.08090543702;5107.7956881724685;5109.744512774347;5113.130767769489;2911.5050441424796;3252.398306313316;3412.334594754024;3466.185446420089;3477.669621385964;857.2284943550792;945.2107490245653;1049.795289918466;1079.83262594298;1097.3415950429758;10322.638707645196;10590.25868189227;10592.947035264775;10615.628453004108;10630;4238.766867822238;4504.819807207675;4565.315202719552;4572.268437050123;4579.152856721517;9260;9277.025912279249;9280.675176368795;9282.025387334368;9314.580843862042;5079.5428411443145;5101.719405432663;5103.693778373309;5108.361454818148;5108.412532558729;4522.34426008227;4563.680542362003;4608.986023074918;4633.374494443207;4692.343071969927;3084.784065115465;3588.8385022674042;3640.8361623726996;3698.223373091681;3722.3671975763646;1056.4506456642503;1195.0797885628017;1225.3995542184266;1226.7055906582534;1238.8823061809114;754.9509281896769;822.7943014246439;850.5492089192737;898.6944438890808;930.7393929699695;5273.499017593323;5509.228707980886;5687.203791469197;5755.712214389264;5801.274840644919;902.4540153207215;935.5088578496208;939.9530023498797;946.2902822882838;971.7522031881825;3644.728055205133;3780.5085338905765;3798.753081049723;3841.442990766379;3842.654161125512;9310.674126405544;9758.2766665013;9797.461139637246;9840.606375745034;9936.403815771077;9723.173530249867;9829.55766990487;9838.557264923096;9838.60645574169;9885.752856178653;7446.2926022028905;7637.732679356196;7700;7752.883706744404;7762.340201082971;5335.78656853737;5361.061814182581;5482.780688772564;5567.387587365468;5645.0605719995;9019.819603608023;9033.232175265177;9098.954505227432;9127.132922372364;9247;9123.27013838878;9178.54107294646;9197.678081267124;9317.44095354281;9343.859842102238;6465.77369792055;6678.899816502853;6683.331666833472;6686.69909854048;6720.865582688417;7312.597807120659;7502.774916752506;7559.433042521723;7572.659230334758;7699.692012319669;6925.995730619133;7012.929870701431;7058.329458701415;7061.435085193069;7069.293070693096;6826.010228516937;6907.102076729993;6921.688524016532;6966.059581956371;6967.895481567679;6423.775167869102;6541.443977261986;6563.146790917151;6563.474922006323;6568.967155164193;4582.289745089516;4738.4787673356595;4787.976060119677;4839.588634965927;4887.926681099858;4735.573798358164;4783.234682450791;4861.51384861511;4894.608431325414;4994.625403094709 20:06:18 INFO - PROCESS | 1643 | |4;prototype.html;271.5912551609827;279.6420581655482;295.87868973720776;296.15300241309865;305.90975662179653;4466.464024317078;4723.504032076634;4778.924741933063;4852.199387101128;4971.651984361096;4661.743604101773;4906.484819093988;4913.231236754766;4948.851534453963;4975.278584605239;3280.8353034672705;3833.9041523961846;3843.21290599871;3845.8653947111857;3854.575996640381;3302.8348582570898;3652.926941461169;3769.6230376962358;3786.318462676717;3803.657670809627;3792.2036372361836;3794.848206071754;3812.752171108883;3830.5211848518934;3833.6933045356445;3162.857671404781;3785.069614496599;3804.144067584813;3820.178661587744;3836.846526138979;2598;2849.173739615509;3187.8087314760955;3291.736661067133;3389.2035371687634;3878.9030274243087;3961.6830653547936;4738.597219236334;4775.2598347256235;4777.116233496814;4278.272693642089;4294.549072347421;4309.784510774449;4316.309390497506;4324.9135017299795;4674.509176536449;5133.948660513384;5155.432902380735;5173.637845350827;5189.844304670828;3563.94654080189;3572.356975744365;3575.982120089409;3585.748997570171;3593.7304702147444;4663.790129444184;5313.555764348404;5339.866503337409;5391.56867450603;5412.864678383033;3140.2149462634343;3205.374951884407;3621.63783621641;3646.4348026056005;3656.597774244831;3096.814191148538;3484.6689564491335;3644.7084233261276;3683.116052147519;3698.537682789651;4071.918561628751;4150.64719498846;4160.271952408317;4262.444207864107;4285.807138678767;5194.532492075731;5213.426523082458;5225.242339860699;5225.878638933866;5252.29094072303;1057.349729916096;1196.9222000569935;1199.5022065842752;1200.2318516149671;1200.2618389690278;653.3760258952689;717.3472140352254;819.2667562531501;831.6257684042205;836.2431999040878;3965.524137103566;4203.696853975216;4241.533431322552;4631.166390049823;4648.814047438133;4323.437953066082;4435.955640443554;4772.665913386029;4987.825426110141;5023.287424790572;4057.829061452168;4145.450547913072;4519.689290105898;4604.526551503487;4629.675922685447;2526.585112337097;2625.3090582153063;2639.0235612822994;2650.032738050598;2653.9203823885314;4653.581177694024;4697.741624210701;5154.948450515447;5162.328897243335;5165.896682066337;4930.457649658535;5072.300779238923;5097.286379906816;5118.411382691038;5150.845474635767;4692.7653617319;4717.811287548459;4980.352554168007;5645.741703318706;5676.240365486712;4790.6167506598695;4978.1288274552535;5380.784768609212;5383.946160538345;5395.298611180521;5015.498450154955;5042.647014708935;5209;5329.7068661224;5338.97330513345;5082.923756143587;5196.584273258206;5612.971935140298;5635.690037047838;5643.294588176478;3171.746260299217;3439.329330780474;3440.950510094345;3667.7615954962844;3684.4525299374864;4428.7121337112985;4975.5522003019905;5094.592432605456;5361.276227709365;5375.7262975933445;4197.782643033486;4687.554682305175;4771.618270538279;5162.716050617252;5229.13719236337;4179.310413781692;4259.87220383389;5078.546588319978;5151.5363617274625;5219.321488206509;4418.226810308119;4766.713997160182;4860.805567777249;4880.755962201804;5126.769295381642;4546.568076032771;5058.772355244097;5149.738314113066;5272.098647001269;5275.762590683506;5100.862969273944;5103.132467480612;5130.6152038598;5141.562967147835;5173.560247379015 20:06:18 INFO - PROCESS | 1643 | |5;yui.html;627.3726273726273;738.3354980517533;744.8622004929089;774.9457537972344;795.5465384730704;14598.489052883151;14932.925335373322;15455.922720386383;15641.139737314443;15655.217239138026;12716;12749.872501274984;12810.359482025908;13089.869101309008;13909.095908765923;821.8356328734247;834.9791255218638;838.9748307550783;840.0926998841268;840.2353857989231;659.696539591786;682.5972676121088;815.1115284340068;837.0499483086679;848.1815048478218;891.6210610490548;891.692366133686;893.2764460786783;895.3866601378077;898.0077014898509;845.7927807687125;848.1137211613817;849.3629777666719;866.9003064647583;876.4259410086404;520.1885059307455;537.3444397834636;642.8521440068764;663.8439966607843;665.9900101498481;15026.474073407488;15030.849691503163;15059.548213553611;15085.170315632637;15089.320980555902;13626.591202263948;13655.931720341434;13669.043166978316;13680.794788078187;13746.518871839438;12571.497140114385;12762.872371276262;12895.419706113247;12903.548375806802;13369.131006484547;4306.5262821089655;4371.4098596689355;4383.517813040595;4439.20955345609;4449.577290157462;99698.501507492;100474.49762751213;100689;101826;103946.48026759893;10595.947020265003;10748.838767418494;10800.621978230723;10845.13238940883;11095;21017.369478915658;21042;21089.894550527148;21109;21121.894390528258;7334.3032411920785;7491.288327608869;7533.773986780406;7656.349210317186;7790.844183116419;4192.93679742431;4274.187904298174;4309.224339618899;4442.533533978885;4455.75493347869;3339.131825725329;3353.480210567366;3373.139849338403;3464.8267586621073;3465.4455287153933;598.6348327520209;602.0577795749638;607.1348328631682;609.7530500147448;621.6767281013938;591.3124847567728;602.8944934636421;619.2105066040834;620.5749061892618;640.2093414632925;7329.486935914541;8727.996280427706;8978.595963181542;8980.101989800967;9170.49562274068;535.370939146509;595.5354823237882;620.3765215957933;645.4868379638199;645.6997496164306;3848.5189351331082;4246.575342465729;4419.113987058238;4588.462359029273;4685.437747470325;101590;103210.38763643237;105427;105735;105954.94045059451;78128.60935695285;87578.68631970526;93981;97045.5147724271;97152.51423742836;78142;79146.20853791389;79243.60378198072;80734.88976653549;82754.58622706847;8747.431416957877;8861.689840855539;8869.68956086534;8991.41555798871;9022.323325750725;50892;51699.74150129225;52135.2179717297;52244.47755522396;54136;69604;71120;72345.27654723385;72771;75975;9714.75713107178;11476.368799715761;11695.356755378536;11733.589324373606;11957.880421196025;12609;12703.797569395927;12959.287239201934;12997.15518491295;13285.66785830362;11650.76698466043;11880.881191188324;12101.636950891487;12171.33057681836;12469;11291.3789741565;12288.75422491563;12435.316057616918;13360.665983350495;13368.398422070835;11117.666470005914;12763.744725105631;13196.406161722554;13210.669733256746;13784.172949623055;10424.218183636105;11021.228514003942;11122;11575.189736718348;11686.123540734308;10491.527881245514;10979.670609881716;11422.543098276308;11456.083513319081;11460.885391145981 20:06:18 INFO - PROCESS | 1643 | __end_tp_report 20:06:18 INFO - PROCESS | 1643 | __start_cc_report 20:06:18 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1943 20:06:18 INFO - PROCESS | 1643 | __end_cc_report 20:06:18 INFO - PROCESS | 1643 | __startTimestamp1480219578317__endTimestamp 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | ------- Summary: start ------- 20:06:18 INFO - PROCESS | 1643 | Number of tests: 6 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5614.17 Median:5782.62 stddev:659.12 (11.4%) stddev-sans-first:620.32 20:06:18 INFO - PROCESS | 1643 | Values: 2702.9 3286.1 3290.0 3313.4 3353.3 5541.3 5553.7 5603.7 5612.0 5612.2 5591.6 5620.2 5622.3 5632.4 5646.2 4260.2 5104.3 5129.7 5150.9 5224.7 4183.4 5143.5 5160.1 5213.1 5232.4 5214.7 5223.6 5225.9 5235.4 5269.3 5186.9 5237.7 5243.0 5247.7 5284.7 4097.9 4979.4 5131.5 5136.7 5199.2 5549.2 5578.2 5661.4 5665.6 5674.2 5918.6 5922.2 5938.7 5956.1 5972.1 6057.5 6075.1 6137.9 6144.4 6147.5 5694.2 5702.6 5722.3 5742.6 5782.6 6219.1 6224.8 6242.8 6242.9 6250.9 5878.4 6056.3 6059.3 6059.7 6067.4 6115.1 6125.8 6131.7 6134.0 6136.6 6082.5 6126.0 6128.9 6132.2 6134.4 6118.4 6134.1 6143.1 6154.1 6155.2 4885.1 4893.5 4897.8 4925.3 4947.2 4128.5 4246.9 4377.4 4398.7 4413.6 5494.7 5540.9 5545.8 5596.1 5726.6 6076.8 6088.9 6093.1 6113.7 6116.6 5572.2 5576.1 5580.3 5584.4 5598.7 5202.7 5219.0 5221.0 5229.2 5232.1 6117.0 6186.6 6201.4 6206.0 6229.1 6107.5 6144.8 6154.8 6194.2 6245.1 6243.3 6248.0 6254.9 6256.8 6261.7 5588.2 6055.2 6075.4 6076.1 6076.3 5026.7 5893.6 5921.1 5932.2 6143.1 6017.8 6026.9 6027.1 6029.1 6047.8 6011.1 6015.3 6025.1 6029.4 6030.2 5705.1 5734.3 5746.2 5852.4 5869.1 5142.2 5818.7 5889.3 5962.2 5999.1 5770.0 5782.1 5783.6 5813.6 5855.1 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:70126.93 Median:38898.81 stddev:155334.98 (399.3%) stddev-sans-first:155682.73 20:06:18 INFO - PROCESS | 1643 | Values: 486.8 517.0 540.5 541.5 562.8 29950.7 31174.8 38567.0 39594.4 39659.6 40879.8 41071.8 41093.0 41173.8 41175.6 9216.5 9231.4 9364.1 9385.3 9390.8 8450.6 8659.7 9269.2 10995.0 11303.6 10897.8 10989.7 10993.6 10998.2 11010.7 11135.5 11192.8 11215.0 11218.7 11221.8 8054.1 8279.0 8286.9 8385.4 11037.1 31304.5 38261.4 38883.0 38914.6 40048.6 3254.9 3357.7 3377.6 3610.2 3616.8 28711.9 29763.7 29956.4 29977.0 30002.6 3144.7 3259.8 3285.4 3299.6 3336.1 479543.0 493556.0 497577.0 501088.0 501174.0 55771.9 56102.7 56112.2 56156.0 56247.0 58189.8 58201.1 58348.7 58374.0 58410.4 13276.8 14909.5 15050.0 15205.8 15545.5 12094.9 12182.5 12185.5 12186.0 12203.3 13028.7 13331.3 14354.1 14793.3 14799.3 5503.6 5968.4 6063.2 6098.3 6134.5 849.6 912.2 915.7 939.3 1008.1 22573.8 29192.9 29578.4 29591.7 30444.5 970.8 996.0 1026.2 1075.1 1144.9 14025.5 14589.1 14614.4 14852.3 14860.6 650103.0 654638.0 655420.0 655927.1 656163.0 45155.1 46036.8 51763.0 52578.0 52653.7 1320.7 1349.3 1369.6 1371.4 1377.5 28847.7 28906.0 28976.7 29428.7 29806.7 47625.3 47821.0 47959.5 47964.3 48021.5 579030.0 580228.0 581239.0 583278.0 584705.0 24178.6 24482.9 42091.0 44088.8 44108.6 41355.8 45516.3 46755.8 47050.1 48171.5 39394.8 39863.8 40515.2 40602.8 41695.0 38802.6 38943.8 39458.8 40458.8 40646.0 37199.8 37526.4 37960.6 38218.6 38616.8 32941.7 34260.8 34268.0 34380.3 34603.3 20511.6 25387.0 25425.6 25668.7 26167.6 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:34722.15 Median:24972.31 stddev:99374.92 (397.9%) stddev-sans-first:99620.17 20:06:18 INFO - PROCESS | 1643 | Values: 347.8 352.7 367.7 370.1 378.2 14513.4 14852.6 15621.8 19698.6 20166.4 16472.9 18656.2 19450.6 20347.7 20357.2 5134.4 5399.9 5418.5 5418.6 5419.7 4573.4 5351.8 5914.3 5954.6 5978.5 5794.1 5909.7 5918.5 5921.7 5932.6 5332.3 5395.9 5406.8 5411.6 5519.2 5225.0 5228.0 5231.1 5235.9 5248.1 23317.9 24312.8 24433.8 24927.8 25016.9 2139.5 2148.3 2245.6 2272.5 2372.7 9573.7 9917.1 10348.2 14423.7 14747.0 1740.4 1760.1 1771.5 1814.3 1840.2 124088.4 125598.0 126123.0 126251.4 126934.0 11065.7 11248.5 11296.5 11356.3 11535.7 14051.7 14061.6 14446.6 14449.8 14462.6 6535.7 8262.7 8282.6 8315.8 8433.4 8148.1 8148.5 8325.9 8339.1 8343.3 4340.5 4381.8 4443.7 4490.2 4616.0 1680.4 1860.4 1875.2 1890.6 1914.6 638.9 801.3 864.8 954.3 974.8 19443.2 20202.5 20338.8 20359.8 20496.8 934.2 937.2 948.8 949.9 970.1 10170.0 10629.1 10656.2 10678.1 10721.9 584852.0 585949.0 592694.0 598843.0 603521.0 119791.0 127623.0 128203.1 139824.0 145000.0 845.8 962.8 986.5 986.8 991.1 18037.6 18345.7 18408.4 18435.5 18451.6 49394.0 50208.2 51600.7 51834.2 52660.7 72675.3 72841.0 73472.6 73801.0 75930.6 6249.1 7602.8 7861.4 7888.1 8128.0 10122.4 11956.6 12127.8 12305.8 12375.2 10444.5 10453.6 10688.1 10856.8 10942.3 8747.3 10212.8 10328.3 10599.3 10689.6 7406.1 7672.9 7934.5 8107.1 10576.4 7945.8 10831.5 11199.8 11337.7 11356.2 10513.2 10696.4 11285.9 11325.3 11426.9 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5326.92 Median:5421.92 stddev:2900.44 (53.5%) stddev-sans-first:2892.90 20:06:18 INFO - PROCESS | 1643 | Values: 1314.7 1456.8 1474.0 1642.1 1845.5 7254.0 7667.8 7998.2 8143.0 8168.7 8084.9 8176.2 8176.4 8177.5 8179.2 2265.2 2305.1 2308.4 2313.0 2314.3 2073.3 2134.0 2240.2 2326.8 2343.3 2257.8 2308.1 2309.7 2310.6 2315.3 2274.9 2310.7 2313.8 2315.5 2318.6 2275.5 2285.6 2302.8 2303.4 2304.8 8108.8 8168.7 8177.4 8190.0 8200.5 4906.5 5106.1 5107.8 5109.7 5113.1 2911.5 3252.4 3412.3 3466.2 3477.7 857.2 945.2 1049.8 1079.8 1097.3 10322.6 10590.3 10592.9 10615.6 10630.0 4238.8 4504.8 4565.3 4572.3 4579.2 9260.0 9277.0 9280.7 9282.0 9314.6 5079.5 5101.7 5103.7 5108.4 5108.4 4522.3 4563.7 4609.0 4633.4 4692.3 3084.8 3588.8 3640.8 3698.2 3722.4 1056.5 1195.1 1225.4 1226.7 1238.9 755.0 822.8 850.5 898.7 930.7 5273.5 5509.2 5687.2 5755.7 5801.3 902.5 935.5 940.0 946.3 971.8 3644.7 3780.5 3798.8 3841.4 3842.7 9310.7 9758.3 9797.5 9840.6 9936.4 9723.2 9829.6 9838.6 9838.6 9885.8 7446.3 7637.7 7700.0 7752.9 7762.3 5335.8 5361.1 5482.8 5567.4 5645.1 9019.8 9033.2 9099.0 9127.1 9247.0 9123.3 9178.5 9197.7 9317.4 9343.9 6465.8 6678.9 6683.3 6686.7 6720.9 7312.6 7502.8 7559.4 7572.7 7699.7 6926.0 7012.9 7058.3 7061.4 7069.3 6826.0 6907.1 6921.7 6966.1 6967.9 6423.8 6541.4 6563.1 6563.5 6569.0 4582.3 4738.5 4788.0 4839.6 4887.9 4735.6 4783.2 4861.5 4894.6 4994.6 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4138.12 Median:4651.20 stddev:1270.12 (27.3%) stddev-sans-first:1240.09 20:06:18 INFO - PROCESS | 1643 | Values: 271.6 279.6 295.9 296.2 305.9 4466.5 4723.5 4778.9 4852.2 4971.7 4661.7 4906.5 4913.2 4948.9 4975.3 3280.8 3833.9 3843.2 3845.9 3854.6 3302.8 3652.9 3769.6 3786.3 3803.7 3792.2 3794.8 3812.8 3830.5 3833.7 3162.9 3785.1 3804.1 3820.2 3836.8 2598.0 2849.2 3187.8 3291.7 3389.2 3878.9 3961.7 4738.6 4775.3 4777.1 4278.3 4294.5 4309.8 4316.3 4324.9 4674.5 5133.9 5155.4 5173.6 5189.8 3563.9 3572.4 3576.0 3585.7 3593.7 4663.8 5313.6 5339.9 5391.6 5412.9 3140.2 3205.4 3621.6 3646.4 3656.6 3096.8 3484.7 3644.7 3683.1 3698.5 4071.9 4150.6 4160.3 4262.4 4285.8 5194.5 5213.4 5225.2 5225.9 5252.3 1057.3 1196.9 1199.5 1200.2 1200.3 653.4 717.3 819.3 831.6 836.2 3965.5 4203.7 4241.5 4631.2 4648.8 4323.4 4436.0 4772.7 4987.8 5023.3 4057.8 4145.5 4519.7 4604.5 4629.7 2526.6 2625.3 2639.0 2650.0 2653.9 4653.6 4697.7 5154.9 5162.3 5165.9 4930.5 5072.3 5097.3 5118.4 5150.8 4692.8 4717.8 4980.4 5645.7 5676.2 4790.6 4978.1 5380.8 5383.9 5395.3 5015.5 5042.6 5209.0 5329.7 5339.0 5082.9 5196.6 5613.0 5635.7 5643.3 3171.7 3439.3 3441.0 3667.8 3684.5 4428.7 4975.6 5094.6 5361.3 5375.7 4197.8 4687.6 4771.6 5162.7 5229.1 4179.3 4259.9 5078.5 5151.5 5219.3 4418.2 4766.7 4860.8 4880.8 5126.8 4546.6 5058.8 5149.7 5272.1 5275.8 5100.9 5103.1 5130.6 5141.6 5173.6 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20416.55 Median:4401.32 stddev:29743.17 (675.8%) stddev-sans-first:29789.50 20:06:18 INFO - PROCESS | 1643 | Values: 627.4 738.3 744.9 774.9 795.5 14598.5 14932.9 15455.9 15641.1 15655.2 12716.0 12749.9 12810.4 13089.9 13909.1 821.8 835.0 839.0 840.1 840.2 659.7 682.6 815.1 837.0 848.2 891.6 891.7 893.3 895.4 898.0 845.8 848.1 849.4 866.9 876.4 520.2 537.3 642.9 663.8 666.0 15026.5 15030.8 15059.5 15085.2 15089.3 13626.6 13655.9 13669.0 13680.8 13746.5 12571.5 12762.9 12895.4 12903.5 13369.1 4306.5 4371.4 4383.5 4439.2 4449.6 99698.5 100474.5 100689.0 101826.0 103946.5 10595.9 10748.8 10800.6 10845.1 11095.0 21017.4 21042.0 21089.9 21109.0 21121.9 7334.3 7491.3 7533.8 7656.3 7790.8 4192.9 4274.2 4309.2 4442.5 4455.8 3339.1 3353.5 3373.1 3464.8 3465.4 598.6 602.1 607.1 609.8 621.7 591.3 602.9 619.2 620.6 640.2 7329.5 8728.0 8978.6 8980.1 9170.5 535.4 595.5 620.4 645.5 645.7 3848.5 4246.6 4419.1 4588.5 4685.4 101590.0 103210.4 105427.0 105735.0 105954.9 78128.6 87578.7 93981.0 97045.5 97152.5 78142.0 79146.2 79243.6 80734.9 82754.6 8747.4 8861.7 8869.7 8991.4 9022.3 50892.0 51699.7 52135.2 52244.5 54136.0 69604.0 71120.0 72345.3 72771.0 75975.0 9714.8 11476.4 11695.4 11733.6 11957.9 12609.0 12703.8 12959.3 12997.2 13285.7 11650.8 11880.9 12101.6 12171.3 12469.0 11291.4 12288.8 12435.3 13360.7 13368.4 11117.7 12763.7 13196.4 13210.7 13784.2 10424.2 11021.2 11122.0 11575.2 11686.1 10491.5 10979.7 11422.5 11456.1 11460.9 20:06:18 INFO - PROCESS | 1643 | -------- Summary: end -------- 20:06:18 INFO - PROCESS | 1643 | 20:06:18 INFO - TEST-INFO | 1643: exit 0 20:06:18 INFO - TEST-OK | dromaeo_css | took 1119933ms 20:06:18 INFO - TEST-START | kraken 20:06:18 INFO - operating with platform_type : mac_ 20:06:18 INFO - Initialising browser for kraken test... 20:06:18 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpriO7a3/profile http://localhost:49247/getInfo.html) 20:06:21 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 20:06:21 INFO - PROCESS | 1648 | colorDepth:24 20:06:21 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 20:06:21 INFO - PROCESS | 1648 | __metrics 20:06:21 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:06:21 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:06:22 INFO - TEST-INFO | 1648: exit 0 20:06:22 INFO - Browser initialized. 20:06:22 INFO - Running cycle 1/1 for kraken test... 20:06:22 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpriO7a3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:35 INFO - PROCESS | 1649 | RSS: Main: 244895744 20:06:35 INFO - PROCESS | 1649 | 20:06:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:38 INFO - PROCESS | 1649 | RSS: Main: 295280640 20:06:38 INFO - PROCESS | 1649 | 20:06:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 20:06:42 INFO - PROCESS | 1649 | RSS: Main: 295829504 20:06:42 INFO - PROCESS | 1649 | 20:06:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 20:06:46 INFO - PROCESS | 1649 | RSS: Main: 388284416 20:06:46 INFO - PROCESS | 1649 | 20:06:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 20:06:48 INFO - PROCESS | 1649 | RSS: Main: 291291136 20:06:48 INFO - PROCESS | 1649 | 20:06:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:51 INFO - PROCESS | 1649 | RSS: Main: 294883328 20:06:51 INFO - PROCESS | 1649 | 20:06:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:54 INFO - PROCESS | 1649 | RSS: Main: 336486400 20:06:54 INFO - PROCESS | 1649 | 20:06:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 20:06:58 INFO - PROCESS | 1649 | RSS: Main: 337379328 20:06:58 INFO - PROCESS | 1649 | 20:07:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 20:07:02 INFO - PROCESS | 1649 | RSS: Main: 335065088 20:07:02 INFO - PROCESS | 1649 | 20:07:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:07:04 INFO - PROCESS | 1649 | RSS: Main: 311341056 20:07:04 INFO - PROCESS | 1649 | 20:07:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:07:06 INFO - PROCESS | 1649 | RSS: Main: 316846080 20:07:06 INFO - PROCESS | 1649 | 20:07:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:07:09 INFO - PROCESS | 1649 | RSS: Main: 317067264 20:07:09 INFO - PROCESS | 1649 | 20:07:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:07:13 INFO - PROCESS | 1649 | RSS: Main: 332591104 20:07:13 INFO - PROCESS | 1649 | 20:07:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:07:16 INFO - PROCESS | 1649 | RSS: Main: 326508544 20:07:16 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 20:07:18 INFO - PROCESS | 1649 | RSS: Main: 370659328 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | __start_tp_report 20:07:18 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 20:07:18 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 20:07:18 INFO - PROCESS | 1649 | |i|pagename|runs| 20:07:18 INFO - PROCESS | 1649 | |0;ai-astar;114;114;114;112;114;115;115;114;115;114 20:07:18 INFO - PROCESS | 1649 | |1;audio-beat-detection;152;116;113;150;114;115;113;113;133;114 20:07:18 INFO - PROCESS | 1649 | |2;audio-dft;183;184;182;185;180;181;182;183;182;185 20:07:18 INFO - PROCESS | 1649 | |3;audio-fft;81;60;59;86;61;58;54;60;66;55 20:07:18 INFO - PROCESS | 1649 | |4;audio-oscillator;88;71;85;70;68;92;65;67;86;114 20:07:18 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;93;130;74;112;133;85;89;85;88;84 20:07:18 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;93;93;93;93;94;94;94;93;94 20:07:18 INFO - PROCESS | 1649 | |7;imaging-desaturate;88;102;138;133;84;84;84;85;88;83 20:07:18 INFO - PROCESS | 1649 | |8;json-parse-financial;56;56;54;54;55;55;54;56;56;54 20:07:18 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;72;67;72;76;72;69;69;71;71;72 20:07:18 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;88;88;87;87;88;89;88;88;88;96 20:07:18 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;147;148;149;149;145;142;146;148;186;160 20:07:18 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;175;178;174;172;175;173;173;175;173;173 20:07:18 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;69;70;70;70;69;70;69;68;68;83 20:07:18 INFO - PROCESS | 1649 | __end_tp_report 20:07:18 INFO - PROCESS | 1649 | __start_cc_report 20:07:18 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2064 20:07:18 INFO - PROCESS | 1649 | __end_cc_report 20:07:18 INFO - PROCESS | 1649 | __startTimestamp1480219638851__endTimestamp 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | ------- Summary: start ------- 20:07:18 INFO - PROCESS | 1649 | Number of tests: 14 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 20:07:18 INFO - PROCESS | 1649 | Values: 114.0 114.0 114.0 112.0 114.0 115.0 115.0 114.0 115.0 114.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:115.50 stddev:15.79 (13.7%) stddev-sans-first:12.89 20:07:18 INFO - PROCESS | 1649 | Values: 152.0 116.0 113.0 150.0 114.0 115.0 113.0 113.0 133.0 114.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.64 (0.9%) stddev-sans-first:1.73 20:07:18 INFO - PROCESS | 1649 | Values: 183.0 184.0 182.0 185.0 180.0 181.0 182.0 183.0 182.0 185.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:64.00 Median:60.50 stddev:10.85 (17.9%) stddev-sans-first:9.61 20:07:18 INFO - PROCESS | 1649 | Values: 81.0 60.0 59.0 86.0 61.0 58.0 54.0 60.0 66.0 55.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:78.00 stddev:15.42 (19.8%) stddev-sans-first:16.12 20:07:18 INFO - PROCESS | 1649 | Values: 88.0 71.0 85.0 70.0 68.0 92.0 65.0 67.0 86.0 114.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:97.30 Median:85.00 stddev:20.43 (24.0%) stddev-sans-first:21.61 20:07:18 INFO - PROCESS | 1649 | Values: 93.0 130.0 74.0 112.0 133.0 85.0 89.0 85.0 88.0 84.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 20:07:18 INFO - PROCESS | 1649 | Values: 94.0 93.0 93.0 93.0 93.0 94.0 94.0 94.0 93.0 94.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:84.00 stddev:21.11 (25.1%) stddev-sans-first:22.14 20:07:18 INFO - PROCESS | 1649 | Values: 88.0 102.0 138.0 133.0 84.0 84.0 84.0 85.0 88.0 83.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:0.94 (1.7%) stddev-sans-first:0.93 20:07:18 INFO - PROCESS | 1649 | Values: 56.0 56.0 54.0 54.0 55.0 55.0 54.0 56.0 56.0 54.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:72.00 stddev:2.42 (3.4%) stddev-sans-first:2.55 20:07:18 INFO - PROCESS | 1649 | Values: 72.0 67.0 72.0 76.0 72.0 69.0 69.0 71.0 71.0 72.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.00 stddev:2.63 (3.0%) stddev-sans-first:2.77 20:07:18 INFO - PROCESS | 1649 | Values: 88.0 88.0 87.0 87.0 88.0 89.0 88.0 88.0 88.0 96.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:148.50 stddev:12.82 (8.6%) stddev-sans-first:13.47 20:07:18 INFO - PROCESS | 1649 | Values: 147.0 148.0 149.0 149.0 145.0 142.0 146.0 148.0 186.0 160.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.50 stddev:1.73 (1.0%) stddev-sans-first:1.80 20:07:18 INFO - PROCESS | 1649 | Values: 175.0 178.0 174.0 172.0 175.0 173.0 173.0 175.0 173.0 173.0 20:07:18 INFO - PROCESS | 1649 | 20:07:18 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:4.43 (6.3%) stddev-sans-first:4.66 20:07:18 INFO - PROCESS | 1649 | Values: 69.0 70.0 70.0 70.0 69.0 70.0 69.0 68.0 68.0 83.0 20:07:18 INFO - PROCESS | 1649 | -------- Summary: end -------- 20:07:18 INFO - PROCESS | 1649 | 20:07:19 INFO - TEST-INFO | 1649: exit 0 20:07:19 INFO - TEST-OK | kraken | took 60975ms 20:07:19 INFO - SUITE-END | took 1180s 20:07:19 INFO - Completed test suite (00:19:40) 20:07:19 INFO - javascript benchmark 20:07:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2702.918912432627, 3286.1291757684203, 3289.967100328997, 3313.370459612675, 3353.295807880345, 5541.33503979522, 5553.666779993198, 5603.719814009293, 5612.0178968680475, 5612.186232996213, 5591.6365436246615, 5620.185073164389, 5622.269105016342, 5632.35227948786, 5646.237757902682, 4260.233158031569, 5104.33643626328, 5129.666571672829, 5150.948490515103, 5224.686518808883, 4183.372494125891, 5143.53708166265, 5160.122779127539, 5213.139831927728, 5232.372115346164, 5214.661047031931, 5223.6343455958095, 5225.921611175835, 5235.424103348629, 5269.341332333458, 5186.896262074756, 5237.659552129137, 5242.97378513105, 5247.658902171384, 5284.735763211824, 4097.85657501986, 4979.377577802775, 5131.461196574381, 5136.666116702402, 5199.168133098686, 5549.223108764776, 5578.191162281447, 5661.377248502661, 5665.575081868835, 5674.177244299594, 5918.644881307136, 5922.170896074553, 5938.703064846741, 5956.106584012389, 5972.134040564138, 6057.454829065361, 6075.119107729354, 6137.877242455126, 6144.433169541783, 6147.493864003303, 5694.174344719992, 5702.572307076985, 5722.2561067061015, 5742.59801813869, 5782.624129431573, 6219.129321894939, 6224.782132625336, 6242.750289988349, 6242.875142497124, 6250.874982500324, 5878.412158784173, 6056.303525094582, 6059.272887253558, 6059.697015149225, 6067.423594758491, 6115.088229002436, 6125.816225513242, 6131.69422353494, 6134.00801433197, 6136.570440069152, 6082.543809214327, 6126.0, 6128.938710612926, 6132.233470816148, 6134.4172303631085, 6118.445944600367, 6134.130457564626, 6143.139960405547, 6154.076888466766, 6155.169052177988, 4885.071836351082, 4893.535114164149, 4897.8285759998225, 4925.285833554115, 4947.158982972831, 4128.483939507561, 4246.8725938221905, 4377.387165796791, 4398.73607583546, 4413.602775750198, 5494.697791621499, 5540.889182216414, 5545.7781688732, 5596.076647353141, 5726.570507211893, 6076.75692972285, 6088.939110608926, 6093.146959425684, 6113.663748493786, 6116.633002019893, 5572.164175373645, 5576.052071147915, 5580.330360356783, 5584.413636568183, 5598.748056337475, 5202.739863006835, 5218.9739051304505, 5221.034108689904, 5229.215617657305, 5232.058229518723, 6117.027903893791, 6186.628802271878, 6201.410865967816, 6206.0, 6229.12792209082, 6107.4922612924165, 6144.849302744004, 6154.815355539341, 6194.163787888578, 6245.0632405139595, 6243.282022567281, 6248.031555108965, 6254.906176407449, 6256.7810126645345, 6261.718222680081, 5588.239704493071, 6055.1522786809, 6075.392460753889, 6076.088586712029, 6076.3012253591405, 5026.74866256693, 5893.616914900518, 5921.082232254007, 5932.228810254639, 6143.112737013596, 6017.759289628366, 6026.879462410815, 6027.065804800263, 6029.095635654687, 6047.758089676364, 6011.098335249572, 6015.2781666200335, 6025.126356678169, 6029.427204415573, 6030.246219222598, 5705.144228365778, 5734.311882574118, 5746.195532625352, 5852.4147585241135, 5869.06095024794, 5142.202958541432, 5818.679972601548, 5889.263842019747, 5962.19510366095, 5999.100134979788, 5769.990251705851, 5782.10377391505, 5783.595148339576, 5813.56398270123, 5855.063189889597], "value": 5570.543204556917, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.817443458703, 517.0099259917257, 540.4973374761475, 541.4720647368816, 562.783328418559, 29950.700492995064, 31174.753009879605, 38566.99999999996, 39594.40608390876, 39659.60340396595, 40879.79560102203, 41071.79464102683, 41093.0, 41173.7941310293, 41175.58824411755, 9216.49309287989, 9231.353805233653, 9364.11040951112, 9385.343025988184, 9390.765230869249, 8450.57747112645, 8659.69691060813, 9269.212116970066, 10995.0, 11303.604373846916, 10897.83653245202, 10989.725256868562, 10993.560257589726, 10998.175136864727, 11010.724731881726, 11135.498902549365, 11192.776144477064, 11215.046721028722, 11218.719532011683, 11221.831672524837, 8054.114047454776, 8278.958605206935, 8286.917130828675, 8385.371097167737, 11037.061849742782, 31304.53043204354, 38261.42607860884, 38883.0, 38914.61085389138, 40048.59951400507, 3254.9096052822333, 3357.748168887343, 3377.5609170807884, 3610.151614370621, 3616.764910280823, 28711.85644071787, 29763.70236297631, 29956.400871982656, 29977.0, 30002.649615805585, 3144.748420126384, 3259.8044117353033, 3285.4414749492644, 3299.5710557627353, 3336.099253201646, 479543.0, 493555.9999999964, 497577.0, 501088.0, 501174.0, 55771.88456230853, 56102.719486402304, 56112.15831762527, 56156.0, 56247.0, 58189.8362032757, 58201.12698309529, 58348.70825645845, 58374.0, 58410.415895841346, 13276.800847987288, 14909.478168264059, 15050.0, 15205.771913421308, 15545.455909043356, 12094.939525302494, 12182.512699492097, 12185.512579496899, 12186.0, 12203.267803931793, 13028.739425211632, 13331.33343332849, 14354.066985645899, 14793.334299956528, 14799.334029968677, 5503.6147469677535, 5968.418948630787, 6063.211782468339, 6098.316740634195, 6134.539909506805, 849.5794581682106, 912.2018234045211, 915.6566287642135, 939.2673714502699, 1008.0725732326277, 22573.774262257168, 29192.854035729684, 29578.40843183124, 29591.704082959324, 30444.54333185004, 970.7815741458115, 996.0487734213808, 1026.1893104447552, 1075.1184029096223, 1144.9427528623535, 14025.509107181404, 14589.124652520883, 14614.415423383158, 14852.331645075998, 14860.5541833743, 650103.0, 654638.0, 655420.0, 655927.0851040381, 656163.0, 45155.096898061856, 46036.76981615071, 51763.0, 52578.0, 52653.683657908856, 1320.7028418605928, 1349.284879014124, 1369.5754316162022, 1371.4171477122384, 1377.4696741754296, 28847.711522884503, 28906.0, 28976.7102328974, 29428.705712943454, 29806.70193298039, 47625.285620715025, 47821.04357912752, 47959.5204047969, 47964.32570788657, 48021.519784801705, 579030.0, 580228.0, 581239.0, 583278.0, 584705.0, 24178.637320439855, 24482.877585611957, 42091.0, 44088.77955610202, 44108.558914410445, 41355.7932210337, 45516.31725524054, 46755.76622116868, 47050.117995279805, 48171.5182848167, 39394.803025984686, 39863.80408587747, 40515.1896962065, 40602.79698601488, 41695.0, 38802.6419075331, 38943.805280973414, 39458.80270598629, 40458.79770601128, 40645.983850402794, 37199.81400092982, 37526.43710344402, 37960.62039379571, 38218.617813821504, 38616.80691596524, 32941.67058329386, 34260.82869585636, 34267.98391500789, 34380.31239375148, 34603.30793384169, 20511.589768204853, 25387.0, 25425.61861572115, 25668.74331256738, 26167.607485888107], "value": 19506.325069142622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7565704007194, 352.7107771627267, 367.665424463738, 370.11727031030983, 378.1661436532446, 14513.419463221471, 14852.554423367303, 15621.84378156218, 19698.606027879432, 20166.395008149742, 16472.929259598117, 18656.160472778723, 19450.61098778027, 20347.69478457824, 20357.185712571518, 5134.435212126672, 5399.946000540003, 5418.539424148932, 5418.647787893794, 5419.674819510842, 4573.405457290564, 5351.839444816662, 5914.260717410324, 5954.612950158247, 5978.461938425541, 5794.130880367937, 5909.704514774266, 5918.4673379395845, 5921.703914804264, 5932.584719069645, 5332.33345831771, 5395.919061214085, 5406.810761623364, 5411.621186516945, 5519.199716041172, 5225.0, 5228.032813929435, 5231.110711179109, 5235.869103272411, 5248.0553500369915, 23317.883410583006, 24312.756872431404, 24433.778311084374, 24927.750722492907, 25016.874915625307, 2139.486523234428, 2148.3232781673723, 2245.62947113726, 2272.4659704969317, 2372.7068747532635, 9573.712788616353, 9917.066172096444, 10348.154257579226, 14423.711525769531, 14747.0, 1740.3560682547538, 1760.128736275539, 1771.5393997560727, 1814.2833580735535, 1840.1811194018667, 124088.37955810253, 125598.0, 126123.0, 126251.36874315569, 126934.0, 11065.668029959113, 11248.493817778219, 11296.458296883136, 11356.261842980344, 11535.653930382103, 14051.71896562063, 14061.648458788408, 14446.566603001927, 14449.78325325121, 14462.566123016326, 6535.738570457223, 8262.710805121791, 8282.627281772335, 8315.792105197419, 8433.367497437717, 8148.10370859205, 8148.470349427387, 8325.916740832636, 8339.12439193876, 8343.332533397313, 4340.52254252032, 4381.846635367747, 4443.6889417741095, 4490.236659767847, 4615.976920115445, 1680.3698613020117, 1860.3767737807716, 1875.1842948317526, 1890.6481865466258, 1914.6457905287566, 638.9361712748315, 801.2828518476048, 864.7708357285325, 954.3367359684952, 974.7660561465198, 19443.22227110928, 20202.494937626678, 20338.79661203369, 20359.77841329525, 20496.795032049788, 934.1545900959643, 937.1846493550654, 948.83869742144, 949.8955114937352, 970.1414248390225, 10170.0, 10629.149668026539, 10656.20078494116, 10678.145748340114, 10721.927807219372, 584852.0, 585949.0, 592694.0, 598843.0, 603521.0, 119791.0, 127623.0, 128203.07695384577, 139824.0, 145000.0, 845.7758693946109, 962.841131213356, 986.4919566423298, 986.7779749556436, 991.1228562722043, 18037.639247215244, 18345.72481412753, 18408.447746567625, 18435.53911152232, 18451.630967380308, 49394.012119758125, 50208.24687629615, 51600.74199629128, 51834.22248666197, 52660.73669631627, 72675.27324726686, 72841.0, 73472.6326368386, 73801.0, 75930.62034689791, 6249.0626406039455, 7602.771916842504, 7861.449698521049, 7888.092869320101, 8128.0246370435925, 10122.418783210234, 11956.58151964677, 12127.75744485123, 12305.753884922431, 12375.195612285173, 10444.529996150039, 10453.581856725647, 10688.144948403953, 10856.837147442637, 10942.343459392461, 8747.256483198998, 10212.846807297748, 10328.277020608786, 10599.258051936598, 10689.625863094754, 7406.07424071991, 7672.8849067265155, 7934.523928564305, 8107.06768721581, 10576.418296993432, 7945.761627151194, 10831.51258193399, 11199.832002519806, 11337.716557086138, 11356.205065645325, 10513.211509136692, 10696.358218506915, 11285.943570282096, 11325.32048077118, 11426.885731142582], "value": 9253.426089788136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.664760486076, 1456.7887656289838, 1473.99263003685, 1642.1296712742244, 1845.5386153461634, 7253.963730181348, 7667.769966900988, 7998.200179981999, 8143.022837259522, 8168.67325306987, 8084.878726819103, 8176.182381761821, 8176.38677099217, 8177.509349439038, 8179.222973817493, 2265.1958554713087, 2305.0664480885184, 2308.4459729664845, 2312.9530365626374, 2314.259436980167, 2073.295079672911, 2133.957320853582, 2240.182333448288, 2326.7789559991775, 2343.285297984114, 2257.7967982881537, 2308.088305119477, 2309.6535519672016, 2310.595645761993, 2315.2938353802083, 2274.943126421844, 2310.699609050813, 2313.8264630152808, 2315.4674424882373, 2318.5594736999915, 2275.465265662568, 2285.611446054158, 2302.792748652629, 2303.389601755536, 2304.8040916522114, 8108.797280067986, 8168.714095006706, 8177.427580069398, 8190.0, 8200.466969646954, 4906.509349065101, 5106.08090543702, 5107.7956881724685, 5109.744512774347, 5113.130767769489, 2911.5050441424796, 3252.398306313316, 3412.334594754024, 3466.185446420089, 3477.669621385964, 857.2284943550792, 945.2107490245653, 1049.795289918466, 1079.83262594298, 1097.3415950429758, 10322.638707645196, 10590.25868189227, 10592.947035264775, 10615.628453004108, 10630.0, 4238.766867822238, 4504.819807207675, 4565.315202719552, 4572.268437050123, 4579.152856721517, 9260.0, 9277.025912279249, 9280.675176368795, 9282.025387334368, 9314.580843862042, 5079.5428411443145, 5101.719405432663, 5103.693778373309, 5108.361454818148, 5108.412532558729, 4522.34426008227, 4563.680542362003, 4608.986023074918, 4633.374494443207, 4692.343071969927, 3084.784065115465, 3588.8385022674042, 3640.8361623726996, 3698.223373091681, 3722.3671975763646, 1056.4506456642503, 1195.0797885628017, 1225.3995542184266, 1226.7055906582534, 1238.8823061809114, 754.9509281896769, 822.7943014246439, 850.5492089192737, 898.6944438890808, 930.7393929699695, 5273.499017593323, 5509.228707980886, 5687.203791469197, 5755.712214389264, 5801.274840644919, 902.4540153207215, 935.5088578496208, 939.9530023498797, 946.2902822882838, 971.7522031881825, 3644.728055205133, 3780.5085338905765, 3798.753081049723, 3841.442990766379, 3842.654161125512, 9310.674126405544, 9758.2766665013, 9797.461139637246, 9840.606375745034, 9936.403815771077, 9723.173530249867, 9829.55766990487, 9838.557264923096, 9838.60645574169, 9885.752856178653, 7446.2926022028905, 7637.732679356196, 7700.0, 7752.883706744404, 7762.340201082971, 5335.78656853737, 5361.061814182581, 5482.780688772564, 5567.387587365468, 5645.0605719995, 9019.819603608023, 9033.232175265177, 9098.954505227432, 9127.132922372364, 9247.0, 9123.27013838878, 9178.54107294646, 9197.678081267124, 9317.44095354281, 9343.859842102238, 6465.77369792055, 6678.899816502853, 6683.331666833472, 6686.69909854048, 6720.865582688417, 7312.597807120659, 7502.774916752506, 7559.433042521723, 7572.659230334758, 7699.692012319669, 6925.995730619133, 7012.929870701431, 7058.329458701415, 7061.435085193069, 7069.293070693096, 6826.010228516937, 6907.102076729993, 6921.688524016532, 6966.059581956371, 6967.895481567679, 6423.775167869102, 6541.443977261986, 6563.146790917151, 6563.474922006323, 6568.967155164193, 4582.289745089516, 4738.4787673356595, 4787.976060119677, 4839.588634965927, 4887.926681099858, 4735.573798358164, 4783.234682450791, 4861.51384861511, 4894.608431325414, 4994.625403094709], "value": 4323.895129231327, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.5912551609827, 279.6420581655482, 295.87868973720776, 296.15300241309865, 305.90975662179653, 4466.464024317078, 4723.504032076634, 4778.924741933063, 4852.199387101128, 4971.651984361096, 4661.743604101773, 4906.484819093988, 4913.231236754766, 4948.851534453963, 4975.278584605239, 3280.8353034672705, 3833.9041523961846, 3843.21290599871, 3845.8653947111857, 3854.575996640381, 3302.8348582570898, 3652.926941461169, 3769.6230376962358, 3786.318462676717, 3803.657670809627, 3792.2036372361836, 3794.848206071754, 3812.752171108883, 3830.5211848518934, 3833.6933045356445, 3162.857671404781, 3785.069614496599, 3804.144067584813, 3820.178661587744, 3836.846526138979, 2598.0, 2849.173739615509, 3187.8087314760955, 3291.736661067133, 3389.2035371687634, 3878.9030274243087, 3961.6830653547936, 4738.597219236334, 4775.2598347256235, 4777.116233496814, 4278.272693642089, 4294.549072347421, 4309.784510774449, 4316.309390497506, 4324.9135017299795, 4674.509176536449, 5133.948660513384, 5155.432902380735, 5173.637845350827, 5189.844304670828, 3563.94654080189, 3572.356975744365, 3575.982120089409, 3585.748997570171, 3593.7304702147444, 4663.790129444184, 5313.555764348404, 5339.866503337409, 5391.56867450603, 5412.864678383033, 3140.2149462634343, 3205.374951884407, 3621.63783621641, 3646.4348026056005, 3656.597774244831, 3096.814191148538, 3484.6689564491335, 3644.7084233261276, 3683.116052147519, 3698.537682789651, 4071.918561628751, 4150.64719498846, 4160.271952408317, 4262.444207864107, 4285.807138678767, 5194.532492075731, 5213.426523082458, 5225.242339860699, 5225.878638933866, 5252.29094072303, 1057.349729916096, 1196.9222000569935, 1199.5022065842752, 1200.2318516149671, 1200.2618389690278, 653.3760258952689, 717.3472140352254, 819.2667562531501, 831.6257684042205, 836.2431999040878, 3965.524137103566, 4203.696853975216, 4241.533431322552, 4631.166390049823, 4648.814047438133, 4323.437953066082, 4435.955640443554, 4772.665913386029, 4987.825426110141, 5023.287424790572, 4057.829061452168, 4145.450547913072, 4519.689290105898, 4604.526551503487, 4629.675922685447, 2526.585112337097, 2625.3090582153063, 2639.0235612822994, 2650.032738050598, 2653.9203823885314, 4653.581177694024, 4697.741624210701, 5154.948450515447, 5162.328897243335, 5165.896682066337, 4930.457649658535, 5072.300779238923, 5097.286379906816, 5118.411382691038, 5150.845474635767, 4692.7653617319, 4717.811287548459, 4980.352554168007, 5645.741703318706, 5676.240365486712, 4790.6167506598695, 4978.1288274552535, 5380.784768609212, 5383.946160538345, 5395.298611180521, 5015.498450154955, 5042.647014708935, 5209.0, 5329.7068661224, 5338.97330513345, 5082.923756143587, 5196.584273258206, 5612.971935140298, 5635.690037047838, 5643.294588176478, 3171.746260299217, 3439.329330780474, 3440.950510094345, 3667.7615954962844, 3684.4525299374864, 4428.7121337112985, 4975.5522003019905, 5094.592432605456, 5361.276227709365, 5375.7262975933445, 4197.782643033486, 4687.554682305175, 4771.618270538279, 5162.716050617252, 5229.13719236337, 4179.310413781692, 4259.87220383389, 5078.546588319978, 5151.5363617274625, 5219.321488206509, 4418.226810308119, 4766.713997160182, 4860.805567777249, 4880.755962201804, 5126.769295381642, 4546.568076032771, 5058.772355244097, 5149.738314113066, 5272.098647001269, 5275.762590683506, 5100.862969273944, 5103.132467480612, 5130.6152038598, 5141.562967147835, 5173.560247379015], "value": 3731.2879122254717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.3726273726273, 738.3354980517533, 744.8622004929089, 774.9457537972344, 795.5465384730704, 14598.489052883151, 14932.925335373322, 15455.922720386383, 15641.139737314443, 15655.217239138026, 12716.0, 12749.872501274984, 12810.359482025908, 13089.869101309008, 13909.095908765923, 821.8356328734247, 834.9791255218638, 838.9748307550783, 840.0926998841268, 840.2353857989231, 659.696539591786, 682.5972676121088, 815.1115284340068, 837.0499483086679, 848.1815048478218, 891.6210610490548, 891.692366133686, 893.2764460786783, 895.3866601378077, 898.0077014898509, 845.7927807687125, 848.1137211613817, 849.3629777666719, 866.9003064647583, 876.4259410086404, 520.1885059307455, 537.3444397834636, 642.8521440068764, 663.8439966607843, 665.9900101498481, 15026.474073407488, 15030.849691503163, 15059.548213553611, 15085.170315632637, 15089.320980555902, 13626.591202263948, 13655.931720341434, 13669.043166978316, 13680.794788078187, 13746.518871839438, 12571.497140114385, 12762.872371276262, 12895.419706113247, 12903.548375806802, 13369.131006484547, 4306.5262821089655, 4371.4098596689355, 4383.517813040595, 4439.20955345609, 4449.577290157462, 99698.501507492, 100474.49762751213, 100689.0, 101826.0, 103946.48026759893, 10595.947020265003, 10748.838767418494, 10800.621978230723, 10845.13238940883, 11095.0, 21017.369478915658, 21042.0, 21089.894550527148, 21109.0, 21121.894390528258, 7334.3032411920785, 7491.288327608869, 7533.773986780406, 7656.349210317186, 7790.844183116419, 4192.93679742431, 4274.187904298174, 4309.224339618899, 4442.533533978885, 4455.75493347869, 3339.131825725329, 3353.480210567366, 3373.139849338403, 3464.8267586621073, 3465.4455287153933, 598.6348327520209, 602.0577795749638, 607.1348328631682, 609.7530500147448, 621.6767281013938, 591.3124847567728, 602.8944934636421, 619.2105066040834, 620.5749061892618, 640.2093414632925, 7329.486935914541, 8727.996280427706, 8978.595963181542, 8980.101989800967, 9170.49562274068, 535.370939146509, 595.5354823237882, 620.3765215957933, 645.4868379638199, 645.6997496164306, 3848.5189351331082, 4246.575342465729, 4419.113987058238, 4588.462359029273, 4685.437747470325, 101590.0, 103210.38763643237, 105427.0, 105735.0, 105954.94045059451, 78128.60935695285, 87578.68631970526, 93981.0, 97045.5147724271, 97152.51423742836, 78142.0, 79146.20853791389, 79243.60378198072, 80734.88976653549, 82754.58622706847, 8747.431416957877, 8861.689840855539, 8869.68956086534, 8991.41555798871, 9022.323325750725, 50892.0, 51699.74150129225, 52135.2179717297, 52244.47755522396, 54136.0, 69604.0, 71120.0, 72345.27654723385, 72771.0, 75975.0, 9714.75713107178, 11476.368799715761, 11695.356755378536, 11733.589324373606, 11957.880421196025, 12609.0, 12703.797569395927, 12959.287239201934, 12997.15518491295, 13285.66785830362, 11650.76698466043, 11880.881191188324, 12101.636950891487, 12171.33057681836, 12469.0, 11291.3789741565, 12288.75422491563, 12435.316057616918, 13360.665983350495, 13368.398422070835, 11117.666470005914, 12763.744725105631, 13196.406161722554, 13210.669733256746, 13784.172949623055, 10424.218183636105, 11021.228514003942, 11122.0, 11575.189736718348, 11686.123540734308, 10491.527881245514, 10979.670609881716, 11422.543098276308, 11456.083513319081, 11460.885391145981], "value": 7267.150819063226, "unit": "score"}], "name": "dromaeo_css", "value": 7002.517650226947, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 112.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 113.0, 150.0, 114.0, 115.0, 113.0, 113.0, 133.0, 114.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 182.0, 185.0, 180.0, 181.0, 182.0, 183.0, 182.0, 185.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 86.0, 61.0, 58.0, 54.0, 60.0, 66.0, 55.0], "value": 64.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 85.0, 70.0, 68.0, 92.0, 65.0, 67.0, 86.0, 114.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 130.0, 74.0, 112.0, 133.0, 85.0, 89.0, 85.0, 88.0, 84.0], "value": 97.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 102.0, 138.0, 133.0, 84.0, 84.0, 84.0, 85.0, 88.0, 83.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 54.0, 55.0, 55.0, 54.0, 56.0, 56.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 72.0, 76.0, 72.0, 69.0, 69.0, 71.0, 71.0, 72.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 88.0, 89.0, 88.0, 88.0, 88.0, 96.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 149.0, 145.0, 142.0, 146.0, 148.0, 186.0, 160.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 174.0, 172.0, 175.0, 173.0, 173.0, 175.0, 173.0, 173.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 70.0, 69.0, 70.0, 69.0, 68.0, 68.0, 83.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1463.8999999999996, "alertThreshold": 2.0}]} 20:07:20 INFO - Return code: 0 20:07:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:07:20 INFO - # TBPL SUCCESS # 20:07:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:07:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:07:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:07:20 INFO - 2016-11-26 20:07:20.134 screenresolution[1653:10305] starting screenresolution argv=screenresolution get 20:07:20 INFO - 2016-11-26 20:07:20.137 screenresolution[1653:10305] Display 0: 1600x1200x32@60 20:07:20 INFO - 2016-11-26 20:07:20.143 screenresolution[1654:10308] starting screenresolution argv=screenresolution list 20:07:20 INFO - Available Modes on Display 0 20:07:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:07:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:07:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:07:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:07:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:07:20 INFO - Intel Iris: 20:07:20 INFO - Chipset Model: Intel Iris 20:07:20 INFO - Type: GPU 20:07:20 INFO - Bus: Built-In 20:07:20 INFO - VRAM (Dynamic, Max): 1536 MB 20:07:20 INFO - Vendor: Intel (0x8086) 20:07:20 INFO - Device ID: 0x0a2e 20:07:20 INFO - Revision ID: 0x0009 20:07:20 INFO - Displays: 20:07:20 INFO - Display: 20:07:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:07:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:07:20 INFO - Display Serial Number: 1600x1200 60 20:07:20 INFO - Main Display: Yes 20:07:20 INFO - Mirror: Off 20:07:20 INFO - Online: Yes 20:07:20 INFO - Rotation: Supported 20:07:20 INFO - Return code: 0 20:07:20 INFO - Running post-action listener: _resource_record_post_action 20:07:20 INFO - [mozharness: 2016-11-27 04:07:20.388802Z] Finished run-tests step (success) 20:07:20 INFO - Running post-run listener: _resource_record_post_run 20:07:20 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 33029120; Write bytes: 690162176; Read time: 308; Write time: 1980 20:07:20 INFO - TinderboxPrint: CPU usage
53.7% 20:07:20 INFO - TinderboxPrint: I/O read bytes / time
33,029,120 / 308 20:07:20 INFO - TinderboxPrint: I/O write bytes / time
690,162,176 / 1,980 20:07:20 INFO - TinderboxPrint: CPU idle
2,247.8 (46.3%) 20:07:20 INFO - TinderboxPrint: CPU system
974.5 (20.1%) 20:07:20 INFO - TinderboxPrint: CPU user
1,635.4 (33.7%) 20:07:20 INFO - TinderboxPrint: Swap in / out
412,692,480 / 0 20:07:20 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 384545280; Write bytes: 385562624; Read time: 28886; Write time: 727 20:07:20 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 28695552; Write bytes: 303284736; Read time: 277; Write time: 1248 20:07:20 INFO - Running post-run listener: _upload_blobber_files 20:07:20 INFO - Blob upload gear active. 20:07:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:07:20 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 20:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:07:21 INFO - (blobuploader) - INFO - Open directory for files ... 20:07:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:07:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:07:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:22 INFO - (blobuploader) - INFO - Done attempting. 20:07:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:07:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:23 INFO - (blobuploader) - INFO - Done attempting. 20:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:25 INFO - (blobuploader) - INFO - Done attempting. 20:07:25 INFO - (blobuploader) - INFO - Iteration through files over. 20:07:25 INFO - Return code: 0 20:07:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:07:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:07:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/477dbf019b80b491c81eeb362dc42d5bb8fbf9198dd432870c3d474a3ec48a85741615a28fc5920189012927be360b877391141110b058ca33d9efb5a003d5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4198f3ba371ce403fe16154ebb9deaf1c501e717365b467ecf2fd9116c78ce1a8025a911ce144c011821b4e8dab2c9c70a6fc3104b8df02772fb3943e25d34e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a56de07e88d87ac60246ffd6c5072bf432638a8cebe47980b4550a5e6a28c247a639ef9907c54b92424eaaef3fc194847d32cca795753894ca9d9b770c73a32"} 20:07:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:07:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:07:25 INFO - Contents: 20:07:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/477dbf019b80b491c81eeb362dc42d5bb8fbf9198dd432870c3d474a3ec48a85741615a28fc5920189012927be360b877391141110b058ca33d9efb5a003d5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4198f3ba371ce403fe16154ebb9deaf1c501e717365b467ecf2fd9116c78ce1a8025a911ce144c011821b4e8dab2c9c70a6fc3104b8df02772fb3943e25d34e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a56de07e88d87ac60246ffd6c5072bf432638a8cebe47980b4550a5e6a28c247a639ef9907c54b92424eaaef3fc194847d32cca795753894ca9d9b770c73a32"} 20:07:25 INFO - Running post-run listener: copy_logs_to_upload_dir 20:07:25 INFO - Copying logs to upload dir... 20:07:25 INFO - mkdir: /builds/slave/test/build/upload/logs 20:07:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.791635 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-26 20:07:25.789284) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 20:07:25.792299) ========= 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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/477dbf019b80b491c81eeb362dc42d5bb8fbf9198dd432870c3d474a3ec48a85741615a28fc5920189012927be360b877391141110b058ca33d9efb5a003d5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4198f3ba371ce403fe16154ebb9deaf1c501e717365b467ecf2fd9116c78ce1a8025a911ce144c011821b4e8dab2c9c70a6fc3104b8df02772fb3943e25d34e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a56de07e88d87ac60246ffd6c5072bf432638a8cebe47980b4550a5e6a28c247a639ef9907c54b92424eaaef3fc194847d32cca795753894ca9d9b770c73a32"} build_url:https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010856 build_url: 'https://queue.taskcluster.net/v1/task/LPy1JeBZS3uLqGeB3P8bTA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/477dbf019b80b491c81eeb362dc42d5bb8fbf9198dd432870c3d474a3ec48a85741615a28fc5920189012927be360b877391141110b058ca33d9efb5a003d5c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4198f3ba371ce403fe16154ebb9deaf1c501e717365b467ecf2fd9116c78ce1a8025a911ce144c011821b4e8dab2c9c70a6fc3104b8df02772fb3943e25d34e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a56de07e88d87ac60246ffd6c5072bf432638a8cebe47980b4550a5e6a28c247a639ef9907c54b92424eaaef3fc194847d32cca795753894ca9d9b770c73a32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 20:07:25.825234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 20:07:25.825518) ========= 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.qWn4JOsT3g/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.XO23nR8ilZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.005211 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 20:07:25.873374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 20:07:25.873644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 20:07:25.873942) ========= ========= Total master_lag: 0.17 =========