builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1447812948.86 results: success (0) buildid: 20151117175137 builduid: 572b82ceffb74a57abcfee3670b0e81c revision: e85794f108f04dd2ee460c6b3e030a148185e81c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.858030) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.858389) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.858694) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006480 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.887753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.888036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.925043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.925297) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.985807) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.986061) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.986385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:48.986663) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 18:15:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2015-11-17 18:15:49 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179570 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:49.205583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:49.205867) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015331 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:49.317316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:49.317611) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e85794f108f04dd2ee460c6b3e030a148185e81c --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 e85794f108f04dd2ee460c6b3e030a148185e81c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 18:15:49,662 truncating revision to first 12 chars 2015-11-17 18:15:49,663 Setting DEBUG logging. 2015-11-17 18:15:49,663 attempt 1/10 2015-11-17 18:15:49,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e85794f108f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 18:15:50,157 unpacking tar archive at: fx-team-e85794f108f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794873 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:50.207932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:50.208198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:50.217953) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:50.218217) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:15:50.218584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-17 18:15:50.218877) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:15:50 INFO - MultiFileLogger online at 20151117 18:15:50 in /builds/slave/test 18:15:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:15:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:15:50 INFO - {'append_to_log': False, 18:15:50 INFO - 'base_work_dir': '/builds/slave/test', 18:15:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:15:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:15:50 INFO - 'branch': 'Fx-Team-Non-PGO', 18:15:50 INFO - 'buildbot_json_path': 'buildprops.json', 18:15:50 INFO - 'config_files': ('talos/linux_config.py',), 18:15:50 INFO - 'default_actions': ('clobber', 18:15:50 INFO - 'read-buildbot-config', 18:15:50 INFO - 'download-and-extract', 18:15:50 INFO - 'populate-webroot', 18:15:50 INFO - 'create-virtualenv', 18:15:50 INFO - 'install', 18:15:50 INFO - 'run-tests'), 18:15:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:15:50 INFO - 'download_minidump_stackwalk': True, 18:15:50 INFO - 'download_symbols': 'ondemand', 18:15:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:15:50 INFO - 'tooltool.py': '/tools/tooltool.py', 18:15:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:15:50 INFO - '/tools/misc-python/virtualenv.py')}, 18:15:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:15:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:15:50 INFO - 'installer_path': 'installer.exe', 18:15:50 INFO - 'log_level': 'info', 18:15:50 INFO - 'log_name': 'talos', 18:15:50 INFO - 'log_to_console': True, 18:15:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:15:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:15:50 INFO - 'opt_config_files': (), 18:15:50 INFO - 'pip_index': False, 18:15:50 INFO - 'sps_profile': False, 18:15:50 INFO - 'sps_profile_interval': 0, 18:15:50 INFO - 'suite': 'dromaeojs', 18:15:50 INFO - 'system_bits': '64', 18:15:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:15:50 INFO - 'title': 'talos-linux64-ix-061', 18:15:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:15:50 INFO - 'use_talos_json': True, 18:15:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:15:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:15:50 INFO - 'work_dir': 'build'} 18:15:50 INFO - ##### 18:15:50 INFO - ##### Running clobber step. 18:15:50 INFO - ##### 18:15:50 INFO - Running pre-action listener: _resource_record_pre_action 18:15:50 INFO - Running main action method: clobber 18:15:50 INFO - rmtree: /builds/slave/test/build 18:15:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:15:51 INFO - Running post-action listener: _resource_record_post_action 18:15:51 INFO - ##### 18:15:51 INFO - ##### Running read-buildbot-config step. 18:15:51 INFO - ##### 18:15:51 INFO - Running pre-action listener: _resource_record_pre_action 18:15:51 INFO - Running main action method: read_buildbot_config 18:15:51 INFO - Using buildbot properties: 18:15:51 INFO - { 18:15:51 INFO - "properties": { 18:15:51 INFO - "buildnumber": 1102, 18:15:51 INFO - "product": "firefox", 18:15:51 INFO - "script_repo_revision": "production", 18:15:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:15:51 INFO - "repository": "", 18:15:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:15:51 INFO - "buildid": "20151117175137", 18:15:51 INFO - "slavename": "talos-linux64-ix-061", 18:15:51 INFO - "pgo_build": "False", 18:15:51 INFO - "basedir": "/builds/slave/test", 18:15:51 INFO - "project": "", 18:15:51 INFO - "platform": "ubuntu64_hw", 18:15:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:15:51 INFO - "slavebuilddir": "test", 18:15:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:15:51 INFO - "branch": "fx-team", 18:15:51 INFO - "repo_path": "integration/fx-team", 18:15:51 INFO - "stage_platform": "linux64", 18:15:51 INFO - "builduid": "572b82ceffb74a57abcfee3670b0e81c", 18:15:51 INFO - "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c" 18:15:51 INFO - }, 18:15:51 INFO - "sourcestamp": { 18:15:51 INFO - "repository": "", 18:15:51 INFO - "hasPatch": false, 18:15:51 INFO - "project": "", 18:15:51 INFO - "branch": "fx-team-linux64-talos", 18:15:51 INFO - "changes": [ 18:15:51 INFO - { 18:15:51 INFO - "category": null, 18:15:51 INFO - "files": [ 18:15:51 INFO - { 18:15:51 INFO - "url": null, 18:15:51 INFO - "name": "https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:15:51 INFO - } 18:15:51 INFO - ], 18:15:51 INFO - "repository": "", 18:15:51 INFO - "rev": "e85794f108f04dd2ee460c6b3e030a148185e81c", 18:15:51 INFO - "who": "mhammond@skippinet.com.au", 18:15:51 INFO - "when": 1447812882, 18:15:51 INFO - "number": 6675344, 18:15:51 INFO - "comments": "Bug 1221906 - Allow Sync to only sync specified engines. r=rnewman", 18:15:51 INFO - "project": "", 18:15:51 INFO - "at": "Tue 17 Nov 2015 18:14:42", 18:15:51 INFO - "branch": "fx-team-linux64-talos", 18:15:51 INFO - "revlink": "", 18:15:51 INFO - "properties": [ 18:15:51 INFO - [ 18:15:51 INFO - "buildid", 18:15:51 INFO - "20151117175137", 18:15:51 INFO - "Change" 18:15:51 INFO - ], 18:15:51 INFO - [ 18:15:51 INFO - "builduid", 18:15:51 INFO - "572b82ceffb74a57abcfee3670b0e81c", 18:15:51 INFO - "Change" 18:15:51 INFO - ], 18:15:51 INFO - [ 18:15:51 INFO - "pgo_build", 18:15:51 INFO - "False", 18:15:51 INFO - "Change" 18:15:51 INFO - ] 18:15:51 INFO - ], 18:15:51 INFO - "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c" 18:15:51 INFO - } 18:15:51 INFO - ], 18:15:51 INFO - "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c" 18:15:51 INFO - } 18:15:51 INFO - } 18:15:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:15:51 INFO - Running post-action listener: _resource_record_post_action 18:15:51 INFO - ##### 18:15:51 INFO - ##### Running download-and-extract step. 18:15:51 INFO - ##### 18:15:51 INFO - Running pre-action listener: _resource_record_pre_action 18:15:51 INFO - Running main action method: download_and_extract 18:15:51 INFO - mkdir: /builds/slave/test/build/tests 18:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:51 INFO - https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/test_packages.json 18:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/test_packages.json 18:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:15:52 INFO - Downloaded 1302 bytes. 18:15:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:15:52 INFO - Using the following test package requirements: 18:15:52 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:15:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:15:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:52 INFO - u'jsshell-linux-x86_64.zip'], 18:15:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:15:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:15:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:15:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:15:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:15:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:15:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:15:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:15:52 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')]} 18:15:52 INFO - https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:15:53 INFO - Downloaded 21277682 bytes. 18:15:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:15:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:15:54 INFO - Return code: 0 18:15:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:15:54 INFO - https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:15:55 INFO - Downloaded 21277682 bytes. 18:15:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:15:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:15:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:15:56 INFO - Return code: 0 18:15: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')]} 18:15:56 INFO - https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:15:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:15:57 INFO - Downloaded 11131693 bytes. 18:15:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:15:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:15:58 INFO - Return code: 0 18:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:58 INFO - https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:15:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:15:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:15:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:15:59 INFO - Downloaded 55654424 bytes. 18:15:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:15:59 INFO - mkdir: /builds/slave/test/properties 18:15:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:15:59 INFO - Writing to file /builds/slave/test/properties/build_url 18:15:59 INFO - Contents: 18:15:59 INFO - build_url:https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:15:59 INFO - Running post-action listener: _resource_record_post_action 18:15:59 INFO - Running post-action listener: set_extra_try_arguments 18:15:59 INFO - ##### 18:15:59 INFO - ##### Running populate-webroot step. 18:15:59 INFO - ##### 18:15:59 INFO - Running pre-action listener: _resource_record_pre_action 18:15:59 INFO - Running main action method: populate_webroot 18:15:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:15:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:15:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:15:59 INFO - '../fennec_ids.txt'], 18:15:59 INFO - 'tests': ['tcheck2']}, 18:15:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:15:59 INFO - '--tppagecycles', 18:15:59 INFO - '7'], 18:15:59 INFO - 'tests': ['tsvgm']}}, 18:15:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:15:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:15:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:15:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:15:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'tests': ['damp', 'tps']}, 18:15:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['damp', 'tps']}, 18:15:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:15:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:15:59 INFO - 'other': {'tests': ['a11yr', 18:15:59 INFO - 'ts_paint', 18:15:59 INFO - 'tpaint', 18:15:59 INFO - 'sessionrestore', 18:15:59 INFO - 'sessionrestore_no_auto_restore']}, 18:15:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['a11yr', 18:15:59 INFO - 'ts_paint', 18:15:59 INFO - 'tpaint', 18:15:59 INFO - 'sessionrestore', 18:15:59 INFO - 'sessionrestore_no_auto_restore']}, 18:15:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['a11yr', 18:15:59 INFO - 'ts_paint', 18:15:59 INFO - 'tpaint', 18:15:59 INFO - 'sessionrestore', 18:15:59 INFO - 'sessionrestore_no_auto_restore']}, 18:15:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['a11yr', 18:15:59 INFO - 'ts_paint', 18:15:59 INFO - 'tpaint', 18:15:59 INFO - 'sessionrestore', 18:15:59 INFO - 'sessionrestore_no_auto_restore']}, 18:15:59 INFO - 'other_l64': {'tests': ['a11yr', 18:15:59 INFO - 'ts_paint', 18:15:59 INFO - 'tpaint', 18:15:59 INFO - 'sessionrestore', 18:15:59 INFO - 'sessionrestore_no_auto_restore']}, 18:15:59 INFO - 'other_nol64': {'tests': ['a11yr', 18:15:59 INFO - 'ts_paint', 18:15:59 INFO - 'tpaint', 18:15:59 INFO - 'sessionrestore', 18:15:59 INFO - 'sessionrestore_no_auto_restore']}, 18:15:59 INFO - 'svgr': {'tests': ['tsvgx', 18:15:59 INFO - 'tsvgr_opacity', 18:15:59 INFO - 'tart', 18:15:59 INFO - 'tscrollx', 18:15:59 INFO - 'cart']}, 18:15:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['tsvgx', 18:15:59 INFO - 'tsvgr_opacity', 18:15:59 INFO - 'tart', 18:15:59 INFO - 'tscrollx', 18:15:59 INFO - 'cart']}, 18:15:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'tests': ['tp5o']}, 18:15:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'talos_options': ['--e10s'], 18:15:59 INFO - 'tests': ['tp5o']}, 18:15:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'talos_options': ['--xperf_path', 18:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:59 INFO - 'tests': ['tp5n']}, 18:15:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:59 INFO - 'talos_options': ['--e10s', 18:15:59 INFO - '--xperf_path', 18:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:59 INFO - 'tests': ['tp5n']}}, 18:15:59 INFO - 'talos.zip': {'path': '', 18:15:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:15:59 INFO - Running post-action listener: _resource_record_post_action 18:15:59 INFO - ##### 18:15:59 INFO - ##### Running create-virtualenv step. 18:15:59 INFO - ##### 18:15:59 INFO - Running pre-action listener: _resource_record_pre_action 18:15:59 INFO - Running main action method: create_virtualenv 18:15:59 INFO - Creating virtualenv /builds/slave/test/build/venv 18:15:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:15:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:16:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:16:00 INFO - Using real prefix '/usr' 18:16:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:16:00 INFO - Installing distribute.............................................................................................................................................................................................done. 18:16:02 INFO - Installing pip.................done. 18:16:02 INFO - Return code: 0 18:16:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:16: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')]} 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16: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')]} 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:02 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 0x7fb22e334c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ef9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:02 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 18:16:02 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 18:16:02 INFO - Using env: {'DISPLAY': ':0', 18:16:02 INFO - 'HOME': '/home/cltbld', 18:16:02 INFO - 'LANG': 'en_US.UTF-8', 18:16:02 INFO - 'LANGUAGE': 'en_US:en', 18:16:02 INFO - 'LOGNAME': 'cltbld', 18:16:02 INFO - 'MAIL': '/var/mail/cltbld', 18:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:02 INFO - 'MOZ_NO_REMOTE': '1', 18:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:02 INFO - 'NO_EM_RESTART': '1', 18:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:02 INFO - 'PWD': '/builds/slave/test', 18:16:02 INFO - 'SHELL': '/bin/bash', 18:16:02 INFO - 'SHLVL': '1', 18:16:02 INFO - 'TERM': 'linux', 18:16:02 INFO - 'TMOUT': '86400', 18:16:02 INFO - 'USER': 'cltbld', 18:16:02 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:02 INFO - '_': '/tools/buildbot/bin/python'} 18:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:16:02 INFO - Cleaning up... 18:16:02 INFO - Return code: 0 18:16:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:16: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')]} 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16: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')]} 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:02 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 0x7fb22e334c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ef9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:02 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 18:16:02 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 18:16:02 INFO - Using env: {'DISPLAY': ':0', 18:16:02 INFO - 'HOME': '/home/cltbld', 18:16:02 INFO - 'LANG': 'en_US.UTF-8', 18:16:02 INFO - 'LANGUAGE': 'en_US:en', 18:16:02 INFO - 'LOGNAME': 'cltbld', 18:16:02 INFO - 'MAIL': '/var/mail/cltbld', 18:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:02 INFO - 'MOZ_NO_REMOTE': '1', 18:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:02 INFO - 'NO_EM_RESTART': '1', 18:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:02 INFO - 'PWD': '/builds/slave/test', 18:16:02 INFO - 'SHELL': '/bin/bash', 18:16:02 INFO - 'SHLVL': '1', 18:16:02 INFO - 'TERM': 'linux', 18:16:02 INFO - 'TMOUT': '86400', 18:16:02 INFO - 'USER': 'cltbld', 18:16:02 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:02 INFO - '_': '/tools/buildbot/bin/python'} 18:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:02 INFO - Downloading/unpacking psutil>=0.7.1 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:16:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:16:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:04 INFO - Installing collected packages: psutil 18:16:04 INFO - Running setup.py install for psutil 18:16:04 INFO - building 'psutil._psutil_linux' extension 18:16:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:16:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:16:04 INFO - building 'psutil._psutil_posix' extension 18:16:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:16:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:16:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:05 INFO - Successfully installed psutil 18:16:05 INFO - Cleaning up... 18:16:05 INFO - Return code: 0 18:16:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:16:05 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')]} 18:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:05 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')]} 18:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:05 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 0x7fb22e334c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ef9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:05 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 18:16:05 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 18:16:05 INFO - Using env: {'DISPLAY': ':0', 18:16:05 INFO - 'HOME': '/home/cltbld', 18:16:05 INFO - 'LANG': 'en_US.UTF-8', 18:16:05 INFO - 'LANGUAGE': 'en_US:en', 18:16:05 INFO - 'LOGNAME': 'cltbld', 18:16:05 INFO - 'MAIL': '/var/mail/cltbld', 18:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:05 INFO - 'MOZ_NO_REMOTE': '1', 18:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:05 INFO - 'NO_EM_RESTART': '1', 18:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:05 INFO - 'PWD': '/builds/slave/test', 18:16:05 INFO - 'SHELL': '/bin/bash', 18:16:05 INFO - 'SHLVL': '1', 18:16:05 INFO - 'TERM': 'linux', 18:16:05 INFO - 'TMOUT': '86400', 18:16:05 INFO - 'USER': 'cltbld', 18:16:05 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:05 INFO - '_': '/tools/buildbot/bin/python'} 18:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:16:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:16:07 INFO - Installing collected packages: mozsystemmonitor 18:16:07 INFO - Running setup.py install for mozsystemmonitor 18:16:07 INFO - Successfully installed mozsystemmonitor 18:16:07 INFO - Cleaning up... 18:16:07 INFO - Return code: 0 18:16:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:16: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')]} 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16: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')]} 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:07 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 0x7fb22e334c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ef9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:07 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 18:16:07 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 18:16:07 INFO - Using env: {'DISPLAY': ':0', 18:16:07 INFO - 'HOME': '/home/cltbld', 18:16:07 INFO - 'LANG': 'en_US.UTF-8', 18:16:07 INFO - 'LANGUAGE': 'en_US:en', 18:16:07 INFO - 'LOGNAME': 'cltbld', 18:16:07 INFO - 'MAIL': '/var/mail/cltbld', 18:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:07 INFO - 'MOZ_NO_REMOTE': '1', 18:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:07 INFO - 'NO_EM_RESTART': '1', 18:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:07 INFO - 'PWD': '/builds/slave/test', 18:16:07 INFO - 'SHELL': '/bin/bash', 18:16:07 INFO - 'SHLVL': '1', 18:16:07 INFO - 'TERM': 'linux', 18:16:07 INFO - 'TMOUT': '86400', 18:16:07 INFO - 'USER': 'cltbld', 18:16:07 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:07 INFO - '_': '/tools/buildbot/bin/python'} 18:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:07 INFO - Downloading/unpacking blobuploader==1.2.4 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:09 INFO - Downloading blobuploader-1.2.4.tar.gz 18:16:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:16:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:16:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:09 INFO - Downloading docopt-0.6.1.tar.gz 18:16:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:16:09 INFO - Installing collected packages: blobuploader, requests, docopt 18:16:09 INFO - Running setup.py install for blobuploader 18:16:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:16:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:16:09 INFO - Running setup.py install for requests 18:16:10 INFO - Running setup.py install for docopt 18:16:10 INFO - Successfully installed blobuploader requests docopt 18:16:10 INFO - Cleaning up... 18:16:10 INFO - Return code: 0 18:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:10 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')]} 18:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:10 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')]} 18:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:10 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 0x7fb22e334c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ef9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:10 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 18:16:10 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 18:16:10 INFO - Using env: {'DISPLAY': ':0', 18:16:10 INFO - 'HOME': '/home/cltbld', 18:16:10 INFO - 'LANG': 'en_US.UTF-8', 18:16:10 INFO - 'LANGUAGE': 'en_US:en', 18:16:10 INFO - 'LOGNAME': 'cltbld', 18:16:10 INFO - 'MAIL': '/var/mail/cltbld', 18:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:10 INFO - 'MOZ_NO_REMOTE': '1', 18:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:10 INFO - 'NO_EM_RESTART': '1', 18:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:10 INFO - 'PWD': '/builds/slave/test', 18:16:10 INFO - 'SHELL': '/bin/bash', 18:16:10 INFO - 'SHLVL': '1', 18:16:10 INFO - 'TERM': 'linux', 18:16:10 INFO - 'TMOUT': '86400', 18:16:10 INFO - 'USER': 'cltbld', 18:16:10 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:10 INFO - '_': '/tools/buildbot/bin/python'} 18:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:10 INFO - Running setup.py (path:/tmp/pip-SDsmu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:10 INFO - Running setup.py (path:/tmp/pip-9sqqn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:10 INFO - Running setup.py (path:/tmp/pip-7TDeDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:10 INFO - Running setup.py (path:/tmp/pip-j88YZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:10 INFO - Running setup.py (path:/tmp/pip-xxUP2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:11 INFO - Running setup.py (path:/tmp/pip-NeI94V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:11 INFO - Running setup.py (path:/tmp/pip-ci3UzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:11 INFO - Running setup.py (path:/tmp/pip-HcJRpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:11 INFO - Running setup.py (path:/tmp/pip-u4Y9oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:11 INFO - Running setup.py (path:/tmp/pip-LFT1jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:11 INFO - Running setup.py (path:/tmp/pip-IRJllP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:11 INFO - Running setup.py (path:/tmp/pip-1Tofl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:11 INFO - Running setup.py (path:/tmp/pip-h9hcuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:11 INFO - Running setup.py (path:/tmp/pip-CTs1vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:11 INFO - Running setup.py (path:/tmp/pip-Y92tAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:11 INFO - Running setup.py (path:/tmp/pip-Yizzaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:11 INFO - Running setup.py (path:/tmp/pip-hAtBGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:16:11 INFO - Running setup.py install for manifestparser 18:16:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:16:11 INFO - Running setup.py install for mozcrash 18:16:12 INFO - Running setup.py install for mozdebug 18:16:12 INFO - Running setup.py install for mozdevice 18:16:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Running setup.py install for mozfile 18:16:12 INFO - Running setup.py install for mozhttpd 18:16:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Running setup.py install for mozinfo 18:16:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Running setup.py install for mozInstall 18:16:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Running setup.py install for mozleak 18:16:12 INFO - Running setup.py install for mozlog 18:16:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Running setup.py install for moznetwork 18:16:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:16:12 INFO - Running setup.py install for mozprocess 18:16:13 INFO - Running setup.py install for mozprofile 18:16:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:16:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:16:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:16:13 INFO - Running setup.py install for mozrunner 18:16:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:16:13 INFO - Running setup.py install for mozscreenshot 18:16:13 INFO - Running setup.py install for moztest 18:16:13 INFO - Running setup.py install for mozversion 18:16:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:16:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:16:13 INFO - Cleaning up... 18:16:13 INFO - Return code: 0 18:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:13 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 0x7fb22e334c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ef9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:13 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 18:16:13 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 18:16:13 INFO - Using env: {'DISPLAY': ':0', 18:16:13 INFO - 'HOME': '/home/cltbld', 18:16:13 INFO - 'LANG': 'en_US.UTF-8', 18:16:13 INFO - 'LANGUAGE': 'en_US:en', 18:16:13 INFO - 'LOGNAME': 'cltbld', 18:16:13 INFO - 'MAIL': '/var/mail/cltbld', 18:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:13 INFO - 'MOZ_NO_REMOTE': '1', 18:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:13 INFO - 'NO_EM_RESTART': '1', 18:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:13 INFO - 'PWD': '/builds/slave/test', 18:16:13 INFO - 'SHELL': '/bin/bash', 18:16:13 INFO - 'SHLVL': '1', 18:16:13 INFO - 'TERM': 'linux', 18:16:13 INFO - 'TMOUT': '86400', 18:16:13 INFO - 'USER': 'cltbld', 18:16:13 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:13 INFO - '_': '/tools/buildbot/bin/python'} 18:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:13 INFO - Running setup.py (path:/tmp/pip-pHV8NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:13 INFO - Running setup.py (path:/tmp/pip-HVDMgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:13 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)) 18:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:13 INFO - Running setup.py (path:/tmp/pip-rUR_OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:14 INFO - Running setup.py (path:/tmp/pip-j8eBbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:14 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)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:14 INFO - Running setup.py (path:/tmp/pip-2ycU4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:14 INFO - Running setup.py (path:/tmp/pip-bErQmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:14 INFO - Running setup.py (path:/tmp/pip-88TJTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:14 INFO - Running setup.py (path:/tmp/pip-4CIbxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:14 INFO - Running setup.py (path:/tmp/pip-S5TJwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:14 INFO - Running setup.py (path:/tmp/pip-TqPBqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:14 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)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:14 INFO - Running setup.py (path:/tmp/pip-N1CKAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:14 INFO - Running setup.py (path:/tmp/pip-M5CqUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:14 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)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:14 INFO - Running setup.py (path:/tmp/pip-lgcsPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:14 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)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:14 INFO - Running setup.py (path:/tmp/pip-nP2Hgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:14 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)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:14 INFO - Running setup.py (path:/tmp/pip-rPgxRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:14 INFO - Running setup.py (path:/tmp/pip-QiqDKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:14 INFO - Running setup.py (path:/tmp/pip-xArP1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:16 INFO - Downloading blessings-1.5.1.tar.gz 18:16:16 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 18:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:16:16 INFO - Installing collected packages: blessings 18:16:16 INFO - Running setup.py install for blessings 18:16:16 INFO - Successfully installed blessings 18:16:16 INFO - Cleaning up... 18:16:16 INFO - Return code: 0 18:16:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:17 INFO - Reading from file tmpfile_stdout 18:16:17 INFO - Current package versions: 18:16:17 INFO - argparse == 1.2.1 18:16:17 INFO - blessings == 1.5.1 18:16:17 INFO - blobuploader == 1.2.4 18:16:17 INFO - docopt == 0.6.1 18:16:17 INFO - manifestparser == 1.1 18:16:17 INFO - mozInstall == 1.12 18:16:17 INFO - mozcrash == 0.16 18:16:17 INFO - mozdebug == 0.1 18:16:17 INFO - mozdevice == 0.47 18:16:17 INFO - mozfile == 1.2 18:16:17 INFO - mozhttpd == 0.7 18:16:17 INFO - mozinfo == 0.9 18:16:17 INFO - mozleak == 0.1 18:16:17 INFO - mozlog == 3.0 18:16:17 INFO - moznetwork == 0.27 18:16:17 INFO - mozprocess == 0.22 18:16:17 INFO - mozprofile == 0.27 18:16:17 INFO - mozrunner == 6.11 18:16:17 INFO - mozscreenshot == 0.1 18:16:17 INFO - mozsystemmonitor == 0.0 18:16:17 INFO - moztest == 0.7 18:16:17 INFO - mozversion == 1.4 18:16:17 INFO - psutil == 3.1.1 18:16:17 INFO - requests == 1.2.3 18:16:17 INFO - wsgiref == 0.1.2 18:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:17 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 0x7fb22e334c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ef9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:17 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 18:16:17 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 18:16:17 INFO - Using env: {'DISPLAY': ':0', 18:16:17 INFO - 'HOME': '/home/cltbld', 18:16:17 INFO - 'LANG': 'en_US.UTF-8', 18:16:17 INFO - 'LANGUAGE': 'en_US:en', 18:16:17 INFO - 'LOGNAME': 'cltbld', 18:16:17 INFO - 'MAIL': '/var/mail/cltbld', 18:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:17 INFO - 'MOZ_NO_REMOTE': '1', 18:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:17 INFO - 'NO_EM_RESTART': '1', 18:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:17 INFO - 'PWD': '/builds/slave/test', 18:16:17 INFO - 'SHELL': '/bin/bash', 18:16:17 INFO - 'SHLVL': '1', 18:16:17 INFO - 'TERM': 'linux', 18:16:17 INFO - 'TMOUT': '86400', 18:16:17 INFO - 'USER': 'cltbld', 18:16:17 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:17 INFO - '_': '/tools/buildbot/bin/python'} 18:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 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)) 18:16:17 INFO - Cleaning up... 18:16:17 INFO - Return code: 0 18:16:17 INFO - Running post-action listener: _resource_record_post_action 18:16:17 INFO - Running post-action listener: _start_resource_monitoring 18:16:17 INFO - Starting resource monitoring. 18:16:17 INFO - ##### 18:16:17 INFO - ##### Running install step. 18:16:17 INFO - ##### 18:16:17 INFO - Running pre-action listener: _resource_record_pre_action 18:16:17 INFO - Running main action method: install 18:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:17 INFO - Reading from file tmpfile_stdout 18:16:17 INFO - Detecting whether we're running mozinstall >=1.0... 18:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:16:17 INFO - Reading from file tmpfile_stdout 18:16:17 INFO - Output received: 18:16:17 INFO - Usage: mozinstall [options] installer 18:16:17 INFO - Options: 18:16:17 INFO - -h, --help show this help message and exit 18:16:17 INFO - -d DEST, --destination=DEST 18:16:17 INFO - Directory to install application into. [default: 18:16:17 INFO - "/builds/slave/test"] 18:16:17 INFO - --app=APP Application being installed. [default: firefox] 18:16:17 INFO - mkdir: /builds/slave/test/build/application 18:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:16:31 INFO - Reading from file tmpfile_stdout 18:16:31 INFO - Output received: 18:16:31 INFO - /builds/slave/test/build/application/firefox/firefox 18:16:31 INFO - Running post-action listener: _resource_record_post_action 18:16:31 INFO - ##### 18:16:31 INFO - ##### Running run-tests step. 18:16:31 INFO - ##### 18:16:31 INFO - Running pre-action listener: _resource_record_pre_action 18:16:31 INFO - Running main action method: run_tests 18:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:16:31 INFO - Python 2.7.3 18:16:31 INFO - Return code: 0 18:16:31 INFO - grabbing minidump binary from tooltool 18:16: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')]} 18:16:31 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157eac0>, '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 0x157f9a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x157fe50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:16:31 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:16:31 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/linux64/releng.manifest -o -c /builds/tooltool_cache 18:16:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:16:31 INFO - Return code: 0 18:16:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:16:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:16:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:16:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:16:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test/build 18:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 18:16:31 INFO - Using env: {'DISPLAY': ':0', 18:16:31 INFO - 'HOME': '/home/cltbld', 18:16:31 INFO - 'LANG': 'en_US.UTF-8', 18:16:31 INFO - 'LANGUAGE': 'en_US:en', 18:16:31 INFO - 'LOGNAME': 'cltbld', 18:16:31 INFO - 'MAIL': '/var/mail/cltbld', 18:16:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:16:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:31 INFO - 'MOZ_NO_REMOTE': '1', 18:16:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:31 INFO - 'NO_EM_RESTART': '1', 18:16:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:31 INFO - 'PWD': '/builds/slave/test', 18:16:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:16:31 INFO - 'SHELL': '/bin/bash', 18:16:31 INFO - 'SHLVL': '1', 18:16:31 INFO - 'TERM': 'linux', 18:16:31 INFO - 'TMOUT': '86400', 18:16:31 INFO - 'USER': 'cltbld', 18:16:31 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285', 18:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:31 INFO - '_': '/tools/buildbot/bin/python'} 18:16:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 18:16:32 INFO - mozversion INFO | application_buildid: 20151117175137 18:16:32 INFO - mozversion INFO | application_changeset: e85794f108f04dd2ee460c6b3e030a148185e81c 18:16:32 INFO - mozversion INFO | application_display_name: Nightly 18:16:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:16:32 INFO - mozversion INFO | application_name: Firefox 18:16:32 INFO - mozversion INFO | application_remotingname: firefox 18:16:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:16:32 INFO - mozversion INFO | application_vendor: Mozilla 18:16:32 INFO - mozversion INFO | application_version: 45.0a1 18:16:32 INFO - mozversion INFO | platform_buildid: 20151117175137 18:16:32 INFO - mozversion INFO | platform_changeset: e85794f108f04dd2ee460c6b3e030a148185e81c 18:16:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:16:32 INFO - mozversion INFO | platform_version: 45.0a1 18:16:32 INFO - 2015-11-17 18:16:32,029 DEBUG : using testdate: 1447812992 18:16:32 INFO - 2015-11-17 18:16:32,029 DEBUG : actual date: 1447812992 18:16:32 INFO - 2015-11-17 18:16:32,038 INFO : starting webserver on 'localhost:52138' 18:16:32 INFO - 2015-11-17 18:16:32,039 INFO : Starting test suite talos-linux64-ix-061 18:16:32 INFO - 2015-11-17 18:16:32,039 INFO : Starting test dromaeo_css 18:16:32 INFO - 2015-11-17 18:16:32,039 DEBUG : operating with platform_type : linux_ 18:16:32 INFO - 2015-11-17 18:16:32,040 INFO : Initialising browser for dromaeo_css test... 18:16:32 INFO - 2015-11-17 18:16:32,057 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7azPQ6/profile http://localhost:52138/getInfo.html 18:16:36 INFO - 2015-11-17 18:16:36,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:16:36 INFO - 2015-11-17 18:16:36,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:16:36 INFO - 2015-11-17 18:16:36,052 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:16:36 INFO - 2015-11-17 18:16:36,052 DEBUG : BROWSER_OUTPUT: __metrics 18:16:36 INFO - 2015-11-17 18:16:36,330 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:16:37 INFO - 2015-11-17 18:16:37,527 INFO : Browser initialized. 18:16:37 INFO - 2015-11-17 18:16:37,527 INFO : Running cycle 1/1 for dromaeo_css test... 18:16:37 INFO - 2015-11-17 18:16:37,527 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7azPQ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:16:49 INFO - 2015-11-17 18:16:49,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 142303232 18:16:49 INFO - 2015-11-17 18:16:49,430 DEBUG : BROWSER_OUTPUT: 18:17:40 INFO - 2015-11-17 18:17:40,784 DEBUG : BROWSER_OUTPUT: 1447813060780 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:19:52 INFO - 2015-11-17 18:19:52,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52138/tests/dromaeo/cssquery-ext.html) 18:19:53 INFO - 2015-11-17 18:19:53,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 300515328 18:19:53 INFO - 2015-11-17 18:19:53,916 DEBUG : BROWSER_OUTPUT: 18:22:56 INFO - 2015-11-17 18:22:56,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/dromaeo/cssquery-ext.html (next: http://localhost:52138/tests/dromaeo/cssquery-jquery.html) 18:22:57 INFO - 2015-11-17 18:22:57,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 225890304 18:22:57 INFO - 2015-11-17 18:22:57,187 DEBUG : BROWSER_OUTPUT: 18:25:59 INFO - 2015-11-17 18:25:59,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52138/tests/dromaeo/cssquery-mootools.html) 18:25:59 INFO - 2015-11-17 18:25:59,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 217763840 18:25:59 INFO - 2015-11-17 18:25:59,828 DEBUG : BROWSER_OUTPUT: 18:29:01 INFO - 2015-11-17 18:29:01,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52138/tests/dromaeo/cssquery-prototype.html) 18:29:02 INFO - 2015-11-17 18:29:02,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 203415552 18:29:02 INFO - 2015-11-17 18:29:02,326 DEBUG : BROWSER_OUTPUT: 18:32:04 INFO - 2015-11-17 18:32:04,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52138/tests/dromaeo/cssquery-yui.html) 18:32:05 INFO - 2015-11-17 18:32:05,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 204509184 18:32:05 INFO - 2015-11-17 18:32:05,552 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/dromaeo/cssquery-yui.html (next: http://localhost:52138/tests/dromaeo/cssquery-dojo.html) 18:35:08 INFO - 2015-11-17 18:35:08,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 276471808 18:35:08 INFO - 2015-11-17 18:35:08,345 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,347 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:35:08 INFO - 2015-11-17 18:35:08,347 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:35:08 INFO - 2015-11-17 18:35:08,347 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:35:08 INFO - 2015-11-17 18:35:08,347 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:35:08 INFO - 2015-11-17 18:35:08,351 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2621.2005338371796;2767.6678798544176;2771.3071732066983;2784.10908509277;2800.243934137783;4588.013577080927;4699.506551812054;4772.236442169254;4797.6161907047435;4821.228603423453;4740.810367585301;4756.690815097017;4854.271859221119;4862.124817532843;4868.878278043051;4380.8247670093315;4421.07157496926;4441.733495990235;4553.658475614326;4599.655025873056;4508.706934049293;4533.818647254122;4569.086182763444;4583.747893865836;4617.792199351037;4188.811503482335;4288.249556327662;4297.67767417445;4388.670849686287;4422.137683151786;4411.316245981846;4427.667924905645;4428.070105277896;4429.291313389875;4456.6880318377725;4393.36296237047;4396.71421357614;4419;4434.490033646108;4456.6880318377725;4514.322851572258;4630.953690463086;4646.1404640141345;4667.88330291742;4817.662763606549;5141.665791723526;5152.92270615941;5153.046686362997;5155.200943853709;5159.045576568347;5192.376914770214;5194.948050519522;5197.1424714922;5231.973840130813;5240.9213861792105;4616.930746038812;4724.551167639069;4728.290756386569;4729.385179926588;4812.446568644581;5347.25138480613;5375.7849686012905;5383.246345511631;5392.4607539246545;5398.433164517669;5135.537801597874;5144.331236939174;5150.175971844487;5153.123968925292;5193;4882.755862206946;5002.849914502571;5004.399472063303;5115.616328775282;5281.313429254249;5177.611679124006;5201.297824793604;5206.97396513015;5209.296744939385;5217.034848553029;5181.145111056709;5182.989317083133;5184.0927837629015;5185.7407129644125;5196.8960620787375;3844.884653460401;3892.9805350973065;3949.7037722170953;3960.2871483133313;3991.521017477863;3525.647435256505;3533.0460775590445;3544.503769472276;3553.875614353537;3557.8043207623828;4437.334399839985;4446.644268458515;4452.8218871245435;4455.732656040648;4483.215437298525;4915.5330243626795;5028.994201159782;5031.77357018935;5136.306598609214;5184.066867963803;4470.105978804252;4475.843345482957;4506.481754598198;4510.413646225969;4513.187626227311;4610.561996610317;4615.792289346988;4622.838200662961;4623.190941585209;4666.673332866667;4678.0643871226575;4769.070031343855;4803.447603525499;4957.429895562056;4967.006598680278;5182.300389447376;5267.157254839208;5271.525562699376;5277.551408130352;5318.787248510016;4913.926291105708;4925.926111108264;4926.137925862888;4928.260760885896;4964.230544265644;4857.101436234308;4980.726060066731;4980.750962451791;5124.410692770379;5131.050755610224;4986.80052797884;4986.80052797884;5003.224500202475;5015.097282489187;5015.899682006267;4917.065757506205;4942.357493525818;4942.777575009205;4944.159492886146;4945.1346014448045;4913.533214344631;4918.704877707206;4938.283948827472;5028.84913452597;5030.320906677698;4924.852254432372;4938.9259161111895;4970.602351811919;4977.601791856715;4981.875453113701;5059.266406371129;5103.336566246513;5105.923411148761;5126.333576635014;5148.510891465305;4648.976755116203;4777.4983626718695;4788.760561971957;4886.877828054327;4973.925391119208 18:35:08 INFO - 2015-11-17 18:35:08,352 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.1503669312567;559.5271995164085;569.1093438768328;577.6043410263968;577.6562945047698;22947.655785163213;23496.412589685246;35326.823365883196;35516.46725299123;35761.28477430453;38067;38386;38630.61369386305;38634.227315453674;38692;6797;7902.407319451036;8073.717419890276;8079.757607271762;8082.959585202066;6909.378155965962;10046.19630429564;10179.745506362364;10343.586256549728;10348.948255258712;9909.207263418944;10005.59977600895;10012.899871001306;10027.047430494127;10032.648857289996;6908.1364829396325;7064.717411303542;9957.551910164024;9981.800363992752;10079.395236285809;9611.855822162674;9754.317197796157;9760.121589056947;9760.95119524405;9767.218622510181;36386;36676;36851.447228291596;36898;36954.815225923965;2626.3302857771337;2705.1478784183114;3048.8170709757487;3297.1097803593134;3330.8501117449773;27871.721282787115;28102.718972810213;28174.859125704446;28298.434031319463;28702.71297287042;2985.596944412498;2988.1035689293126;3026.0921723482866;3070.493368594179;3092.721655051034;221960;223585;224139;224348;224658;36511.4523282151;37287.067823304635;51490.22764658533;51715.224271635954;51851;60854;62077;62088;62167;62199.6890015547;11803.468843902045;12013.339266340261;12016.63950081499;12037.699057523632;12055.698607534707;8603.268722158688;8608.48349099056;8635.179657932485;8641.092685268082;8698.043215246318;17819.910900445673;17980.9100954497;18005.909970450062;18029.368972085915;18059.187336569885;6880.65596720162;7116.573005619679;7161.283871612797;7205.89191162133;7210.206877243499;803.8713805791162;821.708293555791;896.9551522423983;972.5380444288907;1019.7246743379394;25249.30554167752;25661.230163095137;25936.481270374486;25939.48121037569;25946;879.4239772948729;895.632790555882;923.7459698582809;931.7437704631145;945.9810803783886;12476.18904771187;12573.937130314473;12638.368081595883;12687.11190216676;12730.427130778951;254443;260960;261455;261748;261776;36349.27301453956;37743.999999999454;38138.61861381406;38222.42666360007;38312.42531362032;1092.4974511724695;1108.7228192951761;1109.0628418985782;1125.4879030041475;1126.0372381613765;22560.210392636836;22851.428714282276;23306.53386932286;25239.873800630878;25624.871875640503;36448.63551364453;36939.63060369362;36940.81529592335;36965;37040.6295937048;180061;180612;181009;181543.09228453774;182165;22342.994565244928;22759.31722048341;26010;28051;28612;33274.833625831714;33339.83330083431;33451;33547.49678754869;34172.31655366829;29561.408771824874;30795.538066928566;31637.36725265528;32097.679023210403;32269.51595726019;24577;29265.41469170647;30778.53832192474;31812.84093579517;32638;31494.37011259716;31938.840305798323;31959.360812784078;31997.360052798347;32018.51972220372;25560.360990975376;26152.73847261503;27228.863855680596;27479.587806183325;28607.42785144327;22726.545469090855;22906.198283060014;23000.539989199788;23112.306630801104;23566.528669426174 18:35:08 INFO - 2015-11-17 18:35:08,353 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.60035356334924;324.8976572379699;328.9292802047559;330.46464727142023;338.42974587819526;11921.225120367191;12284.508619655204;14546.709065818677;15170.469033583813;15947.28237229326;15497;15735.92132039341;15839.683206335867;16003.119828409433;16024.519264422086;4916.287138364953;4950.752462376876;4959.132151873426;4987.8254261100865;4999.475055119215;3551.271989242199;3632.4914511968345;5045.974770126144;5469.863253418656;5717.085266357383;5629.802956896509;5653.23681303025;5655.660660360371;5681.545476361902;5684.715764211794;5578.693171875545;5725.914111288334;5730.742116604721;5746.569007324447;5750.942490575083;5000.699958002495;5003.124453220672;5009.774560144802;5020.949790502122;5026.095302845486;18907.43277701671;19203.90398048001;19535.804641953542;19580.608387832162;19590.21639134433;1730.1003478191396;1800.3698705453119;1803.3417802502124;1813.5919418130948;1923.3749031564657;12532.624021279376;12646.49414023438;12697.194295882475;12845.293508857008;12957.22256664603;1698.787651543557;1702.1999660159704;1761.3659082730208;1762.0837164674297;1805.8645601579803;53761.1935820963;54817.451825482036;54883;55073;55400;8926.196642302224;9108.407953483002;9397.859032114524;9401.999999999864;9464.384814987005;11671.59149429766;11684.298942063504;11685.298882067103;11689.240199387013;11690.76618467643;6268.968655156787;6607.636579988147;6611.570247933869;6659.334066593399;6662.100616416818;5778.393268706809;5784.334801497882;5889.028310328834;5890.646561206341;5895.587308888336;5542.944570554324;5589.496945274945;5606.355269144101;5615.691136987423;5666.716664166775;1517.521980576115;1589.9205039747967;1592.9362825487083;1598.4325564424462;1640.9015459072493;802.3661307567073;921.5714692667941;929.2473096791485;929.869818225449;939.6382392778693;15975.520734377988;16157.272922718506;16218.270177842025;16575.6684866302;16651.750223746654;771.7954741993376;775.2979522778777;834.9415540912199;882.9293656507464;906.5603182456504;9060.501672407949;9366.344355895159;9408.200302974186;9479.676420653122;9586.089321514444;443857;444055;449753;457276;462594;61064;62445.37554624487;62542.19009007221;62743.372566273756;69147;475.4793501116341;488.6188772757255;488.84601350574457;489.1317910708521;490.47029208454785;9436.669716559887;9547.618095276111;9744.025597440199;9752.756181095529;9803.852942206015;31531.369372612877;31929.201769955936;32936.505952410254;34213.31573368568;34262.82868585641;43267.56732432761;44045.77977110222;45338.546614533436;45689;45750.313745293184;6078.696065196634;6165.599236049642;6168.444839964424;6176.197094377702;6178.969105154445;10704.571817127227;10971.670849874517;10976.451177440937;10997.395143267197;11048.613298534512;9643.228541716786;9789.657361992297;9842.803143937224;9961.35251208669;9992.700218993441;9375.10936461035;9541.427514349161;9665.71002869915;9673.37123086997;9882.061204185591;8281.668733250603;8575.31397488212;9110.863337049817;9389.765255868659;9660;5785.016547187072;5850.561207909339;5971.850703732442;6022.548308876764;6026.186464827192;9184.173424391836;9514.38156519824;9518.571664275263;9538.23694104484;9644.807103857744 18:35:08 INFO - 2015-11-17 18:35:08,357 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1413.561795843288;1620.8055033395995;1659.5933996170932;1679.8824082314236;1687.6877777611144;5979.431953964372;6732.528722989387;6821.556598821073;6839.1451068616425;6871.518993670433;6905.861882762341;7121.181064177621;7144.357007869291;7149.249328820477;7164.570125792456;2046.396313087639;2078.5635016646524;2084.322595156573;2086.2698055680466;2086.9060892259886;2090.613236551243;2096.266306792618;2102.2536999365234;2133.9893300533477;2137.9037943292587;2049.846261530384;2057.9485512862148;2058.3001779395004;2061.9484512887225;2069.1723310675775;1991.2930909527126;2022.5853699991467;2023.4435530229157;2024.6052019856133;2027.0574183004826;2053.240301088592;2057.5267688431745;2090.1117025264202;2090.9268175613934;2091.518950641346;5983.252093488314;6134.417230363153;7029.859402811966;7079.433645308363;7086.645667716593;3983.24318379507;4082.4692789937417;4094.4267802507675;4095.8361665533344;4103.363978583325;2697.0829917827837;2724.209979106057;2771.80597358185;2773.5839624056553;2846.2599724071683;872.5157537566648;881.4667126388571;893.4996402014827;897.3270047464401;903.2051794420868;9560.091791279887;9630;9630.422174669542;9647.372920760128;9655.951720241354;3913.5303763548554;3925.0776067624083;3967.2858885400906;3968.900777480528;3980.104476492824;8314.41799074071;8321.04308004575;8331.625076871554;8334.583270836434;8370.581470926429;4206.621404073648;4217.725847819943;4237.597428244312;4243.915121697549;4249.043965107826;3755.5493340798735;3756.4553139794575;3756.7745935243975;3757.0607348162957;3763.2661630982243;3372.8482218300237;3375.729941604666;3388.119089036868;3393.575803024622;3417.3848707232937;1094.2285688589525;1104.3870651788175;1108.922375433712;1114.5931734916696;1114.7380365614074;1098.780243951213;1107.036877916202;1112.1380929779325;1113.4210210690396;1139.2196345503357;6510;6526.64103474304;6552.410283074546;6558.1802274715665;6563.9343606563325;1059.8410238464292;1072.2119242356862;1087.4399684162663;1092.2190633696946;1093.8031154392286;4539.59143677064;4737.407824021997;4824.469308376076;4829.637777166727;4831.9275210871865;7655.846883062308;8039.15588863161;8210.178982101861;8219.712310069239;8267.338612911073;8167.550784706779;8202.58987050645;8267.379946504036;8290.917090829134;8302.294304984143;6263.091851681481;6545.9018114728315;6566.573172743756;6573.244076931214;6578.506612004023;6496.123023391781;6503.967480162569;6546.541742078009;6560.343965603402;6567.507436942344;7494.288042635941;7739.7678069658;7820.139784623801;7860.0567931848545;7870.567118808521;7644.847103058019;7817.0619525657285;7844.882326764989;7907.802304942423;7932.801679958047;6363.809085727436;6372.458341041063;6422.325655806073;6448.516361272829;6450.580712253689;6581;6582.275949645439;6606.306337834458;6606.6366349849295;6607.57050791697;6475.287718350884;6567.9671601641685;6617.6029438231935;6634.369734875179;6663.766768163091;6314.6842657866;6337.493000560036;6346.460550853045;6382;6393.073004414427;6449.226092868886;6460.547761656639;6481.4166724994975;6492.220933488012;6492.220933488012;5791.189233507228;5815.098659707752;5819.010768169337;5837.854053648693;5842.678652673973;5713.771449141987;5768.625039372428;5777.653340799566;5780.5953583248765;5787.421257874179 18:35:08 INFO - 2015-11-17 18:35:08,358 DEBUG : BROWSER_OUTPUT: |4;prototype.html;279.79994304072585;290.3481683620272;290.8952777000281;302.23685194882916;304.1908523327948;5402.730853041722;5431.293931788872;5445.128779395298;5470.124780035195;5478.123500239963;5380.354357477098;5382.2195781611745;5382.91925621116;5384.273123128377;5385.542228910547;4216.7680777557225;4217.40956266123;4218.30397984333;4219.07180420307;4220.198162349144;3989.301872172373;4093.4269202311702;4116.732412393199;4178.707490475653;4229.915401691965;4143.917121657565;4145.274576949037;4161.771102589357;4163.396307535406;4178.059936514291;3893.201893611831;4020.0502756163237;4170.374443833419;4171.436856024443;4179.979100104495;3545.7163426925786;3615.1504396466808;3622.637736226356;3623.3840247158046;3638.07229156566;5172.948270517284;5182.714950677711;5197.038547868657;5200.6879587224885;5210.583153347723;4806.279058141272;4815.3499277597775;4819.831305904311;4822.71063736177;4824.035192961387;5557.6109672322955;5717.799877004285;5724.542036637059;5729.856753581152;5765.270418874321;4043.959560404417;4053.898652533681;4053.97973010136;4054.6553542948886;4057.2696914555368;5952.821415357546;6042.607230530001;6051.243594550681;6052.182955301022;6053.273607167124;4190.20386126635;4194.182134483807;4194.916101677949;4194.937075943863;4195.853145139906;4149.730267532601;4238.809253583596;4244;4248.235317642792;4261.722988005832;4800.423949126127;4805.1590971579835;4828.493008234085;4837.32277481153;4838.782254798542;5700.800471983461;5703.116017017369;5703.9429605704245;5711.571632127524;5711.971440142773;1459.0370355565276;1470.0591621362337;1471.3820195517908;1472.065238573492;1474.071335058906;996.3722854601555;1001.6944831826363;1005.1154983614373;1006.6476733143488;1025.5487585462372;4995.575376093073;5018.673786203885;5019.3976722793495;5027.4721154279005;5051.393832740095;5933.9406605934255;5941.643501389931;5942.970285148633;5948.970255148696;5950.613210141413;5019.82430614934;5037.219231019198;5040.143175660147;5041.470645582234;5042.647014708935;3088.783785135064;3136.7490600751885;3187.888423905152;3196.632387275493;3223.5648187494858;5501.449855014546;5613.522850557748;5636.887262254732;5644.096944488862;5645.915311270334;6052.939470605325;6063.636181829104;6066.636001839904;6130.01919692847;6135.478484328793;5554.972225138848;5613.101903695389;5646.491815736604;5648.971755141362;5652.2652055233375;5747.511461525817;5937.732802023833;5963.7912673056235;5986.850328741816;5989.1615173874825;5831.883362332815;5835.533157347487;5840.503557197686;5841.883162336814;5851.473367396955;5655.4910058094965;5662.490375866192;5663.7451314690115;5681.0910254359105;5682.034054210877;3973.324534829144;4015.1166743316426;4065.89835254121;4070.7354021988476;4076.775777332275;5971.28344598651;5975.342712301556;5979.760809567569;5979.940200597938;5986.2517185351835;5773.480386765212;5775.537956963517;5776.104703770754;5781.075027995501;5783.884322313446;5668.7165641718575;5735.569832262514;5767.68277744728;5767.971160144172;5772.018756811268;5623.662580245198;5624.634398764068;5635.042042852643;5635.351934527418;5638.097904335451;5805.535557155333;5808.128780682931;5810.796622118206;5814.73833677494;5815.302163740378;5643.689597072201;5653.123765816305;5666.688332141772;5672.744726487401;5675.0636145035605 18:35:08 INFO - 2015-11-17 18:35:08,359 DEBUG : BROWSER_OUTPUT: |5;yui.html;684.9963855722015;694.9583025018499;700.6041586503625;702.4766548921054;717.8779607466734;10324.741881452957;10462;10546.578136874536;10553.366797992116;10660.840087398696;10911.399873006982;11012.39431831249;11014.39420831854;11023.503942322595;11041.613543525958;597.4682532546037;605.5186127029023;749.2769477454256;771.5447885747408;779.9883001754978;775.170567492783;775.5734346109646;780.0795061827042;782.1708988472209;782.671278063212;622.551762730833;788.9447738658296;792.2473650032464;795.6340083561539;795.7851380127362;629.4775336470718;803.995980020102;817.4686453805074;818.1164342510134;819.4141189049858;606.8118883146238;607.6991889014965;607.8905796956547;608.1759216261989;608.270075908911;11114.722131946684;11224.102071834233;11234.157438192087;11265.887341126565;11269.830952535718;8319.292860106898;8474.703385381543;8972.147645973622;10316.48417579118;11021.889781102167;8321.750347489586;8413.915860841375;8617.267532259766;8774.780630484225;8946.821063578756;2784.582312653098;2846.2172902451784;2865.398266364066;2874.425114977013;2913.417316536701;37638.43542346867;38426;38520.03699907497;38550;38565.22869542593;6669.7665581704405;6764.830879228059;6804.047433359334;6872.656367181621;6890.138732658418;10238.33450825694;10266.178705703525;10273.178145748323;10280.537375818107;10284.640037598649;5383.596230282745;5612.214289999403;5674.347450043216;5713.143028545752;5813.389594092644;3514.3674138655288;3593.586737525166;3599.874004409833;3619.3485172668647;3658.8902332930056;2392.210570511727;2408.337707130518;2410.505846301504;2412.9396765081015;2414.7102347718387;375.6619042861392;376.1217557004425;383.79658780845637;385.02396425062335;385.4988514930579;389.3653345047554;449.9527549607244;500.2059379605659;501.2931766209627;505.88111793728444;5864.472197502245;5968.582199246011;5996.730147143389;6113.663748493876;6150.292716337678;495.9305697202395;506.4808571214535;513.8407093800859;527.7255826969954;538.8437353167537;2901.5502597097484;2926.2200909136404;2944.528875379929;2991.985040074829;3029.8182109073527;53880.73059634755;54667.179992300145;54791.72604136954;54859;55177.448225518034;46662.5333746665;47011.529884700714;47724.04551908942;48575.75712121417;49658.50341496611;43046.13907721828;43060.354094688606;43095.56904431041;43332.350014749805;44314.556854431044;7375.852482950419;7393.741219057307;7447.702091916262;7505.362044226302;7548.4716069874585;30988.22529436782;31386.843065784524;31872.681273186972;31906.36187276195;32576;38146.809265953496;38233;39376.606233937295;42885;42950.570494294654;6607.537472376887;6976.372126508639;7038;7057.364837164474;7091.397231235403;10643.254972151875;10783.51474183648;10820.783584328112;10840.295380800222;11100.500477478372;9649;9769.071938165864;9987;10113.5448904798;10129.89870101319;9433.952830235805;9556.474393908402;9764.804703906024;9918.851217231891;9929.503524823875;9609.807803843743;9702.514874256118;9933.403995760278;9939.353941993748;9991.450470224207;8448.577571121297;8604.225619694258;8863.379563430755;8865.734027979172;8867.467951922905;7985.760427187193;8383.832323353621;8716.520591367536;8720.171583699539;8813.118688131135 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1476 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814108346__endTimestamp 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4732.58 Median:4882.76 stddev:528.13 (10.8%) stddev-sans-first:503.10 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: Values: 2621.2 2767.7 2771.3 2784.1 2800.2 4588.0 4699.5 4772.2 4797.6 4821.2 4740.8 4756.7 4854.3 4862.1 4868.9 4380.8 4421.1 4441.7 4553.7 4599.7 4508.7 4533.8 4569.1 4583.7 4617.8 4188.8 4288.2 4297.7 4388.7 4422.1 4411.3 4427.7 4428.1 4429.3 4456.7 4393.4 4396.7 4419.0 4434.5 4456.7 4514.3 4631.0 4646.1 4667.9 4817.7 5141.7 5152.9 5153.0 5155.2 5159.0 5192.4 5194.9 5197.1 5232.0 5240.9 4616.9 4724.6 4728.3 4729.4 4812.4 5347.3 5375.8 5383.2 5392.5 5398.4 5135.5 5144.3 5150.2 5153.1 5193.0 4882.8 5002.8 5004.4 5115.6 5281.3 5177.6 5201.3 5207.0 5209.3 5217.0 5181.1 5183.0 5184.1 5185.7 5196.9 3844.9 3893.0 3949.7 3960.3 3991.5 3525.6 3533.0 3544.5 3553.9 3557.8 4437.3 4446.6 4452.8 4455.7 4483.2 4915.5 5029.0 5031.8 5136.3 5184.1 4470.1 4475.8 4506.5 4510.4 4513.2 4610.6 4615.8 4622.8 4623.2 4666.7 4678.1 4769.1 4803.4 4957.4 4967.0 5182.3 5267.2 5271.5 5277.6 5318.8 4913.9 4925.9 4926.1 4928.3 4964.2 4857.1 4980.7 4980.8 5124.4 5131.1 4986.8 4986.8 5003.2 5015.1 5015.9 4917.1 4942.4 4942.8 4944.2 4945.1 4913.5 4918.7 4938.3 5028.8 5030.3 4924.9 4938.9 4970.6 4977.6 4981.9 5059.3 5103.3 5105.9 5126.3 5148.5 4649.0 4777.5 4788.8 4886.9 4973.9 18:35:08 INFO - 2015-11-17 18:35:08,360 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,361 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37411.01 Median:31565.87 stddev:58341.79 (184.8%) stddev-sans-first:58439.80 18:35:08 INFO - 2015-11-17 18:35:08,361 DEBUG : BROWSER_OUTPUT: Values: 548.2 559.5 569.1 577.6 577.7 22947.7 23496.4 35326.8 35516.5 35761.3 38067.0 38386.0 38630.6 38634.2 38692.0 6797.0 7902.4 8073.7 8079.8 8083.0 6909.4 10046.2 10179.7 10343.6 10348.9 9909.2 10005.6 10012.9 10027.0 10032.6 6908.1 7064.7 9957.6 9981.8 10079.4 9611.9 9754.3 9760.1 9761.0 9767.2 36386.0 36676.0 36851.4 36898.0 36954.8 2626.3 2705.1 3048.8 3297.1 3330.9 27871.7 28102.7 28174.9 28298.4 28702.7 2985.6 2988.1 3026.1 3070.5 3092.7 221960.0 223585.0 224139.0 224348.0 224658.0 36511.5 37287.1 51490.2 51715.2 51851.0 60854.0 62077.0 62088.0 62167.0 62199.7 11803.5 12013.3 12016.6 12037.7 12055.7 8603.3 8608.5 8635.2 8641.1 8698.0 17819.9 17980.9 18005.9 18029.4 18059.2 6880.7 7116.6 7161.3 7205.9 7210.2 803.9 821.7 897.0 972.5 1019.7 25249.3 25661.2 25936.5 25939.5 25946.0 879.4 895.6 923.7 931.7 946.0 12476.2 12573.9 12638.4 12687.1 12730.4 254443.0 260960.0 261455.0 261748.0 261776.0 36349.3 37744.0 38138.6 38222.4 38312.4 1092.5 1108.7 1109.1 1125.5 1126.0 22560.2 22851.4 23306.5 25239.9 25624.9 36448.6 36939.6 36940.8 36965.0 37040.6 180061.0 180612.0 181009.0 181543.1 182165.0 22343.0 22759.3 26010.0 28051.0 28612.0 33274.8 33339.8 33451.0 33547.5 34172.3 29561.4 30795.5 31637.4 32097.7 32269.5 24577.0 29265.4 30778.5 31812.8 32638.0 31494.4 31938.8 31959.4 31997.4 32018.5 25560.4 26152.7 27228.9 27479.6 28607.4 22726.5 22906.2 23000.5 23112.3 23566.5 18:35:08 INFO - 2015-11-17 18:35:08,361 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,361 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24405.26 Median:54850.23 stddev:73819.99 (134.6%) stddev-sans-first:74004.93 18:35:08 INFO - 2015-11-17 18:35:08,362 DEBUG : BROWSER_OUTPUT: Values: 323.6 324.9 328.9 330.5 338.4 11921.2 12284.5 14546.7 15170.5 15947.3 15497.0 15735.9 15839.7 16003.1 16024.5 4916.3 4950.8 4959.1 4987.8 4999.5 3551.3 3632.5 5046.0 5469.9 5717.1 5629.8 5653.2 5655.7 5681.5 5684.7 5578.7 5725.9 5730.7 5746.6 5750.9 5000.7 5003.1 5009.8 5020.9 5026.1 18907.4 19203.9 19535.8 19580.6 19590.2 1730.1 1800.4 1803.3 1813.6 1923.4 12532.6 12646.5 12697.2 12845.3 12957.2 1698.8 1702.2 1761.4 1762.1 1805.9 53761.2 54817.5 54883.0 55073.0 55400.0 8926.2 9108.4 9397.9 9402.0 9464.4 11671.6 11684.3 11685.3 11689.2 11690.8 6269.0 6607.6 6611.6 6659.3 6662.1 5778.4 5784.3 5889.0 5890.6 5895.6 5542.9 5589.5 5606.4 5615.7 5666.7 1517.5 1589.9 1592.9 1598.4 1640.9 802.4 921.6 929.2 929.9 939.6 15975.5 16157.3 16218.3 16575.7 16651.8 771.8 775.3 834.9 882.9 906.6 9060.5 9366.3 9408.2 9479.7 9586.1 443857.0 444055.0 449753.0 457276.0 462594.0 61064.0 62445.4 62542.2 62743.4 69147.0 475.5 488.6 488.8 489.1 490.5 9436.7 9547.6 9744.0 9752.8 9803.9 31531.4 31929.2 32936.5 34213.3 34262.8 43267.6 44045.8 45338.5 45689.0 45750.3 6078.7 6165.6 6168.4 6176.2 6179.0 10704.6 10971.7 10976.5 10997.4 11048.6 9643.2 9789.7 9842.8 9961.4 9992.7 9375.1 9541.4 9665.7 9673.4 9882.1 8281.7 8575.3 9110.9 9389.8 9660.0 5785.0 5850.6 5971.9 6022.5 6026.2 9184.2 9514.4 9518.6 9538.2 9644.8 18:35:08 INFO - 2015-11-17 18:35:08,362 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,362 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4915.05 Median:5981.34 stddev:2514.31 (42.0%) stddev-sans-first:2507.59 18:35:08 INFO - 2015-11-17 18:35:08,362 DEBUG : BROWSER_OUTPUT: Values: 1413.6 1620.8 1659.6 1679.9 1687.7 5979.4 6732.5 6821.6 6839.1 6871.5 6905.9 7121.2 7144.4 7149.2 7164.6 2046.4 2078.6 2084.3 2086.3 2086.9 2090.6 2096.3 2102.3 2134.0 2137.9 2049.8 2057.9 2058.3 2061.9 2069.2 1991.3 2022.6 2023.4 2024.6 2027.1 2053.2 2057.5 2090.1 2090.9 2091.5 5983.3 6134.4 7029.9 7079.4 7086.6 3983.2 4082.5 4094.4 4095.8 4103.4 2697.1 2724.2 2771.8 2773.6 2846.3 872.5 881.5 893.5 897.3 903.2 9560.1 9630.0 9630.4 9647.4 9656.0 3913.5 3925.1 3967.3 3968.9 3980.1 8314.4 8321.0 8331.6 8334.6 8370.6 4206.6 4217.7 4237.6 4243.9 4249.0 3755.5 3756.5 3756.8 3757.1 3763.3 3372.8 3375.7 3388.1 3393.6 3417.4 1094.2 1104.4 1108.9 1114.6 1114.7 1098.8 1107.0 1112.1 1113.4 1139.2 6510.0 6526.6 6552.4 6558.2 6563.9 1059.8 1072.2 1087.4 1092.2 1093.8 4539.6 4737.4 4824.5 4829.6 4831.9 7655.8 8039.2 8210.2 8219.7 8267.3 8167.6 8202.6 8267.4 8290.9 8302.3 6263.1 6545.9 6566.6 6573.2 6578.5 6496.1 6504.0 6546.5 6560.3 6567.5 7494.3 7739.8 7820.1 7860.1 7870.6 7644.8 7817.1 7844.9 7907.8 7932.8 6363.8 6372.5 6422.3 6448.5 6450.6 6581.0 6582.3 6606.3 6606.6 6607.6 6475.3 6568.0 6617.6 6634.4 6663.8 6314.7 6337.5 6346.5 6382.0 6393.1 6449.2 6460.5 6481.4 6492.2 6492.2 5791.2 5815.1 5819.0 5837.9 5842.7 5713.8 5768.6 5777.7 5780.6 5787.4 18:35:08 INFO - 2015-11-17 18:35:08,362 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,362 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4752.91 Median:5382.57 stddev:1404.79 (26.1%) stddev-sans-first:1368.02 18:35:08 INFO - 2015-11-17 18:35:08,363 DEBUG : BROWSER_OUTPUT: Values: 279.8 290.3 290.9 302.2 304.2 5402.7 5431.3 5445.1 5470.1 5478.1 5380.4 5382.2 5382.9 5384.3 5385.5 4216.8 4217.4 4218.3 4219.1 4220.2 3989.3 4093.4 4116.7 4178.7 4229.9 4143.9 4145.3 4161.8 4163.4 4178.1 3893.2 4020.1 4170.4 4171.4 4180.0 3545.7 3615.2 3622.6 3623.4 3638.1 5172.9 5182.7 5197.0 5200.7 5210.6 4806.3 4815.3 4819.8 4822.7 4824.0 5557.6 5717.8 5724.5 5729.9 5765.3 4044.0 4053.9 4054.0 4054.7 4057.3 5952.8 6042.6 6051.2 6052.2 6053.3 4190.2 4194.2 4194.9 4194.9 4195.9 4149.7 4238.8 4244.0 4248.2 4261.7 4800.4 4805.2 4828.5 4837.3 4838.8 5700.8 5703.1 5703.9 5711.6 5712.0 1459.0 1470.1 1471.4 1472.1 1474.1 996.4 1001.7 1005.1 1006.6 1025.5 4995.6 5018.7 5019.4 5027.5 5051.4 5933.9 5941.6 5943.0 5949.0 5950.6 5019.8 5037.2 5040.1 5041.5 5042.6 3088.8 3136.7 3187.9 3196.6 3223.6 5501.4 5613.5 5636.9 5644.1 5645.9 6052.9 6063.6 6066.6 6130.0 6135.5 5555.0 5613.1 5646.5 5649.0 5652.3 5747.5 5937.7 5963.8 5986.9 5989.2 5831.9 5835.5 5840.5 5841.9 5851.5 5655.5 5662.5 5663.7 5681.1 5682.0 3973.3 4015.1 4065.9 4070.7 4076.8 5971.3 5975.3 5979.8 5979.9 5986.3 5773.5 5775.5 5776.1 5781.1 5783.9 5668.7 5735.6 5767.7 5768.0 5772.0 5623.7 5624.6 5635.0 5635.4 5638.1 5805.5 5808.1 5810.8 5814.7 5815.3 5643.7 5653.1 5666.7 5672.7 5675.1 18:35:08 INFO - 2015-11-17 18:35:08,363 DEBUG : BROWSER_OUTPUT: 18:35:08 INFO - 2015-11-17 18:35:08,363 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11815.79 Median:54273.96 stddev:14658.46 (27.0%) stddev-sans-first:14675.75 18:35:08 INFO - 2015-11-17 18:35:08,364 DEBUG : BROWSER_OUTPUT: Values: 685.0 695.0 700.6 702.5 717.9 10324.7 10462.0 10546.6 10553.4 10660.8 10911.4 11012.4 11014.4 11023.5 11041.6 597.5 605.5 749.3 771.5 780.0 775.2 775.6 780.1 782.2 782.7 622.6 788.9 792.2 795.6 795.8 629.5 804.0 817.5 818.1 819.4 606.8 607.7 607.9 608.2 608.3 11114.7 11224.1 11234.2 11265.9 11269.8 8319.3 8474.7 8972.1 10316.5 11021.9 8321.8 8413.9 8617.3 8774.8 8946.8 2784.6 2846.2 2865.4 2874.4 2913.4 37638.4 38426.0 38520.0 38550.0 38565.2 6669.8 6764.8 6804.0 6872.7 6890.1 10238.3 10266.2 10273.2 10280.5 10284.6 5383.6 5612.2 5674.3 5713.1 5813.4 3514.4 3593.6 3599.9 3619.3 3658.9 2392.2 2408.3 2410.5 2412.9 2414.7 375.7 376.1 383.8 385.0 385.5 389.4 450.0 500.2 501.3 505.9 5864.5 5968.6 5996.7 6113.7 6150.3 495.9 506.5 513.8 527.7 538.8 2901.6 2926.2 2944.5 2992.0 3029.8 53880.7 54667.2 54791.7 54859.0 55177.4 46662.5 47011.5 47724.0 48575.8 49658.5 43046.1 43060.4 43095.6 43332.4 44314.6 7375.9 7393.7 7447.7 7505.4 7548.5 30988.2 31386.8 31872.7 31906.4 32576.0 38146.8 38233.0 39376.6 42885.0 42950.6 6607.5 6976.4 7038.0 7057.4 7091.4 10643.3 10783.5 10820.8 10840.3 11100.5 9649.0 9769.1 9987.0 10113.5 10129.9 9434.0 9556.5 9764.8 9918.9 9929.5 9609.8 9702.5 9933.4 9939.4 9991.5 8448.6 8604.2 8863.4 8865.7 8867.5 7985.8 8383.8 8716.5 8720.2 8813.1 18:35:08 INFO - 2015-11-17 18:35:08,364 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:35:08 INFO - 2015-11-17 18:35:08,364 DEBUG : BROWSER_OUTPUT: 18:35:09 INFO - 2015-11-17 18:35:09,083 INFO : Browser exited with error code: 0 18:35:09 INFO - 2015-11-17 18:35:09,106 INFO : Completed test dromaeo_css (00:18:37) 18:35:09 INFO - 2015-11-17 18:35:09,106 INFO : Starting test kraken 18:35:09 INFO - 2015-11-17 18:35:09,106 DEBUG : operating with platform_type : linux_ 18:35:09 INFO - 2015-11-17 18:35:09,107 INFO : Initialising browser for kraken test... 18:35:09 INFO - 2015-11-17 18:35:09,113 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRaAFaH/profile http://localhost:52138/getInfo.html 18:35:12 INFO - 2015-11-17 18:35:12,910 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:35:12 INFO - 2015-11-17 18:35:12,910 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:35:12 INFO - 2015-11-17 18:35:12,910 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:35:12 INFO - 2015-11-17 18:35:12,910 DEBUG : BROWSER_OUTPUT: __metrics 18:35:13 INFO - 2015-11-17 18:35:13,052 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:35:14 INFO - 2015-11-17 18:35:14,231 INFO : Browser initialized. 18:35:14 INFO - 2015-11-17 18:35:14,232 INFO : Running cycle 1/1 for kraken test... 18:35:14 INFO - 2015-11-17 18:35:14,232 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRaAFaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:35:26 INFO - 2015-11-17 18:35:26,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 141115392 18:35:26 INFO - 2015-11-17 18:35:26,194 DEBUG : BROWSER_OUTPUT: 18:35:28 INFO - 2015-11-17 18:35:28,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52138/tests/kraken/driver.html?testName=audio-beat-detection) 18:35:29 INFO - 2015-11-17 18:35:29,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 177340416 18:35:29 INFO - 2015-11-17 18:35:29,378 DEBUG : BROWSER_OUTPUT: 18:35:32 INFO - 2015-11-17 18:35:32,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52138/tests/kraken/driver.html?testName=audio-dft) 18:35:32 INFO - 2015-11-17 18:35:32,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 167260160 18:35:32 INFO - 2015-11-17 18:35:32,672 DEBUG : BROWSER_OUTPUT: 18:35:35 INFO - 2015-11-17 18:35:35,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52138/tests/kraken/driver.html?testName=audio-fft) 18:35:36 INFO - 2015-11-17 18:35:36,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 153370624 18:35:36 INFO - 2015-11-17 18:35:36,259 DEBUG : BROWSER_OUTPUT: 18:35:38 INFO - 2015-11-17 18:35:38,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52138/tests/kraken/driver.html?testName=audio-oscillator) 18:35:38 INFO - 2015-11-17 18:35:38,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 154439680 18:35:38 INFO - 2015-11-17 18:35:38,884 DEBUG : BROWSER_OUTPUT: 18:35:41 INFO - 2015-11-17 18:35:41,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:35:41 INFO - 2015-11-17 18:35:41,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 154206208 18:35:41 INFO - 2015-11-17 18:35:41,671 DEBUG : BROWSER_OUTPUT: 18:35:44 INFO - 2015-11-17 18:35:44,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52138/tests/kraken/driver.html?testName=imaging-darkroom) 18:35:45 INFO - 2015-11-17 18:35:45,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 156901376 18:35:45 INFO - 2015-11-17 18:35:45,244 DEBUG : BROWSER_OUTPUT: 18:35:48 INFO - 2015-11-17 18:35:48,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52138/tests/kraken/driver.html?testName=imaging-desaturate) 18:35:49 INFO - 2015-11-17 18:35:49,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 156491776 18:35:49 INFO - 2015-11-17 18:35:49,254 DEBUG : BROWSER_OUTPUT: 18:35:52 INFO - 2015-11-17 18:35:52,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52138/tests/kraken/driver.html?testName=json-parse-financial) 18:35:52 INFO - 2015-11-17 18:35:52,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 155766784 18:35:52 INFO - 2015-11-17 18:35:52,648 DEBUG : BROWSER_OUTPUT: 18:35:54 INFO - 2015-11-17 18:35:54,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:35:54 INFO - 2015-11-17 18:35:54,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 163221504 18:35:54 INFO - 2015-11-17 18:35:54,950 DEBUG : BROWSER_OUTPUT: 18:35:56 INFO - 2015-11-17 18:35:56,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:35:57 INFO - 2015-11-17 18:35:57,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 164036608 18:35:57 INFO - 2015-11-17 18:35:57,419 DEBUG : BROWSER_OUTPUT: 18:35:59 INFO - 2015-11-17 18:35:59,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:36:00 INFO - 2015-11-17 18:36:00,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 173576192 18:36:00 INFO - 2015-11-17 18:36:00,138 DEBUG : BROWSER_OUTPUT: 18:36:02 INFO - 2015-11-17 18:36:02,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:36:03 INFO - 2015-11-17 18:36:03,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 178921472 18:36:03 INFO - 2015-11-17 18:36:03,241 DEBUG : BROWSER_OUTPUT: 18:36:05 INFO - 2015-11-17 18:36:05,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:36:06 INFO - 2015-11-17 18:36:06,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 176701440 18:36:06 INFO - 2015-11-17 18:36:06,443 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52138/tests/kraken/driver.html?testName=ai-astar) 18:36:08 INFO - 2015-11-17 18:36:08,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 236359680 18:36:08 INFO - 2015-11-17 18:36:08,453 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,454 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:36:08 INFO - 2015-11-17 18:36:08,454 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:36:08 INFO - 2015-11-17 18:36:08,454 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;111;112;112;100;112;104;111 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;130;154;163;131;151;156;131;174;140 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;158;162;160;162;162;161;162 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;84;91;72;73;73;114;90;72 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;132;91;92;93;129;91;93;128 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;110;110;109;109 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;149;148;148;148;148;148;148 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;96;95;96;95 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;69;69;70;69;70;69;78;67;68 18:36:08 INFO - 2015-11-17 18:36:08,455 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;71;69;69;70;70;71;69;70 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;85;85;84;85;91;85;83;85 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;120;128;119;123;129;122;122;129;126 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;138;153;146;164;137;149;149;153;137 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;69;69;70;71;68;68;69;71 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814168453__endTimestamp 18:36:08 INFO - 2015-11-17 18:36:08,456 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,459 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:36:08 INFO - 2015-11-17 18:36:08,459 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:36:08 INFO - 2015-11-17 18:36:08,459 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:111.50 stddev:4.24 (3.8%) stddev-sans-first:4.48 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 111.0 112.0 112.0 100.0 112.0 104.0 111.0 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.30 Median:155.00 stddev:15.58 (10.1%) stddev-sans-first:15.71 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: Values: 163.0 130.0 154.0 163.0 131.0 151.0 156.0 131.0 174.0 140.0 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 158.0 162.0 160.0 162.0 162.0 161.0 162.0 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:73.50 stddev:13.73 (18.7%) stddev-sans-first:14.13 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 84.0 91.0 72.0 73.0 73.0 114.0 90.0 72.0 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:92.00 stddev:18.23 (19.8%) stddev-sans-first:18.88 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 132.0 91.0 92.0 93.0 129.0 91.0 93.0 128.0 18:36:08 INFO - 2015-11-17 18:36:08,460 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 149.0 148.0 148.0 148.0 148.0 148.0 148.0 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.70 Median:69.00 stddev:3.06 (4.4%) stddev-sans-first:3.18 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 69.0 70.0 69.0 78.0 67.0 68.0 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:0.95 (1.4%) stddev-sans-first:0.78 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 71.0 69.0 69.0 70.0 70.0 71.0 69.0 70.0 18:36:08 INFO - 2015-11-17 18:36:08,461 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,462 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.36 (2.8%) stddev-sans-first:2.24 18:36:08 INFO - 2015-11-17 18:36:08,462 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 85.0 85.0 84.0 85.0 91.0 85.0 83.0 85.0 18:36:08 INFO - 2015-11-17 18:36:08,462 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,462 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.50 stddev:4.30 (3.5%) stddev-sans-first:3.87 18:36:08 INFO - 2015-11-17 18:36:08,462 DEBUG : BROWSER_OUTPUT: Values: 117.0 120.0 128.0 119.0 123.0 129.0 122.0 122.0 129.0 126.0 18:36:08 INFO - 2015-11-17 18:36:08,462 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,462 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:150.50 stddev:8.63 (5.7%) stddev-sans-first:9.01 18:36:08 INFO - 2015-11-17 18:36:08,463 DEBUG : BROWSER_OUTPUT: Values: 152.0 138.0 153.0 146.0 164.0 137.0 149.0 149.0 153.0 137.0 18:36:08 INFO - 2015-11-17 18:36:08,463 DEBUG : BROWSER_OUTPUT: 18:36:08 INFO - 2015-11-17 18:36:08,463 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.18 (1.7%) stddev-sans-first:1.24 18:36:08 INFO - 2015-11-17 18:36:08,463 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 69.0 69.0 70.0 71.0 68.0 68.0 69.0 71.0 18:36:08 INFO - 2015-11-17 18:36:08,463 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:36:08 INFO - 2015-11-17 18:36:08,463 DEBUG : BROWSER_OUTPUT: 18:36:09 INFO - 2015-11-17 18:36:09,411 INFO : Browser exited with error code: 0 18:36:09 INFO - 2015-11-17 18:36:09,464 INFO : Completed test kraken (00:01:00) 18:36:09 INFO - 2015-11-17 18:36:09,464 INFO : Starting test v8_7 18:36:09 INFO - 2015-11-17 18:36:09,464 DEBUG : operating with platform_type : linux_ 18:36:09 INFO - 2015-11-17 18:36:09,465 INFO : Initialising browser for v8_7 test... 18:36:09 INFO - 2015-11-17 18:36:09,471 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfgGCB6/profile http://localhost:52138/getInfo.html 18:36:13 INFO - 2015-11-17 18:36:13,410 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:36:13 INFO - 2015-11-17 18:36:13,410 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:36:13 INFO - 2015-11-17 18:36:13,410 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:36:13 INFO - 2015-11-17 18:36:13,410 DEBUG : BROWSER_OUTPUT: __metrics 18:36:13 INFO - 2015-11-17 18:36:13,567 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:36:14 INFO - 2015-11-17 18:36:14,689 INFO : Browser initialized. 18:36:14 INFO - 2015-11-17 18:36:14,690 INFO : Running cycle 1/1 for v8_7 test... 18:36:14 INFO - 2015-11-17 18:36:14,690 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfgGCB6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:36:26 INFO - 2015-11-17 18:36:26,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 141447168 18:36:26 INFO - 2015-11-17 18:36:26,651 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52138/tests/v8_7/run.html (next: http://localhost:52138/tests/v8_7/run.html) 18:36:48 INFO - 2015-11-17 18:36:48,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 438497280 18:36:48 INFO - 2015-11-17 18:36:48,320 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,320 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:36:48 INFO - 2015-11-17 18:36:48,320 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:36:48 INFO - 2015-11-17 18:36:48,320 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:36:48 INFO - 2015-11-17 18:36:48,321 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:36:48 INFO - 2015-11-17 18:36:48,321 DEBUG : BROWSER_OUTPUT: |0;Richards;166.5278934221482 18:36:48 INFO - 2015-11-17 18:36:48,321 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.3816852635629 18:36:48 INFO - 2015-11-17 18:36:48,321 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.3476310625175 18:36:48 INFO - 2015-11-17 18:36:48,321 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 18:36:48 INFO - 2015-11-17 18:36:48,321 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1994.0239043824702 18:36:48 INFO - 2015-11-17 18:36:48,321 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 18:36:48 INFO - 2015-11-17 18:36:48,322 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 18:36:48 INFO - 2015-11-17 18:36:48,322 DEBUG : BROWSER_OUTPUT: |7;RegExp;26205.128205128207 18:36:48 INFO - 2015-11-17 18:36:48,322 DEBUG : BROWSER_OUTPUT: |8;Splay;613.6919315403424 18:36:48 INFO - 2015-11-17 18:36:48,322 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 18:36:48 INFO - 2015-11-17 18:36:48,322 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:36:48 INFO - 2015-11-17 18:36:48,322 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814208319__endTimestamp 18:36:48 INFO - 2015-11-17 18:36:48,322 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,324 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:36:48 INFO - 2015-11-17 18:36:48,324 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:36:48 INFO - 2015-11-17 18:36:48,324 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,324 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,324 DEBUG : BROWSER_OUTPUT: Values: 166.5 18:36:48 INFO - 2015-11-17 18:36:48,324 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,325 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.38 Median:192.38 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,325 DEBUG : BROWSER_OUTPUT: Values: 192.4 18:36:48 INFO - 2015-11-17 18:36:48,325 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,325 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,325 DEBUG : BROWSER_OUTPUT: Values: 280.3 18:36:48 INFO - 2015-11-17 18:36:48,325 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,325 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: Values: 5020.0 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: Values: 1994.0 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: Values: 790.5 18:36:48 INFO - 2015-11-17 18:36:48,326 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,327 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,327 DEBUG : BROWSER_OUTPUT: Values: 12207.3 18:36:48 INFO - 2015-11-17 18:36:48,327 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,327 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26205.13 Median:26205.13 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,327 DEBUG : BROWSER_OUTPUT: Values: 26205.1 18:36:48 INFO - 2015-11-17 18:36:48,327 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,327 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.69 Median:613.69 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,328 DEBUG : BROWSER_OUTPUT: Values: 613.7 18:36:48 INFO - 2015-11-17 18:36:48,328 DEBUG : BROWSER_OUTPUT: 18:36:48 INFO - 2015-11-17 18:36:48,328 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 18:36:48 INFO - 2015-11-17 18:36:48,328 DEBUG : BROWSER_OUTPUT: Values: 4850.2 18:36:48 INFO - 2015-11-17 18:36:48,328 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:36:48 INFO - 2015-11-17 18:36:48,329 DEBUG : BROWSER_OUTPUT: 18:36:49 INFO - 2015-11-17 18:36:49,223 INFO : Browser exited with error code: 0 18:36:49 INFO - 2015-11-17 18:36:49,235 INFO : Completed test v8_7 (00:00:39) 18:36:49 INFO - 2015-11-17 18:36:49,335 INFO : Completed test suite (00:20:17) 18:36:49 INFO - 2015-11-17 18:36:49,336 DEBUG : Working with test: dromaeo_css 18:36:49 INFO - 2015-11-17 18:36:49,336 DEBUG : Generating results file: dromaeo_css 18:36:49 INFO - 2015-11-17 18:36:49,337 DEBUG : Working with test: kraken 18:36:49 INFO - 2015-11-17 18:36:49,337 DEBUG : Generating results file: kraken 18:36:49 INFO - 2015-11-17 18:36:49,337 INFO : javascript benchmark 18:36:49 INFO - 2015-11-17 18:36:49,337 DEBUG : Working with test: v8_7 18:36:49 INFO - 2015-11-17 18:36:49,338 DEBUG : Generating results file: v8_7 18:36:49 INFO - 2015-11-17 18:36:49,338 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:36:49 INFO - 2015-11-17 18:36:49,381 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 18:36:49 INFO - 2015-11-17 18:36:49,381 DEBUG : process_Request line: dromaeo_css 6095.55 graph.html#tests=[[72,132,35]] 18:36:49 INFO - 2015-11-17 18:36:49,382 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:36:49 INFO - 2015-11-17 18:36:49,414 DEBUG : process_Request line: kraken 1522.50 graph.html#tests=[[232,132,35]] 18:36:49 INFO - 2015-11-17 18:36:49,415 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:36:49 INFO - 2015-11-17 18:36:49,440 DEBUG : process_Request line: v8_7 19785.34 graph.html#tests=[[230,132,35]] 18:36:49 INFO - 2015-11-17 18:36:49,441 INFO : javascript benchmark 18:36:49 INFO - 2015-11-17 18:36:49,445 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [323.60035356334924, 324.8976572379699, 328.9292802047559, 330.46464727142023, 338.42974587819526, 11921.225120367191, 12284.508619655204, 14546.709065818677, 15170.469033583813, 15947.28237229326, 15497.0, 15735.92132039341, 15839.683206335867, 16003.119828409433, 16024.519264422086, 4916.287138364953, 4950.752462376876, 4959.132151873426, 4987.8254261100865, 4999.475055119215, 3551.271989242199, 3632.4914511968345, 5045.974770126144, 5469.863253418656, 5717.085266357383, 5629.802956896509, 5653.23681303025, 5655.660660360371, 5681.545476361902, 5684.715764211794, 5578.693171875545, 5725.914111288334, 5730.742116604721, 5746.569007324447, 5750.942490575083, 5000.699958002495, 5003.124453220672, 5009.774560144802, 5020.949790502122, 5026.095302845486, 18907.43277701671, 19203.90398048001, 19535.804641953542, 19580.608387832162, 19590.21639134433, 1730.1003478191396, 1800.3698705453119, 1803.3417802502124, 1813.5919418130948, 1923.3749031564657, 12532.624021279376, 12646.49414023438, 12697.194295882475, 12845.293508857008, 12957.22256664603, 1698.787651543557, 1702.1999660159704, 1761.3659082730208, 1762.0837164674297, 1805.8645601579803, 53761.1935820963, 54817.451825482036, 54883.0, 55073.0, 55400.0, 8926.196642302224, 9108.407953483002, 9397.859032114524, 9401.999999999864, 9464.384814987005, 11671.59149429766, 11684.298942063504, 11685.298882067103, 11689.240199387013, 11690.76618467643, 6268.968655156787, 6607.636579988147, 6611.570247933869, 6659.334066593399, 6662.100616416818, 5778.393268706809, 5784.334801497882, 5889.028310328834, 5890.646561206341, 5895.587308888336, 5542.944570554324, 5589.496945274945, 5606.355269144101, 5615.691136987423, 5666.716664166775, 1517.521980576115, 1589.9205039747967, 1592.9362825487083, 1598.4325564424462, 1640.9015459072493, 802.3661307567073, 921.5714692667941, 929.2473096791485, 929.869818225449, 939.6382392778693, 15975.520734377988, 16157.272922718506, 16218.270177842025, 16575.6684866302, 16651.750223746654, 771.7954741993376, 775.2979522778777, 834.9415540912199, 882.9293656507464, 906.5603182456504, 9060.501672407949, 9366.344355895159, 9408.200302974186, 9479.676420653122, 9586.089321514444, 443857.0, 444055.0, 449753.0, 457276.0, 462594.0, 61064.0, 62445.37554624487, 62542.19009007221, 62743.372566273756, 69147.0, 475.4793501116341, 488.6188772757255, 488.84601350574457, 489.1317910708521, 490.47029208454785, 9436.669716559887, 9547.618095276111, 9744.025597440199, 9752.756181095529, 9803.852942206015, 31531.369372612877, 31929.201769955936, 32936.505952410254, 34213.31573368568, 34262.82868585641, 43267.56732432761, 44045.77977110222, 45338.546614533436, 45689.0, 45750.313745293184, 6078.696065196634, 6165.599236049642, 6168.444839964424, 6176.197094377702, 6178.969105154445, 10704.571817127227, 10971.670849874517, 10976.451177440937, 10997.395143267197, 11048.613298534512, 9643.228541716786, 9789.657361992297, 9842.803143937224, 9961.35251208669, 9992.700218993441, 9375.10936461035, 9541.427514349161, 9665.71002869915, 9673.37123086997, 9882.061204185591, 8281.668733250603, 8575.31397488212, 9110.863337049817, 9389.765255868659, 9660.0, 5785.016547187072, 5850.561207909339, 5971.850703732442, 6022.548308876764, 6026.186464827192, 9184.173424391836, 9514.38156519824, 9518.571664275263, 9538.23694104484, 9644.807103857744], "dojo.html": [2621.2005338371796, 2767.6678798544176, 2771.3071732066983, 2784.10908509277, 2800.243934137783, 4588.013577080927, 4699.506551812054, 4772.236442169254, 4797.6161907047435, 4821.228603423453, 4740.810367585301, 4756.690815097017, 4854.271859221119, 4862.124817532843, 4868.878278043051, 4380.8247670093315, 4421.07157496926, 4441.733495990235, 4553.658475614326, 4599.655025873056, 4508.706934049293, 4533.818647254122, 4569.086182763444, 4583.747893865836, 4617.792199351037, 4188.811503482335, 4288.249556327662, 4297.67767417445, 4388.670849686287, 4422.137683151786, 4411.316245981846, 4427.667924905645, 4428.070105277896, 4429.291313389875, 4456.6880318377725, 4393.36296237047, 4396.71421357614, 4419.0, 4434.490033646108, 4456.6880318377725, 4514.322851572258, 4630.953690463086, 4646.1404640141345, 4667.88330291742, 4817.662763606549, 5141.665791723526, 5152.92270615941, 5153.046686362997, 5155.200943853709, 5159.045576568347, 5192.376914770214, 5194.948050519522, 5197.1424714922, 5231.973840130813, 5240.9213861792105, 4616.930746038812, 4724.551167639069, 4728.290756386569, 4729.385179926588, 4812.446568644581, 5347.25138480613, 5375.7849686012905, 5383.246345511631, 5392.4607539246545, 5398.433164517669, 5135.537801597874, 5144.331236939174, 5150.175971844487, 5153.123968925292, 5193.0, 4882.755862206946, 5002.849914502571, 5004.399472063303, 5115.616328775282, 5281.313429254249, 5177.611679124006, 5201.297824793604, 5206.97396513015, 5209.296744939385, 5217.034848553029, 5181.145111056709, 5182.989317083133, 5184.0927837629015, 5185.7407129644125, 5196.8960620787375, 3844.884653460401, 3892.9805350973065, 3949.7037722170953, 3960.2871483133313, 3991.521017477863, 3525.647435256505, 3533.0460775590445, 3544.503769472276, 3553.875614353537, 3557.8043207623828, 4437.334399839985, 4446.644268458515, 4452.8218871245435, 4455.732656040648, 4483.215437298525, 4915.5330243626795, 5028.994201159782, 5031.77357018935, 5136.306598609214, 5184.066867963803, 4470.105978804252, 4475.843345482957, 4506.481754598198, 4510.413646225969, 4513.187626227311, 4610.561996610317, 4615.792289346988, 4622.838200662961, 4623.190941585209, 4666.673332866667, 4678.0643871226575, 4769.070031343855, 4803.447603525499, 4957.429895562056, 4967.006598680278, 5182.300389447376, 5267.157254839208, 5271.525562699376, 5277.551408130352, 5318.787248510016, 4913.926291105708, 4925.926111108264, 4926.137925862888, 4928.260760885896, 4964.230544265644, 4857.101436234308, 4980.726060066731, 4980.750962451791, 5124.410692770379, 5131.050755610224, 4986.80052797884, 4986.80052797884, 5003.224500202475, 5015.097282489187, 5015.899682006267, 4917.065757506205, 4942.357493525818, 4942.777575009205, 4944.159492886146, 4945.1346014448045, 4913.533214344631, 4918.704877707206, 4938.283948827472, 5028.84913452597, 5030.320906677698, 4924.852254432372, 4938.9259161111895, 4970.602351811919, 4977.601791856715, 4981.875453113701, 5059.266406371129, 5103.336566246513, 5105.923411148761, 5126.333576635014, 5148.510891465305, 4648.976755116203, 4777.4983626718695, 4788.760561971957, 4886.877828054327, 4973.925391119208], "mootools.html": [1413.561795843288, 1620.8055033395995, 1659.5933996170932, 1679.8824082314236, 1687.6877777611144, 5979.431953964372, 6732.528722989387, 6821.556598821073, 6839.1451068616425, 6871.518993670433, 6905.861882762341, 7121.181064177621, 7144.357007869291, 7149.249328820477, 7164.570125792456, 2046.396313087639, 2078.5635016646524, 2084.322595156573, 2086.2698055680466, 2086.9060892259886, 2090.613236551243, 2096.266306792618, 2102.2536999365234, 2133.9893300533477, 2137.9037943292587, 2049.846261530384, 2057.9485512862148, 2058.3001779395004, 2061.9484512887225, 2069.1723310675775, 1991.2930909527126, 2022.5853699991467, 2023.4435530229157, 2024.6052019856133, 2027.0574183004826, 2053.240301088592, 2057.5267688431745, 2090.1117025264202, 2090.9268175613934, 2091.518950641346, 5983.252093488314, 6134.417230363153, 7029.859402811966, 7079.433645308363, 7086.645667716593, 3983.24318379507, 4082.4692789937417, 4094.4267802507675, 4095.8361665533344, 4103.363978583325, 2697.0829917827837, 2724.209979106057, 2771.80597358185, 2773.5839624056553, 2846.2599724071683, 872.5157537566648, 881.4667126388571, 893.4996402014827, 897.3270047464401, 903.2051794420868, 9560.091791279887, 9630.0, 9630.422174669542, 9647.372920760128, 9655.951720241354, 3913.5303763548554, 3925.0776067624083, 3967.2858885400906, 3968.900777480528, 3980.104476492824, 8314.41799074071, 8321.04308004575, 8331.625076871554, 8334.583270836434, 8370.581470926429, 4206.621404073648, 4217.725847819943, 4237.597428244312, 4243.915121697549, 4249.043965107826, 3755.5493340798735, 3756.4553139794575, 3756.7745935243975, 3757.0607348162957, 3763.2661630982243, 3372.8482218300237, 3375.729941604666, 3388.119089036868, 3393.575803024622, 3417.3848707232937, 1094.2285688589525, 1104.3870651788175, 1108.922375433712, 1114.5931734916696, 1114.7380365614074, 1098.780243951213, 1107.036877916202, 1112.1380929779325, 1113.4210210690396, 1139.2196345503357, 6510.0, 6526.64103474304, 6552.410283074546, 6558.1802274715665, 6563.9343606563325, 1059.8410238464292, 1072.2119242356862, 1087.4399684162663, 1092.2190633696946, 1093.8031154392286, 4539.59143677064, 4737.407824021997, 4824.469308376076, 4829.637777166727, 4831.9275210871865, 7655.846883062308, 8039.15588863161, 8210.178982101861, 8219.712310069239, 8267.338612911073, 8167.550784706779, 8202.58987050645, 8267.379946504036, 8290.917090829134, 8302.294304984143, 6263.091851681481, 6545.9018114728315, 6566.573172743756, 6573.244076931214, 6578.506612004023, 6496.123023391781, 6503.967480162569, 6546.541742078009, 6560.343965603402, 6567.507436942344, 7494.288042635941, 7739.7678069658, 7820.139784623801, 7860.0567931848545, 7870.567118808521, 7644.847103058019, 7817.0619525657285, 7844.882326764989, 7907.802304942423, 7932.801679958047, 6363.809085727436, 6372.458341041063, 6422.325655806073, 6448.516361272829, 6450.580712253689, 6581.0, 6582.275949645439, 6606.306337834458, 6606.6366349849295, 6607.57050791697, 6475.287718350884, 6567.9671601641685, 6617.6029438231935, 6634.369734875179, 6663.766768163091, 6314.6842657866, 6337.493000560036, 6346.460550853045, 6382.0, 6393.073004414427, 6449.226092868886, 6460.547761656639, 6481.4166724994975, 6492.220933488012, 6492.220933488012, 5791.189233507228, 5815.098659707752, 5819.010768169337, 5837.854053648693, 5842.678652673973, 5713.771449141987, 5768.625039372428, 5777.653340799566, 5780.5953583248765, 5787.421257874179], "ext.html": [548.1503669312567, 559.5271995164085, 569.1093438768328, 577.6043410263968, 577.6562945047698, 22947.655785163213, 23496.412589685246, 35326.823365883196, 35516.46725299123, 35761.28477430453, 38067.0, 38386.0, 38630.61369386305, 38634.227315453674, 38692.0, 6797.0, 7902.407319451036, 8073.717419890276, 8079.757607271762, 8082.959585202066, 6909.378155965962, 10046.19630429564, 10179.745506362364, 10343.586256549728, 10348.948255258712, 9909.207263418944, 10005.59977600895, 10012.899871001306, 10027.047430494127, 10032.648857289996, 6908.1364829396325, 7064.717411303542, 9957.551910164024, 9981.800363992752, 10079.395236285809, 9611.855822162674, 9754.317197796157, 9760.121589056947, 9760.95119524405, 9767.218622510181, 36386.0, 36676.0, 36851.447228291596, 36898.0, 36954.815225923965, 2626.3302857771337, 2705.1478784183114, 3048.8170709757487, 3297.1097803593134, 3330.8501117449773, 27871.721282787115, 28102.718972810213, 28174.859125704446, 28298.434031319463, 28702.71297287042, 2985.596944412498, 2988.1035689293126, 3026.0921723482866, 3070.493368594179, 3092.721655051034, 221960.0, 223585.0, 224139.0, 224348.0, 224658.0, 36511.4523282151, 37287.067823304635, 51490.22764658533, 51715.224271635954, 51851.0, 60854.0, 62077.0, 62088.0, 62167.0, 62199.6890015547, 11803.468843902045, 12013.339266340261, 12016.63950081499, 12037.699057523632, 12055.698607534707, 8603.268722158688, 8608.48349099056, 8635.179657932485, 8641.092685268082, 8698.043215246318, 17819.910900445673, 17980.9100954497, 18005.909970450062, 18029.368972085915, 18059.187336569885, 6880.65596720162, 7116.573005619679, 7161.283871612797, 7205.89191162133, 7210.206877243499, 803.8713805791162, 821.708293555791, 896.9551522423983, 972.5380444288907, 1019.7246743379394, 25249.30554167752, 25661.230163095137, 25936.481270374486, 25939.48121037569, 25946.0, 879.4239772948729, 895.632790555882, 923.7459698582809, 931.7437704631145, 945.9810803783886, 12476.18904771187, 12573.937130314473, 12638.368081595883, 12687.11190216676, 12730.427130778951, 254443.0, 260960.0, 261455.0, 261748.0, 261776.0, 36349.27301453956, 37743.999999999454, 38138.61861381406, 38222.42666360007, 38312.42531362032, 1092.4974511724695, 1108.7228192951761, 1109.0628418985782, 1125.4879030041475, 1126.0372381613765, 22560.210392636836, 22851.428714282276, 23306.53386932286, 25239.873800630878, 25624.871875640503, 36448.63551364453, 36939.63060369362, 36940.81529592335, 36965.0, 37040.6295937048, 180061.0, 180612.0, 181009.0, 181543.09228453774, 182165.0, 22342.994565244928, 22759.31722048341, 26010.0, 28051.0, 28612.0, 33274.833625831714, 33339.83330083431, 33451.0, 33547.49678754869, 34172.31655366829, 29561.408771824874, 30795.538066928566, 31637.36725265528, 32097.679023210403, 32269.51595726019, 24577.0, 29265.41469170647, 30778.53832192474, 31812.84093579517, 32638.0, 31494.37011259716, 31938.840305798323, 31959.360812784078, 31997.360052798347, 32018.51972220372, 25560.360990975376, 26152.73847261503, 27228.863855680596, 27479.587806183325, 28607.42785144327, 22726.545469090855, 22906.198283060014, 23000.539989199788, 23112.306630801104, 23566.528669426174], "prototype.html": [279.79994304072585, 290.3481683620272, 290.8952777000281, 302.23685194882916, 304.1908523327948, 5402.730853041722, 5431.293931788872, 5445.128779395298, 5470.124780035195, 5478.123500239963, 5380.354357477098, 5382.2195781611745, 5382.91925621116, 5384.273123128377, 5385.542228910547, 4216.7680777557225, 4217.40956266123, 4218.30397984333, 4219.07180420307, 4220.198162349144, 3989.301872172373, 4093.4269202311702, 4116.732412393199, 4178.707490475653, 4229.915401691965, 4143.917121657565, 4145.274576949037, 4161.771102589357, 4163.396307535406, 4178.059936514291, 3893.201893611831, 4020.0502756163237, 4170.374443833419, 4171.436856024443, 4179.979100104495, 3545.7163426925786, 3615.1504396466808, 3622.637736226356, 3623.3840247158046, 3638.07229156566, 5172.948270517284, 5182.714950677711, 5197.038547868657, 5200.6879587224885, 5210.583153347723, 4806.279058141272, 4815.3499277597775, 4819.831305904311, 4822.71063736177, 4824.035192961387, 5557.6109672322955, 5717.799877004285, 5724.542036637059, 5729.856753581152, 5765.270418874321, 4043.959560404417, 4053.898652533681, 4053.97973010136, 4054.6553542948886, 4057.2696914555368, 5952.821415357546, 6042.607230530001, 6051.243594550681, 6052.182955301022, 6053.273607167124, 4190.20386126635, 4194.182134483807, 4194.916101677949, 4194.937075943863, 4195.853145139906, 4149.730267532601, 4238.809253583596, 4244.0, 4248.235317642792, 4261.722988005832, 4800.423949126127, 4805.1590971579835, 4828.493008234085, 4837.32277481153, 4838.782254798542, 5700.800471983461, 5703.116017017369, 5703.9429605704245, 5711.571632127524, 5711.971440142773, 1459.0370355565276, 1470.0591621362337, 1471.3820195517908, 1472.065238573492, 1474.071335058906, 996.3722854601555, 1001.6944831826363, 1005.1154983614373, 1006.6476733143488, 1025.5487585462372, 4995.575376093073, 5018.673786203885, 5019.3976722793495, 5027.4721154279005, 5051.393832740095, 5933.9406605934255, 5941.643501389931, 5942.970285148633, 5948.970255148696, 5950.613210141413, 5019.82430614934, 5037.219231019198, 5040.143175660147, 5041.470645582234, 5042.647014708935, 3088.783785135064, 3136.7490600751885, 3187.888423905152, 3196.632387275493, 3223.5648187494858, 5501.449855014546, 5613.522850557748, 5636.887262254732, 5644.096944488862, 5645.915311270334, 6052.939470605325, 6063.636181829104, 6066.636001839904, 6130.01919692847, 6135.478484328793, 5554.972225138848, 5613.101903695389, 5646.491815736604, 5648.971755141362, 5652.2652055233375, 5747.511461525817, 5937.732802023833, 5963.7912673056235, 5986.850328741816, 5989.1615173874825, 5831.883362332815, 5835.533157347487, 5840.503557197686, 5841.883162336814, 5851.473367396955, 5655.4910058094965, 5662.490375866192, 5663.7451314690115, 5681.0910254359105, 5682.034054210877, 3973.324534829144, 4015.1166743316426, 4065.89835254121, 4070.7354021988476, 4076.775777332275, 5971.28344598651, 5975.342712301556, 5979.760809567569, 5979.940200597938, 5986.2517185351835, 5773.480386765212, 5775.537956963517, 5776.104703770754, 5781.075027995501, 5783.884322313446, 5668.7165641718575, 5735.569832262514, 5767.68277744728, 5767.971160144172, 5772.018756811268, 5623.662580245198, 5624.634398764068, 5635.042042852643, 5635.351934527418, 5638.097904335451, 5805.535557155333, 5808.128780682931, 5810.796622118206, 5814.73833677494, 5815.302163740378, 5643.689597072201, 5653.123765816305, 5666.688332141772, 5672.744726487401, 5675.0636145035605], "yui.html": [684.9963855722015, 694.9583025018499, 700.6041586503625, 702.4766548921054, 717.8779607466734, 10324.741881452957, 10462.0, 10546.578136874536, 10553.366797992116, 10660.840087398696, 10911.399873006982, 11012.39431831249, 11014.39420831854, 11023.503942322595, 11041.613543525958, 597.4682532546037, 605.5186127029023, 749.2769477454256, 771.5447885747408, 779.9883001754978, 775.170567492783, 775.5734346109646, 780.0795061827042, 782.1708988472209, 782.671278063212, 622.551762730833, 788.9447738658296, 792.2473650032464, 795.6340083561539, 795.7851380127362, 629.4775336470718, 803.995980020102, 817.4686453805074, 818.1164342510134, 819.4141189049858, 606.8118883146238, 607.6991889014965, 607.8905796956547, 608.1759216261989, 608.270075908911, 11114.722131946684, 11224.102071834233, 11234.157438192087, 11265.887341126565, 11269.830952535718, 8319.292860106898, 8474.703385381543, 8972.147645973622, 10316.48417579118, 11021.889781102167, 8321.750347489586, 8413.915860841375, 8617.267532259766, 8774.780630484225, 8946.821063578756, 2784.582312653098, 2846.2172902451784, 2865.398266364066, 2874.425114977013, 2913.417316536701, 37638.43542346867, 38426.0, 38520.03699907497, 38550.0, 38565.22869542593, 6669.7665581704405, 6764.830879228059, 6804.047433359334, 6872.656367181621, 6890.138732658418, 10238.33450825694, 10266.178705703525, 10273.178145748323, 10280.537375818107, 10284.640037598649, 5383.596230282745, 5612.214289999403, 5674.347450043216, 5713.143028545752, 5813.389594092644, 3514.3674138655288, 3593.586737525166, 3599.874004409833, 3619.3485172668647, 3658.8902332930056, 2392.210570511727, 2408.337707130518, 2410.505846301504, 2412.9396765081015, 2414.7102347718387, 375.6619042861392, 376.1217557004425, 383.79658780845637, 385.02396425062335, 385.4988514930579, 389.3653345047554, 449.9527549607244, 500.2059379605659, 501.2931766209627, 505.88111793728444, 5864.472197502245, 5968.582199246011, 5996.730147143389, 6113.663748493876, 6150.292716337678, 495.9305697202395, 506.4808571214535, 513.8407093800859, 527.7255826969954, 538.8437353167537, 2901.5502597097484, 2926.2200909136404, 2944.528875379929, 2991.985040074829, 3029.8182109073527, 53880.73059634755, 54667.179992300145, 54791.72604136954, 54859.0, 55177.448225518034, 46662.5333746665, 47011.529884700714, 47724.04551908942, 48575.75712121417, 49658.50341496611, 43046.13907721828, 43060.354094688606, 43095.56904431041, 43332.350014749805, 44314.556854431044, 7375.852482950419, 7393.741219057307, 7447.702091916262, 7505.362044226302, 7548.4716069874585, 30988.22529436782, 31386.843065784524, 31872.681273186972, 31906.36187276195, 32576.0, 38146.809265953496, 38233.0, 39376.606233937295, 42885.0, 42950.570494294654, 6607.537472376887, 6976.372126508639, 7038.0, 7057.364837164474, 7091.397231235403, 10643.254972151875, 10783.51474183648, 10820.783584328112, 10840.295380800222, 11100.500477478372, 9649.0, 9769.071938165864, 9987.0, 10113.5448904798, 10129.89870101319, 9433.952830235805, 9556.474393908402, 9764.804703906024, 9918.851217231891, 9929.503524823875, 9609.807803843743, 9702.514874256118, 9933.403995760278, 9939.353941993748, 9991.450470224207, 8448.577571121297, 8604.225619694258, 8863.379563430755, 8865.734027979172, 8867.467951922905, 7985.760427187193, 8383.832323353621, 8716.520591367536, 8720.171583699539, 8813.118688131135]}, "summary": {"lowerIsBetter": false, "suite": 6095.553969677451, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7504.373441114919, "unit": "ms", "value": 7504.373441114919}, "dojo.html": {"lowerIsBetter": false, "filtered": 4697.754779692171, "unit": "ms", "value": 4697.754779692171}, "mootools.html": {"lowerIsBetter": false, "filtered": 4072.6828430107994, "unit": "ms", "value": 4072.6828430107994}, "ext.html": {"lowerIsBetter": false, "filtered": 16054.21324169381, "unit": "ms", "value": 16054.21324169381}, "prototype.html": {"lowerIsBetter": false, "filtered": 4295.979101518874, "unit": "ms", "value": 4295.979101518874}, "yui.html": {"lowerIsBetter": false, "filtered": 5179.657915500219, "unit": "ms", "value": 5179.657915500219}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447812992, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117175137", "branch": "Fx-Team-Non-PGO", "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 162.0, 158.0, 162.0, 160.0, 162.0, 162.0, 161.0, 162.0], "ai-astar": [110.0, 113.0, 107.0, 111.0, 112.0, 112.0, 100.0, 112.0, 104.0, 111.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "audio-beat-detection": [163.0, 130.0, 154.0, 163.0, 131.0, 151.0, 156.0, 131.0, 174.0, 140.0], "json-stringify-tinderbox": [68.0, 70.0, 71.0, 69.0, 69.0, 70.0, 70.0, 71.0, 69.0, 70.0], "stanford-crypto-pbkdf2": [152.0, 138.0, 153.0, 146.0, 164.0, 137.0, 149.0, 149.0, 153.0, 137.0], "json-parse-financial": [68.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 78.0, 67.0, 68.0], "stanford-crypto-sha256-iterative": [69.0, 71.0, 69.0, 69.0, 70.0, 71.0, 68.0, 68.0, 69.0, 71.0], "audio-fft": [72.0, 74.0, 84.0, 91.0, 72.0, 73.0, 73.0, 114.0, 90.0, 72.0], "imaging-darkroom": [148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0], "stanford-crypto-ccm": [117.0, 120.0, 128.0, 119.0, 123.0, 129.0, 122.0, 122.0, 129.0, 126.0], "audio-oscillator": [92.0, 92.0, 132.0, 91.0, 92.0, 93.0, 129.0, 91.0, 93.0, 128.0], "stanford-crypto-aes": [82.0, 85.0, 85.0, 85.0, 84.0, 85.0, 91.0, 85.0, 83.0, 85.0], "imaging-desaturate": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1522.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.5, "unit": "ms", "value": 81.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.8, "unit": "ms", "value": 147.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.5, "unit": "ms", "value": 123.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.0, "unit": "ms", "value": 148.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.3, "unit": "ms", "value": 103.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.2, "unit": "ms", "value": 161.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 69.5, "unit": "ms", "value": 69.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447812992, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117175137", "branch": "Fx-Team-Non-PGO", "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.3816852635629], "Encrypt": [280.3476310625175], "NavierStokes": [4850.241545893719], "Decrypt": [5020.0], "Splay": [613.6919315403424], "Richards": [166.5278934221482], "RegExp": [26205.128205128207], "Earley": [790.5138339920949], "Boyer": [12207.317073170732], "RayTrace": [1994.0239043824702]}, "summary": {"lowerIsBetter": false, "suite": 19785.335093057718, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 343.681364, "unit": "score", "value": 343.681364}, "Encrypt": {"lowerIsBetter": false, "filtered": 949.4676269999999, "unit": "score", "value": 949.4676269999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 305.9641434262948, "unit": "score", "value": 305.9641434262948}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.0241035856574, "unit": "score", "value": 53.0241035856574}, "Splay": {"lowerIsBetter": false, "filtered": 132.78812350597605, "unit": "score", "value": 132.78812350597605}, "RegExp": {"lowerIsBetter": false, "filtered": 34.76361545988257, "unit": "score", "value": 34.76361545988257}, "Richards": {"lowerIsBetter": false, "filtered": 211.98851000000005, "unit": "score", "value": 211.98851000000005}, "Earley": {"lowerIsBetter": false, "filtered": 843.0756950000003, "unit": "score", "value": 843.0756950000003}, "Boyer": {"lowerIsBetter": false, "filtered": 54.595370629370635, "unit": "score", "value": 54.595370629370635}, "RayTrace": {"lowerIsBetter": false, "filtered": 371.1033746253746, "unit": "score", "value": 371.1033746253746}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447812992, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117175137", "branch": "Fx-Team-Non-PGO", "revision": "e85794f108f04dd2ee460c6b3e030a148185e81c"}}] 18:36:49 INFO - RETURN: dromaeo_css: 6095.55 18:36:49 INFO - RETURN: kraken: 1522.50 18:36:49 INFO - RETURN: v8_7: 19785.34 18:36:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19785.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1522.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6095.55"}}} 18:36:49 INFO - Return code: 0 18:36:49 INFO - # TBPL SUCCESS # 18:36:49 INFO - Running post-action listener: _resource_record_post_action 18:36:49 INFO - Running post-run listener: _resource_record_post_run 18:36:50 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 508469248; Read time: 0; Write time: 389192 18:36:50 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 229773312; Read time: 0; Write time: 256740 18:36:50 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 278695936; Read time: 0; Write time: 132452 18:36:50 INFO - Running post-run listener: _upload_blobber_files 18:36:50 INFO - Blob upload gear active. 18:36:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:36:50 INFO - Copying logs to upload dir... 18:36:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1260.214930 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-17 18:36:50.436648) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:36:50.440128) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010078 build_url: 'https://queue.taskcluster.net/v1/task/7YBJrSNMSSuPxbgcVLikYg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:36:50.490231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:36:50.490510) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1447810957.926125-1444046285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:36:50.539321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:36:50.539587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:36:50.539845) ========= ========= Total master_lag: 0.40 =========