builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1447880509.89 results: success (0) buildid: 20151118110040 builduid: 9c6de3ea7cf74608abccc223c809d13a revision: 929982f95a788e798b848da372725dd80cc44b36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.895011) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.895457) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.895762) ========= 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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.004767 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.916462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.916779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.932372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.932676) ========= 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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005051 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.981252) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.981559) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.981958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:49.982234) ========= 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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 --2015-11-18 13:01:49-- 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% 1.62G=0s 2015-11-18 13:01:50 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193983 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:50.189765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:50.190117) ========= 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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.026024 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:50.239247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-11-18 13:01:50.239644) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 929982f95a788e798b848da372725dd80cc44b36 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 929982f95a788e798b848da372725dd80cc44b36 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 2015-11-18 13:01:50,314 truncating revision to first 12 chars 2015-11-18 13:01:50,315 Setting DEBUG logging. 2015-11-18 13:01:50,315 attempt 1/10 2015-11-18 13:01:50,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/929982f95a78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 13:01:50,949 unpacking tar archive at: fx-team-929982f95a78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.879362 ========= master_lag: 3.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-11-18 13:01:54.263100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.263415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.313656) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.314035) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.314634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-18 13:01:54.314950) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:01:54 INFO - MultiFileLogger online at 20151118 13:01:54 in /builds/slave/test 13:01:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:01:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:01:54 INFO - {'append_to_log': False, 13:01:54 INFO - 'base_work_dir': '/builds/slave/test', 13:01:54 INFO - 'blob_upload_branch': 'Fx-Team', 13:01:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:01:54 INFO - 'branch': 'Fx-Team', 13:01:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:01:54 INFO - 'config_files': ('talos/mac_config.py',), 13:01:54 INFO - 'default_actions': ('clobber', 13:01:54 INFO - 'read-buildbot-config', 13:01:54 INFO - 'download-and-extract', 13:01:54 INFO - 'populate-webroot', 13:01:54 INFO - 'create-virtualenv', 13:01:54 INFO - 'install', 13:01:54 INFO - 'run-tests'), 13:01:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:01:54 INFO - 'download_minidump_stackwalk': True, 13:01:54 INFO - 'download_symbols': 'ondemand', 13:01:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:01:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:01:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:01:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:01:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:01:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:01:54 INFO - 'installer_path': 'installer.exe', 13:01:54 INFO - 'log_level': 'info', 13:01:54 INFO - 'log_name': 'talos', 13:01:54 INFO - 'log_to_console': True, 13:01:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:01:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:01:54 INFO - 'opt_config_files': (), 13:01:54 INFO - 'pip_index': False, 13:01:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:01:54 INFO - 'cmd': ('bash', 13:01:54 INFO - '-c', 13:01:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:01:54 INFO - 'enabled': True, 13:01:54 INFO - 'halt_on_failure': False, 13:01:54 INFO - 'name': 'check_screen_resolution'},), 13:01:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:01:54 INFO - 'cmd': ('bash', 13:01:54 INFO - '-c', 13:01:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:01:54 INFO - 'enabled': True, 13:01:54 INFO - 'halt_on_failure': False, 13:01:54 INFO - 'name': 'check_screen_resolution'},), 13:01:54 INFO - 'run_cmd_checks_enabled': True, 13:01:54 INFO - 'sps_profile': False, 13:01:54 INFO - 'sps_profile_interval': 0, 13:01:54 INFO - 'suite': 'dromaeojs', 13:01:54 INFO - 'system_bits': '64', 13:01:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:01:54 INFO - 'title': 't-yosemite-r7-0060', 13:01:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:01:54 INFO - 'use_talos_json': True, 13:01:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:01:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:01:54 INFO - 'work_dir': 'build'} 13:01:54 INFO - ##### 13:01:54 INFO - ##### Running clobber step. 13:01:54 INFO - ##### 13:01:54 INFO - Running pre-action listener: _resource_record_pre_action 13:01:54 INFO - Running main action method: clobber 13:01:54 INFO - rmtree: /builds/slave/test/build 13:01:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:01:55 INFO - Running post-action listener: _resource_record_post_action 13:01:55 INFO - ##### 13:01:55 INFO - ##### Running read-buildbot-config step. 13:01:55 INFO - ##### 13:01:55 INFO - Running pre-action listener: _resource_record_pre_action 13:01:55 INFO - Running main action method: read_buildbot_config 13:01:55 INFO - Using buildbot properties: 13:01:55 INFO - { 13:01:55 INFO - "properties": { 13:01:55 INFO - "buildnumber": 1, 13:01:55 INFO - "product": "firefox", 13:01:55 INFO - "script_repo_revision": "production", 13:01:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:01:55 INFO - "repository": "", 13:01:55 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:01:55 INFO - "buildid": "20151118110040", 13:01:55 INFO - "slavename": "t-yosemite-r7-0060", 13:01:55 INFO - "pgo_build": "False", 13:01:55 INFO - "basedir": "/builds/slave/test", 13:01:55 INFO - "project": "", 13:01:55 INFO - "platform": "yosemite_r7", 13:01:55 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:01:55 INFO - "slavebuilddir": "test", 13:01:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:01:55 INFO - "branch": "fx-team", 13:01:55 INFO - "repo_path": "integration/fx-team", 13:01:55 INFO - "stage_platform": "macosx64", 13:01:55 INFO - "builduid": "9c6de3ea7cf74608abccc223c809d13a", 13:01:55 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 13:01:55 INFO - }, 13:01:55 INFO - "sourcestamp": { 13:01:55 INFO - "repository": "", 13:01:55 INFO - "hasPatch": false, 13:01:55 INFO - "project": "", 13:01:55 INFO - "branch": "fx-team-macosx64-talos", 13:01:55 INFO - "changes": [ 13:01:55 INFO - { 13:01:55 INFO - "category": null, 13:01:55 INFO - "files": [ 13:01:55 INFO - { 13:01:55 INFO - "url": null, 13:01:55 INFO - "name": "https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 13:01:55 INFO - } 13:01:55 INFO - ], 13:01:55 INFO - "repository": "", 13:01:55 INFO - "rev": "5cb637976cf157ccbe39795017eba8f937aae9d5", 13:01:55 INFO - "who": "jwein@mozilla.com", 13:01:55 INFO - "when": 1447875524, 13:01:55 INFO - "number": 6678405, 13:01:55 INFO - "comments": "Bug 1190961 - Change info-pages.css' placeholder icon to one that exists in toolkit/ r=jaws", 13:01:56 INFO - "project": "", 13:01:56 INFO - "at": "Wed 18 Nov 2015 11:38:44", 13:01:56 INFO - "branch": "fx-team-macosx64-talos", 13:01:56 INFO - "revlink": "", 13:01:56 INFO - "properties": [ 13:01:56 INFO - [ 13:01:56 INFO - "buildid", 13:01:56 INFO - "20151118095124", 13:01:56 INFO - "Change" 13:01:56 INFO - ], 13:01:56 INFO - [ 13:01:56 INFO - "builduid", 13:01:56 INFO - "44abfd8021434a6cb5d9398df0cdf265", 13:01:56 INFO - "Change" 13:01:56 INFO - ], 13:01:56 INFO - [ 13:01:56 INFO - "pgo_build", 13:01:56 INFO - "False", 13:01:56 INFO - "Change" 13:01:56 INFO - ] 13:01:56 INFO - ], 13:01:56 INFO - "revision": "5cb637976cf157ccbe39795017eba8f937aae9d5" 13:01:56 INFO - }, 13:01:56 INFO - { 13:01:56 INFO - "category": null, 13:01:56 INFO - "files": [ 13:01:56 INFO - { 13:01:56 INFO - "url": null, 13:01:56 INFO - "name": "https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 13:01:56 INFO - } 13:01:56 INFO - ], 13:01:56 INFO - "repository": "", 13:01:56 INFO - "rev": "929982f95a788e798b848da372725dd80cc44b36", 13:01:56 INFO - "who": "alessio.placitelli@gmail.com", 13:01:56 INFO - "when": 1447878479, 13:01:56 INFO - "number": 6678659, 13:01:56 INFO - "comments": "Bug 1221505 - Remove osfile.jsm dependency from TelemetrySession.jsm. r=dexter", 13:01:56 INFO - "project": "", 13:01:56 INFO - "at": "Wed 18 Nov 2015 12:27:59", 13:01:56 INFO - "branch": "fx-team-macosx64-talos", 13:01:56 INFO - "revlink": "", 13:01:56 INFO - "properties": [ 13:01:56 INFO - [ 13:01:56 INFO - "buildid", 13:01:56 INFO - "20151118110040", 13:01:56 INFO - "Change" 13:01:56 INFO - ], 13:01:56 INFO - [ 13:01:56 INFO - "builduid", 13:01:56 INFO - "9c6de3ea7cf74608abccc223c809d13a", 13:01:56 INFO - "Change" 13:01:56 INFO - ], 13:01:56 INFO - [ 13:01:56 INFO - "pgo_build", 13:01:56 INFO - "False", 13:01:56 INFO - "Change" 13:01:56 INFO - ] 13:01:56 INFO - ], 13:01:56 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 13:01:56 INFO - } 13:01:56 INFO - ], 13:01:56 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 13:01:56 INFO - } 13:01:56 INFO - } 13:01:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 13:01:56 INFO - Running post-action listener: _resource_record_post_action 13:01:56 INFO - ##### 13:01:56 INFO - ##### Running download-and-extract step. 13:01:56 INFO - ##### 13:01:56 INFO - Running pre-action listener: _resource_record_pre_action 13:01:56 INFO - Running main action method: download_and_extract 13:01:56 INFO - mkdir: /builds/slave/test/build/tests 13:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:01:56 INFO - https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:01:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/test_packages.json 13:01:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/test_packages.json 13:01:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:01:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:01:57 INFO - Downloaded 1149 bytes. 13:01:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:01:57 INFO - Using the following test package requirements: 13:01:57 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:01:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:57 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 13:01:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:57 INFO - u'jsshell-mac.zip'], 13:01:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:57 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 13:01:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:01:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:57 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 13:01:57 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:57 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 13:01:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:57 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 13:01:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:01:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:57 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 13:01:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:01:57 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')]} 13:01:57 INFO - https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:01:59 INFO - Downloaded 17476854 bytes. 13:01:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 13:01:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:01:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:02:02 INFO - Return code: 0 13:02:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:02:02 INFO - https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:02:03 INFO - Downloaded 17476854 bytes. 13:02:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 13:02:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:02:07 INFO - Return code: 0 13:02: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')]} 13:02:07 INFO - https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:02:08 INFO - Downloaded 11130997 bytes. 13:02:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 13:02:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:02:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 13:02:08 INFO - Return code: 0 13:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:02:08 INFO - https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:02:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 13:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 13:02:12 INFO - Downloaded 108850893 bytes. 13:02:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:12 INFO - mkdir: /builds/slave/test/properties 13:02:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:02:12 INFO - Writing to file /builds/slave/test/properties/build_url 13:02:12 INFO - Contents: 13:02:12 INFO - build_url:https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:12 INFO - Running post-action listener: _resource_record_post_action 13:02:12 INFO - Running post-action listener: set_extra_try_arguments 13:02:12 INFO - ##### 13:02:12 INFO - ##### Running populate-webroot step. 13:02:12 INFO - ##### 13:02:12 INFO - Running pre-action listener: _resource_record_pre_action 13:02:12 INFO - Running main action method: populate_webroot 13:02:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:02:12 INFO - '../fennec_ids.txt'], 13:02:12 INFO - 'tests': ['tcheck2']}, 13:02:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:12 INFO - '--tppagecycles', 13:02:12 INFO - '7'], 13:02:12 INFO - 'tests': ['tsvgm']}}, 13:02:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:02:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:02:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:02:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'tests': ['damp', 'tps']}, 13:02:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['damp', 'tps']}, 13:02:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:02:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:12 INFO - 'other': {'tests': ['a11yr', 13:02:12 INFO - 'ts_paint', 13:02:12 INFO - 'tpaint', 13:02:12 INFO - 'sessionrestore', 13:02:12 INFO - 'sessionrestore_no_auto_restore']}, 13:02:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['a11yr', 13:02:12 INFO - 'ts_paint', 13:02:12 INFO - 'tpaint', 13:02:12 INFO - 'sessionrestore', 13:02:12 INFO - 'sessionrestore_no_auto_restore']}, 13:02:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['a11yr', 13:02:12 INFO - 'ts_paint', 13:02:12 INFO - 'tpaint', 13:02:12 INFO - 'sessionrestore', 13:02:12 INFO - 'sessionrestore_no_auto_restore']}, 13:02:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['a11yr', 13:02:12 INFO - 'ts_paint', 13:02:12 INFO - 'tpaint', 13:02:12 INFO - 'sessionrestore', 13:02:12 INFO - 'sessionrestore_no_auto_restore']}, 13:02:12 INFO - 'other_l64': {'tests': ['a11yr', 13:02:12 INFO - 'ts_paint', 13:02:12 INFO - 'tpaint', 13:02:12 INFO - 'sessionrestore', 13:02:12 INFO - 'sessionrestore_no_auto_restore']}, 13:02:12 INFO - 'other_nol64': {'tests': ['a11yr', 13:02:12 INFO - 'ts_paint', 13:02:12 INFO - 'tpaint', 13:02:12 INFO - 'sessionrestore', 13:02:12 INFO - 'sessionrestore_no_auto_restore']}, 13:02:12 INFO - 'svgr': {'tests': ['tsvgx', 13:02:12 INFO - 'tsvgr_opacity', 13:02:12 INFO - 'tart', 13:02:12 INFO - 'tscrollx', 13:02:12 INFO - 'cart']}, 13:02:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['tsvgx', 13:02:12 INFO - 'tsvgr_opacity', 13:02:12 INFO - 'tart', 13:02:12 INFO - 'tscrollx', 13:02:12 INFO - 'cart']}, 13:02:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'tests': ['tp5o']}, 13:02:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'talos_options': ['--e10s'], 13:02:12 INFO - 'tests': ['tp5o']}, 13:02:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'talos_options': ['--xperf_path', 13:02:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:12 INFO - 'tests': ['tp5n']}, 13:02:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:12 INFO - 'talos_options': ['--e10s', 13:02:12 INFO - '--xperf_path', 13:02:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:12 INFO - 'tests': ['tp5n']}}, 13:02:12 INFO - 'talos.zip': {'path': '', 13:02:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:12 INFO - Running post-action listener: _resource_record_post_action 13:02:12 INFO - ##### 13:02:12 INFO - ##### Running create-virtualenv step. 13:02:12 INFO - ##### 13:02:12 INFO - Running pre-action listener: _resource_record_pre_action 13:02:12 INFO - Running main action method: create_virtualenv 13:02:12 INFO - Creating virtualenv /builds/slave/test/build/venv 13:02:12 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 13:02:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:02:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:12 INFO - Using real prefix '/tools/python27' 13:02:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:02:13 INFO - Installing distribute.............................................................................................................................................................................................done. 13:02:15 INFO - Installing pip.................done. 13:02:15 INFO - Return code: 0 13:02:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:02:15 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')]} 13:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:15 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')]} 13:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b331490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b30e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb01a499380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, '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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:02:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:02:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:15 INFO - 'HOME': '/Users/cltbld', 13:02:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:15 INFO - 'LOGNAME': 'cltbld', 13:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:15 INFO - 'MOZ_NO_REMOTE': '1', 13:02:15 INFO - 'NO_EM_RESTART': '1', 13:02:15 INFO - 'PAGER': '/bin/cat', 13:02:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:15 INFO - 'PWD': '/builds/slave/test', 13:02:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:15 INFO - 'SHELL': '/bin/bash', 13:02:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:02:15 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:02:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:15 INFO - 'USER': 'cltbld', 13:02:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:15 INFO - 'XPC_FLAGS': '0x0', 13:02:15 INFO - 'XPC_SERVICE_NAME': '0', 13:02:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:16 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 13:02:16 INFO - Cleaning up... 13:02:16 INFO - Return code: 0 13:02:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b331490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b30e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb01a499380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, '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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:02:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:02:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:16 INFO - 'HOME': '/Users/cltbld', 13:02:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:16 INFO - 'LOGNAME': 'cltbld', 13:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:16 INFO - 'MOZ_NO_REMOTE': '1', 13:02:16 INFO - 'NO_EM_RESTART': '1', 13:02:16 INFO - 'PAGER': '/bin/cat', 13:02:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:16 INFO - 'PWD': '/builds/slave/test', 13:02:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:16 INFO - 'SHELL': '/bin/bash', 13:02:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:02:16 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:02:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:16 INFO - 'USER': 'cltbld', 13:02:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:16 INFO - 'XPC_FLAGS': '0x0', 13:02:16 INFO - 'XPC_SERVICE_NAME': '0', 13:02:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:16 INFO - Downloading/unpacking psutil>=0.7.1 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:02:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:02:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:19 INFO - Installing collected packages: psutil 13:02:19 INFO - Running setup.py install for psutil 13:02:19 INFO - building 'psutil._psutil_osx' extension 13:02:19 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 13:02:19 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 13:02:19 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 13:02:19 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 13:02:19 INFO - building 'psutil._psutil_posix' extension 13:02:19 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 13:02:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:02:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:02:19 INFO - ^ 13:02:20 INFO - 1 warning generated. 13:02:20 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 13:02:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:20 INFO - Successfully installed psutil 13:02:20 INFO - Cleaning up... 13:02:20 INFO - Return code: 0 13:02:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:02:20 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')]} 13:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:20 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')]} 13:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b331490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b30e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb01a499380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, '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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:02:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:02:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:20 INFO - 'HOME': '/Users/cltbld', 13:02:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:20 INFO - 'LOGNAME': 'cltbld', 13:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:20 INFO - 'MOZ_NO_REMOTE': '1', 13:02:20 INFO - 'NO_EM_RESTART': '1', 13:02:20 INFO - 'PAGER': '/bin/cat', 13:02:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:20 INFO - 'PWD': '/builds/slave/test', 13:02:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:20 INFO - 'SHELL': '/bin/bash', 13:02:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:02:20 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:02:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:20 INFO - 'USER': 'cltbld', 13:02:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:20 INFO - 'XPC_FLAGS': '0x0', 13:02:20 INFO - 'XPC_SERVICE_NAME': '0', 13:02:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02: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 13:02:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:02:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:02:22 INFO - Installing collected packages: mozsystemmonitor 13:02:22 INFO - Running setup.py install for mozsystemmonitor 13:02:22 INFO - Successfully installed mozsystemmonitor 13:02:22 INFO - Cleaning up... 13:02:22 INFO - Return code: 0 13:02:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:02:22 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')]} 13:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:22 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')]} 13:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b331490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b30e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb01a499380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, '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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:02:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:02:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:22 INFO - 'HOME': '/Users/cltbld', 13:02:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:22 INFO - 'LOGNAME': 'cltbld', 13:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:22 INFO - 'MOZ_NO_REMOTE': '1', 13:02:22 INFO - 'NO_EM_RESTART': '1', 13:02:22 INFO - 'PAGER': '/bin/cat', 13:02:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:22 INFO - 'PWD': '/builds/slave/test', 13:02:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:22 INFO - 'SHELL': '/bin/bash', 13:02:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:02:22 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:02:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:22 INFO - 'USER': 'cltbld', 13:02:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:22 INFO - 'XPC_FLAGS': '0x0', 13:02:22 INFO - 'XPC_SERVICE_NAME': '0', 13:02:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:23 INFO - Downloading/unpacking blobuploader==1.2.4 13:02:23 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 13:02:23 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 13:02:23 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 13:02:23 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 13:02:23 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 13:02:23 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 13:02:25 INFO - Downloading blobuploader-1.2.4.tar.gz 13:02:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:02:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:02:25 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 13:02:25 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 13:02:25 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 13:02:25 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 13:02:25 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 13:02:25 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 13:02:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:02:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:02:26 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 13:02:26 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 13:02:26 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 13:02:26 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 13:02:26 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 13:02:26 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 13:02:26 INFO - Downloading docopt-0.6.1.tar.gz 13:02:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:02:26 INFO - Installing collected packages: blobuploader, requests, docopt 13:02:26 INFO - Running setup.py install for blobuploader 13:02:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:02:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:02:26 INFO - Running setup.py install for requests 13:02:27 INFO - Running setup.py install for docopt 13:02:27 INFO - Successfully installed blobuploader requests docopt 13:02:27 INFO - Cleaning up... 13:02:27 INFO - Return code: 0 13:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b331490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b30e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb01a499380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, '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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 13:02:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:02:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:27 INFO - 'HOME': '/Users/cltbld', 13:02:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:27 INFO - 'LOGNAME': 'cltbld', 13:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:27 INFO - 'MOZ_NO_REMOTE': '1', 13:02:27 INFO - 'NO_EM_RESTART': '1', 13:02:27 INFO - 'PAGER': '/bin/cat', 13:02:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:27 INFO - 'PWD': '/builds/slave/test', 13:02:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:27 INFO - 'SHELL': '/bin/bash', 13:02:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:02:27 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:02:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:27 INFO - 'USER': 'cltbld', 13:02:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:27 INFO - 'XPC_FLAGS': '0x0', 13:02:27 INFO - 'XPC_SERVICE_NAME': '0', 13:02:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:27 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-RLjTiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:27 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-yz2XHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:27 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Vfqkbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:27 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-3pwIvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:27 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-di4DzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-G3eWkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-eHRpD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-YXEdS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-n5rjji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-6wgXKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Dj06EK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-O9KcZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-KzHKtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:28 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-bnlXWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:29 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-fNEzIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:29 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-IDzrt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:29 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-17_Dzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:29 INFO - Running setup.py install for manifestparser 13:02:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Running setup.py install for mozcrash 13:02:29 INFO - Running setup.py install for mozdebug 13:02:29 INFO - Running setup.py install for mozdevice 13:02:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Running setup.py install for mozfile 13:02:30 INFO - Running setup.py install for mozhttpd 13:02:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for mozinfo 13:02:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for mozInstall 13:02:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for mozleak 13:02:30 INFO - Running setup.py install for mozlog 13:02:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for moznetwork 13:02:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for mozprocess 13:02:31 INFO - Running setup.py install for mozprofile 13:02:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:02:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:02:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:02:31 INFO - Running setup.py install for mozrunner 13:02:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:02:31 INFO - Running setup.py install for mozscreenshot 13:02:31 INFO - Running setup.py install for moztest 13:02:31 INFO - Running setup.py install for mozversion 13:02:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:02:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:31 INFO - Cleaning up... 13:02:31 INFO - Return code: 0 13:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:31 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')]} 13:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:31 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')]} 13:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b331490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b30e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb01a499380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, '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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:31 INFO - 'HOME': '/Users/cltbld', 13:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:31 INFO - 'LOGNAME': 'cltbld', 13:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:31 INFO - 'MOZ_NO_REMOTE': '1', 13:02:31 INFO - 'NO_EM_RESTART': '1', 13:02:31 INFO - 'PAGER': '/bin/cat', 13:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:31 INFO - 'PWD': '/builds/slave/test', 13:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:31 INFO - 'SHELL': '/bin/bash', 13:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:02:31 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:31 INFO - 'USER': 'cltbld', 13:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:31 INFO - 'XPC_FLAGS': '0x0', 13:02:31 INFO - 'XPC_SERVICE_NAME': '0', 13:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-nt4gAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Md4hyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-PSgjta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-oqgSlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-CdgVjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-kMKRD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-dNijxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-86XTfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:32 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-hEFZ5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-wabLpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-83bEA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-HfvFrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-9e5HBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-yuLTfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-t2uxx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-6JbzWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:33 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-4KtZyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:33 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)) 13:02:33 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:02:33 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:02:33 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)) 13:02:33 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:02:33 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:02:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:36 INFO - Downloading blessings-1.5.1.tar.gz 13:02:36 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:36 INFO - Installing collected packages: blessings 13:02:36 INFO - Running setup.py install for blessings 13:02:36 INFO - Successfully installed blessings 13:02:36 INFO - Cleaning up... 13:02:36 INFO - Return code: 0 13:02:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:36 INFO - Reading from file tmpfile_stdout 13:02:36 INFO - Current package versions: 13:02:36 INFO - blessings == 1.5.1 13:02:36 INFO - blobuploader == 1.2.4 13:02:36 INFO - docopt == 0.6.1 13:02:36 INFO - manifestparser == 1.1 13:02:36 INFO - mozInstall == 1.12 13:02:36 INFO - mozcrash == 0.16 13:02:36 INFO - mozdebug == 0.1 13:02:36 INFO - mozdevice == 0.47 13:02:36 INFO - mozfile == 1.2 13:02:36 INFO - mozhttpd == 0.7 13:02:36 INFO - mozinfo == 0.9 13:02:36 INFO - mozleak == 0.1 13:02:36 INFO - mozlog == 3.0 13:02:36 INFO - moznetwork == 0.27 13:02:36 INFO - mozprocess == 0.22 13:02:36 INFO - mozprofile == 0.27 13:02:36 INFO - mozrunner == 6.11 13:02:36 INFO - mozscreenshot == 0.1 13:02:36 INFO - mozsystemmonitor == 0.0 13:02:36 INFO - moztest == 0.7 13:02:36 INFO - mozversion == 1.4 13:02:36 INFO - psutil == 3.1.1 13:02:36 INFO - requests == 1.2.3 13:02:36 INFO - wsgiref == 0.1.2 13:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:36 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')]} 13:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:36 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')]} 13:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10b331490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b30e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb01a499380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, '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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 13:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:02:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:02:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:36 INFO - 'HOME': '/Users/cltbld', 13:02:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:36 INFO - 'LOGNAME': 'cltbld', 13:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:36 INFO - 'MOZ_NO_REMOTE': '1', 13:02:36 INFO - 'NO_EM_RESTART': '1', 13:02:36 INFO - 'PAGER': '/bin/cat', 13:02:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:36 INFO - 'PWD': '/builds/slave/test', 13:02:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:36 INFO - 'SHELL': '/bin/bash', 13:02:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:02:36 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:02:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:36 INFO - 'USER': 'cltbld', 13:02:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:36 INFO - 'XPC_FLAGS': '0x0', 13:02:36 INFO - 'XPC_SERVICE_NAME': '0', 13:02:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:36 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 1)) 13:02:36 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 2)) 13:02:36 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 3)) 13:02:36 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 4)) 13:02:36 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 5)) 13:02:36 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 6)) 13:02:36 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 7)) 13:02:36 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 8)) 13:02:36 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:02:36 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 3)) 13:02:36 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:02:36 INFO - Cleaning up... 13:02:36 INFO - Return code: 0 13:02:36 INFO - Running post-action listener: _resource_record_post_action 13:02:36 INFO - Running post-action listener: _start_resource_monitoring 13:02:36 INFO - Starting resource monitoring. 13:02:36 INFO - ##### 13:02:36 INFO - ##### Running install step. 13:02:36 INFO - ##### 13:02:36 INFO - Running pre-action listener: _resource_record_pre_action 13:02:36 INFO - Running main action method: install 13:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:37 INFO - Reading from file tmpfile_stdout 13:02:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:02:37 INFO - Reading from file tmpfile_stdout 13:02:37 INFO - Output received: 13:02:37 INFO - Usage: mozinstall [options] installer 13:02:37 INFO - Options: 13:02:37 INFO - -h, --help show this help message and exit 13:02:37 INFO - -d DEST, --destination=DEST 13:02:37 INFO - Directory to install application into. [default: 13:02:37 INFO - "/builds/slave/test"] 13:02:37 INFO - --app=APP Application being installed. [default: firefox] 13:02:37 INFO - mkdir: /builds/slave/test/build/application 13:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:03:07 INFO - Reading from file tmpfile_stdout 13:03:07 INFO - Output received: 13:03:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:03:07 INFO - Running post-action listener: _resource_record_post_action 13:03:07 INFO - ##### 13:03:07 INFO - ##### Running run-tests step. 13:03:07 INFO - ##### 13:03:07 INFO - Running pre-action listener: _resource_record_pre_action 13:03:07 INFO - Running main action method: run_tests 13:03:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:03:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:03:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:03:07 INFO - 2015-11-18 13:03:07.676 screenresolution[1638:7537] starting screenresolution argv=screenresolution get 13:03:07 INFO - 2015-11-18 13:03:07.679 screenresolution[1638:7537] Display 0: 1600x1200x32@60 13:03:07 INFO - 2015-11-18 13:03:07.684 screenresolution[1639:7539] starting screenresolution argv=screenresolution list 13:03:07 INFO - Available Modes on Display 0 13:03:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:03:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:03:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:03:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:03:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:03:07 INFO - Intel Iris: 13:03:07 INFO - Chipset Model: Intel Iris 13:03:07 INFO - Type: GPU 13:03:07 INFO - Bus: Built-In 13:03:07 INFO - VRAM (Dynamic, Max): 1536 MB 13:03:07 INFO - Vendor: Intel (0x8086) 13:03:07 INFO - Device ID: 0x0a2e 13:03:07 INFO - Revision ID: 0x0009 13:03:07 INFO - Displays: 13:03:07 INFO - Display: 13:03:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:03:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:03:07 INFO - Display Serial Number: 1600x1200 60 13:03:07 INFO - Main Display: Yes 13:03:07 INFO - Mirror: Off 13:03:07 INFO - Online: Yes 13:03:07 INFO - Rotation: Supported 13:03:07 INFO - Return code: 0 13:03:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:03:07 INFO - Python 2.7.3 13:03:07 INFO - Return code: 0 13:03:07 INFO - grabbing minidump binary from tooltool 13:03: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')]} 13:03:07 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 0x10b2559f0>, '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 0x10afb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b2488c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:03:07 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 13:03:07 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 13:03:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:03:08 INFO - Return code: 0 13:03:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:03:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:03:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:03:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:03:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost'] in /builds/slave/test/build 13:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --webServer localhost 13:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZ7TunLhzq/Render', 13:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:08 INFO - 'HOME': '/Users/cltbld', 13:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:08 INFO - 'LOGNAME': 'cltbld', 13:03:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:03:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:08 INFO - 'MOZ_NO_REMOTE': '1', 13:03:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:03:08 INFO - 'NO_EM_RESTART': '1', 13:03:08 INFO - 'PAGER': '/bin/cat', 13:03:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:08 INFO - 'PWD': '/builds/slave/test', 13:03:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:08 INFO - 'SHELL': '/bin/bash', 13:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFF6fs8v6r/Listeners', 13:03:08 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 13:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:08 INFO - 'USER': 'cltbld', 13:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:08 INFO - 'XPC_FLAGS': '0x0', 13:03:08 INFO - 'XPC_SERVICE_NAME': '0', 13:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--webServer', 'localhost'] with output_timeout 3600 13:03:08 INFO - mozversion INFO | application_buildid: 20151118110040 13:03:08 INFO - mozversion INFO | application_changeset: 929982f95a788e798b848da372725dd80cc44b36 13:03:08 INFO - mozversion INFO | application_display_name: Nightly 13:03:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:03:08 INFO - mozversion INFO | application_name: Firefox 13:03:08 INFO - mozversion INFO | application_remotingname: firefox 13:03:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:03:08 INFO - mozversion INFO | application_vendor: Mozilla 13:03:08 INFO - mozversion INFO | application_version: 45.0a1 13:03:08 INFO - mozversion INFO | platform_buildid: 20151118110040 13:03:08 INFO - mozversion INFO | platform_changeset: 929982f95a788e798b848da372725dd80cc44b36 13:03:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:03:08 INFO - mozversion INFO | platform_version: 45.0a1 13:03:08 INFO - 2015-11-18 13:03:08,236 DEBUG : using testdate: 1447880588 13:03:08 INFO - 2015-11-18 13:03:08,236 DEBUG : actual date: 1447880588 13:03:08 INFO - 2015-11-18 13:03:08,579 INFO : starting webserver on 'localhost:49264' 13:03:08 INFO - 2015-11-18 13:03:08,580 INFO : Starting test suite t-yosemite-r7-0060 13:03:08 INFO - 2015-11-18 13:03:08,580 INFO : Starting test dromaeo_css 13:03:08 INFO - 2015-11-18 13:03:08,580 DEBUG : operating with platform_type : mac_ 13:03:08 INFO - 2015-11-18 13:03:08,581 INFO : Initialising browser for dromaeo_css test... 13:03:08 INFO - 2015-11-18 13:03:08,594 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmp72SNXe/profile http://localhost:49264/getInfo.html 13:03:10 INFO - 2015-11-18 13:03:10,903 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:03:10 INFO - 2015-11-18 13:03:10,903 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:03:10 INFO - 2015-11-18 13:03:10,903 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:03:10 INFO - 2015-11-18 13:03:10,904 DEBUG : BROWSER_OUTPUT: __metrics 13:03:10 INFO - 2015-11-18 13:03:10,919 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:03:11 INFO - 2015-11-18 13:03:11,668 INFO : Browser initialized. 13:03:11 INFO - 2015-11-18 13:03:11,669 INFO : Running cycle 1/1 for dromaeo_css test... 13:03:11 INFO - 2015-11-18 13:03:11,669 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmp72SNXe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:03:23 INFO - 2015-11-18 13:03:23,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 226406400 13:03:23 INFO - 2015-11-18 13:03:23,437 DEBUG : BROWSER_OUTPUT: 13:04:14 INFO - 2015-11-18 13:04:14,989 DEBUG : BROWSER_OUTPUT: 1447880654988 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] 13:06:24 INFO - 2015-11-18 13:06:24,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 13:06:26 INFO - 2015-11-18 13:06:26,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 361205760 13:06:26 INFO - 2015-11-18 13:06:26,253 DEBUG : BROWSER_OUTPUT: 13:09:29 INFO - 2015-11-18 13:09:29,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 13:09:29 INFO - 2015-11-18 13:09:29,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 362860544 13:09:29 INFO - 2015-11-18 13:09:29,627 DEBUG : BROWSER_OUTPUT: 13:12:31 INFO - 2015-11-18 13:12:31,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 13:12:32 INFO - 2015-11-18 13:12:32,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 361111552 13:12:32 INFO - 2015-11-18 13:12:32,293 DEBUG : BROWSER_OUTPUT: 13:15:34 INFO - 2015-11-18 13:15:34,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 13:15:34 INFO - 2015-11-18 13:15:34,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 322023424 13:15:34 INFO - 2015-11-18 13:15:34,833 DEBUG : BROWSER_OUTPUT: 13:18:37 INFO - 2015-11-18 13:18:37,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 13:18:38 INFO - 2015-11-18 13:18:38,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 325632000 13:18:38 INFO - 2015-11-18 13:18:38,253 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 13:21:41 INFO - 2015-11-18 13:21:41,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 377643008 13:21:41 INFO - 2015-11-18 13:21:41,309 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,309 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:21:41 INFO - 2015-11-18 13:21:41,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:21:41 INFO - 2015-11-18 13:21:41,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:21:41 INFO - 2015-11-18 13:21:41,309 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:21:41 INFO - 2015-11-18 13:21:41,309 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3430.622631510533;3553.6268691787363;3577.3560759063375;3578.874739384122;3611.4402267648506;5708.058170401879;5892.587518873681;6011.038233882579;6019.157317975487;6037.607555508895;4803.303520989454;5831.154482600031;5961.0760332148475;5971.641701497913;6138.202033735608;5331.920021199666;5351.197320401932;5353.357597088355;5378.381486129087;5447.346318441792;4948.950510494885;5468.781248750045;5502.119660854244;5525.060739674265;5562.3047119110115;5195.324607801;5292.841214763564;5309.787608495655;5415.891682166374;5455.536279416235;4129.504459464883;5362.973185134088;5375.139977603565;5382.165764306539;5385.919211211835;5370.865728356784;5373.677579345252;5381.13901775714;5393.2449457076045;5395.649282796606;5814.563907706939;5825.475707186331;5834.5915785895;5835.153902684087;5838.299404071496;6218.22272215973;6283.811485655392;6288.465480434169;6295.496360291166;6298.685065746694;6309.968450157766;6343.809685709436;6354.205724284465;6358.237011558596;6362.713677884506;5889.087191485327;5995.070764031582;6157.476614487774;6169.537284703621;6183.165272688175;5310.389305229871;6406.2953075161695;6568.638724870082;6581.934180658228;6592.538522303393;6311.368863113652;6314.147590075373;6323.810285691345;6326.019466982625;6342.873142537216;6199.845003874939;6344.6827658616885;6422.42198202164;6425.807225783141;6430.453411459985;6067.150598916155;6347.920853454923;6348.650824204713;6352.396522330371;6356.968215158987;6217.564770466114;6244;6325.493960483151;6331.715072821734;6333.714982825692;4339.327404252346;5119.334486516729;5120.667156634807;5121.4878512149235;5127.435982041972;4559.726416415026;4562.224421848294;4577.450705915311;4606.631469482433;4628.861134165981;5744.798932037359;5832.329282132524;5839.357670656224;5958.255218097738;6065.727042283108;6366.522510811707;6398.584092034003;6404.199475065617;6422.967885160544;6425.839354016187;6049;6093.451589356979;6095.207623008981;6114.908276375858;6118.479929206067;5432.59255555827;5510.889782204334;5516.779328826802;5521.254630624894;5593.720313984284;6421.8715625688155;6462.224533056064;6498.870022599522;6522.967385163044;6562.868742625216;6397.808065758035;6401.583897046677;6415.935840641534;6420.3258657842125;6430.678466076584;6320;6627.6354800484505;6628.966855165693;6638.402543771083;6641.767538136142;5277.8416647500635;6226.034964580497;6343.302236754045;6372.235331760218;6374.904376434264;6383.042543618494;6410.551261411656;6419.101325814483;6422.710978005907;6529.5102867284195;5616.326040875121;6053.606515576474;6323.36766323364;6335.1130841683125;6347.587406818542;6115.816525504242;6190.876182476235;6194.845128871634;6223.844403889939;6352.205974253218;6241.469475094486;6272.937270627418;6274.466670333073;6278.246610406598;6279.811605651837;6319.178506794087;6328.588641738273;6337.176167098248;6344.651044192614;6347.936520634919;6042.365551617193;6103.337669688754;6133.619935514474;6154.015357542772;6277.623342599459 13:21:41 INFO - 2015-11-18 13:21:41,313 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.4538629449994;562.3055526424865;584.3863942859998;610.9144719739236;632.0329895260251;32109.83945080274;41818;42637.93405164872;42746;42766.78616606916;44743;44996.77501612488;45239.32141017879;45312.54687453125;45361.86595335118;8926.241269492068;9021.594028268712;9941.254405919548;10103.545340459661;10133.03736145065;12110.333931633757;12349.629511114681;12356.876431235707;12368.567100151451;12368.628941131736;12125.818112728317;12152.574659886906;12184.878151218463;12206.96240819527;12219.450124744364;9076.682316118937;9134.588943497558;12096.576619818308;12194.756104877853;12346.876531234662;11976.101792365607;12101.576444824388;12121.818172727417;12124.636260912186;12150.635480935585;43002.56997430017;43430;43435.78282108601;43475.13049739019;43530.78234608807;3273.5253388258807;3287.4056082799825;3301.323228738127;3636.4181730922924;3818.7517811342173;29750.256243593867;29911.551326730118;29942;30328.090157295315;30428.69571304281;2624.134035768192;2638.56463683492;2676.330917270682;2751.0247692084945;2781.5966684830787;511703;512251;513196.4340178312;514213.4289328567;514993;56580.43419565834;58449.831003379695;58459.415405846245;66242.33757662361;69305.3069469309;70114.64942675254;70744;70979.6451017752;70999;71145.6442717783;16783.412580559867;16926.57683557921;16931;16981.981081134923;17033.40383086586;12797.168184068007;12853.036022298365;12857.228566286052;12885.162464439969;12982.156159849768;21150.153993840075;21436.356909292746;21451.67822482664;21470;21525.892370538048;7544.509606875646;8796.208341249318;9014.414063085878;9018.819623607491;9093.863592046124;977.6187286958092;988.3476905242505;997.0706682569252;999.835027220515;1022.8005538919839;30013;30175.245618859703;30730.078097657108;30731.2317192072;30947;1165.4405885175163;1177.935213563245;1242.5092088625124;1257.4467234416827;1281.1992504684572;14435.49475768364;15485.767713484081;15708.33601576778;15734.9213253933;16079;547575;551874;551916;552345.7148142781;554874;61612.69193654003;61674.69162654248;61815.145545633706;61874.381256187764;61933;1133.2633788037842;1362.3120324236197;1365.215001374214;1460.1968917095555;1491.7687758397465;30987.845060775453;31156.532652009784;31171.90898318548;31596.368072638877;31753.20616984594;52939.47060529499;53586;53596.1960570584;53604;53695.46304536905;407862;501406;508984;545154;552534;31147.377052459276;31272;31360.215994600316;31372.529412058382;31458.528122078646;43552.78223608862;44084.779576101915;44156.779216103714;44622.55377446184;45299;29597.704022959493;36517.63482365249;36955;37320.62679373172;37425.43861842129;37517.81241093777;37574.24851503009;38457;38541.80729096336;38583.42124868073;30351.696483035772;35603.93188204358;37887.242255155295;38420.6157938417;38534.80732596319;28105.71894281031;29934.700652994063;31434.371312573163;34354;34406.311873761886;23618.29145125649;25379.492410152063;25749.227523174333;25797.3550661235;26038.08866689657 13:21:41 INFO - 2015-11-18 13:21:41,313 DEBUG : BROWSER_OUTPUT: |2;jquery.html;362.5142309305532;364.77201748906936;367.78668372344043;368.27449923650414;368.7658336956033;10906.727331816708;11247.212695111346;12558.246505209683;12954.805677914826;18832.05839708014;10609.893901060987;11263.324200547973;12574.748505029895;12645.430955606997;12649.810252846191;4573.336866154414;4832.444268909086;4833.275008748681;4834.661573689843;4836.685615434985;3653.7442379033478;3736.1967177056927;3739.9626003740022;3743.88768336949;4781.760911954406;3705.3515634763944;4314.417553630266;5187.144121219994;5192.818251361203;5200.089984252741;4958.281049247857;5084.77118529667;5099.5410413063;5151.922721159186;5166.535011848933;4218.409422680827;4226.957730422687;4229.598188172119;4288.635465985395;4289.549597292271;14036.649083772885;14218.862491000695;14569.49006784768;14664.340104695208;14685;1978.6339527187372;1983.0481368942988;2027.5539381336082;2124.0972586650764;2182.552576721768;9275.907240927572;9486.33595648305;10336.94831525845;10413.323133996266;10504.422256775873;1598.9459241243676;1598.9760153597706;1608.7068777184218;1645.654412573361;1684.0623668064227;85548;85941.57029214814;86243.70634440488;86502.56748716216;89912;5743.569232307594;6788.117544719254;6831.69257383419;6845.14435695538;6876.349676077805;7812.257835505618;7813.804654883674;7814.257645523666;7818.335441487424;7841.411894107965;5796.101604251347;5797.884042319214;5810.535157187415;5849.532037436995;5854.414558544197;6226.844328891723;6293.30773614902;6309.747610095545;6330.588511746721;6363.96818015907;3089.7528197744127;3100.953485697716;3104.7516198704047;3124.9687503125133;3131.01373067483;1045.4093437207953;1059.1050562274866;1079.6329248055542;1081.897219764137;1165.2891736041008;414.70763112005966;437.9671524635665;448.34317724533713;449.5931182280042;452.5971885022333;11892.643220703392;12311.26132432039;12313.322767247888;12355.135140540076;12375.195612285173;446.17012357015926;470.8987567672967;473.39641956505045;480.1549273279054;498.8478514053176;5787.305523337226;6419.646919419477;6487.690214029444;6526.34736526353;6632.336766323329;749749;752048;755680;770037;794900;113770;118200;118492;118635.40682296533;120889;518.4996478398364;536.6833568194784;537.854779209619;537.9973100134553;539.3016044222741;9041.954790226007;11822.822657660314;11824.586139485076;12007;12307.138500304893;46127.308090379345;46778.36275730469;47336;47525.81185470391;48760.2685959718;67148.6642566784;70643.64678176577;71966;72132.27867721465;73031.63484182545;6386.489080873426;6470.288268290578;6496.610203387811;6498.480121590167;6502.804915852532;12279.140460167702;12375.257484550955;12582.748345032865;12607;12619.621411357673;8811.779705507413;9210.677626283048;9366.391184572982;10635.989580989793;11089.722756931142;10589.258751887293;10601.734956626146;10711.196660250356;10737.463126843782;11046.502907369348;8013.759587212393;10925.726856828644;11176.27354221973;11294.378809165575;11301.321920684784;6476.481881449378;6479.449246814073;6484.870302594016;6489.253735820441;6507.414332710079;10628.84056739165;10884.346939183675;10914.399708016135;10965.287256328313;11052.723681908017 13:21:41 INFO - 2015-11-18 13:21:41,317 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1658.146054781787;1745.5461579989199;1814.292425953878;1927.431407734718;1939.7575303087106;6704.731810727571;7667.61661916904;7668.96165519173;8084.312833409167;8238.752837414871;8013.519188848673;8120.878186827203;8122.1877812218745;8125.431219814615;8128.30909372704;2332.6151185054487;2363.9645405318934;2364.6334818103223;2364.9408764780846;2367.810575153992;2367.9052837886466;2372.383180373107;2414.6619473273754;2416.5770990076753;2419.0565679385054;2330.3009097270838;2358.2807243790635;2359.6460530920413;2362.173239366225;2377.524495100978;2348.3072493614427;2369.869657168855;2385.8091352691745;2386.916457923964;2390.3904504351367;2355.1639168095253;2385.677933478993;2396.1852969990114;2397.113068164773;2399.4841109161616;8111.716089936824;8143.429959902809;8161.265486106219;8164.795880102985;8183.79540511486;4204.579542045802;4425.402570652953;4714.198586240347;4985.426675932242;5163.63854530183;2919.284775230061;3492.6856582907662;3536.8938931832085;3542.167590616203;3562.590302115264;1049.7113293844177;1053.1785207538132;1086.000879191146;1633.9264733087039;1656.1884676508544;10716.303440276357;10799.298045627087;10802.5678972841;10846.78306433867;10856.34861908288;4349.391085248068;4361;4414.205443020287;4440.622547083534;4445.1998640245065;8831.735047948572;8840.778980525538;8845.380823342304;8854.158854908774;8866;5008.899822003539;5015.724135172601;5015.874603134951;5016.874578135503;5020.598352131894;4623.42207224097;4653.092646933816;4660.6970546914345;4669;4669.626429885601;3501.9299614007577;3567.23304489536;3596.5973270424556;3602.819859007039;3603.0992251937014;966.7728083900278;1151.867535233459;1155.9711007224887;1157.560127151694;1160.4255893332686;1124.4602590756483;1316.5457917018614;1333.3466601365456;1376.9793453098212;1379.2138481065697;7634.274743899321;7749.961250193825;7752.612369381621;7762.495437796525;7773.611319434006;1181.2321990705939;1198.8621308549455;1199.4602428907026;1219.5121951219583;1241.509603706549;5793.710314484259;5923.822285331447;6141.570090093651;6187.226596675416;6187.412195841478;9247;9353.579088941015;9645;9758.46328451942;9774.902250977399;9311.72064838056;9577.808443831085;9748.26887983404;9779.168770654433;9788.972157923457;7683.884741728879;7756.883646745417;7805.985221921114;7814.335781458526;7820.882686759704;7588.27911348421;7624.69501219945;7641.1212710539;7690.846183076419;7702.845943080995;8635.6977505787;8813.91186088131;8821;8902.243309318521;8977.416467929565;9052.864207036768;9058.00361960197;9143.039980802187;9274.258059355101;9277.582508787256;7138.143422789299;7167.605781682058;7196.9640151801;7228.060352154186;7229.457790665616;7848.979632647719;7874.370050396069;7886.369090472634;7890.526568405914;7896;7279.162896266997;7309.926900730925;7313.67088481009;7398.482106252511;7461.253874612496;7139.178994415709;7177.928220717726;7207.8558428832175;7265.019222404908;7309.5248808827255;7256.310650488406;7290.015847860471;7335.266473352622;7340;7358.448116391185;6731.495137864582;6763.140136462513;6763.526553141233;6765.966170169315;6772.86454270902;6714.294999025227;6770.458363330823;6806.455483561403;6809;6809.421199198124 13:21:41 INFO - 2015-11-18 13:21:41,317 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.1851288470842;326.3603337458581;328.54660568415613;332.9417351963406;333.5213967955983;6685.899711504331;6715.462762978962;6723.428508576771;6761.695723692434;6785.898211526831;6644.933550664492;6645.136132302806;6655.966720166392;6659.966700166505;6684.231313398961;4858.829940952068;4998.400191976968;5005.474425185358;5006.374203224597;5020.071286811952;4037.172379662177;4156.958430415702;4848.636352273594;4949.307097006422;4985.52637499437;4887.1447496688115;4908.116539022974;4929.926051109236;4944.233643785219;4945;4652.837150699726;4764.761761911891;4775.498572649856;4910.140725373063;4910.41075070992;4095.5494895561465;4117.938230926538;4225.72532785368;4236.449261596003;4266.935995960063;6383.680815959184;6392.968035159841;6393.488520918316;6447.742090316382;6454.451371633417;5578.897767655529;5607.80372686954;5885.146653735184;5888.4700376966275;5891.528677705774;7004.229534751174;7258.165310989199;7268.45486588508;7270.781876543712;7316.414686825041;4708.364370809931;4728.66899317048;4736.9526304736855;4738.265568836836;4744.4069491313585;7421.814454638623;7665.923340766577;7673.923260767377;7674;7675.923240767633;4802.159622066194;4853.150698627726;4854.563089321978;4886.144924638245;4893.926591101136;4342.609165175149;4817.397825271841;4949.90100197994;4976.950230497721;4986.401631804134;5884.529237660977;5888.705564721747;5890.322612899486;5906.822795316148;5909.965755992684;6108.847278818065;7046.6476676165985;7085.362317391357;7223.277672232734;7274.345308922222;1719.6388758360883;1742;1742.8344307290788;1743.2044993656555;1743.8692098092695;1121.62986214549;1124.8031594470935;1139.9658010259704;1145.0839328537138;1150.263831148066;6727.899081513781;6734.393904548516;6748.527603067738;6752.797416077526;6753;7481.177070522238;7481.289277518627;7489.775306740807;7493.587852668046;7498.32515073646;6532.608043517404;6681.098051763047;6723.932760672331;6737.023131645884;6743.629100399525;3957.9010524737114;3969.186316805048;3972.3644216925154;3975.7018223632763;3977.463042489227;7748.845023099507;7756.844863102707;7759.72840950564;7764.961175194087;7773.028371453568;6218.968905155445;7478.887816682754;7501.099868015873;7603.695852165852;7704.691812327556;7654.464187506933;7713.267239612228;7863.488873223222;7876;7891.960540197262;7483.914832349387;7537.886931695919;7540.698372065275;7543.170251272465;7548;6238.500919926304;7234.74678386254;7311.122665280201;7436.330730234088;7445.813854653677;7811.218878112143;7821.491603045783;7823.452358334862;7833.060032796101;7854.253845884632;4869;4875.780589873535;4876.341693871282;4884.3650325457465;4885.731284779371;7258.237885022208;7523.172451030273;7539.396848252236;7544.245575442412;7550.35821955118;6605.44771978575;7222.855542889218;7241.167265764294;7251.383632391306;7254.927450725425;5696.772129114789;5879.823605291848;5985.371535988658;7015.789526314219;7218.566885986857;7103.893441598277;7110.146782386147;7120.857582848417;7122.465815063787;7137.678804453708;6240.469560087262;6879.759208427681;7232.89150662751;7251.093613298338;7254.528455650366;6923.4807389447;7107.182673992557;7107.253738357398;7146.285371462812;7151.964240178766 13:21:41 INFO - 2015-11-18 13:21:41,320 DEBUG : BROWSER_OUTPUT: |5;yui.html;719.697726954679;747.7382915979408;789.5657388436358;820.7701843483825;839.0979696825906;15030.94783365165;15369.92315038426;15407.537773866788;15412.537623871274;15416.152111633855;14304.998650094498;14371.856281437182;14390.568282951503;14405;14424.278786060708;752.0636807175075;769.5575044349494;770.3413581387916;771.972980945667;773.5204173412465;752.5371896283773;949.1268033409245;971.519098046468;975.229568640773;977.1010670183413;961.5192403798101;1018.0379541333443;1018.4296793795461;1019.1999280564759;1019.5463018956567;787.8503084413943;799.4443861516248;800.9479383840031;981.5337714585586;1013.3312014070715;586.7183751799117;594.6996766632823;740.4631642059463;758.4311766175368;760.1941941541928;15072.321745521478;15281.465148719853;15287.923560382238;15312.693746125127;15316.923415382851;10449.47752612374;12525.686857828627;12947;13181.011424143227;13417.127886687334;9836.90163098367;9903.80192396148;9921.50392480373;9997.800043999152;10530.473476326153;3154.3218208085373;3231.9030429087165;3233.030090972699;3234.951475727866;3237.045071703853;70564.58870822555;71664;71773.64113179401;72325.63837180832;72499.63750181269;7214.458915581353;7254.455915806336;7306.561606303639;7328.193898671142;7412.258774122544;12749.617511474671;12756.93621531905;12758.170718903428;12758.80861787074;12774.23354598727;6533.673316334164;6540.4767618590395;6726.495512836557;6859.9314006860295;6942.757003504853;3992.5608183099835;4088.366303223005;4097.160082183145;4103.753774773523;4109.301418758818;3179.0145055032554;3201.2317043909293;3204.295055087877;3205.4230238556815;3206.551082848403;477.5296333111882;492.15349598690193;496.5655051829649;497.8431793984956;508.31631455692036;483.494747988353;490.91409003424974;494.7031780931412;504.61569086068033;514.9356330458693;7943.364530837519;8021.558814265271;8352.624131914079;8353.415260931677;8426.957865210634;455.6924076248519;472.07002205655493;479.56838845039044;526.7892842862885;532.0449792622252;3813.733038687321;3847.8845634631007;3923;4028.60097855922;4233.428487154195;102715.48642256741;103576;103869.48065259625;103913.48043259735;104469.47765261125;67740.95165717555;85507.5724621373;85953.14046859452;89716.10283897078;90051.64922526167;72033;72112.99999999895;72673.63663181651;74864.62567687235;76044.098897528;7401.481896267425;7671.695811712134;8337.583120843812;8487.78780530467;8496.06543280251;48955.75522122509;49321.50678493169;53027.878884844176;53467;53597.19604206018;68328.3167168322;68840.08339040873;69177;69808;71827;7438.814029649086;7551.471397002157;7656.349210317186;7772.7668169954995;7883.329916957123;11167.553297868319;11303.434828258718;11412.201145919706;11443.198976071595;11487.483063262007;10796.622118225825;10835.349879007284;10850.511726972147;10862.674119776419;10863;10727.731806704895;10738.785224295627;10743.892561074603;10803.621873234399;10828.675139745821;9500.382475139093;10593.470326483492;10597.41714205726;10661.840072398765;10880.836787448354;8646.221840034426;9438.764030899283;9788.9021109788;10151.187904967437;10215.489225538842;9639.095941328043;9979.32803666166;10007.349522281029;10197.54111064989;10207.234457415576 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1070 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: __startTimestamp1447881701306__endTimestamp 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,321 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5894.58 Median:6157.48 stddev:669.89 (10.9%) stddev-sans-first:643.45 13:21:41 INFO - 2015-11-18 13:21:41,322 DEBUG : BROWSER_OUTPUT: Values: 3430.6 3553.6 3577.4 3578.9 3611.4 5708.1 5892.6 6011.0 6019.2 6037.6 4803.3 5831.2 5961.1 5971.6 6138.2 5331.9 5351.2 5353.4 5378.4 5447.3 4949.0 5468.8 5502.1 5525.1 5562.3 5195.3 5292.8 5309.8 5415.9 5455.5 4129.5 5363.0 5375.1 5382.2 5385.9 5370.9 5373.7 5381.1 5393.2 5395.6 5814.6 5825.5 5834.6 5835.2 5838.3 6218.2 6283.8 6288.5 6295.5 6298.7 6310.0 6343.8 6354.2 6358.2 6362.7 5889.1 5995.1 6157.5 6169.5 6183.2 5310.4 6406.3 6568.6 6581.9 6592.5 6311.4 6314.1 6323.8 6326.0 6342.9 6199.8 6344.7 6422.4 6425.8 6430.5 6067.2 6347.9 6348.7 6352.4 6357.0 6217.6 6244.0 6325.5 6331.7 6333.7 4339.3 5119.3 5120.7 5121.5 5127.4 4559.7 4562.2 4577.5 4606.6 4628.9 5744.8 5832.3 5839.4 5958.3 6065.7 6366.5 6398.6 6404.2 6423.0 6425.8 6049.0 6093.5 6095.2 6114.9 6118.5 5432.6 5510.9 5516.8 5521.3 5593.7 6421.9 6462.2 6498.9 6523.0 6562.9 6397.8 6401.6 6415.9 6420.3 6430.7 6320.0 6627.6 6629.0 6638.4 6641.8 5277.8 6226.0 6343.3 6372.2 6374.9 6383.0 6410.6 6419.1 6422.7 6529.5 5616.3 6053.6 6323.4 6335.1 6347.6 6115.8 6190.9 6194.8 6223.8 6352.2 6241.5 6272.9 6274.5 6278.2 6279.8 6319.2 6328.6 6337.2 6344.7 6347.9 6042.4 6103.3 6133.6 6154.0 6277.6 13:21:41 INFO - 2015-11-18 13:21:41,322 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,322 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:67285.68 Median:34380.16 stddev:139352.08 (405.3%) stddev-sans-first:139652.93 13:21:41 INFO - 2015-11-18 13:21:41,323 DEBUG : BROWSER_OUTPUT: Values: 554.5 562.3 584.4 610.9 632.0 32109.8 41818.0 42637.9 42746.0 42766.8 44743.0 44996.8 45239.3 45312.5 45361.9 8926.2 9021.6 9941.3 10103.5 10133.0 12110.3 12349.6 12356.9 12368.6 12368.6 12125.8 12152.6 12184.9 12207.0 12219.5 9076.7 9134.6 12096.6 12194.8 12346.9 11976.1 12101.6 12121.8 12124.6 12150.6 43002.6 43430.0 43435.8 43475.1 43530.8 3273.5 3287.4 3301.3 3636.4 3818.8 29750.3 29911.6 29942.0 30328.1 30428.7 2624.1 2638.6 2676.3 2751.0 2781.6 511703.0 512251.0 513196.4 514213.4 514993.0 56580.4 58449.8 58459.4 66242.3 69305.3 70114.6 70744.0 70979.6 70999.0 71145.6 16783.4 16926.6 16931.0 16982.0 17033.4 12797.2 12853.0 12857.2 12885.2 12982.2 21150.2 21436.4 21451.7 21470.0 21525.9 7544.5 8796.2 9014.4 9018.8 9093.9 977.6 988.3 997.1 999.8 1022.8 30013.0 30175.2 30730.1 30731.2 30947.0 1165.4 1177.9 1242.5 1257.4 1281.2 14435.5 15485.8 15708.3 15734.9 16079.0 547575.0 551874.0 551916.0 552345.7 554874.0 61612.7 61674.7 61815.1 61874.4 61933.0 1133.3 1362.3 1365.2 1460.2 1491.8 30987.8 31156.5 31171.9 31596.4 31753.2 52939.5 53586.0 53596.2 53604.0 53695.5 407862.0 501406.0 508984.0 545154.0 552534.0 31147.4 31272.0 31360.2 31372.5 31458.5 43552.8 44084.8 44156.8 44622.6 45299.0 29597.7 36517.6 36955.0 37320.6 37425.4 37517.8 37574.2 38457.0 38541.8 38583.4 30351.7 35603.9 37887.2 38420.6 38534.8 28105.7 29934.7 31434.4 34354.0 34406.3 23618.3 25379.5 25749.2 25797.4 26038.1 13:21:41 INFO - 2015-11-18 13:21:41,323 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,323 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:35938.54 Median:442.07 stddev:126061.58 (28516.3%) stddev-sans-first:126386.90 13:21:41 INFO - 2015-11-18 13:21:41,324 DEBUG : BROWSER_OUTPUT: Values: 362.5 364.8 367.8 368.3 368.8 10906.7 11247.2 12558.2 12954.8 18832.1 10609.9 11263.3 12574.7 12645.4 12649.8 4573.3 4832.4 4833.3 4834.7 4836.7 3653.7 3736.2 3740.0 3743.9 4781.8 3705.4 4314.4 5187.1 5192.8 5200.1 4958.3 5084.8 5099.5 5151.9 5166.5 4218.4 4227.0 4229.6 4288.6 4289.5 14036.6 14218.9 14569.5 14664.3 14685.0 1978.6 1983.0 2027.6 2124.1 2182.6 9275.9 9486.3 10336.9 10413.3 10504.4 1598.9 1599.0 1608.7 1645.7 1684.1 85548.0 85941.6 86243.7 86502.6 89912.0 5743.6 6788.1 6831.7 6845.1 6876.3 7812.3 7813.8 7814.3 7818.3 7841.4 5796.1 5797.9 5810.5 5849.5 5854.4 6226.8 6293.3 6309.7 6330.6 6364.0 3089.8 3101.0 3104.8 3125.0 3131.0 1045.4 1059.1 1079.6 1081.9 1165.3 414.7 438.0 448.3 449.6 452.6 11892.6 12311.3 12313.3 12355.1 12375.2 446.2 470.9 473.4 480.2 498.8 5787.3 6419.6 6487.7 6526.3 6632.3 749749.0 752048.0 755680.0 770037.0 794900.0 113770.0 118200.0 118492.0 118635.4 120889.0 518.5 536.7 537.9 538.0 539.3 9042.0 11822.8 11824.6 12007.0 12307.1 46127.3 46778.4 47336.0 47525.8 48760.3 67148.7 70643.6 71966.0 72132.3 73031.6 6386.5 6470.3 6496.6 6498.5 6502.8 12279.1 12375.3 12582.7 12607.0 12619.6 8811.8 9210.7 9366.4 10636.0 11089.7 10589.3 10601.7 10711.2 10737.5 11046.5 8013.8 10925.7 11176.3 11294.4 11301.3 6476.5 6479.4 6484.9 6489.3 6507.4 10628.8 10884.3 10914.4 10965.3 11052.7 13:21:41 INFO - 2015-11-18 13:21:41,324 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,324 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5690.44 Median:6722.90 stddev:2885.42 (42.9%) stddev-sans-first:2877.60 13:21:41 INFO - 2015-11-18 13:21:41,325 DEBUG : BROWSER_OUTPUT: Values: 1658.1 1745.5 1814.3 1927.4 1939.8 6704.7 7667.6 7669.0 8084.3 8238.8 8013.5 8120.9 8122.2 8125.4 8128.3 2332.6 2364.0 2364.6 2364.9 2367.8 2367.9 2372.4 2414.7 2416.6 2419.1 2330.3 2358.3 2359.6 2362.2 2377.5 2348.3 2369.9 2385.8 2386.9 2390.4 2355.2 2385.7 2396.2 2397.1 2399.5 8111.7 8143.4 8161.3 8164.8 8183.8 4204.6 4425.4 4714.2 4985.4 5163.6 2919.3 3492.7 3536.9 3542.2 3562.6 1049.7 1053.2 1086.0 1633.9 1656.2 10716.3 10799.3 10802.6 10846.8 10856.3 4349.4 4361.0 4414.2 4440.6 4445.2 8831.7 8840.8 8845.4 8854.2 8866.0 5008.9 5015.7 5015.9 5016.9 5020.6 4623.4 4653.1 4660.7 4669.0 4669.6 3501.9 3567.2 3596.6 3602.8 3603.1 966.8 1151.9 1156.0 1157.6 1160.4 1124.5 1316.5 1333.3 1377.0 1379.2 7634.3 7750.0 7752.6 7762.5 7773.6 1181.2 1198.9 1199.5 1219.5 1241.5 5793.7 5923.8 6141.6 6187.2 6187.4 9247.0 9353.6 9645.0 9758.5 9774.9 9311.7 9577.8 9748.3 9779.2 9789.0 7683.9 7756.9 7806.0 7814.3 7820.9 7588.3 7624.7 7641.1 7690.8 7702.8 8635.7 8813.9 8821.0 8902.2 8977.4 9052.9 9058.0 9143.0 9274.3 9277.6 7138.1 7167.6 7197.0 7228.1 7229.5 7849.0 7874.4 7886.4 7890.5 7896.0 7279.2 7309.9 7313.7 7398.5 7461.3 7139.2 7177.9 7207.9 7265.0 7309.5 7256.3 7290.0 7335.3 7340.0 7358.4 6731.5 6763.1 6763.5 6766.0 6772.9 6714.3 6770.5 6806.5 6809.0 6809.4 13:21:41 INFO - 2015-11-18 13:21:41,325 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,325 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5878.23 Median:6650.55 stddev:1869.34 (28.1%) stddev-sans-first:1827.45 13:21:41 INFO - 2015-11-18 13:21:41,326 DEBUG : BROWSER_OUTPUT: Values: 320.2 326.4 328.5 332.9 333.5 6685.9 6715.5 6723.4 6761.7 6785.9 6644.9 6645.1 6656.0 6660.0 6684.2 4858.8 4998.4 5005.5 5006.4 5020.1 4037.2 4157.0 4848.6 4949.3 4985.5 4887.1 4908.1 4929.9 4944.2 4945.0 4652.8 4764.8 4775.5 4910.1 4910.4 4095.5 4117.9 4225.7 4236.4 4266.9 6383.7 6393.0 6393.5 6447.7 6454.5 5578.9 5607.8 5885.1 5888.5 5891.5 7004.2 7258.2 7268.5 7270.8 7316.4 4708.4 4728.7 4737.0 4738.3 4744.4 7421.8 7665.9 7673.9 7674.0 7675.9 4802.2 4853.2 4854.6 4886.1 4893.9 4342.6 4817.4 4949.9 4977.0 4986.4 5884.5 5888.7 5890.3 5906.8 5910.0 6108.8 7046.6 7085.4 7223.3 7274.3 1719.6 1742.0 1742.8 1743.2 1743.9 1121.6 1124.8 1140.0 1145.1 1150.3 6727.9 6734.4 6748.5 6752.8 6753.0 7481.2 7481.3 7489.8 7493.6 7498.3 6532.6 6681.1 6723.9 6737.0 6743.6 3957.9 3969.2 3972.4 3975.7 3977.5 7748.8 7756.8 7759.7 7765.0 7773.0 6219.0 7478.9 7501.1 7603.7 7704.7 7654.5 7713.3 7863.5 7876.0 7892.0 7483.9 7537.9 7540.7 7543.2 7548.0 6238.5 7234.7 7311.1 7436.3 7445.8 7811.2 7821.5 7823.5 7833.1 7854.3 4869.0 4875.8 4876.3 4884.4 4885.7 7258.2 7523.2 7539.4 7544.2 7550.4 6605.4 7222.9 7241.2 7251.4 7254.9 5696.8 5879.8 5985.4 7015.8 7218.6 7103.9 7110.1 7120.9 7122.5 7137.7 6240.5 6879.8 7232.9 7251.1 7254.5 6923.5 7107.2 7107.3 7146.3 7152.0 13:21:41 INFO - 2015-11-18 13:21:41,327 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,327 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18233.39 Median:497.20 stddev:26984.48 (5427.2%) stddev-sans-first:27028.14 13:21:41 INFO - 2015-11-18 13:21:41,328 DEBUG : BROWSER_OUTPUT: Values: 719.7 747.7 789.6 820.8 839.1 15030.9 15369.9 15407.5 15412.5 15416.2 14305.0 14371.9 14390.6 14405.0 14424.3 752.1 769.6 770.3 772.0 773.5 752.5 949.1 971.5 975.2 977.1 961.5 1018.0 1018.4 1019.2 1019.5 787.9 799.4 800.9 981.5 1013.3 586.7 594.7 740.5 758.4 760.2 15072.3 15281.5 15287.9 15312.7 15316.9 10449.5 12525.7 12947.0 13181.0 13417.1 9836.9 9903.8 9921.5 9997.8 10530.5 3154.3 3231.9 3233.0 3235.0 3237.0 70564.6 71664.0 71773.6 72325.6 72499.6 7214.5 7254.5 7306.6 7328.2 7412.3 12749.6 12756.9 12758.2 12758.8 12774.2 6533.7 6540.5 6726.5 6859.9 6942.8 3992.6 4088.4 4097.2 4103.8 4109.3 3179.0 3201.2 3204.3 3205.4 3206.6 477.5 492.2 496.6 497.8 508.3 483.5 490.9 494.7 504.6 514.9 7943.4 8021.6 8352.6 8353.4 8427.0 455.7 472.1 479.6 526.8 532.0 3813.7 3847.9 3923.0 4028.6 4233.4 102715.5 103576.0 103869.5 103913.5 104469.5 67741.0 85507.6 85953.1 89716.1 90051.6 72033.0 72113.0 72673.6 74864.6 76044.1 7401.5 7671.7 8337.6 8487.8 8496.1 48955.8 49321.5 53027.9 53467.0 53597.2 68328.3 68840.1 69177.0 69808.0 71827.0 7438.8 7551.5 7656.3 7772.8 7883.3 11167.6 11303.4 11412.2 11443.2 11487.5 10796.6 10835.3 10850.5 10862.7 10863.0 10727.7 10738.8 10743.9 10803.6 10828.7 9500.4 10593.5 10597.4 10661.8 10880.8 8646.2 9438.8 9788.9 10151.2 10215.5 9639.1 9979.3 10007.3 10197.5 10207.2 13:21:41 INFO - 2015-11-18 13:21:41,328 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:21:41 INFO - 2015-11-18 13:21:41,328 DEBUG : BROWSER_OUTPUT: 13:21:41 INFO - 2015-11-18 13:21:41,733 INFO : Browser exited with error code: 0 13:21:41 INFO - 2015-11-18 13:21:41,756 INFO : Completed test dromaeo_css (00:18:33) 13:21:41 INFO - 2015-11-18 13:21:41,756 INFO : Starting test kraken 13:21:41 INFO - 2015-11-18 13:21:41,757 DEBUG : operating with platform_type : mac_ 13:21:41 INFO - 2015-11-18 13:21:41,757 INFO : Initialising browser for kraken test... 13:21:41 INFO - 2015-11-18 13:21:41,769 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpbLX0QP/profile http://localhost:49264/getInfo.html 13:21:43 INFO - 2015-11-18 13:21:43,763 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:21:43 INFO - 2015-11-18 13:21:43,763 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:21:43 INFO - 2015-11-18 13:21:43,763 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:21:43 INFO - 2015-11-18 13:21:43,763 DEBUG : BROWSER_OUTPUT: __metrics 13:21:43 INFO - 2015-11-18 13:21:43,781 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:21:44 INFO - 2015-11-18 13:21:44,039 DEBUG : BROWSER_OUTPUT: console.error: 13:21:44 INFO - 2015-11-18 13:21:44,040 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 13:21:44 INFO - 2015-11-18 13:21:44,040 DEBUG : BROWSER_OUTPUT: Stack: 13:21:44 INFO - 2015-11-18 13:21:44,040 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 13:21:44 INFO - 2015-11-18 13:21:44,041 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 13:21:44 INFO - 2015-11-18 13:21:44,042 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 13:21:44 INFO - 2015-11-18 13:21:44,042 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 13:21:44 INFO - 2015-11-18 13:21:44,042 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 13:21:44 INFO - 2015-11-18 13:21:44,042 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 13:21:44 INFO - 2015-11-18 13:21:44,042 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 13:21:44 INFO - 2015-11-18 13:21:44,042 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 13:21:44 INFO - 2015-11-18 13:21:44,042 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 13:21:44 INFO - 2015-11-18 13:21:44,043 DEBUG : BROWSER_OUTPUT: 13:21:44 INFO - 2015-11-18 13:21:44,435 INFO : Browser initialized. 13:21:44 INFO - 2015-11-18 13:21:44,436 INFO : Running cycle 1/1 for kraken test... 13:21:44 INFO - 2015-11-18 13:21:44,436 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpbLX0QP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:21:56 INFO - 2015-11-18 13:21:56,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 225841152 13:21:56 INFO - 2015-11-18 13:21:56,223 DEBUG : BROWSER_OUTPUT: 13:21:58 INFO - 2015-11-18 13:21:58,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 13:21:59 INFO - 2015-11-18 13:21:59,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 276041728 13:21:59 INFO - 2015-11-18 13:21:59,334 DEBUG : BROWSER_OUTPUT: 13:22:01 INFO - 2015-11-18 13:22:01,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 13:22:02 INFO - 2015-11-18 13:22:02,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 289378304 13:22:02 INFO - 2015-11-18 13:22:02,551 DEBUG : BROWSER_OUTPUT: 13:22:05 INFO - 2015-11-18 13:22:05,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 13:22:06 INFO - 2015-11-18 13:22:06,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 277495808 13:22:06 INFO - 2015-11-18 13:22:06,337 DEBUG : BROWSER_OUTPUT: 13:22:08 INFO - 2015-11-18 13:22:08,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 13:22:08 INFO - 2015-11-18 13:22:08,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 279076864 13:22:08 INFO - 2015-11-18 13:22:08,881 DEBUG : BROWSER_OUTPUT: 13:22:10 INFO - 2015-11-18 13:22:10,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:22:11 INFO - 2015-11-18 13:22:11,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 280625152 13:22:11 INFO - 2015-11-18 13:22:11,462 DEBUG : BROWSER_OUTPUT: 13:22:14 INFO - 2015-11-18 13:22:14,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 13:22:14 INFO - 2015-11-18 13:22:14,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 280756224 13:22:14 INFO - 2015-11-18 13:22:14,794 DEBUG : BROWSER_OUTPUT: 13:22:17 INFO - 2015-11-18 13:22:17,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 13:22:18 INFO - 2015-11-18 13:22:18,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 281784320 13:22:18 INFO - 2015-11-18 13:22:18,158 DEBUG : BROWSER_OUTPUT: 13:22:20 INFO - 2015-11-18 13:22:20,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 13:22:21 INFO - 2015-11-18 13:22:21,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 281243648 13:22:21 INFO - 2015-11-18 13:22:21,516 DEBUG : BROWSER_OUTPUT: 13:22:23 INFO - 2015-11-18 13:22:23,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:23 INFO - 2015-11-18 13:22:23,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 313851904 13:22:23 INFO - 2015-11-18 13:22:23,610 DEBUG : BROWSER_OUTPUT: 13:22:25 INFO - 2015-11-18 13:22:25,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:25 INFO - 2015-11-18 13:22:25,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 314028032 13:22:25 INFO - 2015-11-18 13:22:25,997 DEBUG : BROWSER_OUTPUT: 13:22:28 INFO - 2015-11-18 13:22:28,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:28 INFO - 2015-11-18 13:22:28,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 322412544 13:22:28 INFO - 2015-11-18 13:22:28,759 DEBUG : BROWSER_OUTPUT: 13:22:31 INFO - 2015-11-18 13:22:31,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:31 INFO - 2015-11-18 13:22:31,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 324599808 13:22:31 INFO - 2015-11-18 13:22:31,956 DEBUG : BROWSER_OUTPUT: 13:22:34 INFO - 2015-11-18 13:22:34,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:22:34 INFO - 2015-11-18 13:22:34,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 323321856 13:22:34 INFO - 2015-11-18 13:22:34,969 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 13:22:36 INFO - 2015-11-18 13:22:36,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 383033344 13:22:36 INFO - 2015-11-18 13:22:36,868 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,868 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;102;108;110;109;100;110;102;109 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;119;139;154;120;139;117;167;171;149 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |2;audio-dft;182;182;181;183;184;182;184;182;186;181 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |3;audio-fft;66;77;106;100;59;55;57;73;71;53 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;84;115;74;75;74;111;74;76;113 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;89;87;89;89;87;89;87;88;88;92 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;94;94;94;94;95;95;93;94;93 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;88;86;87;82;86;86;84;87;96;133 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;57;55;56;55;57;68;54;54 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;63;62;62;61;65;65;65;70;66 13:22:36 INFO - 2015-11-18 13:22:36,869 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;82;80;84;104;106;105;79;82 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;128;122;121;130;127;121;123;119;158 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;135;132;135;136;117;134;139;133;133 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;63;65;64;63;64;64;67;64;65 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1086 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: __startTimestamp1447881756863__endTimestamp 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.90 Median:109.00 stddev:3.93 (3.6%) stddev-sans-first:4.09 13:22:36 INFO - 2015-11-18 13:22:36,870 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 102.0 108.0 110.0 109.0 100.0 110.0 102.0 109.0 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.30 Median:148.50 stddev:19.29 (13.0%) stddev-sans-first:20.35 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: Values: 148.0 119.0 139.0 154.0 120.0 139.0 117.0 167.0 171.0 149.0 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.70 Median:182.50 stddev:1.57 (0.9%) stddev-sans-first:1.64 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: Values: 182.0 182.0 181.0 183.0 184.0 182.0 184.0 182.0 186.0 181.0 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.70 Median:62.50 stddev:18.40 (29.4%) stddev-sans-first:19.40 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: Values: 66.0 77.0 106.0 100.0 59.0 55.0 57.0 73.0 71.0 53.0 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.00 Median:74.50 stddev:17.69 (23.7%) stddev-sans-first:18.70 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 115.0 74.0 75.0 74.0 111.0 74.0 76.0 113.0 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:1.51 (1.7%) stddev-sans-first:1.59 13:22:36 INFO - 2015-11-18 13:22:36,871 DEBUG : BROWSER_OUTPUT: Values: 89.0 87.0 89.0 89.0 87.0 89.0 87.0 88.0 88.0 92.0 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 94.0 94.0 94.0 95.0 95.0 93.0 94.0 93.0 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:91.50 Median:86.50 stddev:15.03 (17.4%) stddev-sans-first:15.89 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: Values: 88.0 86.0 87.0 82.0 86.0 86.0 84.0 87.0 96.0 133.0 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:55.50 stddev:4.14 (7.5%) stddev-sans-first:4.35 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 57.0 55.0 56.0 55.0 57.0 68.0 54.0 54.0 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:65.00 stddev:2.79 (4.3%) stddev-sans-first:2.74 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: Values: 61.0 63.0 62.0 62.0 61.0 65.0 65.0 65.0 70.0 66.0 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:80.50 stddev:11.61 (14.4%) stddev-sans-first:12.02 13:22:36 INFO - 2015-11-18 13:22:36,872 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 82.0 80.0 84.0 104.0 106.0 105.0 79.0 82.0 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.00 stddev:11.28 (8.9%) stddev-sans-first:11.96 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: Values: 127.0 128.0 122.0 121.0 130.0 127.0 121.0 123.0 119.0 158.0 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.00 Median:135.00 stddev:5.96 (4.4%) stddev-sans-first:6.22 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 132.0 135.0 136.0 117.0 134.0 139.0 133.0 133.0 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 65.0 64.0 63.0 64.0 64.0 67.0 64.0 65.0 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:22:36 INFO - 2015-11-18 13:22:36,873 DEBUG : BROWSER_OUTPUT: 13:22:37 INFO - 2015-11-18 13:22:37,500 INFO : Browser exited with error code: 0 13:22:37 INFO - 2015-11-18 13:22:37,543 INFO : Completed test kraken (00:00:55) 13:22:37 INFO - 2015-11-18 13:22:37,544 INFO : Starting test v8_7 13:22:37 INFO - 2015-11-18 13:22:37,544 DEBUG : operating with platform_type : mac_ 13:22:37 INFO - 2015-11-18 13:22:37,544 INFO : Initialising browser for v8_7 test... 13:22:37 INFO - 2015-11-18 13:22:37,556 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpjVTBwc/profile http://localhost:49264/getInfo.html 13:22:39 INFO - 2015-11-18 13:22:39,669 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:22:39 INFO - 2015-11-18 13:22:39,669 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:22:39 INFO - 2015-11-18 13:22:39,669 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:22:39 INFO - 2015-11-18 13:22:39,669 DEBUG : BROWSER_OUTPUT: __metrics 13:22:39 INFO - 2015-11-18 13:22:39,677 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:40 INFO - 2015-11-18 13:22:40,391 INFO : Browser initialized. 13:22:40 INFO - 2015-11-18 13:22:40,392 INFO : Running cycle 1/1 for v8_7 test... 13:22:40 INFO - 2015-11-18 13:22:40,392 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpjVTBwc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:22:52 INFO - 2015-11-18 13:22:52,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 227905536 13:22:52 INFO - 2015-11-18 13:22:52,206 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 13:23:13 INFO - 2015-11-18 13:23:13,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 688766976 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |0;Richards;145.79384749963552 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.08247422680412 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.0567734682406 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4840.579710144928 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1718.213058419244 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 13:23:13 INFO - 2015-11-18 13:23:13,979 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: |8;Splay;606.2801932367149 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: __startTimestamp1447881793975__endTimestamp 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:145.79 Median:145.79 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: Values: 145.8 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.08 Median:161.08 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,980 DEBUG : BROWSER_OUTPUT: Values: 161.1 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: Values: 281.1 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: Values: 4840.6 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1718.21 Median:1718.21 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: Values: 1718.2 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: Values: 790.5 13:23:13 INFO - 2015-11-18 13:23:13,981 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: Values: 12382.7 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: Values: 27027.0 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.28 Median:606.28 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: Values: 606.3 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: Values: 4509.0 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:23:13 INFO - 2015-11-18 13:23:13,982 DEBUG : BROWSER_OUTPUT: 13:23:14 INFO - 2015-11-18 13:23:14,760 INFO : Browser exited with error code: 0 13:23:14 INFO - 2015-11-18 13:23:14,775 INFO : Completed test v8_7 (00:00:37) 13:23:14 INFO - 2015-11-18 13:23:14,957 INFO : Completed test suite (00:20:06) 13:23:14 INFO - 2015-11-18 13:23:14,957 DEBUG : Working with test: dromaeo_css 13:23:14 INFO - 2015-11-18 13:23:14,957 DEBUG : Generating results file: dromaeo_css 13:23:14 INFO - 2015-11-18 13:23:14,958 DEBUG : Working with test: kraken 13:23:14 INFO - 2015-11-18 13:23:14,958 DEBUG : Generating results file: kraken 13:23:14 INFO - 2015-11-18 13:23:14,958 INFO : javascript benchmark 13:23:14 INFO - 2015-11-18 13:23:14,958 DEBUG : Working with test: v8_7 13:23:14 INFO - 2015-11-18 13:23:14,958 DEBUG : Generating results file: v8_7 13:23:14 INFO - 2015-11-18 13:23:14,959 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:15 INFO - 2015-11-18 13:23:15,344 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:23:15 INFO - 2015-11-18 13:23:15,344 DEBUG : process_Request line: dromaeo_css 7214.81 graph.html#tests=[[72,64,59]] 13:23:15 INFO - 2015-11-18 13:23:15,344 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:15 INFO - 2015-11-18 13:23:15,369 DEBUG : process_Request line: kraken 1399.40 graph.html#tests=[[232,64,59]] 13:23:15 INFO - 2015-11-18 13:23:15,370 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:15 INFO - 2015-11-18 13:23:15,397 DEBUG : process_Request line: v8_7 20871.78 graph.html#tests=[[230,64,59]] 13:23:15 INFO - 2015-11-18 13:23:15,398 INFO : javascript benchmark 13:23:15 INFO - 2015-11-18 13:23:15,400 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3430.622631510533, 3553.6268691787363, 3577.3560759063375, 3578.874739384122, 3611.4402267648506, 5708.058170401879, 5892.587518873681, 6011.038233882579, 6019.157317975487, 6037.607555508895, 4803.303520989454, 5831.154482600031, 5961.0760332148475, 5971.641701497913, 6138.202033735608, 5331.920021199666, 5351.197320401932, 5353.357597088355, 5378.381486129087, 5447.346318441792, 4948.950510494885, 5468.781248750045, 5502.119660854244, 5525.060739674265, 5562.3047119110115, 5195.324607801, 5292.841214763564, 5309.787608495655, 5415.891682166374, 5455.536279416235, 4129.504459464883, 5362.973185134088, 5375.139977603565, 5382.165764306539, 5385.919211211835, 5370.865728356784, 5373.677579345252, 5381.13901775714, 5393.2449457076045, 5395.649282796606, 5814.563907706939, 5825.475707186331, 5834.5915785895, 5835.153902684087, 5838.299404071496, 6218.22272215973, 6283.811485655392, 6288.465480434169, 6295.496360291166, 6298.685065746694, 6309.968450157766, 6343.809685709436, 6354.205724284465, 6358.237011558596, 6362.713677884506, 5889.087191485327, 5995.070764031582, 6157.476614487774, 6169.537284703621, 6183.165272688175, 5310.389305229871, 6406.2953075161695, 6568.638724870082, 6581.934180658228, 6592.538522303393, 6311.368863113652, 6314.147590075373, 6323.810285691345, 6326.019466982625, 6342.873142537216, 6199.845003874939, 6344.6827658616885, 6422.42198202164, 6425.807225783141, 6430.453411459985, 6067.150598916155, 6347.920853454923, 6348.650824204713, 6352.396522330371, 6356.968215158987, 6217.564770466114, 6244.0, 6325.493960483151, 6331.715072821734, 6333.714982825692, 4339.327404252346, 5119.334486516729, 5120.667156634807, 5121.4878512149235, 5127.435982041972, 4559.726416415026, 4562.224421848294, 4577.450705915311, 4606.631469482433, 4628.861134165981, 5744.798932037359, 5832.329282132524, 5839.357670656224, 5958.255218097738, 6065.727042283108, 6366.522510811707, 6398.584092034003, 6404.199475065617, 6422.967885160544, 6425.839354016187, 6049.0, 6093.451589356979, 6095.207623008981, 6114.908276375858, 6118.479929206067, 5432.59255555827, 5510.889782204334, 5516.779328826802, 5521.254630624894, 5593.720313984284, 6421.8715625688155, 6462.224533056064, 6498.870022599522, 6522.967385163044, 6562.868742625216, 6397.808065758035, 6401.583897046677, 6415.935840641534, 6420.3258657842125, 6430.678466076584, 6320.0, 6627.6354800484505, 6628.966855165693, 6638.402543771083, 6641.767538136142, 5277.8416647500635, 6226.034964580497, 6343.302236754045, 6372.235331760218, 6374.904376434264, 6383.042543618494, 6410.551261411656, 6419.101325814483, 6422.710978005907, 6529.5102867284195, 5616.326040875121, 6053.606515576474, 6323.36766323364, 6335.1130841683125, 6347.587406818542, 6115.816525504242, 6190.876182476235, 6194.845128871634, 6223.844403889939, 6352.205974253218, 6241.469475094486, 6272.937270627418, 6274.466670333073, 6278.246610406598, 6279.811605651837, 6319.178506794087, 6328.588641738273, 6337.176167098248, 6344.651044192614, 6347.936520634919, 6042.365551617193, 6103.337669688754, 6133.619935514474, 6154.015357542772, 6277.623342599459], "unit": "ms", "name": "dojo.html", "value": 5853.79102145867}, {"lowerIsBetter": false, "replicates": [554.4538629449994, 562.3055526424865, 584.3863942859998, 610.9144719739236, 632.0329895260251, 32109.83945080274, 41818.0, 42637.93405164872, 42746.0, 42766.78616606916, 44743.0, 44996.77501612488, 45239.32141017879, 45312.54687453125, 45361.86595335118, 8926.241269492068, 9021.594028268712, 9941.254405919548, 10103.545340459661, 10133.03736145065, 12110.333931633757, 12349.629511114681, 12356.876431235707, 12368.567100151451, 12368.628941131736, 12125.818112728317, 12152.574659886906, 12184.878151218463, 12206.96240819527, 12219.450124744364, 9076.682316118937, 9134.588943497558, 12096.576619818308, 12194.756104877853, 12346.876531234662, 11976.101792365607, 12101.576444824388, 12121.818172727417, 12124.636260912186, 12150.635480935585, 43002.56997430017, 43430.0, 43435.78282108601, 43475.13049739019, 43530.78234608807, 3273.5253388258807, 3287.4056082799825, 3301.323228738127, 3636.4181730922924, 3818.7517811342173, 29750.256243593867, 29911.551326730118, 29942.0, 30328.090157295315, 30428.69571304281, 2624.134035768192, 2638.56463683492, 2676.330917270682, 2751.0247692084945, 2781.5966684830787, 511703.0, 512251.0, 513196.4340178312, 514213.4289328567, 514993.0, 56580.43419565834, 58449.831003379695, 58459.415405846245, 66242.33757662361, 69305.3069469309, 70114.64942675254, 70744.0, 70979.6451017752, 70999.0, 71145.6442717783, 16783.412580559867, 16926.57683557921, 16931.0, 16981.981081134923, 17033.40383086586, 12797.168184068007, 12853.036022298365, 12857.228566286052, 12885.162464439969, 12982.156159849768, 21150.153993840075, 21436.356909292746, 21451.67822482664, 21470.0, 21525.892370538048, 7544.509606875646, 8796.208341249318, 9014.414063085878, 9018.819623607491, 9093.863592046124, 977.6187286958092, 988.3476905242505, 997.0706682569252, 999.835027220515, 1022.8005538919839, 30013.0, 30175.245618859703, 30730.078097657108, 30731.2317192072, 30947.0, 1165.4405885175163, 1177.935213563245, 1242.5092088625124, 1257.4467234416827, 1281.1992504684572, 14435.49475768364, 15485.767713484081, 15708.33601576778, 15734.9213253933, 16079.0, 547575.0, 551874.0, 551916.0, 552345.7148142781, 554874.0, 61612.69193654003, 61674.69162654248, 61815.145545633706, 61874.381256187764, 61933.0, 1133.2633788037842, 1362.3120324236197, 1365.215001374214, 1460.1968917095555, 1491.7687758397465, 30987.845060775453, 31156.532652009784, 31171.90898318548, 31596.368072638877, 31753.20616984594, 52939.47060529499, 53586.0, 53596.1960570584, 53604.0, 53695.46304536905, 407862.0, 501406.0, 508984.0, 545154.0, 552534.0, 31147.377052459276, 31272.0, 31360.215994600316, 31372.529412058382, 31458.528122078646, 43552.78223608862, 44084.779576101915, 44156.779216103714, 44622.55377446184, 45299.0, 29597.704022959493, 36517.63482365249, 36955.0, 37320.62679373172, 37425.43861842129, 37517.81241093777, 37574.24851503009, 38457.0, 38541.80729096336, 38583.42124868073, 30351.696483035772, 35603.93188204358, 37887.242255155295, 38420.6157938417, 38534.80732596319, 28105.71894281031, 29934.700652994063, 31434.371312573163, 34354.0, 34406.311873761886, 23618.29145125649, 25379.492410152063, 25749.227523174333, 25797.3550661235, 26038.08866689657], "unit": "ms", "name": "ext.html", "value": 20801.294412285246}, {"lowerIsBetter": false, "replicates": [362.5142309305532, 364.77201748906936, 367.78668372344043, 368.27449923650414, 368.7658336956033, 10906.727331816708, 11247.212695111346, 12558.246505209683, 12954.805677914826, 18832.05839708014, 10609.893901060987, 11263.324200547973, 12574.748505029895, 12645.430955606997, 12649.810252846191, 4573.336866154414, 4832.444268909086, 4833.275008748681, 4834.661573689843, 4836.685615434985, 3653.7442379033478, 3736.1967177056927, 3739.9626003740022, 3743.88768336949, 4781.760911954406, 3705.3515634763944, 4314.417553630266, 5187.144121219994, 5192.818251361203, 5200.089984252741, 4958.281049247857, 5084.77118529667, 5099.5410413063, 5151.922721159186, 5166.535011848933, 4218.409422680827, 4226.957730422687, 4229.598188172119, 4288.635465985395, 4289.549597292271, 14036.649083772885, 14218.862491000695, 14569.49006784768, 14664.340104695208, 14685.0, 1978.6339527187372, 1983.0481368942988, 2027.5539381336082, 2124.0972586650764, 2182.552576721768, 9275.907240927572, 9486.33595648305, 10336.94831525845, 10413.323133996266, 10504.422256775873, 1598.9459241243676, 1598.9760153597706, 1608.7068777184218, 1645.654412573361, 1684.0623668064227, 85548.0, 85941.57029214814, 86243.70634440488, 86502.56748716216, 89912.0, 5743.569232307594, 6788.117544719254, 6831.69257383419, 6845.14435695538, 6876.349676077805, 7812.257835505618, 7813.804654883674, 7814.257645523666, 7818.335441487424, 7841.411894107965, 5796.101604251347, 5797.884042319214, 5810.535157187415, 5849.532037436995, 5854.414558544197, 6226.844328891723, 6293.30773614902, 6309.747610095545, 6330.588511746721, 6363.96818015907, 3089.7528197744127, 3100.953485697716, 3104.7516198704047, 3124.9687503125133, 3131.01373067483, 1045.4093437207953, 1059.1050562274866, 1079.6329248055542, 1081.897219764137, 1165.2891736041008, 414.70763112005966, 437.9671524635665, 448.34317724533713, 449.5931182280042, 452.5971885022333, 11892.643220703392, 12311.26132432039, 12313.322767247888, 12355.135140540076, 12375.195612285173, 446.17012357015926, 470.8987567672967, 473.39641956505045, 480.1549273279054, 498.8478514053176, 5787.305523337226, 6419.646919419477, 6487.690214029444, 6526.34736526353, 6632.336766323329, 749749.0, 752048.0, 755680.0, 770037.0, 794900.0, 113770.0, 118200.0, 118492.0, 118635.40682296533, 120889.0, 518.4996478398364, 536.6833568194784, 537.854779209619, 537.9973100134553, 539.3016044222741, 9041.954790226007, 11822.822657660314, 11824.586139485076, 12007.0, 12307.138500304893, 46127.308090379345, 46778.36275730469, 47336.0, 47525.81185470391, 48760.2685959718, 67148.6642566784, 70643.64678176577, 71966.0, 72132.27867721465, 73031.63484182545, 6386.489080873426, 6470.288268290578, 6496.610203387811, 6498.480121590167, 6502.804915852532, 12279.140460167702, 12375.257484550955, 12582.748345032865, 12607.0, 12619.621411357673, 8811.779705507413, 9210.677626283048, 9366.391184572982, 10635.989580989793, 11089.722756931142, 10589.258751887293, 10601.734956626146, 10711.196660250356, 10737.463126843782, 11046.502907369348, 8013.759587212393, 10925.726856828644, 11176.27354221973, 11294.378809165575, 11301.321920684784, 6476.481881449378, 6479.449246814073, 6484.870302594016, 6489.253735820441, 6507.414332710079, 10628.84056739165, 10884.346939183675, 10914.399708016135, 10965.287256328313, 11052.723681908017], "unit": "ms", "name": "jquery.html", "value": 7154.1455534541865}, {"lowerIsBetter": false, "replicates": [1658.146054781787, 1745.5461579989199, 1814.292425953878, 1927.431407734718, 1939.7575303087106, 6704.731810727571, 7667.61661916904, 7668.96165519173, 8084.312833409167, 8238.752837414871, 8013.519188848673, 8120.878186827203, 8122.1877812218745, 8125.431219814615, 8128.30909372704, 2332.6151185054487, 2363.9645405318934, 2364.6334818103223, 2364.9408764780846, 2367.810575153992, 2367.9052837886466, 2372.383180373107, 2414.6619473273754, 2416.5770990076753, 2419.0565679385054, 2330.3009097270838, 2358.2807243790635, 2359.6460530920413, 2362.173239366225, 2377.524495100978, 2348.3072493614427, 2369.869657168855, 2385.8091352691745, 2386.916457923964, 2390.3904504351367, 2355.1639168095253, 2385.677933478993, 2396.1852969990114, 2397.113068164773, 2399.4841109161616, 8111.716089936824, 8143.429959902809, 8161.265486106219, 8164.795880102985, 8183.79540511486, 4204.579542045802, 4425.402570652953, 4714.198586240347, 4985.426675932242, 5163.63854530183, 2919.284775230061, 3492.6856582907662, 3536.8938931832085, 3542.167590616203, 3562.590302115264, 1049.7113293844177, 1053.1785207538132, 1086.000879191146, 1633.9264733087039, 1656.1884676508544, 10716.303440276357, 10799.298045627087, 10802.5678972841, 10846.78306433867, 10856.34861908288, 4349.391085248068, 4361.0, 4414.205443020287, 4440.622547083534, 4445.1998640245065, 8831.735047948572, 8840.778980525538, 8845.380823342304, 8854.158854908774, 8866.0, 5008.899822003539, 5015.724135172601, 5015.874603134951, 5016.874578135503, 5020.598352131894, 4623.42207224097, 4653.092646933816, 4660.6970546914345, 4669.0, 4669.626429885601, 3501.9299614007577, 3567.23304489536, 3596.5973270424556, 3602.819859007039, 3603.0992251937014, 966.7728083900278, 1151.867535233459, 1155.9711007224887, 1157.560127151694, 1160.4255893332686, 1124.4602590756483, 1316.5457917018614, 1333.3466601365456, 1376.9793453098212, 1379.2138481065697, 7634.274743899321, 7749.961250193825, 7752.612369381621, 7762.495437796525, 7773.611319434006, 1181.2321990705939, 1198.8621308549455, 1199.4602428907026, 1219.5121951219583, 1241.509603706549, 5793.710314484259, 5923.822285331447, 6141.570090093651, 6187.226596675416, 6187.412195841478, 9247.0, 9353.579088941015, 9645.0, 9758.46328451942, 9774.902250977399, 9311.72064838056, 9577.808443831085, 9748.26887983404, 9779.168770654433, 9788.972157923457, 7683.884741728879, 7756.883646745417, 7805.985221921114, 7814.335781458526, 7820.882686759704, 7588.27911348421, 7624.69501219945, 7641.1212710539, 7690.846183076419, 7702.845943080995, 8635.6977505787, 8813.91186088131, 8821.0, 8902.243309318521, 8977.416467929565, 9052.864207036768, 9058.00361960197, 9143.039980802187, 9274.258059355101, 9277.582508787256, 7138.143422789299, 7167.605781682058, 7196.9640151801, 7228.060352154186, 7229.457790665616, 7848.979632647719, 7874.370050396069, 7886.369090472634, 7890.526568405914, 7896.0, 7279.162896266997, 7309.926900730925, 7313.67088481009, 7398.482106252511, 7461.253874612496, 7139.178994415709, 7177.928220717726, 7207.8558428832175, 7265.019222404908, 7309.5248808827255, 7256.310650488406, 7290.015847860471, 7335.266473352622, 7340.0, 7358.448116391185, 6731.495137864582, 6763.140136462513, 6763.526553141233, 6765.966170169315, 6772.86454270902, 6714.294999025227, 6770.458363330823, 6806.455483561403, 6809.0, 6809.421199198124], "unit": "ms", "name": "mootools.html", "value": 4723.676048172496}, {"lowerIsBetter": false, "replicates": [320.1851288470842, 326.3603337458581, 328.54660568415613, 332.9417351963406, 333.5213967955983, 6685.899711504331, 6715.462762978962, 6723.428508576771, 6761.695723692434, 6785.898211526831, 6644.933550664492, 6645.136132302806, 6655.966720166392, 6659.966700166505, 6684.231313398961, 4858.829940952068, 4998.400191976968, 5005.474425185358, 5006.374203224597, 5020.071286811952, 4037.172379662177, 4156.958430415702, 4848.636352273594, 4949.307097006422, 4985.52637499437, 4887.1447496688115, 4908.116539022974, 4929.926051109236, 4944.233643785219, 4945.0, 4652.837150699726, 4764.761761911891, 4775.498572649856, 4910.140725373063, 4910.41075070992, 4095.5494895561465, 4117.938230926538, 4225.72532785368, 4236.449261596003, 4266.935995960063, 6383.680815959184, 6392.968035159841, 6393.488520918316, 6447.742090316382, 6454.451371633417, 5578.897767655529, 5607.80372686954, 5885.146653735184, 5888.4700376966275, 5891.528677705774, 7004.229534751174, 7258.165310989199, 7268.45486588508, 7270.781876543712, 7316.414686825041, 4708.364370809931, 4728.66899317048, 4736.9526304736855, 4738.265568836836, 4744.4069491313585, 7421.814454638623, 7665.923340766577, 7673.923260767377, 7674.0, 7675.923240767633, 4802.159622066194, 4853.150698627726, 4854.563089321978, 4886.144924638245, 4893.926591101136, 4342.609165175149, 4817.397825271841, 4949.90100197994, 4976.950230497721, 4986.401631804134, 5884.529237660977, 5888.705564721747, 5890.322612899486, 5906.822795316148, 5909.965755992684, 6108.847278818065, 7046.6476676165985, 7085.362317391357, 7223.277672232734, 7274.345308922222, 1719.6388758360883, 1742.0, 1742.8344307290788, 1743.2044993656555, 1743.8692098092695, 1121.62986214549, 1124.8031594470935, 1139.9658010259704, 1145.0839328537138, 1150.263831148066, 6727.899081513781, 6734.393904548516, 6748.527603067738, 6752.797416077526, 6753.0, 7481.177070522238, 7481.289277518627, 7489.775306740807, 7493.587852668046, 7498.32515073646, 6532.608043517404, 6681.098051763047, 6723.932760672331, 6737.023131645884, 6743.629100399525, 3957.9010524737114, 3969.186316805048, 3972.3644216925154, 3975.7018223632763, 3977.463042489227, 7748.845023099507, 7756.844863102707, 7759.72840950564, 7764.961175194087, 7773.028371453568, 6218.968905155445, 7478.887816682754, 7501.099868015873, 7603.695852165852, 7704.691812327556, 7654.464187506933, 7713.267239612228, 7863.488873223222, 7876.0, 7891.960540197262, 7483.914832349387, 7537.886931695919, 7540.698372065275, 7543.170251272465, 7548.0, 6238.500919926304, 7234.74678386254, 7311.122665280201, 7436.330730234088, 7445.813854653677, 7811.218878112143, 7821.491603045783, 7823.452358334862, 7833.060032796101, 7854.253845884632, 4869.0, 4875.780589873535, 4876.341693871282, 4884.3650325457465, 4885.731284779371, 7258.237885022208, 7523.172451030273, 7539.396848252236, 7544.245575442412, 7550.35821955118, 6605.44771978575, 7222.855542889218, 7241.167265764294, 7251.383632391306, 7254.927450725425, 5696.772129114789, 5879.823605291848, 5985.371535988658, 7015.789526314219, 7218.566885986857, 7103.893441598277, 7110.146782386147, 7120.857582848417, 7122.465815063787, 7137.678804453708, 6240.469560087262, 6879.759208427681, 7232.89150662751, 7251.093613298338, 7254.528455650366, 6923.4807389447, 7107.182673992557, 7107.253738357398, 7146.285371462812, 7151.964240178766], "unit": "ms", "name": "prototype.html", "value": 5256.880213074057}, {"lowerIsBetter": false, "replicates": [719.697726954679, 747.7382915979408, 789.5657388436358, 820.7701843483825, 839.0979696825906, 15030.94783365165, 15369.92315038426, 15407.537773866788, 15412.537623871274, 15416.152111633855, 14304.998650094498, 14371.856281437182, 14390.568282951503, 14405.0, 14424.278786060708, 752.0636807175075, 769.5575044349494, 770.3413581387916, 771.972980945667, 773.5204173412465, 752.5371896283773, 949.1268033409245, 971.519098046468, 975.229568640773, 977.1010670183413, 961.5192403798101, 1018.0379541333443, 1018.4296793795461, 1019.1999280564759, 1019.5463018956567, 787.8503084413943, 799.4443861516248, 800.9479383840031, 981.5337714585586, 1013.3312014070715, 586.7183751799117, 594.6996766632823, 740.4631642059463, 758.4311766175368, 760.1941941541928, 15072.321745521478, 15281.465148719853, 15287.923560382238, 15312.693746125127, 15316.923415382851, 10449.47752612374, 12525.686857828627, 12947.0, 13181.011424143227, 13417.127886687334, 9836.90163098367, 9903.80192396148, 9921.50392480373, 9997.800043999152, 10530.473476326153, 3154.3218208085373, 3231.9030429087165, 3233.030090972699, 3234.951475727866, 3237.045071703853, 70564.58870822555, 71664.0, 71773.64113179401, 72325.63837180832, 72499.63750181269, 7214.458915581353, 7254.455915806336, 7306.561606303639, 7328.193898671142, 7412.258774122544, 12749.617511474671, 12756.93621531905, 12758.170718903428, 12758.80861787074, 12774.23354598727, 6533.673316334164, 6540.4767618590395, 6726.495512836557, 6859.9314006860295, 6942.757003504853, 3992.5608183099835, 4088.366303223005, 4097.160082183145, 4103.753774773523, 4109.301418758818, 3179.0145055032554, 3201.2317043909293, 3204.295055087877, 3205.4230238556815, 3206.551082848403, 477.5296333111882, 492.15349598690193, 496.5655051829649, 497.8431793984956, 508.31631455692036, 483.494747988353, 490.91409003424974, 494.7031780931412, 504.61569086068033, 514.9356330458693, 7943.364530837519, 8021.558814265271, 8352.624131914079, 8353.415260931677, 8426.957865210634, 455.6924076248519, 472.07002205655493, 479.56838845039044, 526.7892842862885, 532.0449792622252, 3813.733038687321, 3847.8845634631007, 3923.0, 4028.60097855922, 4233.428487154195, 102715.48642256741, 103576.0, 103869.48065259625, 103913.48043259735, 104469.47765261125, 67740.95165717555, 85507.5724621373, 85953.14046859452, 89716.10283897078, 90051.64922526167, 72033.0, 72112.99999999895, 72673.63663181651, 74864.62567687235, 76044.098897528, 7401.481896267425, 7671.695811712134, 8337.583120843812, 8487.78780530467, 8496.06543280251, 48955.75522122509, 49321.50678493169, 53027.878884844176, 53467.0, 53597.19604206018, 68328.3167168322, 68840.08339040873, 69177.0, 69808.0, 71827.0, 7438.814029649086, 7551.471397002157, 7656.349210317186, 7772.7668169954995, 7883.329916957123, 11167.553297868319, 11303.434828258718, 11412.201145919706, 11443.198976071595, 11487.483063262007, 10796.622118225825, 10835.349879007284, 10850.511726972147, 10862.674119776419, 10863.0, 10727.731806704895, 10738.785224295627, 10743.892561074603, 10803.621873234399, 10828.675139745821, 9500.382475139093, 10593.470326483492, 10597.41714205726, 10661.840072398765, 10880.836787448354, 8646.221840034426, 9438.764030899283, 9788.9021109788, 10151.187904967437, 10215.489225538842, 9639.095941328043, 9979.32803666166, 10007.349522281029, 10197.54111064989, 10207.234457415576], "unit": "ms", "name": "yui.html", "value": 6519.568969458803}], "name": "dromaeo_css", "value": 7214.806651183541}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 102.0, 108.0, 110.0, 109.0, 100.0, 110.0, 102.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 106.9}, {"lowerIsBetter": true, "replicates": [148.0, 119.0, 139.0, 154.0, 120.0, 139.0, 117.0, 167.0, 171.0, 149.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [182.0, 182.0, 181.0, 183.0, 184.0, 182.0, 184.0, 182.0, 186.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 182.7}, {"lowerIsBetter": true, "replicates": [66.0, 77.0, 106.0, 100.0, 59.0, 55.0, 57.0, 73.0, 71.0, 53.0], "unit": "ms", "name": "audio-fft", "value": 71.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 115.0, 74.0, 75.0, 74.0, 111.0, 74.0, 76.0, 113.0], "unit": "ms", "name": "audio-oscillator", "value": 88.0}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 89.0, 89.0, 87.0, 89.0, 87.0, 88.0, 88.0, 92.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 88.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 93.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.9}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 87.0, 82.0, 86.0, 86.0, 84.0, 87.0, 96.0, 133.0], "unit": "ms", "name": "imaging-desaturate", "value": 91.5}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 57.0, 55.0, 56.0, 55.0, 57.0, 68.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 62.0, 62.0, 61.0, 65.0, 65.0, 65.0, 70.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 82.0, 80.0, 84.0, 104.0, 106.0, 105.0, 79.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [127.0, 128.0, 122.0, 121.0, 130.0, 127.0, 121.0, 123.0, 119.0, 158.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [136.0, 135.0, 132.0, 135.0, 136.0, 117.0, 134.0, 139.0, 133.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 133.0}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 65.0, 64.0, 63.0, 64.0, 64.0, 67.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.4}], "name": "kraken", "value": 1399.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [145.79384749963552], "unit": "score", "name": "Richards", "value": 242.136418}, {"lowerIsBetter": false, "replicates": [161.08247422680412], "unit": "score", "name": "DeltaBlue", "value": 410.460544}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "Decrypt", "value": 54.98948802395209}, {"lowerIsBetter": false, "replicates": [1718.213058419244], "unit": "score", "name": "RayTrace", "value": 430.6735979999999}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [606.2801932367149], "unit": "score", "name": "Splay", "value": 134.41145019920324}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 20871.784965940664}]} 13:23:15 INFO - RETURN: dromaeo_css: 7214.81 13:23:15 INFO - RETURN: kraken: 1399.40 13:23:15 INFO - RETURN: v8_7: 20871.78 13:23:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20871.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1399.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7214.81"}}} 13:23:15 INFO - Return code: 0 13:23:15 INFO - # TBPL SUCCESS # 13:23:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:23:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:23:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:23:15 INFO - 2015-11-18 13:23:15.504 screenresolution[1668:10242] starting screenresolution argv=screenresolution get 13:23:15 INFO - 2015-11-18 13:23:15.506 screenresolution[1668:10242] Display 0: 1600x1200x32@60 13:23:15 INFO - 2015-11-18 13:23:15.512 screenresolution[1669:10245] starting screenresolution argv=screenresolution list 13:23:15 INFO - Available Modes on Display 0 13:23:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:23:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:23:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:23:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:23:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:23:15 INFO - Intel Iris: 13:23:15 INFO - Chipset Model: Intel Iris 13:23:15 INFO - Type: GPU 13:23:15 INFO - Bus: Built-In 13:23:15 INFO - VRAM (Dynamic, Max): 1536 MB 13:23:15 INFO - Vendor: Intel (0x8086) 13:23:15 INFO - Device ID: 0x0a2e 13:23:15 INFO - Revision ID: 0x0009 13:23:15 INFO - Displays: 13:23:15 INFO - Display: 13:23:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:23:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:23:15 INFO - Display Serial Number: 1600x1200 60 13:23:15 INFO - Main Display: Yes 13:23:15 INFO - Mirror: Off 13:23:15 INFO - Online: Yes 13:23:15 INFO - Rotation: Supported 13:23:15 INFO - Return code: 0 13:23:15 INFO - Running post-action listener: _resource_record_post_action 13:23:15 INFO - Running post-run listener: _resource_record_post_run 13:23:16 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 38536704; Write bytes: 687007744; Read time: 457; Write time: 2091 13:23:16 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 335946240; Write bytes: 335926784; Read time: 26048; Write time: 706 13:23:16 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 37611008; Write bytes: 340713984; Read time: 443; Write time: 1352 13:23:16 INFO - Running post-run listener: _upload_blobber_files 13:23:16 INFO - Blob upload gear active. 13:23:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:23:16 INFO - Copying logs to upload dir... 13:23:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.516339 ========= master_lag: 2.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-18 13:23:19.037017) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:19.040230) ========= 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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 build_url:https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009693 build_url: 'https://queue.taskcluster.net/v1/task/u-0TIBD2THGhXwXtAVIgiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:19.091994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:19.092353) ========= 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.BZ7TunLhzq/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.gFF6fs8v6r/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005296 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:19.141846) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:23:19.142151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:23:19.142534) ========= ========= Total master_lag: 5.53 =========