builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0172 starttime: 1457527108.4 results: success (0) buildid: 20160309024612 builduid: b6ce28a19a9d40cfa274f3bcbecacc52 revision: ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.397843) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.398243) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.398525) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005450 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.425232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.425500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.445142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.445400) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005584 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.493111) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.493376) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.496717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.496993) ========= 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.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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-03-09 04:38:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-03-09 04:38:28 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.619264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.619572) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.026917 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:28.670971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 04:38:28.671275) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc --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 ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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-03-09 04:38:28,752 truncating revision to first 12 chars 2016-03-09 04:38:28,752 Setting DEBUG logging. 2016-03-09 04:38:28,752 attempt 1/10 2016-03-09 04:38:28,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ebcf7897ef0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 04:38:30,301 unpacking tar archive at: mozilla-central-ebcf7897ef0e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.800038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 04:38:30.490329) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:30.493689) ========= echo ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc program finished with exit code 0 elapsedTime=0.005108 script_repo_revision: 'ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:30.545914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:30.546184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 04:38:30.559960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-09 04:38:30.560234) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:38:30 INFO - MultiFileLogger online at 20160309 04:38:30 in /builds/slave/test 04:38:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:38:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:30 INFO - {'append_to_log': False, 04:38:30 INFO - 'base_work_dir': '/builds/slave/test', 04:38:30 INFO - 'blob_upload_branch': 'Firefox', 04:38:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:30 INFO - 'branch': 'Firefox', 04:38:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:30 INFO - 'config_files': ('talos/mac_config.py',), 04:38:30 INFO - 'default_actions': ('clobber', 04:38:30 INFO - 'read-buildbot-config', 04:38:30 INFO - 'download-and-extract', 04:38:30 INFO - 'populate-webroot', 04:38:30 INFO - 'create-virtualenv', 04:38:30 INFO - 'install', 04:38:30 INFO - 'run-tests'), 04:38:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:30 INFO - 'download_minidump_stackwalk': True, 04:38:30 INFO - 'download_symbols': 'ondemand', 04:38:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:30 INFO - 'installer_path': 'installer.exe', 04:38:30 INFO - 'log_level': 'info', 04:38:30 INFO - 'log_name': 'talos', 04:38:30 INFO - 'log_to_console': True, 04:38:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:30 INFO - 'opt_config_files': (), 04:38:30 INFO - 'pip_index': False, 04:38:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:30 INFO - 'cmd': ('bash', 04:38:30 INFO - '-c', 04:38:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:30 INFO - 'enabled': True, 04:38:30 INFO - 'halt_on_failure': False, 04:38:30 INFO - 'name': 'check_screen_resolution'},), 04:38:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:30 INFO - 'cmd': ('bash', 04:38:30 INFO - '-c', 04:38:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:30 INFO - 'enabled': True, 04:38:30 INFO - 'halt_on_failure': False, 04:38:30 INFO - 'name': 'check_screen_resolution'},), 04:38:30 INFO - 'run_cmd_checks_enabled': True, 04:38:30 INFO - 'sps_profile': False, 04:38:30 INFO - 'sps_profile_interval': 0, 04:38:30 INFO - 'suite': 'dromaeojs-e10s', 04:38:30 INFO - 'system_bits': '32', 04:38:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:30 INFO - 'title': 't-yosemite-r7-0172', 04:38:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:30 INFO - 'use_talos_json': True, 04:38:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:30 INFO - 'work_dir': 'build'} 04:38:30 INFO - ##### 04:38:30 INFO - ##### Running clobber step. 04:38:30 INFO - ##### 04:38:30 INFO - Running pre-action listener: _resource_record_pre_action 04:38:30 INFO - Running main action method: clobber 04:38:30 INFO - rmtree: /builds/slave/test/build 04:38:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:33 INFO - Running post-action listener: _resource_record_post_action 04:38:33 INFO - ##### 04:38:33 INFO - ##### Running read-buildbot-config step. 04:38:33 INFO - ##### 04:38:33 INFO - Running pre-action listener: _resource_record_pre_action 04:38:33 INFO - Running main action method: read_buildbot_config 04:38:33 INFO - Using buildbot properties: 04:38:33 INFO - { 04:38:33 INFO - "project": "", 04:38:33 INFO - "product": "firefox", 04:38:33 INFO - "script_repo_revision": "production", 04:38:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:38:33 INFO - "repository": "", 04:38:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:38:33 INFO - "buildid": "20160309024612", 04:38:33 INFO - "pgo_build": "False", 04:38:33 INFO - "basedir": "/builds/slave/test", 04:38:33 INFO - "buildnumber": 202, 04:38:33 INFO - "slavename": "t-yosemite-r7-0172", 04:38:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:38:33 INFO - "platform": "yosemite_r7", 04:38:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:38:33 INFO - "branch": "mozilla-central", 04:38:33 INFO - "repo_path": "mozilla-central", 04:38:33 INFO - "revision": "ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc", 04:38:33 INFO - "stage_platform": "macosx64", 04:38:33 INFO - "builduid": "b6ce28a19a9d40cfa274f3bcbecacc52", 04:38:33 INFO - "slavebuilddir": "test" 04:38:33 INFO - } 04:38:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:38:33 INFO - Running post-action listener: _resource_record_post_action 04:38:33 INFO - ##### 04:38:33 INFO - ##### Running download-and-extract step. 04:38:33 INFO - ##### 04:38:33 INFO - Running pre-action listener: _resource_record_pre_action 04:38:33 INFO - Running main action method: download_and_extract 04:38:33 INFO - mkdir: /builds/slave/test/build/tests 04:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:33 INFO - https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:38:33 INFO - Downloaded 1199 bytes. 04:38:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:38:33 INFO - Using the following test package requirements: 04:38:33 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:38:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:38:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'jsshell-mac.zip'], 04:38:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:38:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:38:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:38:33 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:38:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:38:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:38:33 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:33 INFO - https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:34 INFO - Downloaded 17867253 bytes. 04:38:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:38 INFO - Return code: 0 04:38:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:38 INFO - https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:38 INFO - Downloaded 17867253 bytes. 04:38:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:42 INFO - Return code: 0 04:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:42 INFO - https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:38:43 INFO - Downloaded 10845161 bytes. 04:38:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:38:43 INFO - Return code: 0 04:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:43 INFO - https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:38:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:38:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:38:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:38:46 INFO - Downloaded 110884862 bytes. 04:38:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:38:46 INFO - mkdir: /builds/slave/test/properties 04:38:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:38:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:38:46 INFO - Contents: 04:38:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:38:47 INFO - Running post-action listener: _resource_record_post_action 04:38:47 INFO - Running post-action listener: set_extra_try_arguments 04:38:47 INFO - ##### 04:38:47 INFO - ##### Running populate-webroot step. 04:38:47 INFO - ##### 04:38:47 INFO - Running pre-action listener: _resource_record_pre_action 04:38:47 INFO - Running main action method: populate_webroot 04:38:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:38:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:38:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:38:47 INFO - '--tppagecycles', 04:38:47 INFO - '7'], 04:38:47 INFO - 'tests': ['tsvgm']}}, 04:38:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:38:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:38:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:38:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:38:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'tests': ['damp', 'tps']}, 04:38:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['damp', 'tps']}, 04:38:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:38:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:38:47 INFO - 'other': {'tests': ['a11yr', 04:38:47 INFO - 'ts_paint', 04:38:47 INFO - 'tpaint', 04:38:47 INFO - 'sessionrestore', 04:38:47 INFO - 'sessionrestore_no_auto_restore', 04:38:47 INFO - 'tabpaint']}, 04:38:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['a11yr', 04:38:47 INFO - 'ts_paint', 04:38:47 INFO - 'tpaint', 04:38:47 INFO - 'sessionrestore', 04:38:47 INFO - 'sessionrestore_no_auto_restore', 04:38:47 INFO - 'tabpaint']}, 04:38:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['a11yr', 04:38:47 INFO - 'ts_paint', 04:38:47 INFO - 'tpaint', 04:38:47 INFO - 'sessionrestore', 04:38:47 INFO - 'sessionrestore_no_auto_restore', 04:38:47 INFO - 'tabpaint']}, 04:38:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['a11yr', 04:38:47 INFO - 'ts_paint', 04:38:47 INFO - 'tpaint', 04:38:47 INFO - 'sessionrestore', 04:38:47 INFO - 'sessionrestore_no_auto_restore', 04:38:47 INFO - 'tabpaint']}, 04:38:47 INFO - 'other_l64': {'tests': ['a11yr', 04:38:47 INFO - 'ts_paint', 04:38:47 INFO - 'tpaint', 04:38:47 INFO - 'sessionrestore', 04:38:47 INFO - 'sessionrestore_no_auto_restore', 04:38:47 INFO - 'tabpaint']}, 04:38:47 INFO - 'other_nol64': {'tests': ['a11yr', 04:38:47 INFO - 'ts_paint', 04:38:47 INFO - 'tpaint', 04:38:47 INFO - 'sessionrestore', 04:38:47 INFO - 'sessionrestore_no_auto_restore', 04:38:47 INFO - 'tabpaint']}, 04:38:47 INFO - 'svgr': {'tests': ['tsvgx', 04:38:47 INFO - 'tsvgr_opacity', 04:38:47 INFO - 'tart', 04:38:47 INFO - 'tscrollx', 04:38:47 INFO - 'cart']}, 04:38:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['tsvgx', 04:38:47 INFO - 'tsvgr_opacity', 04:38:47 INFO - 'tart', 04:38:47 INFO - 'tscrollx', 04:38:47 INFO - 'cart']}, 04:38:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'tests': ['tp5o']}, 04:38:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'talos_options': ['--e10s'], 04:38:47 INFO - 'tests': ['tp5o']}, 04:38:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'talos_options': ['--xperf_path', 04:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:47 INFO - 'tests': ['tp5n']}, 04:38:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:47 INFO - 'talos_options': ['--e10s', 04:38:47 INFO - '--xperf_path', 04:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:47 INFO - 'tests': ['tp5n']}}, 04:38:47 INFO - 'talos.zip': {'path': '', 04:38:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:38:47 INFO - Running post-action listener: _resource_record_post_action 04:38:47 INFO - ##### 04:38:47 INFO - ##### Running create-virtualenv step. 04:38:47 INFO - ##### 04:38:47 INFO - Running pre-action listener: _resource_record_pre_action 04:38:47 INFO - Running main action method: create_virtualenv 04:38:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:38:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:38:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:38:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:38:47 INFO - Using real prefix '/tools/python27' 04:38:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:38:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:38:51 INFO - Installing pip.................done. 04:38:51 INFO - Return code: 0 04:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:51 INFO - 'HOME': '/Users/cltbld', 04:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:51 INFO - 'LOGNAME': 'cltbld', 04:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:51 INFO - 'MOZ_NO_REMOTE': '1', 04:38:51 INFO - 'NO_EM_RESTART': '1', 04:38:51 INFO - 'PAGER': '/bin/cat', 04:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:51 INFO - 'PWD': '/builds/slave/test', 04:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:51 INFO - 'SHELL': '/bin/bash', 04:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:38:51 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:51 INFO - 'USER': 'cltbld', 04:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:51 INFO - 'XPC_FLAGS': '0x0', 04:38:51 INFO - 'XPC_SERVICE_NAME': '0', 04:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:38:51 INFO - Cleaning up... 04:38:51 INFO - Return code: 0 04:38:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:51 INFO - 'HOME': '/Users/cltbld', 04:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:51 INFO - 'LOGNAME': 'cltbld', 04:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:51 INFO - 'MOZ_NO_REMOTE': '1', 04:38:51 INFO - 'NO_EM_RESTART': '1', 04:38:51 INFO - 'PAGER': '/bin/cat', 04:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:51 INFO - 'PWD': '/builds/slave/test', 04:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:51 INFO - 'SHELL': '/bin/bash', 04:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:38:51 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:51 INFO - 'USER': 'cltbld', 04:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:51 INFO - 'XPC_FLAGS': '0x0', 04:38:51 INFO - 'XPC_SERVICE_NAME': '0', 04:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:51 INFO - Downloading/unpacking psutil>=0.7.1 04:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:54 INFO - Installing collected packages: psutil 04:38:54 INFO - Running setup.py install for psutil 04:38:54 INFO - building 'psutil._psutil_osx' extension 04:38:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:38:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:38:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:38:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:38:55 INFO - building 'psutil._psutil_posix' extension 04:38:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:38:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:38:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:38:55 INFO - ^ 04:38:55 INFO - 1 warning generated. 04:38:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:38:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:55 INFO - Successfully installed psutil 04:38:55 INFO - Cleaning up... 04:38:55 INFO - Return code: 0 04:38:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:55 INFO - 'HOME': '/Users/cltbld', 04:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:55 INFO - 'LOGNAME': 'cltbld', 04:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:55 INFO - 'MOZ_NO_REMOTE': '1', 04:38:55 INFO - 'NO_EM_RESTART': '1', 04:38:55 INFO - 'PAGER': '/bin/cat', 04:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:55 INFO - 'PWD': '/builds/slave/test', 04:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:55 INFO - 'SHELL': '/bin/bash', 04:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:38:55 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:55 INFO - 'USER': 'cltbld', 04:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:55 INFO - 'XPC_FLAGS': '0x0', 04:38:55 INFO - 'XPC_SERVICE_NAME': '0', 04:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:38:58 INFO - Installing collected packages: mozsystemmonitor 04:38:58 INFO - Running setup.py install for mozsystemmonitor 04:38:58 INFO - Successfully installed mozsystemmonitor 04:38:58 INFO - Cleaning up... 04:38:58 INFO - Return code: 0 04:38:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:58 INFO - 'HOME': '/Users/cltbld', 04:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:58 INFO - 'LOGNAME': 'cltbld', 04:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:58 INFO - 'MOZ_NO_REMOTE': '1', 04:38:58 INFO - 'NO_EM_RESTART': '1', 04:38:58 INFO - 'PAGER': '/bin/cat', 04:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:58 INFO - 'PWD': '/builds/slave/test', 04:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:58 INFO - 'SHELL': '/bin/bash', 04:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:38:58 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:58 INFO - 'USER': 'cltbld', 04:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:58 INFO - 'XPC_FLAGS': '0x0', 04:38:58 INFO - 'XPC_SERVICE_NAME': '0', 04:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:02 INFO - Downloading docopt-0.6.1.tar.gz 04:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:02 INFO - Running setup.py install for blobuploader 04:39:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:02 INFO - Running setup.py install for requests 04:39:03 INFO - Running setup.py install for docopt 04:39:03 INFO - Successfully installed blobuploader requests docopt 04:39:03 INFO - Cleaning up... 04:39:03 INFO - Return code: 0 04:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:03 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 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:03 INFO - 'HOME': '/Users/cltbld', 04:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:03 INFO - 'LOGNAME': 'cltbld', 04:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:03 INFO - 'MOZ_NO_REMOTE': '1', 04:39:03 INFO - 'NO_EM_RESTART': '1', 04:39:03 INFO - 'PAGER': '/bin/cat', 04:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:03 INFO - 'PWD': '/builds/slave/test', 04:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:03 INFO - 'SHELL': '/bin/bash', 04:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:39:03 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:03 INFO - 'USER': 'cltbld', 04:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:03 INFO - 'XPC_FLAGS': '0x0', 04:39:03 INFO - 'XPC_SERVICE_NAME': '0', 04:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:03 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-dOztjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:03 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-qQvZJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:03 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-OlHawr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:03 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-xNw_BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-T5vc7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-v2Q7aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-JQf1jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-9w0kQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-miz9YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-aEaHDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-NKMvDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-S7PIbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:04 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-f3gjEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:05 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-2lzFPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:05 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Tkgz_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:05 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-fNrBxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:05 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-mNQCgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:05 INFO - Running setup.py install for manifestparser 04:39:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:05 INFO - Running setup.py install for mozcrash 04:39:05 INFO - Running setup.py install for mozdebug 04:39:05 INFO - Running setup.py install for mozdevice 04:39:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Running setup.py install for mozfile 04:39:06 INFO - Running setup.py install for mozhttpd 04:39:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Running setup.py install for mozinfo 04:39:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Running setup.py install for mozInstall 04:39:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Running setup.py install for mozleak 04:39:06 INFO - Running setup.py install for mozlog 04:39:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:06 INFO - Running setup.py install for moznetwork 04:39:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:07 INFO - Running setup.py install for mozprocess 04:39:07 INFO - Running setup.py install for mozprofile 04:39:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:07 INFO - Running setup.py install for mozrunner 04:39:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:07 INFO - Running setup.py install for mozscreenshot 04:39:07 INFO - Running setup.py install for moztest 04:39:07 INFO - Running setup.py install for mozversion 04:39:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:07 INFO - Cleaning up... 04:39:07 INFO - Return code: 0 04:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:07 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 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:07 INFO - 'HOME': '/Users/cltbld', 04:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:07 INFO - 'LOGNAME': 'cltbld', 04:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:07 INFO - 'MOZ_NO_REMOTE': '1', 04:39:07 INFO - 'NO_EM_RESTART': '1', 04:39:07 INFO - 'PAGER': '/bin/cat', 04:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:07 INFO - 'PWD': '/builds/slave/test', 04:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:07 INFO - 'SHELL': '/bin/bash', 04:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:39:07 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:07 INFO - 'USER': 'cltbld', 04:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:07 INFO - 'XPC_FLAGS': '0x0', 04:39:07 INFO - 'XPC_SERVICE_NAME': '0', 04:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-VjNxBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-trssVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-pz3iA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-gF3Mzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ZR2A_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-C8Kbbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-kpGOYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:08 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-G9BGrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-tHYQYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-JrHx3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-vhYo7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-T8P1i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-8mOYuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Xprl_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-r7kEkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-NHEDpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:09 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Hm_4ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:12 INFO - Downloading blessings-1.6.tar.gz 04:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:12 INFO - Installing collected packages: blessings 04:39:12 INFO - Running setup.py install for blessings 04:39:12 INFO - Successfully installed blessings 04:39:12 INFO - Cleaning up... 04:39:12 INFO - Return code: 0 04:39:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:12 INFO - Reading from file tmpfile_stdout 04:39:12 INFO - Current package versions: 04:39:12 INFO - blessings == 1.6 04:39:12 INFO - blobuploader == 1.2.4 04:39:12 INFO - docopt == 0.6.1 04:39:12 INFO - manifestparser == 1.1 04:39:12 INFO - mozInstall == 1.12 04:39:12 INFO - mozcrash == 0.17 04:39:12 INFO - mozdebug == 0.1 04:39:12 INFO - mozdevice == 0.48 04:39:12 INFO - mozfile == 1.2 04:39:12 INFO - mozhttpd == 0.7 04:39:12 INFO - mozinfo == 0.9 04:39:12 INFO - mozleak == 0.1 04:39:12 INFO - mozlog == 3.1 04:39:12 INFO - moznetwork == 0.27 04:39:12 INFO - mozprocess == 0.22 04:39:12 INFO - mozprofile == 0.28 04:39:12 INFO - mozrunner == 6.11 04:39:12 INFO - mozscreenshot == 0.1 04:39:12 INFO - mozsystemmonitor == 0.0 04:39:12 INFO - moztest == 0.7 04:39:12 INFO - mozversion == 1.4 04:39:12 INFO - psutil == 3.1.1 04:39:12 INFO - requests == 1.2.3 04:39:12 INFO - wsgiref == 0.1.2 04:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:12 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 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:13 INFO - 'HOME': '/Users/cltbld', 04:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:13 INFO - 'LOGNAME': 'cltbld', 04:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:13 INFO - 'MOZ_NO_REMOTE': '1', 04:39:13 INFO - 'NO_EM_RESTART': '1', 04:39:13 INFO - 'PAGER': '/bin/cat', 04:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:13 INFO - 'PWD': '/builds/slave/test', 04:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:13 INFO - 'SHELL': '/bin/bash', 04:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:39:13 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:13 INFO - 'USER': 'cltbld', 04:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:13 INFO - 'XPC_FLAGS': '0x0', 04:39:13 INFO - 'XPC_SERVICE_NAME': '0', 04:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:13 INFO - Cleaning up... 04:39:13 INFO - Return code: 0 04:39:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:13 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 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:13 INFO - 'HOME': '/Users/cltbld', 04:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:13 INFO - 'LOGNAME': 'cltbld', 04:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:13 INFO - 'MOZ_NO_REMOTE': '1', 04:39:13 INFO - 'NO_EM_RESTART': '1', 04:39:13 INFO - 'PAGER': '/bin/cat', 04:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:13 INFO - 'PWD': '/builds/slave/test', 04:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:13 INFO - 'SHELL': '/bin/bash', 04:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:39:13 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:13 INFO - 'USER': 'cltbld', 04:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:13 INFO - 'XPC_FLAGS': '0x0', 04:39:13 INFO - 'XPC_SERVICE_NAME': '0', 04:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:13 INFO - Downloading/unpacking jsonschema 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:15 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:16 INFO - warning: no files found matching '*.txt' 04:39:16 INFO - no previously-included directories found matching 'build' 04:39:16 INFO - no previously-included directories found matching 'dist' 04:39:16 INFO - no previously-included directories found matching '.git*' 04:39:16 INFO - Installing collected packages: jsonschema, functools32 04:39:16 INFO - Running setup.py install for functools32 04:39:16 INFO - warning: no files found matching '*.txt' 04:39:16 INFO - no previously-included directories found matching 'build' 04:39:16 INFO - no previously-included directories found matching 'dist' 04:39:16 INFO - no previously-included directories found matching '.git*' 04:39:16 INFO - Successfully installed jsonschema functools32 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9aa4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb58b556210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, '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.y7Dji10UJs/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.TBbF63E6T9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:16 INFO - 'HOME': '/Users/cltbld', 04:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PAGER': '/bin/cat', 04:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:39:16 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - 'XPC_FLAGS': '0x0', 04:39:16 INFO - 'XPC_SERVICE_NAME': '0', 04:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 INFO - Downloading/unpacking flake8 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:20 INFO - no previously-included directories found matching 'docs/_build' 04:39:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:20 INFO - Running setup.py install for pep8 04:39:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:20 INFO - no previously-included directories found matching 'docs/_build' 04:39:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:20 INFO - Cleaning up... 04:39:20 INFO - Return code: 0 04:39:20 INFO - Running post-action listener: _resource_record_post_action 04:39:20 INFO - Running post-action listener: _start_resource_monitoring 04:39:20 INFO - Starting resource monitoring. 04:39:20 INFO - ##### 04:39:20 INFO - ##### Running install step. 04:39:20 INFO - ##### 04:39:20 INFO - Running pre-action listener: _resource_record_pre_action 04:39:20 INFO - Running main action method: install 04:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:21 INFO - Reading from file tmpfile_stdout 04:39:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:21 INFO - Reading from file tmpfile_stdout 04:39:21 INFO - Output received: 04:39:21 INFO - Usage: mozinstall [options] installer 04:39:21 INFO - Options: 04:39:21 INFO - -h, --help show this help message and exit 04:39:21 INFO - -d DEST, --destination=DEST 04:39:21 INFO - Directory to install application into. [default: 04:39:21 INFO - "/builds/slave/test"] 04:39:21 INFO - --app=APP Application being installed. [default: firefox] 04:39:21 INFO - mkdir: /builds/slave/test/build/application 04:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:39:55 INFO - Reading from file tmpfile_stdout 04:39:55 INFO - Output received: 04:39:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:39:55 INFO - Running post-action listener: _resource_record_post_action 04:39:55 INFO - ##### 04:39:55 INFO - ##### Running run-tests step. 04:39:55 INFO - ##### 04:39:55 INFO - Running pre-action listener: _resource_record_pre_action 04:39:55 INFO - Running main action method: run_tests 04:39:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:55 INFO - 2016-03-09 04:39:55.531 screenresolution[1645:7419] starting screenresolution argv=screenresolution get 04:39:55 INFO - 2016-03-09 04:39:55.534 screenresolution[1645:7419] Display 0: 1600x1200x32@60 04:39:55 INFO - 2016-03-09 04:39:55.540 screenresolution[1646:7421] starting screenresolution argv=screenresolution list 04:39:55 INFO - Available Modes on Display 0 04:39:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:55 INFO - Intel Iris: 04:39:55 INFO - Chipset Model: Intel Iris 04:39:55 INFO - Type: GPU 04:39:55 INFO - Bus: Built-In 04:39:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:55 INFO - Vendor: Intel (0x8086) 04:39:55 INFO - Device ID: 0x0a2e 04:39:55 INFO - Revision ID: 0x0009 04:39:55 INFO - Displays: 04:39:55 INFO - Display: 04:39:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:55 INFO - Display Serial Number: 1600x1200 60 04:39:55 INFO - Main Display: Yes 04:39:55 INFO - Mirror: Off 04:39:55 INFO - Online: Yes 04:39:55 INFO - Rotation: Supported 04:39:55 INFO - Return code: 0 04:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:55 INFO - Python 2.7.3 04:39:55 INFO - Return code: 0 04:39:55 INFO - grabbing minidump binary from tooltool 04:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a847d30>, '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 0x10a66bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a83eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:39:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:39:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:55 INFO - Return code: 0 04:39:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:39:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:39:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:39:57 INFO - Return code: 0 04:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:39:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Dji10UJs/Render', 04:39:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:57 INFO - 'HOME': '/Users/cltbld', 04:39:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:57 INFO - 'LOGNAME': 'cltbld', 04:39:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:57 INFO - 'MOZ_NO_REMOTE': '1', 04:39:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:57 INFO - 'NO_EM_RESTART': '1', 04:39:57 INFO - 'PAGER': '/bin/cat', 04:39:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:57 INFO - 'PWD': '/builds/slave/test', 04:39:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:57 INFO - 'SHELL': '/bin/bash', 04:39:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TBbF63E6T9/Listeners', 04:39:57 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 04:39:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:57 INFO - 'USER': 'cltbld', 04:39:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:57 INFO - 'XPC_FLAGS': '0x0', 04:39:57 INFO - 'XPC_SERVICE_NAME': '0', 04:39:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:39:57 INFO - mozversion application_buildid: 20160309024612 04:39:57 INFO - mozversion application_changeset: ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc 04:39:57 INFO - mozversion application_display_name: Nightly 04:39:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:57 INFO - mozversion application_name: Firefox 04:39:57 INFO - mozversion application_remotingname: firefox 04:39:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:39:57 INFO - mozversion application_vendor: Mozilla 04:39:57 INFO - mozversion application_version: 48.0a1 04:39:57 INFO - mozversion platform_buildid: 20160309024612 04:39:57 INFO - mozversion platform_changeset: ebcf7897ef0e99f3bf6c0a26578ce2e4a46bbdbc 04:39:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:39:57 INFO - mozversion platform_version: 48.0a1 04:39:57 INFO - using testdate: 1457527197 04:39:57 INFO - actual date: 1457527197 04:39:57 INFO - starting webserver on 'localhost:49281' 04:39:57 INFO - SUITE-START | Running 2 tests 04:39:57 INFO - TEST-START | dromaeo_css 04:39:57 INFO - operating with platform_type : mac_ 04:39:57 INFO - Initialising browser for dromaeo_css test... 04:39:57 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmphfLO9J/profile http://localhost:49281/getInfo.html) 04:40:00 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 04:40:00 INFO - PROCESS | 1664 | colorDepth:24 04:40:00 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 04:40:00 INFO - PROCESS | 1664 | __metrics 04:40:00 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 04:40:00 INFO - TEST-INFO | 1664: exit 0 04:40:00 INFO - Browser initialized. 04:40:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:00 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmphfLO9J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:12 INFO - PROCESS | 1668 | RSS: Main: 256294912 04:40:12 INFO - PROCESS | 1668 | 04:41:02 INFO - PROCESS | 1668 | 1457527262510 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:43:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 04:43:14 INFO - PROCESS | 1668 | RSS: Main: 269975552 04:43:14 INFO - PROCESS | 1668 | 04:46:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 04:46:17 INFO - PROCESS | 1668 | RSS: Main: 281321472 04:46:17 INFO - PROCESS | 1668 | 04:49:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 04:49:19 INFO - PROCESS | 1668 | RSS: Main: 282066944 04:49:19 INFO - PROCESS | 1668 | 04:52:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 04:52:21 INFO - PROCESS | 1668 | RSS: Main: 282849280 04:52:21 INFO - PROCESS | 1668 | 04:55:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 04:55:25 INFO - PROCESS | 1668 | RSS: Main: 285589504 04:55:25 INFO - PROCESS | 1668 | 04:58:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 04:58:28 INFO - PROCESS | 1668 | RSS: Main: 289062912 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | __start_tp_report 04:58:28 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 04:58:28 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 04:58:28 INFO - PROCESS | 1668 | |i|pagename|runs| 04:58:28 INFO - PROCESS | 1668 | |0;dojo.html;3367.5958884933807;3430.5711786026745;3463.5670541182353;3494.947575786364;3499.9650003499955;5460.34475862896;5465.754041068151;5475.561955043592;5534.640248383852;5572;5626;5698.914516282249;5708.1437784332375;5727.513161381277;5789.739461724222;5060.671056381323;5092.643514953955;5196.298499702549;5276.551493123089;5302.946970530284;5125.641205115643;5201.947980520203;5212.504812042869;5252.71110088945;5269.1832765921345;4863.197572400567;5150.27896094547;5177;5181.378234611833;5185.351831021122;5153.613478989053;5167.896642067175;5169.689818610857;5172.922406163911;5216.321878155815;5054.1407960646775;5087.160618497944;5137.691738495702;5201.115810312256;5208.322918020671;4433.246348120827;4675.953240467586;5597.888042239173;5628.352739434977;5636.661800291996;6181.412765787288;6247.562670613059;6257.87484250317;6261.624302541862;6273.62358258506;6105.368770830132;6117;6133.78531751391;6142.6007309525185;6284.905726414107;5829.62107463022;5845.824625261249;5862.736176872051;5873.500752436005;5902.439268269508;6254.312025677172;6263.874722505524;6272.874542509216;6273.027680709497;6277.7175027123885;6079.148919151322;6087.878242435127;6106.582013105394;6146.754129834846;6154.692265386802;6111.755529778848;6118.969405152946;6178.258608966953;6187.102870083902;6220.471259942865;6141.815745527641;6147.907781383283;6151.6001459904965;6202.751889924442;6229.4393504583895;6089.725962331617;6189.752409903644;6198.6280823150755;6199.752009919643;6271.655058971709;4870.6103511718975;4884.438289596671;4896.143174944371;4933.112039832865;4946.282788995575;4421.314696222091;4433.290673492225;4439.1121775645;4456.442944631921;4484.551544845489;5589.972050139723;5713.314402271754;5725.799597014085;5734.512566431817;5764.971175144097;5541.2796336476;5885.705714714247;6269.937300626935;6281.528885333618;6308.116863639094;5572.58205634579;5780.739866706008;5800.216970708984;5818.534517238695;5909.645421274738;5317.388500322435;5368.8657783554945;5371.274877891435;5400.351957765093;5414.133738601805;6340.778072767431;6358.936410635927;6371.267304259976;6381.202349706286;6394.680265986589;6123.526657168115;6131.448169664752;6188.4739797117745;6214.161088253028;6231.470325022424;6191.442770150708;6257.2804127525915;6272.968635156795;6293.559450838397;6316.747330106744;6079.3008803988105;6087.57386982907;6140.938590614215;6158.630482171084;6169.56813023084;6009.579329446897;6013.849653758691;6106.3089915548935;6200.441960223421;6213.782517611862;5075.467075957119;5988.940110598838;6073.939260607514;6125.173101631222;6152.661603611844;5396.865078373072;6023.457888789854;6028.668423236764;6097.359777223505;6131.294901086254;5734.885302293847;5904.202932604216;5991.161237426851;6014.127951446928;6027.914975304488;4717.528247175393;4862.3922009748785;5039.420466646383;5609.579281553818;6146.094710639716;4898.436679781728;4907.77914993819;5013.298138260573;5986.88026239464;5989 04:58:28 INFO - PROCESS | 1668 | |1;ext.html;572.7021948586732;578.5429510686558;599.8752339363693;620.8230654263535;640.5548144039892;39102.63140790073;39494.01264968373;39505.60494395055;39542;39578.40632390516;41334.79332603333;41880.95297617561;41945.37081943773;42302.94242643928;42381.788091059505;9552.522373881313;9712.951435242814;9769.90230097697;9792.902070979306;9802.901970980305;8771.605277762515;9614.13472787449;9735;9748.610055597803;9776.853347199798;9763.121319081281;9840.114389704926;9856.359336643096;9921.355111917703;9942.701718948443;9830.754231144207;9836.901630983706;9901.653442129491;9903.55434005468;9911.504424778732;9753.609855605839;9851.704448866545;9864.556094975744;9871.062249086326;9897.4556399398;40560.79719601383;40712.592874071175;40962;41112;41156.1768764626;2506.4360518883104;3178.4278829810855;3782.3002744492355;3914.667253283474;3960.2277555876326;27424.314392140357;27793.86103069492;27881.72118278832;28257;28364.29089272764;2671.8396896186096;2708.8239264447748;2816.662000559946;2826.6184065151147;2830.6978789756736;352151;353723;354170;355386;356073;60734.69632651808;60978.0853287201;61496.69251653713;61738.76522469526;61987.38012619906;64998;65017.67491162608;65156;65395;65629.67185164044;16730.916345418194;16792.99242045481;16853.073080980663;16927.576810579834;16982.23579938881;12762.17045892014;12936.417861196269;13013.739725205443;13082.803757943639;13101.475940962446;18755.97138684697;19400.648217402144;19629.312974046126;19701.802981969995;19798.010099494968;8433.873491897626;9133.269338452908;9323.487208203615;9334.673286434941;9346.205572526276;953.2897990996613;963.7831487915163;1028.3264461777549;1078.229066217658;1086.397049637443;27652.446951060865;28254.15237542877;28265.293367665974;28427.71572284292;28492.857535712603;938.6010945348336;1056.102313033915;1077.671310250381;1135.994320028411;1188.0733028237987;12624.305663188428;14702.338394772261;14884.702305954037;14938;15050.247487625575;518195;521637;525497;528989;530254;56696.43303566994;58425;58960.70519647374;58999.705001474715;59071.637134515;1232.2914324263584;1403.9789403158961;1428.8785453236592;1448.8913331499969;1451.3178805961181;28299.292517687223;28404.57393139063;28900;28938.42123157483;29090.854545727983;41793.582064180184;49798.25302620536;50270.994580107465;50653.98692026213;50735.746321268154;429411;429428;430527;431219;432344.8975816562;31951.201219968756;33078.834605826814;33289.336853051216;33605.66394336123;33744.49383259204;35317.28513251406;42078;43793.124137517705;45295.773521132185;45321.320180196664;33949.49075763816;34327.65672343245;34388.16772716586;35118.12204694903;35790;33420.49869251915;33655.495167573;34266;34304.97085087452;34307.14232144116;28549.571756424084;32619.184520386232;32829.83585082059;33686.15784605405;33747.15632109217;29389.412211755218;29957.951471698387;33405.16487087842;33812.492812608325;34072.82963585166;20234.898825506367;20429.48926276855;21257.89371053135;23573.29280121599;24080 04:58:28 INFO - PROCESS | 1668 | |2;jquery.html;292.79943238881367;355.85232128666587;362.4979403526117;368.78241837315977;371.3353097954661;19939.900300498495;20178.798212017893;22102.336929892088;22106.22628208013;22118.00468978896;20578.176872925065;20628;20891;21061.052252648627;21079.68380474294;5840.678762668052;6070.514358851281;6117.66352850593;6118.663473508956;6125.601835880676;4374.58441448062;5971.283445986466;6481.546291759579;6497.415232629062;6509.4466970307585;6417.8716425671455;6435.195600549931;6446.548741588091;6449.258335291454;6458.160439142905;6137.110119032737;6374.203224596926;6391.648459334735;6406.903896441557;6428.19647544057;5075.314832497639;5442.074847275972;5513.972430137864;5537.972310138463;5542.584306177053;12564.685882852911;13015.609531714064;13123.343832808321;13149.671258218525;13186.142900711424;1973.4868934077099;2103.137713537458;2188.102877820086;2198.0658220256487;2456.4242842462213;9344.672936447192;9591.328606997513;9923.156531694814;9994.00059994002;13447.86552134476;1712.332190445727;1737.1574786228668;1758.806531281558;1797.2631221199376;1797.8202179782047;101496;103064;106441;109264.90735092627;109430.45284773526;11451;11488.54045838157;11521.769564608661;11605;11665.76668466626;13673.24797136167;13854.653633659038;13857.584272471842;13895.305234738222;13896.027278090638;8518.48889066658;8686.131386861389;8705.129487051245;8738.30093592511;8769.473831570127;8095;8794.692185773467;8799.516026618598;8807;8863.734087977371;4473.843415480443;4556.2937744649635;4557.612602928722;4579.839705610354;4603.355530225771;1875.4561177258715;1911.550785565391;1922.5385907382408;1974.9308774192834;1978.169168949045;867.9435836670597;898.6654817595864;923.6166990698919;931.7204838548408;941.1435593609782;19278.903605481883;19764.802351976297;19811.801881980995;20041.899790500953;20335.796642033685;890.2121622364255;892.6922059183328;918.42598376015;919.4901189491216;1026.4867566216892;9667.598198261212;10336.431496267778;10612.469376531142;10740.409277489813;10752.892471075345;515835;525278;528431;558421;563694;125193.37403312925;128119;129136.35431822969;132715.33642331918;132805;1025.5846382215216;1034.1003327105316;1045.3518818332682;1061.2147011211648;1062.7290041039485;15299.76641577993;17876.195571199067;17888;18193.545161371072;18314.084295785426;40469.797651011555;44510.66468005965;46492.53507464882;51000.74499627626;52245.73051233876;72051.27948720656;75046.24953750393;75097;75424.62287688526;77802.2219777795;7784.766457006299;7913.44605877583;8008.6396112173925;8156.225158609923;8343.207395297437;11262.493187806733;11509.654710358702;12935.417906194432;13613.11514751538;13638.727225455237;10016.899831001596;10785.975555357327;11067.561217041733;11308.83036754433;11760;9296.349255552046;10335.328203666737;11224.709158446884;11586.131040171853;11910.940445297718;10174;11755.88244117548;11862.110341724232;11949.283043017447;12163.45264463119;7736.574488403192;7844;7942.801429964297;8039.035315762146;8415.032271288881;8521.318294536546;9574.760630984003;10877.960865087576;11565.248258863146;11935.641930742091 04:58:28 INFO - PROCESS | 1668 | |3;mootools.html;1525.8474152584743;1602.9358825646975;1686.940957066503;1834.5963887944656;1882.85878559108;8041.236082572146;8526.829463410728;8881.777955551115;9065.773355666104;9094.954525227373;8779.03430622631;8782.91217087829;8874.55627218638;8888.644454221823;8895.288376929846;2473.3692908308403;2475.183189547445;2492.4142826435773;2494.950100997988;2495.126705653025;2419.2742177346813;2471.5921872890954;2482.329770961839;2483.627455881623;2488.5645012122895;2091.7176181215495;2446.0338166424253;2470.876456177184;2500.737422570622;2509.134348649713;2437.366284765965;2457.275103844361;2467.7902378297867;2483.8509689418693;2493.875306234681;2449;2456.4350199454047;2487.291122030231;2491.775740183374;2501.0496011515506;8862.911370886273;8971;9014.323925705532;9020.05289444612;9024.684136055206;5417.972910135463;5521.337439507245;5540.531759083846;5553.444655534455;5592.832215033555;3175.666555011737;3187.4581321175456;3256.7557433192605;3658;3707.3697471429923;1055.4511653939985;1069.6737495064003;1070.5396679427843;1078.7464945737745;1103.7020004598714;11742.765144697143;11946.462409191607;11958.760824783456;11976.580819671357;12020.879791202064;4876.8780780480065;4922.753862306942;5004.2493625956395;5014.172661510883;5019.698818070854;8846.894138232721;10188.796224075477;10200.3369780964;10203.795924081476;10241.43672098027;4734.384530011145;5003.849114703638;5323.3079699639575;5556.111022236423;5594.9720251398485;4462.241418958784;4906.681065730716;4996.400431948189;5036.194208926628;5043.84868453947;3973.9602603974167;4018.698597605133;4057.9391309130388;4086.427900093989;4114.629683328515;1339.5512503311304;1352.499575157198;1356.9728605428033;1361.4077876123918;1377.1530508737055;1199.7900367435664;1357.0297237475252;1366.9863301367059;1393.6933874547583;1403.8315402151807;8051.557164356017;8430.32557395407;8439.240468357877;8488.320934325238;8491.702790402307;503.8261799679105;509.7629602234978;512.6027328820194;513.2404042017835;522.2349258336556;6269.874602508015;6272.5922815016875;6343.682815859189;6347.52393570484;6361;10370.585176592851;10708.571657133783;10737.463126843626;10813.729656758644;10817.83773243402;10378.014088661565;10475.947620262003;10671;10678.94660526708;10726.785464290671;8341.16588341161;8366.958165209257;8369.372297077743;8384.329253659693;8426.157384261525;7887.329576986021;7895.960520197362;7944.563049032358;7952.681892724227;8049.39629527776;9374.906250937403;9397.718068457958;9453.33826632129;9562.808743825224;9592.712218633453;9747.548383231378;9803.411795292306;9858.704238872846;9950.900490994998;10046.8492972604;6775.695093720696;7141.285871412817;7372.189059203591;7477.364424024019;7524.247575242432;8304.87542686848;8311.044229913638;8329.333653307842;8340.207680270365;8351.624176911931;7277.235890231449;7400.074990626172;7415.703371865281;7506.887396688945;7547.471676982558;6184.567080304336;6424.967875160594;7174.641267936687;7303.196648368781;7353.247139247988;7736.419768517271;7771.33943614799;7813.257740514642;7815.101263354787;7833.5691536966015;7056.223815380202;7061.399781018466;7111.644417778987;7161.892571611535;7177.569345839266;6947.965260173667;7019.087518622547;7087.397571206299;7098.538594991309;7111.7866464006165 04:58:28 INFO - PROCESS | 1668 | |4;prototype.html;317.90303957293025;318.77048525061946;323;324.6347858659009;325.1724361499983;6983.231844497108;7077.3984211342095;7105.218425973146;7109.289071092895;7140.50016498844;6989.0215369848265;7037.437005039597;7046.753363632274;7061.540999835007;7071.43428525718;4840.9515904840855;4935.8272460463895;5070.974645126769;5090.745462726867;5115.437301896788;5040.848774536751;5044.092063428599;5053;5066.873328166788;5067.721275329855;4990.925136122961;5007.949920500785;5024.497550244982;5040.42035165957;5052.242163675442;5028.949710502903;5032.572231360339;5034.993001399716;5042.798288068473;5043.823466178666;4268.637165840907;4278;4283.593058659422;4287.185434767384;4291.50647675515;4717.962048349392;5531.280933478622;6465.612063276171;6774.559653622498;6809.863802723918;4839.370881785346;5197.882455272134;5807;5923.881522369572;5966.940330596725;6021.578489505737;7489.400847932152;7490.25097490252;7496.212897645778;7501.7374391896565;4828.975855120737;4835.734034628094;4836.381255900606;4846.539578740014;4847.2729090636685;6338.492920566389;7852.411069169835;7939.0870049944415;7941.245581669732;7951.562664053475;4658.813647454064;4740.2178640523925;4812.374391329105;4879.609631229493;4889.902201955941;3946.408038794204;4905.043516514245;4954.232094025432;4959.355283813081;4965.180745177077;5923.763049478059;5927.73325200367;5928.318243401977;5945.16767652529;5945.791897283574;6721.932780672229;7334.706611735577;7373.078365204349;7390.926090739132;7418.703251869865;1622.1807986966742;1684.823093575157;1723.603571178636;1728.971262099049;1729.3774241273131;1106.9778604427866;1110.1840147491587;1110.2949626986922;1115.81031224692;1116.7989761842946;6140.631562106288;6370.490360771128;6864.5881247125335;6904.758333458305;6919.273476285019;5817.680027598522;7036.859262814715;7681.231876812386;7696.11494678108;7702.306792388712;6853.451723862079;6886.931130688729;6894.9655251724425;6898.517103802686;6916.723331066802;4044.8584299549375;4079.449274347925;4079.918401631951;4092.5907409258834;4096.672266218696;8037.075736290284;8272.917270827214;8313.667453301921;8316.085230624627;8319.750407487785;8153;8181.486425011273;8196.139405362352;8201.384896132813;8210.958945205235;6895.586264824126;7457.366123879422;8263.397029935551;8279.420440569224;8287.50274983503;7635.618219089134;7864.9606751965875;7905.486143400661;7912.604369781603;7930.206979302255;7671.309582137635;7718.53688778675;7731.304182623591;7737.92262077372;7757.301842834172;8258.380621453294;8263.710770123016;8271.917280827114;8288.751337459886;8295.751127466187;4691.554302341272;4740.762961851962;4745.549172828576;4758.4765675776325;4765.7140571565815;7585.962070189614;7780.260875216845;7820.296173344426;7824.84350313002;7869.960650196941;7182.3535881770895;7323.304286092813;7451.3293803557945;7451.5901625411125;7498.437617178624;6062.363451837494;6074.696265186634;7456.217097204715;7502.587357695379;7569.772906812805;7304.890426643498;7315.926840731525;7338.96330518344;7341.229170936975;7400.222976587381;7288.854222915618;7512.361449276873;7520.623968801648;7537.736179233701;7540.396768258636;7259;7284.562926224444;7298.197198308076;7306.561606303639;7315.780526584211 04:58:28 INFO - PROCESS | 1668 | |5;yui.html;585.2450339062609;710.2187593646989;733.6441825714529;773.6905237904838;795.4789612803615;12861.228326300417;13042.543510977117;13045;13049.478020879153;13072.673183170426;13608.387622556984;14223;14284.500042498514;14330.641733956656;14364.640883977905;741.8924255982879;911.0889110889127;912.63494602159;916.2074805293406;932.1005229953093;926.6710317837172;928.3779867488798;929.4609126706493;929.586334081334;930.3534043839534;971.9805603887918;986.0583143098324;986.659602437158;991.9305648604601;994.328828041073;963.5615794813343;973.3624475968252;974.1281553010016;976.5361453309692;978.9118979291862;702.5257950883184;728.6101935464501;729.0777166883896;729.9562026278387;732.3226015935238;14747.77878331826;14818.925905370512;14911.478098266618;14976.17631030293;15034.849651503455;12938.094333396666;12953.28756918369;13018.544350947672;13028.088033837636;13200.273984930825;9920.206383489303;10043.598256069748;10176;10572.995565421274;10939.070179034792;3430.4168291390274;3519.9296014079573;3541.185527328703;3585.731070169748;3637.436197389409;71720.56558868794;73027.63486182535;74595.62702186454;74800.6259968702;74861.87707184396;9180.632774688938;9287.210587100037;9315.25477961775;9428.95285523568;9569.904300957041;19781.60436791285;19950.30173943905;20398;20639.793602063786;20702.792972070387;7130.2869713028285;7252.818679532948;7253.963730181315;7322.1945585985495;7469.58917259556;4013.5986401359633;4016.859409920639;4044.8179831907637;4059.3707975263883;4062.6343629073526;3651.8721844735837;3653.6529029742132;3681.5398075240596;3682.6869716073898;3686.3548878946076;641.1824923222928;645.6739346629922;649.7628365646505;659.3011407907633;662.4038365471018;507.73343994403234;528.4002656984351;529.3621186470294;549.445060488901;605.8848818724429;7841.215878412113;7999.400044996649;8118.472299300526;8159.877601835978;8242.464239824392;522.3627174846681;555.469526602094;566.3232437237544;571.5227784799739;576.8644368573382;3634.763740356921;3716.21959388526;3791.33651610967;3836.9232615347537;3863.343231650626;76469.23530764622;76504;76646.6167669158;77163;78603.21396786073;73527.52944941178;73971.63014184895;74087.62956185185;74226.38192460599;78108;42891.14217715691;56409.87180256372;56710.43289567134;61196.2461689225;62126.68936655378;8336.624851881801;8359.37304702162;8385.454945428528;8430.367722420966;8583.957080214559;47214.05571888612;48688;48960.95952739718;49082.50917490779;49118.508814911394;64775;65018;66254.33745662482;66418;66909.66545167437;10499.265051446326;10533.473326333806;10565.9512792799;10714.732131696459;10932.726681833017;11670;11811.82282265784;11878.584249551224;11900.940495297467;12236.08229382782;10213.285070045025;10801.9738124878;11118.555257789598;11227.55089796399;11551.480183391935;9523.285753568649;11245.7750844981;11276.835932427002;11446.02708769764;11600.245984011011;9446.858297125686;10648.254622176682;10795;10925.399103049409;11195.2723073;9173.54132293396;9349.953250233706;9394;9545.809083818423;9638.325317227727;9148.902131744233;9289.972142065395;9349.439033658002;9626.133647971716;9715.854262185932 04:58:28 INFO - PROCESS | 1668 | __end_tp_report 04:58:28 INFO - PROCESS | 1668 | __start_cc_report 04:58:28 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,364 04:58:28 INFO - PROCESS | 1668 | __end_cc_report 04:58:28 INFO - PROCESS | 1668 | __startTimestamp1457528308084__endTimestamp 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | ------- Summary: start ------- 04:58:28 INFO - PROCESS | 1668 | Number of tests: 6 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5653.33 Median:5862.74 stddev:651.11 (11.1%) stddev-sans-first:627.93 04:58:28 INFO - PROCESS | 1668 | Values: 3367.6 3430.6 3463.6 3494.9 3500.0 5460.3 5465.8 5475.6 5534.6 5572.0 5626.0 5698.9 5708.1 5727.5 5789.7 5060.7 5092.6 5196.3 5276.6 5302.9 5125.6 5201.9 5212.5 5252.7 5269.2 4863.2 5150.3 5177.0 5181.4 5185.4 5153.6 5167.9 5169.7 5172.9 5216.3 5054.1 5087.2 5137.7 5201.1 5208.3 4433.2 4676.0 5597.9 5628.4 5636.7 6181.4 6247.6 6257.9 6261.6 6273.6 6105.4 6117.0 6133.8 6142.6 6284.9 5829.6 5845.8 5862.7 5873.5 5902.4 6254.3 6263.9 6272.9 6273.0 6277.7 6079.1 6087.9 6106.6 6146.8 6154.7 6111.8 6119.0 6178.3 6187.1 6220.5 6141.8 6147.9 6151.6 6202.8 6229.4 6089.7 6189.8 6198.6 6199.8 6271.7 4870.6 4884.4 4896.1 4933.1 4946.3 4421.3 4433.3 4439.1 4456.4 4484.6 5590.0 5713.3 5725.8 5734.5 5765.0 5541.3 5885.7 6269.9 6281.5 6308.1 5572.6 5780.7 5800.2 5818.5 5909.6 5317.4 5368.9 5371.3 5400.4 5414.1 6340.8 6358.9 6371.3 6381.2 6394.7 6123.5 6131.4 6188.5 6214.2 6231.5 6191.4 6257.3 6273.0 6293.6 6316.7 6079.3 6087.6 6140.9 6158.6 6169.6 6009.6 6013.8 6106.3 6200.4 6213.8 5075.5 5988.9 6073.9 6125.2 6152.7 5396.9 6023.5 6028.7 6097.4 6131.3 5734.9 5904.2 5991.2 6014.1 6027.9 4717.5 4862.4 5039.4 5609.6 6146.1 4898.4 4907.8 5013.3 5986.9 5989.0 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:58701.97 Median:21442.47 stddev:117362.64 (547.3%) stddev-sans-first:117610.72 04:58:28 INFO - PROCESS | 1668 | Values: 572.7 578.5 599.9 620.8 640.6 39102.6 39494.0 39505.6 39542.0 39578.4 41334.8 41881.0 41945.4 42302.9 42381.8 9552.5 9713.0 9769.9 9792.9 9802.9 8771.6 9614.1 9735.0 9748.6 9776.9 9763.1 9840.1 9856.4 9921.4 9942.7 9830.8 9836.9 9901.7 9903.6 9911.5 9753.6 9851.7 9864.6 9871.1 9897.5 40560.8 40712.6 40962.0 41112.0 41156.2 2506.4 3178.4 3782.3 3914.7 3960.2 27424.3 27793.9 27881.7 28257.0 28364.3 2671.8 2708.8 2816.7 2826.6 2830.7 352151.0 353723.0 354170.0 355386.0 356073.0 60734.7 60978.1 61496.7 61738.8 61987.4 64998.0 65017.7 65156.0 65395.0 65629.7 16730.9 16793.0 16853.1 16927.6 16982.2 12762.2 12936.4 13013.7 13082.8 13101.5 18756.0 19400.6 19629.3 19701.8 19798.0 8433.9 9133.3 9323.5 9334.7 9346.2 953.3 963.8 1028.3 1078.2 1086.4 27652.4 28254.2 28265.3 28427.7 28492.9 938.6 1056.1 1077.7 1136.0 1188.1 12624.3 14702.3 14884.7 14938.0 15050.2 518195.0 521637.0 525497.0 528989.0 530254.0 56696.4 58425.0 58960.7 58999.7 59071.6 1232.3 1404.0 1428.9 1448.9 1451.3 28299.3 28404.6 28900.0 28938.4 29090.9 41793.6 49798.3 50271.0 50654.0 50735.7 429411.0 429428.0 430527.0 431219.0 432344.9 31951.2 33078.8 33289.3 33605.7 33744.5 35317.3 42078.0 43793.1 45295.8 45321.3 33949.5 34327.7 34388.2 35118.1 35790.0 33420.5 33655.5 34266.0 34305.0 34307.1 28549.6 32619.2 32829.8 33686.2 33747.2 29389.4 29958.0 33405.2 33812.5 34072.8 20234.9 20429.5 21257.9 23573.3 24080.0 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:32457.87 Median:22112.12 stddev:90249.33 (408.1%) stddev-sans-first:90470.19 04:58:28 INFO - PROCESS | 1668 | Values: 292.8 355.9 362.5 368.8 371.3 19939.9 20178.8 22102.3 22106.2 22118.0 20578.2 20628.0 20891.0 21061.1 21079.7 5840.7 6070.5 6117.7 6118.7 6125.6 4374.6 5971.3 6481.5 6497.4 6509.4 6417.9 6435.2 6446.5 6449.3 6458.2 6137.1 6374.2 6391.6 6406.9 6428.2 5075.3 5442.1 5514.0 5538.0 5542.6 12564.7 13015.6 13123.3 13149.7 13186.1 1973.5 2103.1 2188.1 2198.1 2456.4 9344.7 9591.3 9923.2 9994.0 13447.9 1712.3 1737.2 1758.8 1797.3 1797.8 101496.0 103064.0 106441.0 109264.9 109430.5 11451.0 11488.5 11521.8 11605.0 11665.8 13673.2 13854.7 13857.6 13895.3 13896.0 8518.5 8686.1 8705.1 8738.3 8769.5 8095.0 8794.7 8799.5 8807.0 8863.7 4473.8 4556.3 4557.6 4579.8 4603.4 1875.5 1911.6 1922.5 1974.9 1978.2 867.9 898.7 923.6 931.7 941.1 19278.9 19764.8 19811.8 20041.9 20335.8 890.2 892.7 918.4 919.5 1026.5 9667.6 10336.4 10612.5 10740.4 10752.9 515835.0 525278.0 528431.0 558421.0 563694.0 125193.4 128119.0 129136.4 132715.3 132805.0 1025.6 1034.1 1045.4 1061.2 1062.7 15299.8 17876.2 17888.0 18193.5 18314.1 40469.8 44510.7 46492.5 51000.7 52245.7 72051.3 75046.2 75097.0 75424.6 77802.2 7784.8 7913.4 8008.6 8156.2 8343.2 11262.5 11509.7 12935.4 13613.1 13638.7 10016.9 10786.0 11067.6 11308.8 11760.0 9296.3 10335.3 11224.7 11586.1 11910.9 10174.0 11755.9 11862.1 11949.3 12163.5 7736.6 7844.0 7942.8 8039.0 8415.0 8521.3 9574.8 10878.0 11565.2 11935.6 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6063.96 Median:517.74 stddev:3211.17 (620.2%) stddev-sans-first:3202.06 04:58:28 INFO - PROCESS | 1668 | Values: 1525.8 1602.9 1686.9 1834.6 1882.9 8041.2 8526.8 8881.8 9065.8 9095.0 8779.0 8782.9 8874.6 8888.6 8895.3 2473.4 2475.2 2492.4 2495.0 2495.1 2419.3 2471.6 2482.3 2483.6 2488.6 2091.7 2446.0 2470.9 2500.7 2509.1 2437.4 2457.3 2467.8 2483.9 2493.9 2449.0 2456.4 2487.3 2491.8 2501.0 8862.9 8971.0 9014.3 9020.1 9024.7 5418.0 5521.3 5540.5 5553.4 5592.8 3175.7 3187.5 3256.8 3658.0 3707.4 1055.5 1069.7 1070.5 1078.7 1103.7 11742.8 11946.5 11958.8 11976.6 12020.9 4876.9 4922.8 5004.2 5014.2 5019.7 8846.9 10188.8 10200.3 10203.8 10241.4 4734.4 5003.8 5323.3 5556.1 5595.0 4462.2 4906.7 4996.4 5036.2 5043.8 3974.0 4018.7 4057.9 4086.4 4114.6 1339.6 1352.5 1357.0 1361.4 1377.2 1199.8 1357.0 1367.0 1393.7 1403.8 8051.6 8430.3 8439.2 8488.3 8491.7 503.8 509.8 512.6 513.2 522.2 6269.9 6272.6 6343.7 6347.5 6361.0 10370.6 10708.6 10737.5 10813.7 10817.8 10378.0 10475.9 10671.0 10678.9 10726.8 8341.2 8367.0 8369.4 8384.3 8426.2 7887.3 7896.0 7944.6 7952.7 8049.4 9374.9 9397.7 9453.3 9562.8 9592.7 9747.5 9803.4 9858.7 9950.9 10046.8 6775.7 7141.3 7372.2 7477.4 7524.2 8304.9 8311.0 8329.3 8340.2 8351.6 7277.2 7400.1 7415.7 7506.9 7547.5 6184.6 6425.0 7174.6 7303.2 7353.2 7736.4 7771.3 7813.3 7815.1 7833.6 7056.2 7061.4 7111.6 7161.9 7177.6 6948.0 7019.1 7087.4 7098.5 7111.8 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:6041.76 Median:6890.95 stddev:1987.20 (28.8%) stddev-sans-first:1945.78 04:58:28 INFO - PROCESS | 1668 | Values: 317.9 318.8 323.0 324.6 325.2 6983.2 7077.4 7105.2 7109.3 7140.5 6989.0 7037.4 7046.8 7061.5 7071.4 4841.0 4935.8 5071.0 5090.7 5115.4 5040.8 5044.1 5053.0 5066.9 5067.7 4990.9 5007.9 5024.5 5040.4 5052.2 5028.9 5032.6 5035.0 5042.8 5043.8 4268.6 4278.0 4283.6 4287.2 4291.5 4718.0 5531.3 6465.6 6774.6 6809.9 4839.4 5197.9 5807.0 5923.9 5966.9 6021.6 7489.4 7490.3 7496.2 7501.7 4829.0 4835.7 4836.4 4846.5 4847.3 6338.5 7852.4 7939.1 7941.2 7951.6 4658.8 4740.2 4812.4 4879.6 4889.9 3946.4 4905.0 4954.2 4959.4 4965.2 5923.8 5927.7 5928.3 5945.2 5945.8 6721.9 7334.7 7373.1 7390.9 7418.7 1622.2 1684.8 1723.6 1729.0 1729.4 1107.0 1110.2 1110.3 1115.8 1116.8 6140.6 6370.5 6864.6 6904.8 6919.3 5817.7 7036.9 7681.2 7696.1 7702.3 6853.5 6886.9 6895.0 6898.5 6916.7 4044.9 4079.4 4079.9 4092.6 4096.7 8037.1 8272.9 8313.7 8316.1 8319.8 8153.0 8181.5 8196.1 8201.4 8211.0 6895.6 7457.4 8263.4 8279.4 8287.5 7635.6 7865.0 7905.5 7912.6 7930.2 7671.3 7718.5 7731.3 7737.9 7757.3 8258.4 8263.7 8271.9 8288.8 8295.8 4691.6 4740.8 4745.5 4758.5 4765.7 7586.0 7780.3 7820.3 7824.8 7870.0 7182.4 7323.3 7451.3 7451.6 7498.4 6062.4 6074.7 7456.2 7502.6 7569.8 7304.9 7315.9 7339.0 7341.2 7400.2 7288.9 7512.4 7520.6 7537.7 7540.4 7259.0 7284.6 7298.2 7306.6 7315.8 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:16968.55 Median:30901.07 stddev:22976.73 (74.4%) stddev-sans-first:23008.25 04:58:28 INFO - PROCESS | 1668 | Values: 585.2 710.2 733.6 773.7 795.5 12861.2 13042.5 13045.0 13049.5 13072.7 13608.4 14223.0 14284.5 14330.6 14364.6 741.9 911.1 912.6 916.2 932.1 926.7 928.4 929.5 929.6 930.4 972.0 986.1 986.7 991.9 994.3 963.6 973.4 974.1 976.5 978.9 702.5 728.6 729.1 730.0 732.3 14747.8 14818.9 14911.5 14976.2 15034.8 12938.1 12953.3 13018.5 13028.1 13200.3 9920.2 10043.6 10176.0 10573.0 10939.1 3430.4 3519.9 3541.2 3585.7 3637.4 71720.6 73027.6 74595.6 74800.6 74861.9 9180.6 9287.2 9315.3 9429.0 9569.9 19781.6 19950.3 20398.0 20639.8 20702.8 7130.3 7252.8 7254.0 7322.2 7469.6 4013.6 4016.9 4044.8 4059.4 4062.6 3651.9 3653.7 3681.5 3682.7 3686.4 641.2 645.7 649.8 659.3 662.4 507.7 528.4 529.4 549.4 605.9 7841.2 7999.4 8118.5 8159.9 8242.5 522.4 555.5 566.3 571.5 576.9 3634.8 3716.2 3791.3 3836.9 3863.3 76469.2 76504.0 76646.6 77163.0 78603.2 73527.5 73971.6 74087.6 74226.4 78108.0 42891.1 56409.9 56710.4 61196.2 62126.7 8336.6 8359.4 8385.5 8430.4 8584.0 47214.1 48688.0 48961.0 49082.5 49118.5 64775.0 65018.0 66254.3 66418.0 66909.7 10499.3 10533.5 10566.0 10714.7 10932.7 11670.0 11811.8 11878.6 11900.9 12236.1 10213.3 10802.0 11118.6 11227.6 11551.5 9523.3 11245.8 11276.8 11446.0 11600.2 9446.9 10648.3 10795.0 10925.4 11195.3 9173.5 9350.0 9394.0 9545.8 9638.3 9148.9 9290.0 9349.4 9626.1 9715.9 04:58:28 INFO - PROCESS | 1668 | -------- Summary: end -------- 04:58:28 INFO - PROCESS | 1668 | 04:58:28 INFO - TEST-INFO | 1668: exit 0 04:58:28 INFO - TEST-OK | dromaeo_css | took 1111410ms 04:58:28 INFO - TEST-START | kraken 04:58:28 INFO - operating with platform_type : mac_ 04:58:28 INFO - Initialising browser for kraken test... 04:58:28 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpuTJ3V4/profile http://localhost:49281/getInfo.html) 04:58:31 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 04:58:31 INFO - PROCESS | 1681 | colorDepth:24 04:58:31 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 04:58:31 INFO - PROCESS | 1681 | __metrics 04:58:31 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 04:58:31 INFO - TEST-INFO | 1681: exit 0 04:58:31 INFO - Browser initialized. 04:58:31 INFO - Running cycle 1/1 for kraken test... 04:58:31 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpuTJ3V4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:43 INFO - PROCESS | 1684 | RSS: Main: 256307200 04:58:43 INFO - PROCESS | 1684 | 04:58:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:47 INFO - PROCESS | 1684 | RSS: Main: 268943360 04:58:47 INFO - PROCESS | 1684 | 04:58:49 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 04:58:50 INFO - PROCESS | 1684 | RSS: Main: 276885504 04:58:50 INFO - PROCESS | 1684 | 04:58:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 04:58:54 INFO - PROCESS | 1684 | RSS: Main: 280854528 04:58:54 INFO - PROCESS | 1684 | 04:58:56 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 04:58:56 INFO - PROCESS | 1684 | RSS: Main: 280973312 04:58:56 INFO - PROCESS | 1684 | 04:58:58 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:58:59 INFO - PROCESS | 1684 | RSS: Main: 282062848 04:58:59 INFO - PROCESS | 1684 | 04:59:02 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:02 INFO - PROCESS | 1684 | RSS: Main: 283410432 04:59:02 INFO - PROCESS | 1684 | 04:59:06 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:06 INFO - PROCESS | 1684 | RSS: Main: 283336704 04:59:06 INFO - PROCESS | 1684 | 04:59:09 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 04:59:10 INFO - PROCESS | 1684 | RSS: Main: 283811840 04:59:10 INFO - PROCESS | 1684 | 04:59:11 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:12 INFO - PROCESS | 1684 | RSS: Main: 283803648 04:59:12 INFO - PROCESS | 1684 | 04:59:14 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:15 INFO - PROCESS | 1684 | RSS: Main: 282726400 04:59:15 INFO - PROCESS | 1684 | 04:59:17 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:17 INFO - PROCESS | 1684 | RSS: Main: 282972160 04:59:17 INFO - PROCESS | 1684 | 04:59:20 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:21 INFO - PROCESS | 1684 | RSS: Main: 283541504 04:59:21 INFO - PROCESS | 1684 | 04:59:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:24 INFO - PROCESS | 1684 | RSS: Main: 283377664 04:59:24 INFO - PROCESS | 1684 | 04:59:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 04:59:26 INFO - PROCESS | 1684 | RSS: Main: 285794304 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | __start_tp_report 04:59:26 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 04:59:26 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 04:59:26 INFO - PROCESS | 1684 | |i|pagename|runs| 04:59:26 INFO - PROCESS | 1684 | |0;ai-astar;115;109;116;118;115;127;116;115;116;116 04:59:26 INFO - PROCESS | 1684 | |1;audio-beat-detection;146;124;141;174;153;142;135;118;183;150 04:59:26 INFO - PROCESS | 1684 | |2;audio-dft;195;200;197;200;204;207;210;191;204;198 04:59:26 INFO - PROCESS | 1684 | |3;audio-fft;73;75;56;72;81;84;92;123;56;55 04:59:26 INFO - PROCESS | 1684 | |4;audio-oscillator;83;87;115;77;82;79;109;80;82;112 04:59:26 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;114;89;91;131;135;88;93;90;92;88 04:59:26 INFO - PROCESS | 1684 | |6;imaging-darkroom;96;98;97;96;139;117;100;152;151;98 04:59:26 INFO - PROCESS | 1684 | |7;imaging-desaturate;110;150;154;93;90;127;147;153;86;152 04:59:26 INFO - PROCESS | 1684 | |8;json-parse-financial;56;56;56;57;56;57;57;67;59;56 04:59:26 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;64;67;70;97;105;105;99;75;64;65 04:59:26 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;86;84;84;84;84;86;83;87;83;86 04:59:26 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;136;143;117;123;122;125;125;134;145;150 04:59:26 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;137;146;143;142;142;141;142;140;180;141 04:59:26 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;71;93;100;77;66;69;70;67;72;72 04:59:26 INFO - PROCESS | 1684 | __end_tp_report 04:59:26 INFO - PROCESS | 1684 | __start_cc_report 04:59:26 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,939 04:59:26 INFO - PROCESS | 1684 | __end_cc_report 04:59:26 INFO - PROCESS | 1684 | __startTimestamp1457528366237__endTimestamp 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | ------- Summary: start ------- 04:59:26 INFO - PROCESS | 1684 | Number of tests: 14 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:116.30 Median:116.00 stddev:4.42 (3.8%) stddev-sans-first:4.67 04:59:26 INFO - PROCESS | 1684 | Values: 115.0 109.0 116.0 118.0 115.0 127.0 116.0 115.0 116.0 116.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:148.00 stddev:20.12 (13.6%) stddev-sans-first:21.34 04:59:26 INFO - PROCESS | 1684 | Values: 146.0 124.0 141.0 174.0 153.0 142.0 135.0 118.0 183.0 150.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:200.60 Median:202.00 stddev:5.74 (2.8%) stddev-sans-first:5.72 04:59:26 INFO - PROCESS | 1684 | Values: 195.0 200.0 197.0 200.0 204.0 207.0 210.0 191.0 204.0 198.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:76.70 Median:74.00 stddev:20.59 (27.8%) stddev-sans-first:21.80 04:59:26 INFO - PROCESS | 1684 | Values: 73.0 75.0 56.0 72.0 81.0 84.0 92.0 123.0 56.0 55.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.00 stddev:15.06 (18.6%) stddev-sans-first:15.73 04:59:26 INFO - PROCESS | 1684 | Values: 83.0 87.0 115.0 77.0 82.0 79.0 109.0 80.0 82.0 112.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:101.10 Median:89.50 stddev:18.48 (20.6%) stddev-sans-first:19.00 04:59:26 INFO - PROCESS | 1684 | Values: 114.0 89.0 91.0 131.0 135.0 88.0 93.0 90.0 92.0 88.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:114.40 Median:96.00 stddev:23.78 (24.8%) stddev-sans-first:24.28 04:59:26 INFO - PROCESS | 1684 | Values: 96.0 98.0 97.0 96.0 139.0 117.0 100.0 152.0 151.0 98.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:126.20 Median:153.50 stddev:28.77 (18.7%) stddev-sans-first:29.91 04:59:26 INFO - PROCESS | 1684 | Values: 110.0 150.0 154.0 93.0 90.0 127.0 147.0 153.0 86.0 152.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.40 (6.0%) stddev-sans-first:3.55 04:59:26 INFO - PROCESS | 1684 | Values: 56.0 56.0 56.0 57.0 56.0 57.0 57.0 67.0 59.0 56.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:81.10 Median:68.50 stddev:18.01 (26.3%) stddev-sans-first:18.01 04:59:26 INFO - PROCESS | 1684 | Values: 64.0 67.0 70.0 97.0 105.0 105.0 99.0 75.0 64.0 65.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:1.42 (1.7%) stddev-sans-first:1.42 04:59:26 INFO - PROCESS | 1684 | Values: 86.0 84.0 84.0 84.0 84.0 86.0 83.0 87.0 83.0 86.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:135.00 stddev:11.24 (8.3%) stddev-sans-first:11.83 04:59:26 INFO - PROCESS | 1684 | Values: 136.0 143.0 117.0 123.0 122.0 125.0 125.0 134.0 145.0 150.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:142.00 stddev:12.37 (8.7%) stddev-sans-first:12.74 04:59:26 INFO - PROCESS | 1684 | Values: 137.0 146.0 143.0 142.0 142.0 141.0 142.0 140.0 180.0 141.0 04:59:26 INFO - PROCESS | 1684 | 04:59:26 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:71.50 stddev:11.49 (16.1%) stddev-sans-first:12.06 04:59:26 INFO - PROCESS | 1684 | Values: 71.0 93.0 100.0 77.0 66.0 69.0 70.0 67.0 72.0 72.0 04:59:26 INFO - PROCESS | 1684 | -------- Summary: end -------- 04:59:26 INFO - PROCESS | 1684 | 04:59:27 INFO - TEST-INFO | 1684: exit 0 04:59:27 INFO - TEST-OK | kraken | took 58473ms 04:59:27 INFO - SUITE-END | took 1169s 04:59:27 INFO - Completed test suite (00:19:30) 04:59:27 INFO - javascript benchmark 04:59:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3367.5958884933807, 3430.5711786026745, 3463.5670541182353, 3494.947575786364, 3499.9650003499955, 5460.34475862896, 5465.754041068151, 5475.561955043592, 5534.640248383852, 5572.0, 5626.0, 5698.914516282249, 5708.1437784332375, 5727.513161381277, 5789.739461724222, 5060.671056381323, 5092.643514953955, 5196.298499702549, 5276.551493123089, 5302.946970530284, 5125.641205115643, 5201.947980520203, 5212.504812042869, 5252.71110088945, 5269.1832765921345, 4863.197572400567, 5150.27896094547, 5177.0, 5181.378234611833, 5185.351831021122, 5153.613478989053, 5167.896642067175, 5169.689818610857, 5172.922406163911, 5216.321878155815, 5054.1407960646775, 5087.160618497944, 5137.691738495702, 5201.115810312256, 5208.322918020671, 4433.246348120827, 4675.953240467586, 5597.888042239173, 5628.352739434977, 5636.661800291996, 6181.412765787288, 6247.562670613059, 6257.87484250317, 6261.624302541862, 6273.62358258506, 6105.368770830132, 6117.0, 6133.78531751391, 6142.6007309525185, 6284.905726414107, 5829.62107463022, 5845.824625261249, 5862.736176872051, 5873.500752436005, 5902.439268269508, 6254.312025677172, 6263.874722505524, 6272.874542509216, 6273.027680709497, 6277.7175027123885, 6079.148919151322, 6087.878242435127, 6106.582013105394, 6146.754129834846, 6154.692265386802, 6111.755529778848, 6118.969405152946, 6178.258608966953, 6187.102870083902, 6220.471259942865, 6141.815745527641, 6147.907781383283, 6151.6001459904965, 6202.751889924442, 6229.4393504583895, 6089.725962331617, 6189.752409903644, 6198.6280823150755, 6199.752009919643, 6271.655058971709, 4870.6103511718975, 4884.438289596671, 4896.143174944371, 4933.112039832865, 4946.282788995575, 4421.314696222091, 4433.290673492225, 4439.1121775645, 4456.442944631921, 4484.551544845489, 5589.972050139723, 5713.314402271754, 5725.799597014085, 5734.512566431817, 5764.971175144097, 5541.2796336476, 5885.705714714247, 6269.937300626935, 6281.528885333618, 6308.116863639094, 5572.58205634579, 5780.739866706008, 5800.216970708984, 5818.534517238695, 5909.645421274738, 5317.388500322435, 5368.8657783554945, 5371.274877891435, 5400.351957765093, 5414.133738601805, 6340.778072767431, 6358.936410635927, 6371.267304259976, 6381.202349706286, 6394.680265986589, 6123.526657168115, 6131.448169664752, 6188.4739797117745, 6214.161088253028, 6231.470325022424, 6191.442770150708, 6257.2804127525915, 6272.968635156795, 6293.559450838397, 6316.747330106744, 6079.3008803988105, 6087.57386982907, 6140.938590614215, 6158.630482171084, 6169.56813023084, 6009.579329446897, 6013.849653758691, 6106.3089915548935, 6200.441960223421, 6213.782517611862, 5075.467075957119, 5988.940110598838, 6073.939260607514, 6125.173101631222, 6152.661603611844, 5396.865078373072, 6023.457888789854, 6028.668423236764, 6097.359777223505, 6131.294901086254, 5734.885302293847, 5904.202932604216, 5991.161237426851, 6014.127951446928, 6027.914975304488, 4717.528247175393, 4862.3922009748785, 5039.420466646383, 5609.579281553818, 6146.094710639716, 4898.436679781728, 4907.77914993819, 5013.298138260573, 5986.88026239464, 5989.0], "unit": "score", "name": "dojo.html", "value": 5614.306208401902}, {"lowerIsBetter": false, "replicates": [572.7021948586732, 578.5429510686558, 599.8752339363693, 620.8230654263535, 640.5548144039892, 39102.63140790073, 39494.01264968373, 39505.60494395055, 39542.0, 39578.40632390516, 41334.79332603333, 41880.95297617561, 41945.37081943773, 42302.94242643928, 42381.788091059505, 9552.522373881313, 9712.951435242814, 9769.90230097697, 9792.902070979306, 9802.901970980305, 8771.605277762515, 9614.13472787449, 9735.0, 9748.610055597803, 9776.853347199798, 9763.121319081281, 9840.114389704926, 9856.359336643096, 9921.355111917703, 9942.701718948443, 9830.754231144207, 9836.901630983706, 9901.653442129491, 9903.55434005468, 9911.504424778732, 9753.609855605839, 9851.704448866545, 9864.556094975744, 9871.062249086326, 9897.4556399398, 40560.79719601383, 40712.592874071175, 40962.0, 41112.0, 41156.1768764626, 2506.4360518883104, 3178.4278829810855, 3782.3002744492355, 3914.667253283474, 3960.2277555876326, 27424.314392140357, 27793.86103069492, 27881.72118278832, 28257.0, 28364.29089272764, 2671.8396896186096, 2708.8239264447748, 2816.662000559946, 2826.6184065151147, 2830.6978789756736, 352151.0, 353723.0, 354170.0, 355386.0, 356073.0, 60734.69632651808, 60978.0853287201, 61496.69251653713, 61738.76522469526, 61987.38012619906, 64998.0, 65017.67491162608, 65156.0, 65395.0, 65629.67185164044, 16730.916345418194, 16792.99242045481, 16853.073080980663, 16927.576810579834, 16982.23579938881, 12762.17045892014, 12936.417861196269, 13013.739725205443, 13082.803757943639, 13101.475940962446, 18755.97138684697, 19400.648217402144, 19629.312974046126, 19701.802981969995, 19798.010099494968, 8433.873491897626, 9133.269338452908, 9323.487208203615, 9334.673286434941, 9346.205572526276, 953.2897990996613, 963.7831487915163, 1028.3264461777549, 1078.229066217658, 1086.397049637443, 27652.446951060865, 28254.15237542877, 28265.293367665974, 28427.71572284292, 28492.857535712603, 938.6010945348336, 1056.102313033915, 1077.671310250381, 1135.994320028411, 1188.0733028237987, 12624.305663188428, 14702.338394772261, 14884.702305954037, 14938.0, 15050.247487625575, 518195.0, 521637.0, 525497.0, 528989.0, 530254.0, 56696.43303566994, 58425.0, 58960.70519647374, 58999.705001474715, 59071.637134515, 1232.2914324263584, 1403.9789403158961, 1428.8785453236592, 1448.8913331499969, 1451.3178805961181, 28299.292517687223, 28404.57393139063, 28900.0, 28938.42123157483, 29090.854545727983, 41793.582064180184, 49798.25302620536, 50270.994580107465, 50653.98692026213, 50735.746321268154, 429411.0, 429428.0, 430527.0, 431219.0, 432344.8975816562, 31951.201219968756, 33078.834605826814, 33289.336853051216, 33605.66394336123, 33744.49383259204, 35317.28513251406, 42078.0, 43793.124137517705, 45295.773521132185, 45321.320180196664, 33949.49075763816, 34327.65672343245, 34388.16772716586, 35118.12204694903, 35790.0, 33420.49869251915, 33655.495167573, 34266.0, 34304.97085087452, 34307.14232144116, 28549.571756424084, 32619.184520386232, 32829.83585082059, 33686.15784605405, 33747.15632109217, 29389.412211755218, 29957.951471698387, 33405.16487087842, 33812.492812608325, 34072.82963585166, 20234.898825506367, 20429.48926276855, 21257.89371053135, 23573.29280121599, 24080.0], "unit": "score", "name": "ext.html", "value": 19411.342385841053}, {"lowerIsBetter": false, "replicates": [292.79943238881367, 355.85232128666587, 362.4979403526117, 368.78241837315977, 371.3353097954661, 19939.900300498495, 20178.798212017893, 22102.336929892088, 22106.22628208013, 22118.00468978896, 20578.176872925065, 20628.0, 20891.0, 21061.052252648627, 21079.68380474294, 5840.678762668052, 6070.514358851281, 6117.66352850593, 6118.663473508956, 6125.601835880676, 4374.58441448062, 5971.283445986466, 6481.546291759579, 6497.415232629062, 6509.4466970307585, 6417.8716425671455, 6435.195600549931, 6446.548741588091, 6449.258335291454, 6458.160439142905, 6137.110119032737, 6374.203224596926, 6391.648459334735, 6406.903896441557, 6428.19647544057, 5075.314832497639, 5442.074847275972, 5513.972430137864, 5537.972310138463, 5542.584306177053, 12564.685882852911, 13015.609531714064, 13123.343832808321, 13149.671258218525, 13186.142900711424, 1973.4868934077099, 2103.137713537458, 2188.102877820086, 2198.0658220256487, 2456.4242842462213, 9344.672936447192, 9591.328606997513, 9923.156531694814, 9994.00059994002, 13447.86552134476, 1712.332190445727, 1737.1574786228668, 1758.806531281558, 1797.2631221199376, 1797.8202179782047, 101496.0, 103064.0, 106441.0, 109264.90735092627, 109430.45284773526, 11451.0, 11488.54045838157, 11521.769564608661, 11605.0, 11665.76668466626, 13673.24797136167, 13854.653633659038, 13857.584272471842, 13895.305234738222, 13896.027278090638, 8518.48889066658, 8686.131386861389, 8705.129487051245, 8738.30093592511, 8769.473831570127, 8095.0, 8794.692185773467, 8799.516026618598, 8807.0, 8863.734087977371, 4473.843415480443, 4556.2937744649635, 4557.612602928722, 4579.839705610354, 4603.355530225771, 1875.4561177258715, 1911.550785565391, 1922.5385907382408, 1974.9308774192834, 1978.169168949045, 867.9435836670597, 898.6654817595864, 923.6166990698919, 931.7204838548408, 941.1435593609782, 19278.903605481883, 19764.802351976297, 19811.801881980995, 20041.899790500953, 20335.796642033685, 890.2121622364255, 892.6922059183328, 918.42598376015, 919.4901189491216, 1026.4867566216892, 9667.598198261212, 10336.431496267778, 10612.469376531142, 10740.409277489813, 10752.892471075345, 515835.0, 525278.0, 528431.0, 558421.0, 563694.0, 125193.37403312925, 128119.0, 129136.35431822969, 132715.33642331918, 132805.0, 1025.5846382215216, 1034.1003327105316, 1045.3518818332682, 1061.2147011211648, 1062.7290041039485, 15299.76641577993, 17876.195571199067, 17888.0, 18193.545161371072, 18314.084295785426, 40469.797651011555, 44510.66468005965, 46492.53507464882, 51000.74499627626, 52245.73051233876, 72051.27948720656, 75046.24953750393, 75097.0, 75424.62287688526, 77802.2219777795, 7784.766457006299, 7913.44605877583, 8008.6396112173925, 8156.225158609923, 8343.207395297437, 11262.493187806733, 11509.654710358702, 12935.417906194432, 13613.11514751538, 13638.727225455237, 10016.899831001596, 10785.975555357327, 11067.561217041733, 11308.83036754433, 11760.0, 9296.349255552046, 10335.328203666737, 11224.709158446884, 11586.131040171853, 11910.940445297718, 10174.0, 11755.88244117548, 11862.110341724232, 11949.283043017447, 12163.45264463119, 7736.574488403192, 7844.0, 7942.801429964297, 8039.035315762146, 8415.032271288881, 8521.318294536546, 9574.760630984003, 10877.960865087576, 11565.248258863146, 11935.641930742091], "unit": "score", "name": "jquery.html", "value": 9281.558450901508}, {"lowerIsBetter": false, "replicates": [1525.8474152584743, 1602.9358825646975, 1686.940957066503, 1834.5963887944656, 1882.85878559108, 8041.236082572146, 8526.829463410728, 8881.777955551115, 9065.773355666104, 9094.954525227373, 8779.03430622631, 8782.91217087829, 8874.55627218638, 8888.644454221823, 8895.288376929846, 2473.3692908308403, 2475.183189547445, 2492.4142826435773, 2494.950100997988, 2495.126705653025, 2419.2742177346813, 2471.5921872890954, 2482.329770961839, 2483.627455881623, 2488.5645012122895, 2091.7176181215495, 2446.0338166424253, 2470.876456177184, 2500.737422570622, 2509.134348649713, 2437.366284765965, 2457.275103844361, 2467.7902378297867, 2483.8509689418693, 2493.875306234681, 2449.0, 2456.4350199454047, 2487.291122030231, 2491.775740183374, 2501.0496011515506, 8862.911370886273, 8971.0, 9014.323925705532, 9020.05289444612, 9024.684136055206, 5417.972910135463, 5521.337439507245, 5540.531759083846, 5553.444655534455, 5592.832215033555, 3175.666555011737, 3187.4581321175456, 3256.7557433192605, 3658.0, 3707.3697471429923, 1055.4511653939985, 1069.6737495064003, 1070.5396679427843, 1078.7464945737745, 1103.7020004598714, 11742.765144697143, 11946.462409191607, 11958.760824783456, 11976.580819671357, 12020.879791202064, 4876.8780780480065, 4922.753862306942, 5004.2493625956395, 5014.172661510883, 5019.698818070854, 8846.894138232721, 10188.796224075477, 10200.3369780964, 10203.795924081476, 10241.43672098027, 4734.384530011145, 5003.849114703638, 5323.3079699639575, 5556.111022236423, 5594.9720251398485, 4462.241418958784, 4906.681065730716, 4996.400431948189, 5036.194208926628, 5043.84868453947, 3973.9602603974167, 4018.698597605133, 4057.9391309130388, 4086.427900093989, 4114.629683328515, 1339.5512503311304, 1352.499575157198, 1356.9728605428033, 1361.4077876123918, 1377.1530508737055, 1199.7900367435664, 1357.0297237475252, 1366.9863301367059, 1393.6933874547583, 1403.8315402151807, 8051.557164356017, 8430.32557395407, 8439.240468357877, 8488.320934325238, 8491.702790402307, 503.8261799679105, 509.7629602234978, 512.6027328820194, 513.2404042017835, 522.2349258336556, 6269.874602508015, 6272.5922815016875, 6343.682815859189, 6347.52393570484, 6361.0, 10370.585176592851, 10708.571657133783, 10737.463126843626, 10813.729656758644, 10817.83773243402, 10378.014088661565, 10475.947620262003, 10671.0, 10678.94660526708, 10726.785464290671, 8341.16588341161, 8366.958165209257, 8369.372297077743, 8384.329253659693, 8426.157384261525, 7887.329576986021, 7895.960520197362, 7944.563049032358, 7952.681892724227, 8049.39629527776, 9374.906250937403, 9397.718068457958, 9453.33826632129, 9562.808743825224, 9592.712218633453, 9747.548383231378, 9803.411795292306, 9858.704238872846, 9950.900490994998, 10046.8492972604, 6775.695093720696, 7141.285871412817, 7372.189059203591, 7477.364424024019, 7524.247575242432, 8304.87542686848, 8311.044229913638, 8329.333653307842, 8340.207680270365, 8351.624176911931, 7277.235890231449, 7400.074990626172, 7415.703371865281, 7506.887396688945, 7547.471676982558, 6184.567080304336, 6424.967875160594, 7174.641267936687, 7303.196648368781, 7353.247139247988, 7736.419768517271, 7771.33943614799, 7813.257740514642, 7815.101263354787, 7833.5691536966015, 7056.223815380202, 7061.399781018466, 7111.644417778987, 7161.892571611535, 7177.569345839266, 6947.965260173667, 7019.087518622547, 7087.397571206299, 7098.538594991309, 7111.7866464006165], "unit": "score", "name": "mootools.html", "value": 4868.546969228846}, {"lowerIsBetter": false, "replicates": [317.90303957293025, 318.77048525061946, 323.0, 324.6347858659009, 325.1724361499983, 6983.231844497108, 7077.3984211342095, 7105.218425973146, 7109.289071092895, 7140.50016498844, 6989.0215369848265, 7037.437005039597, 7046.753363632274, 7061.540999835007, 7071.43428525718, 4840.9515904840855, 4935.8272460463895, 5070.974645126769, 5090.745462726867, 5115.437301896788, 5040.848774536751, 5044.092063428599, 5053.0, 5066.873328166788, 5067.721275329855, 4990.925136122961, 5007.949920500785, 5024.497550244982, 5040.42035165957, 5052.242163675442, 5028.949710502903, 5032.572231360339, 5034.993001399716, 5042.798288068473, 5043.823466178666, 4268.637165840907, 4278.0, 4283.593058659422, 4287.185434767384, 4291.50647675515, 4717.962048349392, 5531.280933478622, 6465.612063276171, 6774.559653622498, 6809.863802723918, 4839.370881785346, 5197.882455272134, 5807.0, 5923.881522369572, 5966.940330596725, 6021.578489505737, 7489.400847932152, 7490.25097490252, 7496.212897645778, 7501.7374391896565, 4828.975855120737, 4835.734034628094, 4836.381255900606, 4846.539578740014, 4847.2729090636685, 6338.492920566389, 7852.411069169835, 7939.0870049944415, 7941.245581669732, 7951.562664053475, 4658.813647454064, 4740.2178640523925, 4812.374391329105, 4879.609631229493, 4889.902201955941, 3946.408038794204, 4905.043516514245, 4954.232094025432, 4959.355283813081, 4965.180745177077, 5923.763049478059, 5927.73325200367, 5928.318243401977, 5945.16767652529, 5945.791897283574, 6721.932780672229, 7334.706611735577, 7373.078365204349, 7390.926090739132, 7418.703251869865, 1622.1807986966742, 1684.823093575157, 1723.603571178636, 1728.971262099049, 1729.3774241273131, 1106.9778604427866, 1110.1840147491587, 1110.2949626986922, 1115.81031224692, 1116.7989761842946, 6140.631562106288, 6370.490360771128, 6864.5881247125335, 6904.758333458305, 6919.273476285019, 5817.680027598522, 7036.859262814715, 7681.231876812386, 7696.11494678108, 7702.306792388712, 6853.451723862079, 6886.931130688729, 6894.9655251724425, 6898.517103802686, 6916.723331066802, 4044.8584299549375, 4079.449274347925, 4079.918401631951, 4092.5907409258834, 4096.672266218696, 8037.075736290284, 8272.917270827214, 8313.667453301921, 8316.085230624627, 8319.750407487785, 8153.0, 8181.486425011273, 8196.139405362352, 8201.384896132813, 8210.958945205235, 6895.586264824126, 7457.366123879422, 8263.397029935551, 8279.420440569224, 8287.50274983503, 7635.618219089134, 7864.9606751965875, 7905.486143400661, 7912.604369781603, 7930.206979302255, 7671.309582137635, 7718.53688778675, 7731.304182623591, 7737.92262077372, 7757.301842834172, 8258.380621453294, 8263.710770123016, 8271.917280827114, 8288.751337459886, 8295.751127466187, 4691.554302341272, 4740.762961851962, 4745.549172828576, 4758.4765675776325, 4765.7140571565815, 7585.962070189614, 7780.260875216845, 7820.296173344426, 7824.84350313002, 7869.960650196941, 7182.3535881770895, 7323.304286092813, 7451.3293803557945, 7451.5901625411125, 7498.437617178624, 6062.363451837494, 6074.696265186634, 7456.217097204715, 7502.587357695379, 7569.772906812805, 7304.890426643498, 7315.926840731525, 7338.96330518344, 7341.229170936975, 7400.222976587381, 7288.854222915618, 7512.361449276873, 7520.623968801648, 7537.736179233701, 7540.396768258636, 7259.0, 7284.562926224444, 7298.197198308076, 7306.561606303639, 7315.780526584211], "unit": "score", "name": "prototype.html", "value": 5374.35437417367}, {"lowerIsBetter": false, "replicates": [585.2450339062609, 710.2187593646989, 733.6441825714529, 773.6905237904838, 795.4789612803615, 12861.228326300417, 13042.543510977117, 13045.0, 13049.478020879153, 13072.673183170426, 13608.387622556984, 14223.0, 14284.500042498514, 14330.641733956656, 14364.640883977905, 741.8924255982879, 911.0889110889127, 912.63494602159, 916.2074805293406, 932.1005229953093, 926.6710317837172, 928.3779867488798, 929.4609126706493, 929.586334081334, 930.3534043839534, 971.9805603887918, 986.0583143098324, 986.659602437158, 991.9305648604601, 994.328828041073, 963.5615794813343, 973.3624475968252, 974.1281553010016, 976.5361453309692, 978.9118979291862, 702.5257950883184, 728.6101935464501, 729.0777166883896, 729.9562026278387, 732.3226015935238, 14747.77878331826, 14818.925905370512, 14911.478098266618, 14976.17631030293, 15034.849651503455, 12938.094333396666, 12953.28756918369, 13018.544350947672, 13028.088033837636, 13200.273984930825, 9920.206383489303, 10043.598256069748, 10176.0, 10572.995565421274, 10939.070179034792, 3430.4168291390274, 3519.9296014079573, 3541.185527328703, 3585.731070169748, 3637.436197389409, 71720.56558868794, 73027.63486182535, 74595.62702186454, 74800.6259968702, 74861.87707184396, 9180.632774688938, 9287.210587100037, 9315.25477961775, 9428.95285523568, 9569.904300957041, 19781.60436791285, 19950.30173943905, 20398.0, 20639.793602063786, 20702.792972070387, 7130.2869713028285, 7252.818679532948, 7253.963730181315, 7322.1945585985495, 7469.58917259556, 4013.5986401359633, 4016.859409920639, 4044.8179831907637, 4059.3707975263883, 4062.6343629073526, 3651.8721844735837, 3653.6529029742132, 3681.5398075240596, 3682.6869716073898, 3686.3548878946076, 641.1824923222928, 645.6739346629922, 649.7628365646505, 659.3011407907633, 662.4038365471018, 507.73343994403234, 528.4002656984351, 529.3621186470294, 549.445060488901, 605.8848818724429, 7841.215878412113, 7999.400044996649, 8118.472299300526, 8159.877601835978, 8242.464239824392, 522.3627174846681, 555.469526602094, 566.3232437237544, 571.5227784799739, 576.8644368573382, 3634.763740356921, 3716.21959388526, 3791.33651610967, 3836.9232615347537, 3863.343231650626, 76469.23530764622, 76504.0, 76646.6167669158, 77163.0, 78603.21396786073, 73527.52944941178, 73971.63014184895, 74087.62956185185, 74226.38192460599, 78108.0, 42891.14217715691, 56409.87180256372, 56710.43289567134, 61196.2461689225, 62126.68936655378, 8336.624851881801, 8359.37304702162, 8385.454945428528, 8430.367722420966, 8583.957080214559, 47214.05571888612, 48688.0, 48960.95952739718, 49082.50917490779, 49118.508814911394, 64775.0, 65018.0, 66254.33745662482, 66418.0, 66909.66545167437, 10499.265051446326, 10533.473326333806, 10565.9512792799, 10714.732131696459, 10932.726681833017, 11670.0, 11811.82282265784, 11878.584249551224, 11900.940495297467, 12236.08229382782, 10213.285070045025, 10801.9738124878, 11118.555257789598, 11227.55089796399, 11551.480183391935, 9523.285753568649, 11245.7750844981, 11276.835932427002, 11446.02708769764, 11600.245984011011, 9446.858297125686, 10648.254622176682, 10795.0, 10925.399103049409, 11195.2723073, 9173.54132293396, 9349.953250233706, 9394.0, 9545.809083818423, 9638.325317227727, 9148.902131744233, 9289.972142065395, 9349.439033658002, 9626.133647971716, 9715.854262185932], "unit": "score", "name": "yui.html", "value": 6723.12674927993}], "name": "dromaeo_css", "value": 7499.81472694626}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 116.0, 118.0, 115.0, 127.0, 116.0, 115.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [146.0, 124.0, 141.0, 174.0, 153.0, 142.0, 135.0, 118.0, 183.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [195.0, 200.0, 197.0, 200.0, 204.0, 207.0, 210.0, 191.0, 204.0, 198.0], "unit": "score", "name": "audio-dft", "value": 200.6}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 56.0, 72.0, 81.0, 84.0, 92.0, 123.0, 56.0, 55.0], "unit": "score", "name": "audio-fft", "value": 76.7}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 115.0, 77.0, 82.0, 79.0, 109.0, 80.0, 82.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 90.6}, {"lowerIsBetter": true, "replicates": [114.0, 89.0, 91.0, 131.0, 135.0, 88.0, 93.0, 90.0, 92.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.1}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 96.0, 139.0, 117.0, 100.0, 152.0, 151.0, 98.0], "unit": "score", "name": "imaging-darkroom", "value": 114.4}, {"lowerIsBetter": true, "replicates": [110.0, 150.0, 154.0, 93.0, 90.0, 127.0, 147.0, 153.0, 86.0, 152.0], "unit": "score", "name": "imaging-desaturate", "value": 126.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 57.0, 67.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 70.0, 97.0, 105.0, 105.0, 99.0, 75.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.1}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 86.0, 83.0, 87.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [136.0, 143.0, 117.0, 123.0, 122.0, 125.0, 125.0, 134.0, 145.0, 150.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.0}, {"lowerIsBetter": true, "replicates": [137.0, 146.0, 143.0, 142.0, 142.0, 141.0, 142.0, 140.0, 180.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [71.0, 93.0, 100.0, 77.0, 66.0, 69.0, 70.0, 67.0, 72.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.7}], "name": "kraken", "value": 1549.1000000000001}]} 04:59:27 INFO - Return code: 0 04:59:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:27 ERROR - # TBPL SUCCESS # 04:59:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:27 INFO - 2016-03-09 04:59:27.529 screenresolution[1689:10258] starting screenresolution argv=screenresolution get 04:59:27 INFO - 2016-03-09 04:59:27.532 screenresolution[1689:10258] Display 0: 1600x1200x32@60 04:59:27 INFO - 2016-03-09 04:59:27.538 screenresolution[1690:10261] starting screenresolution argv=screenresolution list 04:59:27 INFO - Available Modes on Display 0 04:59:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:27 INFO - Intel Iris: 04:59:27 INFO - Chipset Model: Intel Iris 04:59:27 INFO - Type: GPU 04:59:27 INFO - Bus: Built-In 04:59:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:27 INFO - Vendor: Intel (0x8086) 04:59:27 INFO - Device ID: 0x0a2e 04:59:27 INFO - Revision ID: 0x0009 04:59:27 INFO - Displays: 04:59:27 INFO - Display: 04:59:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:27 INFO - Display Serial Number: 1600x1200 60 04:59:27 INFO - Main Display: Yes 04:59:27 INFO - Mirror: Off 04:59:27 INFO - Online: Yes 04:59:27 INFO - Rotation: Supported 04:59:27 INFO - Return code: 0 04:59:27 INFO - Running post-action listener: _resource_record_post_action 04:59:27 INFO - Running post-run listener: _resource_record_post_run 04:59:28 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39314944; Write bytes: 704163328; Read time: 429; Write time: 1904 04:59:28 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390939136; Write bytes: 384542208; Read time: 29774; Write time: 668 04:59:28 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37524992; Write bytes: 300255232; Read time: 410; Write time: 1191 04:59:28 INFO - Running post-run listener: _upload_blobber_files 04:59:28 INFO - Blob upload gear active. 04:59:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:59:28 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'] 04:59:28 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 04:59:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:59:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:30 INFO - (blobuploader) - INFO - Done attempting. 04:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:31 INFO - (blobuploader) - INFO - Done attempting. 04:59:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:31 INFO - Return code: 0 04:59:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11acecfa4b9c9d8fb2782868af3764b9e892f4e281bfbbbd4fd77e2e8844367161107538142694407bf24a20d40ae3c7e8bf234860491905ca756863cd05b3de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab8788f0bb7cc3bf0720a353d827c73ed3de6c09752739855eb38fa3c7831f0b5f3e33f48b8bcd1fd1aca78d8b2c6e584c4d4e3d37031be80671af94443d5506"} 04:59:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:31 INFO - Contents: 04:59:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11acecfa4b9c9d8fb2782868af3764b9e892f4e281bfbbbd4fd77e2e8844367161107538142694407bf24a20d40ae3c7e8bf234860491905ca756863cd05b3de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab8788f0bb7cc3bf0720a353d827c73ed3de6c09752739855eb38fa3c7831f0b5f3e33f48b8bcd1fd1aca78d8b2c6e584c4d4e3d37031be80671af94443d5506"} 04:59:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:31 INFO - Copying logs to upload dir... 04:59:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.859032 ========= master_lag: 1.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-09 04:59:32.857013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 04:59:32.860037) ========= 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.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11acecfa4b9c9d8fb2782868af3764b9e892f4e281bfbbbd4fd77e2e8844367161107538142694407bf24a20d40ae3c7e8bf234860491905ca756863cd05b3de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab8788f0bb7cc3bf0720a353d827c73ed3de6c09752739855eb38fa3c7831f0b5f3e33f48b8bcd1fd1aca78d8b2c6e584c4d4e3d37031be80671af94443d5506"} build_url:https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/Si7N8V6sTQiCDO07t3Z7Lg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11acecfa4b9c9d8fb2782868af3764b9e892f4e281bfbbbd4fd77e2e8844367161107538142694407bf24a20d40ae3c7e8bf234860491905ca756863cd05b3de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab8788f0bb7cc3bf0720a353d827c73ed3de6c09752739855eb38fa3c7831f0b5f3e33f48b8bcd1fd1aca78d8b2c6e584c4d4e3d37031be80671af94443d5506"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 04:59:32.919337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:59:32.922652) ========= 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.y7Dji10UJs/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.TBbF63E6T9/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005121 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:59:32.991132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 04:59:32.991431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 04:59:32.996412) ========= ========= Total master_lag: 1.72 =========