builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1447893365.44 results: success (0) buildid: 20151118154139 builduid: 630d960dc858488789592a4d43744bb6 revision: 1af31ad7eefc788678b22f71b9602bb7711fe6da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.444805) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.445301) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.445640) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006464 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.470978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.471308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.506856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.507128) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004762 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.562660) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.563015) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.563406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.563698) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 16:36:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2015-11-18 16:36:06 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.754354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.754729) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018305 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.804553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:05.804926) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1af31ad7eefc788678b22f71b9602bb7711fe6da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1af31ad7eefc788678b22f71b9602bb7711fe6da --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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 16:36:06,533 truncating revision to first 12 chars 2015-11-18 16:36:06,533 Setting DEBUG logging. 2015-11-18 16:36:06,533 attempt 1/10 2015-11-18 16:36:06,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1af31ad7eefc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 16:36:06,829 unpacking tar archive at: mozilla-inbound-1af31ad7eefc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:06.398568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:06.398926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:06.406343) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:06.406707) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 16:36:06.407223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 16:36:06.407544) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-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', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:36:07 INFO - MultiFileLogger online at 20151118 16:36:07 in /builds/slave/test 16:36:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 16:36:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:07 INFO - {'append_to_log': False, 16:36:07 INFO - 'base_work_dir': '/builds/slave/test', 16:36:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 16:36:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:07 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 16:36:07 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:07 INFO - 'config_files': ('talos/linux_config.py',), 16:36:07 INFO - 'default_actions': ('clobber', 16:36:07 INFO - 'read-buildbot-config', 16:36:07 INFO - 'download-and-extract', 16:36:07 INFO - 'populate-webroot', 16:36:07 INFO - 'create-virtualenv', 16:36:07 INFO - 'install', 16:36:07 INFO - 'run-tests'), 16:36:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:07 INFO - 'download_minidump_stackwalk': True, 16:36:07 INFO - 'download_symbols': 'ondemand', 16:36:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:07 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:07 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:07 INFO - 'installer_path': 'installer.exe', 16:36:07 INFO - 'log_level': 'info', 16:36:07 INFO - 'log_name': 'talos', 16:36:07 INFO - 'log_to_console': True, 16:36:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:36:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:36:07 INFO - 'opt_config_files': (), 16:36:07 INFO - 'pip_index': False, 16:36:07 INFO - 'sps_profile': False, 16:36:07 INFO - 'sps_profile_interval': 0, 16:36:07 INFO - 'suite': 'dromaeojs', 16:36:07 INFO - 'system_bits': '64', 16:36:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:07 INFO - 'title': 'talos-linux64-ix-010', 16:36:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:07 INFO - 'use_talos_json': True, 16:36:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:07 INFO - 'work_dir': 'build'} 16:36:07 INFO - ##### 16:36:07 INFO - ##### Running clobber step. 16:36:07 INFO - ##### 16:36:07 INFO - Running pre-action listener: _resource_record_pre_action 16:36:07 INFO - Running main action method: clobber 16:36:07 INFO - rmtree: /builds/slave/test/build 16:36:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:07 INFO - Running post-action listener: _resource_record_post_action 16:36:07 INFO - ##### 16:36:07 INFO - ##### Running read-buildbot-config step. 16:36:07 INFO - ##### 16:36:07 INFO - Running pre-action listener: _resource_record_pre_action 16:36:07 INFO - Running main action method: read_buildbot_config 16:36:07 INFO - Using buildbot properties: 16:36:07 INFO - { 16:36:07 INFO - "properties": { 16:36:07 INFO - "buildnumber": 2591, 16:36:07 INFO - "product": "firefox", 16:36:07 INFO - "script_repo_revision": "production", 16:36:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:36:07 INFO - "repository": "", 16:36:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 16:36:07 INFO - "buildid": "20151118154139", 16:36:07 INFO - "slavename": "talos-linux64-ix-010", 16:36:07 INFO - "pgo_build": "False", 16:36:07 INFO - "basedir": "/builds/slave/test", 16:36:07 INFO - "project": "", 16:36:07 INFO - "platform": "ubuntu64_hw", 16:36:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:36:07 INFO - "slavebuilddir": "test", 16:36:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 16:36:07 INFO - "branch": "mozilla-inbound", 16:36:07 INFO - "repo_path": "integration/mozilla-inbound", 16:36:07 INFO - "stage_platform": "linux64", 16:36:07 INFO - "builduid": "630d960dc858488789592a4d43744bb6", 16:36:07 INFO - "revision": "1af31ad7eefc788678b22f71b9602bb7711fe6da" 16:36:07 INFO - }, 16:36:07 INFO - "sourcestamp": { 16:36:07 INFO - "repository": "", 16:36:07 INFO - "hasPatch": false, 16:36:07 INFO - "project": "", 16:36:07 INFO - "branch": "mozilla-inbound-linux64-talos", 16:36:07 INFO - "changes": [ 16:36:07 INFO - { 16:36:07 INFO - "category": null, 16:36:07 INFO - "files": [ 16:36:07 INFO - { 16:36:07 INFO - "url": null, 16:36:07 INFO - "name": "https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:36:07 INFO - } 16:36:07 INFO - ], 16:36:07 INFO - "repository": "", 16:36:07 INFO - "rev": "1af31ad7eefc788678b22f71b9602bb7711fe6da", 16:36:07 INFO - "who": "jyavenard@mozilla.com", 16:36:07 INFO - "when": 1447893294, 16:36:07 INFO - "number": 6679814, 16:36:07 INFO - "comments": "Bug 1209388: [mp3] Remove AppleMP3Reader. r=kentuckyfriedtakahe\n\nFollowing bug 1209410, it was no longer used.\n", 16:36:07 INFO - "project": "", 16:36:07 INFO - "at": "Wed 18 Nov 2015 16:34:54", 16:36:07 INFO - "branch": "mozilla-inbound-linux64-talos", 16:36:07 INFO - "revlink": "", 16:36:07 INFO - "properties": [ 16:36:07 INFO - [ 16:36:07 INFO - "buildid", 16:36:07 INFO - "20151118154139", 16:36:07 INFO - "Change" 16:36:07 INFO - ], 16:36:07 INFO - [ 16:36:07 INFO - "builduid", 16:36:07 INFO - "630d960dc858488789592a4d43744bb6", 16:36:07 INFO - "Change" 16:36:07 INFO - ], 16:36:07 INFO - [ 16:36:07 INFO - "pgo_build", 16:36:07 INFO - "False", 16:36:07 INFO - "Change" 16:36:07 INFO - ] 16:36:07 INFO - ], 16:36:07 INFO - "revision": "1af31ad7eefc788678b22f71b9602bb7711fe6da" 16:36:07 INFO - } 16:36:07 INFO - ], 16:36:07 INFO - "revision": "1af31ad7eefc788678b22f71b9602bb7711fe6da" 16:36:07 INFO - } 16:36:07 INFO - } 16:36:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:36:07 INFO - Running post-action listener: _resource_record_post_action 16:36:07 INFO - ##### 16:36:07 INFO - ##### Running download-and-extract step. 16:36:07 INFO - ##### 16:36:07 INFO - Running pre-action listener: _resource_record_pre_action 16:36:07 INFO - Running main action method: download_and_extract 16:36:07 INFO - mkdir: /builds/slave/test/build/tests 16:36: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')]} 16:36:07 INFO - https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/test_packages.json 16:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/test_packages.json 16:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:36:10 INFO - Downloaded 1302 bytes. 16:36:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:36:10 INFO - Using the following test package requirements: 16:36:10 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:36:10 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:36:10 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:10 INFO - u'jsshell-linux-x86_64.zip'], 16:36:10 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:36:10 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:36:10 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:36:10 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:36:10 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:36:10 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:36:10 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:36:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:36: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')]} 16:36:10 INFO - https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:14 INFO - Downloaded 21329179 bytes. 16:36:14 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 16:36:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:14 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 16:36:15 INFO - Return code: 0 16:36:15 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 16:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:15 INFO - https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:17 INFO - Downloaded 21329179 bytes. 16:36:17 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 16:36:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:17 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 16:36:18 INFO - Return code: 0 16:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:36:18 INFO - https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:36:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:36:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:36:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:19 INFO - Downloaded 11130997 bytes. 16:36:19 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 16:36:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:36:19 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 16:36:20 INFO - Return code: 0 16:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:20 INFO - https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0MQfbV1S4merpW1WY5lfQ/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 16:36:21 INFO - Downloaded 55774966 bytes. 16:36:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:21 INFO - mkdir: /builds/slave/test/properties 16:36:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:21 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:21 INFO - Contents: 16:36:21 INFO - build_url:https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:21 INFO - Running post-action listener: _resource_record_post_action 16:36:21 INFO - Running post-action listener: set_extra_try_arguments 16:36:21 INFO - ##### 16:36:21 INFO - ##### Running populate-webroot step. 16:36:21 INFO - ##### 16:36:21 INFO - Running pre-action listener: _resource_record_pre_action 16:36:21 INFO - Running main action method: populate_webroot 16:36:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:36:21 INFO - '../fennec_ids.txt'], 16:36:21 INFO - 'tests': ['tcheck2']}, 16:36:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:21 INFO - '--tppagecycles', 16:36:21 INFO - '7'], 16:36:21 INFO - 'tests': ['tsvgm']}}, 16:36:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:36:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:36:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:36:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'tests': ['damp', 'tps']}, 16:36:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['damp', 'tps']}, 16:36:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:36:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:21 INFO - 'other': {'tests': ['a11yr', 16:36:21 INFO - 'ts_paint', 16:36:21 INFO - 'tpaint', 16:36:21 INFO - 'sessionrestore', 16:36:21 INFO - 'sessionrestore_no_auto_restore']}, 16:36:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['a11yr', 16:36:21 INFO - 'ts_paint', 16:36:21 INFO - 'tpaint', 16:36:21 INFO - 'sessionrestore', 16:36:21 INFO - 'sessionrestore_no_auto_restore']}, 16:36:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['a11yr', 16:36:21 INFO - 'ts_paint', 16:36:21 INFO - 'tpaint', 16:36:21 INFO - 'sessionrestore', 16:36:21 INFO - 'sessionrestore_no_auto_restore']}, 16:36:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['a11yr', 16:36:21 INFO - 'ts_paint', 16:36:21 INFO - 'tpaint', 16:36:21 INFO - 'sessionrestore', 16:36:21 INFO - 'sessionrestore_no_auto_restore']}, 16:36:21 INFO - 'other_l64': {'tests': ['a11yr', 16:36:21 INFO - 'ts_paint', 16:36:21 INFO - 'tpaint', 16:36:21 INFO - 'sessionrestore', 16:36:21 INFO - 'sessionrestore_no_auto_restore']}, 16:36:21 INFO - 'other_nol64': {'tests': ['a11yr', 16:36:21 INFO - 'ts_paint', 16:36:21 INFO - 'tpaint', 16:36:21 INFO - 'sessionrestore', 16:36:21 INFO - 'sessionrestore_no_auto_restore']}, 16:36:21 INFO - 'svgr': {'tests': ['tsvgx', 16:36:21 INFO - 'tsvgr_opacity', 16:36:21 INFO - 'tart', 16:36:21 INFO - 'tscrollx', 16:36:21 INFO - 'cart']}, 16:36:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['tsvgx', 16:36:21 INFO - 'tsvgr_opacity', 16:36:21 INFO - 'tart', 16:36:21 INFO - 'tscrollx', 16:36:21 INFO - 'cart']}, 16:36:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'tests': ['tp5o']}, 16:36:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'talos_options': ['--e10s'], 16:36:21 INFO - 'tests': ['tp5o']}, 16:36:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'talos_options': ['--xperf_path', 16:36:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:21 INFO - 'tests': ['tp5n']}, 16:36:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:21 INFO - 'talos_options': ['--e10s', 16:36:21 INFO - '--xperf_path', 16:36:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:21 INFO - 'tests': ['tp5n']}}, 16:36:21 INFO - 'talos.zip': {'path': '', 16:36:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:21 INFO - Running post-action listener: _resource_record_post_action 16:36:21 INFO - ##### 16:36:21 INFO - ##### Running create-virtualenv step. 16:36:21 INFO - ##### 16:36:21 INFO - Running pre-action listener: _resource_record_pre_action 16:36:21 INFO - Running main action method: create_virtualenv 16:36:21 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:21 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 16:36:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:21 INFO - Using real prefix '/usr' 16:36:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:21 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:23 INFO - Installing pip.................done. 16:36:23 INFO - Return code: 0 16:36:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36:23 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')]} 16:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:23 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')]} 16:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:23 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 0x7f7cf55a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', '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 16:36:23 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 16:36:23 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 16:36:23 INFO - Using env: {'DISPLAY': ':0', 16:36:23 INFO - 'HOME': '/home/cltbld', 16:36:23 INFO - 'LANG': 'en_US.UTF-8', 16:36:23 INFO - 'LANGUAGE': 'en_US:en', 16:36:23 INFO - 'LOGNAME': 'cltbld', 16:36:23 INFO - 'MAIL': '/var/mail/cltbld', 16:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:23 INFO - 'MOZ_NO_REMOTE': '1', 16:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:23 INFO - 'NO_EM_RESTART': '1', 16:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:23 INFO - 'PWD': '/builds/slave/test', 16:36:23 INFO - 'SHELL': '/bin/bash', 16:36:23 INFO - 'SHLVL': '1', 16:36:23 INFO - 'TERM': 'linux', 16:36:23 INFO - 'TMOUT': '86400', 16:36:23 INFO - 'USER': 'cltbld', 16:36:23 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:23 INFO - '_': '/tools/buildbot/bin/python'} 16:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:24 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 16:36:24 INFO - Cleaning up... 16:36:24 INFO - Return code: 0 16:36:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:36:24 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')]} 16:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:24 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')]} 16:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:24 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 0x7f7cf55a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', '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 16:36:24 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 16:36:24 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 16:36:24 INFO - Using env: {'DISPLAY': ':0', 16:36:24 INFO - 'HOME': '/home/cltbld', 16:36:24 INFO - 'LANG': 'en_US.UTF-8', 16:36:24 INFO - 'LANGUAGE': 'en_US:en', 16:36:24 INFO - 'LOGNAME': 'cltbld', 16:36:24 INFO - 'MAIL': '/var/mail/cltbld', 16:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:24 INFO - 'MOZ_NO_REMOTE': '1', 16:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:24 INFO - 'NO_EM_RESTART': '1', 16:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:24 INFO - 'PWD': '/builds/slave/test', 16:36:24 INFO - 'SHELL': '/bin/bash', 16:36:24 INFO - 'SHLVL': '1', 16:36:24 INFO - 'TERM': 'linux', 16:36:24 INFO - 'TMOUT': '86400', 16:36:24 INFO - 'USER': 'cltbld', 16:36:24 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:24 INFO - '_': '/tools/buildbot/bin/python'} 16:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:24 INFO - Downloading/unpacking psutil>=0.7.1 16:36:24 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 16:36:24 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 16:36:24 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 16:36:24 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 16:36:24 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 16:36:24 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 16:36:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:36:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:26 INFO - Installing collected packages: psutil 16:36:26 INFO - Running setup.py install for psutil 16:36:26 INFO - building 'psutil._psutil_linux' extension 16:36:26 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 16:36:26 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 16:36:26 INFO - building 'psutil._psutil_posix' extension 16:36:26 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 16:36:26 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 16:36:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:26 INFO - Successfully installed psutil 16:36:26 INFO - Cleaning up... 16:36:26 INFO - Return code: 0 16:36:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:26 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 0x7f7cf55a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', '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 16:36:26 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 16:36:26 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 16:36:26 INFO - Using env: {'DISPLAY': ':0', 16:36:26 INFO - 'HOME': '/home/cltbld', 16:36:26 INFO - 'LANG': 'en_US.UTF-8', 16:36:26 INFO - 'LANGUAGE': 'en_US:en', 16:36:26 INFO - 'LOGNAME': 'cltbld', 16:36:26 INFO - 'MAIL': '/var/mail/cltbld', 16:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:26 INFO - 'MOZ_NO_REMOTE': '1', 16:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:26 INFO - 'NO_EM_RESTART': '1', 16:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:26 INFO - 'PWD': '/builds/slave/test', 16:36:26 INFO - 'SHELL': '/bin/bash', 16:36:26 INFO - 'SHLVL': '1', 16:36:26 INFO - 'TERM': 'linux', 16:36:26 INFO - 'TMOUT': '86400', 16:36:26 INFO - 'USER': 'cltbld', 16:36:26 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:26 INFO - '_': '/tools/buildbot/bin/python'} 16:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:36:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:36:28 INFO - Installing collected packages: mozsystemmonitor 16:36:28 INFO - Running setup.py install for mozsystemmonitor 16:36:28 INFO - Successfully installed mozsystemmonitor 16:36:28 INFO - Cleaning up... 16:36:28 INFO - Return code: 0 16:36:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:28 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 0x7f7cf55a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', '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 16:36:28 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 16:36:28 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 16:36:28 INFO - Using env: {'DISPLAY': ':0', 16:36:28 INFO - 'HOME': '/home/cltbld', 16:36:28 INFO - 'LANG': 'en_US.UTF-8', 16:36:28 INFO - 'LANGUAGE': 'en_US:en', 16:36:28 INFO - 'LOGNAME': 'cltbld', 16:36:28 INFO - 'MAIL': '/var/mail/cltbld', 16:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:28 INFO - 'MOZ_NO_REMOTE': '1', 16:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:28 INFO - 'NO_EM_RESTART': '1', 16:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:28 INFO - 'PWD': '/builds/slave/test', 16:36:28 INFO - 'SHELL': '/bin/bash', 16:36:28 INFO - 'SHLVL': '1', 16:36:28 INFO - 'TERM': 'linux', 16:36:28 INFO - 'TMOUT': '86400', 16:36:28 INFO - 'USER': 'cltbld', 16:36:28 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:28 INFO - '_': '/tools/buildbot/bin/python'} 16:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:28 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 16:36:28 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 16:36:28 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 16:36:28 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 16:36:28 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 16:36:28 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 16:36:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:30 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 16:36:30 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 16:36:30 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 16:36:30 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 16:36:30 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 16:36:30 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 16:36:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:31 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 16:36:31 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 16:36:31 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 16:36:31 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 16:36:31 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 16:36:31 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 16:36:31 INFO - Downloading docopt-0.6.1.tar.gz 16:36:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:31 INFO - Running setup.py install for blobuploader 16:36:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:31 INFO - Running setup.py install for requests 16:36:31 INFO - Running setup.py install for docopt 16:36:32 INFO - Successfully installed blobuploader requests docopt 16:36:32 INFO - Cleaning up... 16:36:32 INFO - Return code: 0 16:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:32 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')]} 16:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:32 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')]} 16:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:32 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 0x7f7cf55a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', '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 16:36:32 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 16:36:32 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 16:36:32 INFO - Using env: {'DISPLAY': ':0', 16:36:32 INFO - 'HOME': '/home/cltbld', 16:36:32 INFO - 'LANG': 'en_US.UTF-8', 16:36:32 INFO - 'LANGUAGE': 'en_US:en', 16:36:32 INFO - 'LOGNAME': 'cltbld', 16:36:32 INFO - 'MAIL': '/var/mail/cltbld', 16:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:32 INFO - 'MOZ_NO_REMOTE': '1', 16:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:32 INFO - 'NO_EM_RESTART': '1', 16:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:32 INFO - 'PWD': '/builds/slave/test', 16:36:32 INFO - 'SHELL': '/bin/bash', 16:36:32 INFO - 'SHLVL': '1', 16:36:32 INFO - 'TERM': 'linux', 16:36:32 INFO - 'TMOUT': '86400', 16:36:32 INFO - 'USER': 'cltbld', 16:36:32 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:32 INFO - '_': '/tools/buildbot/bin/python'} 16:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:32 INFO - Running setup.py (path:/tmp/pip-EdmWAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:32 INFO - Running setup.py (path:/tmp/pip-VbkQsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:32 INFO - Running setup.py (path:/tmp/pip-lPRrYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:32 INFO - Running setup.py (path:/tmp/pip-XYSghm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:32 INFO - Running setup.py (path:/tmp/pip-6k9yjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:32 INFO - Running setup.py (path:/tmp/pip-nXwKf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:32 INFO - Running setup.py (path:/tmp/pip-sS_y0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:32 INFO - Running setup.py (path:/tmp/pip-1UZFT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:32 INFO - Running setup.py (path:/tmp/pip-rU5FDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:32 INFO - Running setup.py (path:/tmp/pip-uKLSLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:32 INFO - Running setup.py (path:/tmp/pip-Ez00s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:33 INFO - Running setup.py (path:/tmp/pip-FpjX2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:33 INFO - Running setup.py (path:/tmp/pip-HysDeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:33 INFO - Running setup.py (path:/tmp/pip-hm0RFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:33 INFO - Running setup.py (path:/tmp/pip-rKSp52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:33 INFO - Running setup.py (path:/tmp/pip-95qdGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:33 INFO - Running setup.py (path:/tmp/pip-CXvrAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:33 INFO - Running setup.py install for manifestparser 16:36:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:33 INFO - Running setup.py install for mozcrash 16:36:33 INFO - Running setup.py install for mozdebug 16:36:33 INFO - Running setup.py install for mozdevice 16:36:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:36:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:33 INFO - Running setup.py install for mozfile 16:36:34 INFO - Running setup.py install for mozhttpd 16:36:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Running setup.py install for mozinfo 16:36:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Running setup.py install for mozInstall 16:36:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Running setup.py install for mozleak 16:36:34 INFO - Running setup.py install for mozlog 16:36:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Running setup.py install for moznetwork 16:36:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Running setup.py install for mozprocess 16:36:34 INFO - Running setup.py install for mozprofile 16:36:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Running setup.py install for mozrunner 16:36:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:34 INFO - Running setup.py install for mozscreenshot 16:36:35 INFO - Running setup.py install for moztest 16:36:35 INFO - Running setup.py install for mozversion 16:36:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:35 INFO - Cleaning up... 16:36:35 INFO - Return code: 0 16:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:35 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')]} 16:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:35 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')]} 16:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:35 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 0x7f7cf55a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', '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 16:36:35 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 16:36:35 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 16:36:35 INFO - Using env: {'DISPLAY': ':0', 16:36:35 INFO - 'HOME': '/home/cltbld', 16:36:35 INFO - 'LANG': 'en_US.UTF-8', 16:36:35 INFO - 'LANGUAGE': 'en_US:en', 16:36:35 INFO - 'LOGNAME': 'cltbld', 16:36:35 INFO - 'MAIL': '/var/mail/cltbld', 16:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:35 INFO - 'MOZ_NO_REMOTE': '1', 16:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:35 INFO - 'NO_EM_RESTART': '1', 16:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:35 INFO - 'PWD': '/builds/slave/test', 16:36:35 INFO - 'SHELL': '/bin/bash', 16:36:35 INFO - 'SHLVL': '1', 16:36:35 INFO - 'TERM': 'linux', 16:36:35 INFO - 'TMOUT': '86400', 16:36:35 INFO - 'USER': 'cltbld', 16:36:35 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:35 INFO - '_': '/tools/buildbot/bin/python'} 16:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:35 INFO - Running setup.py (path:/tmp/pip-WsNQPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:35 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)) 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:35 INFO - Running setup.py (path:/tmp/pip-3ZS4j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:35 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)) 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:35 INFO - Running setup.py (path:/tmp/pip-3V10nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:35 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)) 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:35 INFO - Running setup.py (path:/tmp/pip-HsRHjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:35 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)) 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:35 INFO - Running setup.py (path:/tmp/pip-RwwsbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:35 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)) 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:35 INFO - Running setup.py (path:/tmp/pip-aKPAyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:35 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)) 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:35 INFO - Running setup.py (path:/tmp/pip-qtEuOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:35 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)) 16:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:35 INFO - Running setup.py (path:/tmp/pip-N2X44A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:36 INFO - Running setup.py (path:/tmp/pip-fviJBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:36 INFO - Running setup.py (path:/tmp/pip-kqoAIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:36 INFO - Running setup.py (path:/tmp/pip-69h1Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:36 INFO - Running setup.py (path:/tmp/pip-cBdC9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:36 INFO - Running setup.py (path:/tmp/pip-nOHUzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:36 INFO - Running setup.py (path:/tmp/pip-We_Djy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:36 INFO - Running setup.py (path:/tmp/pip-g3mNfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:36 INFO - Running setup.py (path:/tmp/pip-e2CgrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:36 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)) 16:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:36 INFO - Running setup.py (path:/tmp/pip-nPIhD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:36 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)) 16:36:36 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)) 16:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:36:36 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)) 16:36:36 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)) 16:36:36 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)) 16:36:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:36 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 16:36:36 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 16:36:36 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 16:36:36 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 16:36:36 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 16:36:36 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 16:36:38 INFO - Downloading blessings-1.5.1.tar.gz 16:36:38 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 16:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:38 INFO - Installing collected packages: blessings 16:36:38 INFO - Running setup.py install for blessings 16:36:38 INFO - Successfully installed blessings 16:36:38 INFO - Cleaning up... 16:36:38 INFO - Return code: 0 16:36:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:38 INFO - Reading from file tmpfile_stdout 16:36:38 INFO - Current package versions: 16:36:38 INFO - argparse == 1.2.1 16:36:38 INFO - blessings == 1.5.1 16:36:38 INFO - blobuploader == 1.2.4 16:36:38 INFO - docopt == 0.6.1 16:36:38 INFO - manifestparser == 1.1 16:36:38 INFO - mozInstall == 1.12 16:36:38 INFO - mozcrash == 0.16 16:36:38 INFO - mozdebug == 0.1 16:36:38 INFO - mozdevice == 0.47 16:36:38 INFO - mozfile == 1.2 16:36:38 INFO - mozhttpd == 0.7 16:36:38 INFO - mozinfo == 0.9 16:36:38 INFO - mozleak == 0.1 16:36:38 INFO - mozlog == 3.0 16:36:38 INFO - moznetwork == 0.27 16:36:38 INFO - mozprocess == 0.22 16:36:38 INFO - mozprofile == 0.27 16:36:38 INFO - mozrunner == 6.11 16:36:38 INFO - mozscreenshot == 0.1 16:36:38 INFO - mozsystemmonitor == 0.0 16:36:38 INFO - moztest == 0.7 16:36:38 INFO - mozversion == 1.4 16:36:38 INFO - psutil == 3.1.1 16:36:38 INFO - requests == 1.2.3 16:36:38 INFO - wsgiref == 0.1.2 16:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:38 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 0x7f7cf55a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', '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 16:36:38 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 16:36:38 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 16:36:38 INFO - Using env: {'DISPLAY': ':0', 16:36:38 INFO - 'HOME': '/home/cltbld', 16:36:38 INFO - 'LANG': 'en_US.UTF-8', 16:36:38 INFO - 'LANGUAGE': 'en_US:en', 16:36:38 INFO - 'LOGNAME': 'cltbld', 16:36:38 INFO - 'MAIL': '/var/mail/cltbld', 16:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:38 INFO - 'MOZ_NO_REMOTE': '1', 16:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:38 INFO - 'NO_EM_RESTART': '1', 16:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:38 INFO - 'PWD': '/builds/slave/test', 16:36:38 INFO - 'SHELL': '/bin/bash', 16:36:38 INFO - 'SHLVL': '1', 16:36:38 INFO - 'TERM': 'linux', 16:36:38 INFO - 'TMOUT': '86400', 16:36:38 INFO - 'USER': 'cltbld', 16:36:38 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:38 INFO - '_': '/tools/buildbot/bin/python'} 16:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 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)) 16:36:39 INFO - Cleaning up... 16:36:39 INFO - Return code: 0 16:36:39 INFO - Running post-action listener: _resource_record_post_action 16:36:39 INFO - Running post-action listener: _start_resource_monitoring 16:36:39 INFO - Starting resource monitoring. 16:36:39 INFO - ##### 16:36:39 INFO - ##### Running install step. 16:36:39 INFO - ##### 16:36:39 INFO - Running pre-action listener: _resource_record_pre_action 16:36:39 INFO - Running main action method: install 16:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:39 INFO - Reading from file tmpfile_stdout 16:36:39 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:39 INFO - Reading from file tmpfile_stdout 16:36:39 INFO - Output received: 16:36:39 INFO - Usage: mozinstall [options] installer 16:36:39 INFO - Options: 16:36:39 INFO - -h, --help show this help message and exit 16:36:39 INFO - -d DEST, --destination=DEST 16:36:39 INFO - Directory to install application into. [default: 16:36:39 INFO - "/builds/slave/test"] 16:36:39 INFO - --app=APP Application being installed. [default: firefox] 16:36:39 INFO - mkdir: /builds/slave/test/build/application 16:36:39 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'] 16:36:39 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 16:36:53 INFO - Reading from file tmpfile_stdout 16:36:53 INFO - Output received: 16:36:53 INFO - /builds/slave/test/build/application/firefox/firefox 16:36:53 INFO - Running post-action listener: _resource_record_post_action 16:36:53 INFO - ##### 16:36:53 INFO - ##### Running run-tests step. 16:36:53 INFO - ##### 16:36:53 INFO - Running pre-action listener: _resource_record_pre_action 16:36:53 INFO - Running main action method: run_tests 16:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:53 INFO - Python 2.7.3 16:36:53 INFO - Return code: 0 16:36:53 INFO - grabbing minidump binary from tooltool 16:36:53 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')]} 16:36:53 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 0x18a4b70>, '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 0x18f5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18f6250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:53 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 16:36:53 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 16:36:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:53 INFO - Return code: 0 16:36:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:36:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:36:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test/build 16:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 16:36:53 INFO - Using env: {'DISPLAY': ':0', 16:36:53 INFO - 'HOME': '/home/cltbld', 16:36:53 INFO - 'LANG': 'en_US.UTF-8', 16:36:53 INFO - 'LANGUAGE': 'en_US:en', 16:36:53 INFO - 'LOGNAME': 'cltbld', 16:36:53 INFO - 'MAIL': '/var/mail/cltbld', 16:36:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:53 INFO - 'MOZ_NO_REMOTE': '1', 16:36:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:53 INFO - 'NO_EM_RESTART': '1', 16:36:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:53 INFO - 'PWD': '/builds/slave/test', 16:36:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:53 INFO - 'SHELL': '/bin/bash', 16:36:53 INFO - 'SHLVL': '1', 16:36:53 INFO - 'TERM': 'linux', 16:36:53 INFO - 'TMOUT': '86400', 16:36:53 INFO - 'USER': 'cltbld', 16:36:53 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865', 16:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:53 INFO - '_': '/tools/buildbot/bin/python'} 16:36:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 16:36:53 INFO - mozversion INFO | application_buildid: 20151118154139 16:36:53 INFO - mozversion INFO | application_changeset: 1af31ad7eefc788678b22f71b9602bb7711fe6da 16:36:53 INFO - mozversion INFO | application_display_name: Nightly 16:36:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:53 INFO - mozversion INFO | application_name: Firefox 16:36:53 INFO - mozversion INFO | application_remotingname: firefox 16:36:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:36:53 INFO - mozversion INFO | application_vendor: Mozilla 16:36:53 INFO - mozversion INFO | application_version: 45.0a1 16:36:53 INFO - mozversion INFO | platform_buildid: 20151118154139 16:36:53 INFO - mozversion INFO | platform_changeset: 1af31ad7eefc788678b22f71b9602bb7711fe6da 16:36:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:36:53 INFO - mozversion INFO | platform_version: 45.0a1 16:36:53 INFO - 2015-11-18 16:36:53,896 DEBUG : using testdate: 1447893413 16:36:53 INFO - 2015-11-18 16:36:53,896 DEBUG : actual date: 1447893413 16:36:53 INFO - 2015-11-18 16:36:53,943 INFO : starting webserver on 'localhost:39197' 16:36:53 INFO - 2015-11-18 16:36:53,944 INFO : Starting test suite talos-linux64-ix-010 16:36:53 INFO - 2015-11-18 16:36:53,944 INFO : Starting test dromaeo_css 16:36:53 INFO - 2015-11-18 16:36:53,944 DEBUG : operating with platform_type : linux_ 16:36:53 INFO - 2015-11-18 16:36:53,944 INFO : Initialising browser for dromaeo_css test... 16:36:53 INFO - 2015-11-18 16:36:53,951 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5fb5ZZ/profile http://localhost:39197/getInfo.html 16:36:58 INFO - 2015-11-18 16:36:58,882 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:36:58 INFO - 2015-11-18 16:36:58,882 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:36:58 INFO - 2015-11-18 16:36:58,882 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:36:58 INFO - 2015-11-18 16:36:58,882 DEBUG : BROWSER_OUTPUT: __metrics 16:36:58 INFO - 2015-11-18 16:36:58,999 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:37:00 INFO - 2015-11-18 16:37:00,270 INFO : Browser initialized. 16:37:00 INFO - 2015-11-18 16:37:00,271 INFO : Running cycle 1/1 for dromaeo_css test... 16:37:00 INFO - 2015-11-18 16:37:00,271 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5fb5ZZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:37:12 INFO - 2015-11-18 16:37:12,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 141459456 16:37:12 INFO - 2015-11-18 16:37:12,215 DEBUG : BROWSER_OUTPUT: 16:38:03 INFO - 2015-11-18 16:38:03,649 DEBUG : BROWSER_OUTPUT: 1447893483648 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] 16:40:15 INFO - 2015-11-18 16:40:15,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39197/tests/dromaeo/cssquery-ext.html) 16:40:16 INFO - 2015-11-18 16:40:16,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 250626048 16:40:16 INFO - 2015-11-18 16:40:16,670 DEBUG : BROWSER_OUTPUT: 16:43:19 INFO - 2015-11-18 16:43:19,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/dromaeo/cssquery-ext.html (next: http://localhost:39197/tests/dromaeo/cssquery-jquery.html) 16:43:19 INFO - 2015-11-18 16:43:19,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 221827072 16:43:19 INFO - 2015-11-18 16:43:19,792 DEBUG : BROWSER_OUTPUT: 16:46:21 INFO - 2015-11-18 16:46:21,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39197/tests/dromaeo/cssquery-mootools.html) 16:46:22 INFO - 2015-11-18 16:46:22,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 219910144 16:46:22 INFO - 2015-11-18 16:46:22,352 DEBUG : BROWSER_OUTPUT: 16:49:24 INFO - 2015-11-18 16:49:24,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39197/tests/dromaeo/cssquery-prototype.html) 16:49:24 INFO - 2015-11-18 16:49:24,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 203411456 16:49:24 INFO - 2015-11-18 16:49:24,822 DEBUG : BROWSER_OUTPUT: 16:52:27 INFO - 2015-11-18 16:52:27,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39197/tests/dromaeo/cssquery-yui.html) 16:52:28 INFO - 2015-11-18 16:52:28,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 207757312 16:52:28 INFO - 2015-11-18 16:52:28,203 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/dromaeo/cssquery-yui.html (next: http://localhost:39197/tests/dromaeo/cssquery-dojo.html) 16:55:31 INFO - 2015-11-18 16:55:31,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 249126912 16:55:31 INFO - 2015-11-18 16:55:31,292 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,293 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:55:31 INFO - 2015-11-18 16:55:31,293 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:55:31 INFO - 2015-11-18 16:55:31,293 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:55:31 INFO - 2015-11-18 16:55:31,294 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:55:31 INFO - 2015-11-18 16:55:31,294 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.710181879993;2721.7822574194065;2723.6867760207583;2728.3588356736163;2749.615053892455;4486.97756511217;4597.5172606876295;4702;4735.029318989607;4760.095581839448;4667.276572131316;4682.765861706909;4766.73782941938;4770.451398089221;4779.689320194194;4305.913881722364;4383.189110014658;4384.47386313642;4470.083632855257;4485.327200919872;4153.460050193471;4395;4414.977925110386;4459.777011149429;4506.188886000518;4194.601512856304;4287.2711639021445;4291.6137547620865;4299.6775241856985;4336.479622445295;4351.0862718829085;4375.47494300686;4382.627476664487;4391;4398.868033958986;4132.359484279911;4263.040815816447;4332.891677708051;4338.262495375794;4381.277089280265;4578.130155270488;4675.462321832964;4692.178868697964;4696.107739529512;4721.3862197914395;5126.846194614168;5135.589152867761;5137.7944882204665;5138.588912886998;5178.40448348441;4841.878953026167;4964.429090654585;4974.154393753034;5163.896722065538;5185.377754669464;4703.365045718819;4781.497942715965;4788.880277993078;4801.9039619208115;4841.709497430165;5221.295125158131;5238.7904483820985;5250.369955605352;5284.339457567804;5286.656367336111;4762.976185119052;4896.804127834918;4900.093482705711;5015.623828212826;5035.647504674711;4868.440129385166;4952.059108769322;4970.080535101018;4974.204127339608;4999.175136102575;5014.623903207274;5054.494550544916;5058.064258112261;5065.924011139836;5104.2088476286235;4862.05189987949;5006.148954677714;5008.6744361616375;5030.144875371196;5035.748212589356;4091.5294741105154;4164.541900390955;4177.791110444466;4204.495460544754;4213.304804707251;3690.8523659053335;3691.9446208306895;3695.427208782643;3725.0314918121485;3730.0301921500604;4194;4300.4194433751045;4350.825966961349;4350.977520282731;4380.145871555016;4936.3829521309835;4983.277424773388;5009.173486374707;5012.398512178489;5037.647364684437;4341.978290108529;4355.629771469397;4356.825726970949;4357.975875669215;4403.515613282536;4327.740335579875;4459.353393757887;4518.480374756879;4520.706154099973;4557.225271703818;4621.722696638145;4699.15415225249;4711.2933060039895;4747.430308363018;4761.5714585686765;5067.949320506747;5088.491150884882;5094.388673359221;5095.13382724945;5141.2288156776785;4581.2899000653615;4696.882577935442;4817;4824.903501930012;4855.781489833037;4812.494688057704;4907;4917.237828136645;4934.18585933317;4937.333459982857;5089.796408143633;5112.309838171799;5114.974425127999;5115.104856649997;5152.458991805806;4946.060248552763;4948.826791062295;4953.356063711839;4957.182064959241;4958.553730164303;4710.057988402402;4839.7096174229655;4845.781939812647;4895.510448955076;5033;4821.493743156918;4852.490488498657;4858.149823780895;4860.756962151949;4868.561829435368;4954.182559877724;4965.577925876341;4966.8758281043265;4974.079795237748;5007.84976450707;4628.305754136906;4692.554207350297;4750.619950404029;4754.619630429488;4768.284757286296 16:55:31 INFO - 2015-11-18 16:55:31,295 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.7939862250968;571.2545128607168;572.8399990020212;577.5927970780599;578.849499130226;25229.74770252297;25953.870230648845;36755.81622091886;37756;37785;39940;40511;40535.79732101343;40543.79728101363;40572;6835.931640683604;7863.29230369268;8005.839883202332;8008.67965281388;8009.159038300982;6921.65391730414;10074.546645400938;10403.271770976035;10419.843702344433;10423.635172768954;9984.700458986243;10082.193424526056;10094.586757853906;10101.343412678189;10118.949405252963;7061.082059332254;7259.491835571512;9936.304458687895;10069.244806639495;10112.595496180144;9788.070133337322;9939;9944.303898727092;9947.850782238273;9952.253580981383;37347;37583.248335033146;37705;37882;37917.43123853144;2861.899833505838;2981.761459083268;3038.4226996870525;3586.1393265616066;3623.3115708015393;27937;28181.436371272666;28246.293842653893;28505.144845654664;28885.277868053257;2946.1603443018635;2990.4318179546035;2997.325601739613;3022.909312720622;3095.90712278632;224541;225412;227363;227533.86233068895;227996;52211.47788522142;52869.2069618956;56694.14958775622;57047;57164;66719.66640166866;67675.66162169256;68020.6598967002;68112;68129.65935170293;14555.708885822225;14712.852871471148;14722.116672999655;14728.484503042342;14736.705265894836;11180.496877640526;11244.49399777012;11248.775024499464;11266.155038372155;11279.887201127884;19484.70772938407;19615.901920490305;19721.704174437396;19764.70352944707;19849.30527431533;7635.885461718079;7912.208779122157;7984.640691168911;7988.920110798934;8011.357671677292;787.9842403151905;790.6205021589554;834.7787836223406;854.4574195385975;878.2798105553512;30241;31281.843590782355;31695.988881056262;31815;31951;909.3634455880909;911.5487833522317;918.3846822628855;921.5162039929091;935.7192842147329;13256.138351007154;13341.799873001914;13345.532906348231;13347.332633368293;13367.732645347038;315826;316553;319600;321261;322343;46898.76550617225;47500;47504.28743568849;47559.28661070087;47606;1154.8960593546622;1166.2943918929095;1191.416206059025;1204.0488014468472;1206.2400687566776;24312.905919233322;25064.248072557853;25509.3622659435;25548.361290967874;25681.357966050997;38988.41517377185;39625;39672.20655586814;39704;39799.60200397959;230978;234899;239960;240985;242450;26989.595156072282;27067.59398609062;27158.72841271641;27404.314892127855;27459.31351716223;34917.650823491436;45329.77335113303;46181.538184619065;46613.766931165126;47441.051178976915;33199;33269.667303326656;33463.49804752882;34039.149021273675;34420.65579344275;33222.83388583138;33360.83319583387;33583.328333432706;33640.3271934555;34239.48640770341;34196.65803342034;34346.82826585851;34489;38802.41796373113;39531.60468395279;29197.85401072981;30692.846535767178;31087.533686995164;31139.688603114584;31181.53227701632;24005;24005.759942400353;24039.75960240445;24098.15656452016;24337.878310608332 16:55:31 INFO - 2015-11-18 16:55:31,296 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.84302427274224;311.02338656618207;311.70543836074916;315.34565776014773;319.9600049993751;13029;13038.087333886631;13953.023288369806;15257;15854.365825366986;10296.794064118732;10559.630412935549;10568.313059651136;10573.365598064122;16547.751783723255;3726.2920045191395;4238.809253583596;4285.47865507745;4293.785310734466;4375.824967001332;4281.336392859096;4312.849050283241;4319.697621166504;4320.438343015419;4322.654187664995;3161.7154456098947;3236.1100697308193;3247.447933851251;4267.893302667442;4278.893027674302;4490.371348011281;4561.885952851172;4610.631149508032;4613.308003799423;4614.469336026366;3831.3103641344546;3973.0266084809405;3976.3836605325932;3976.701747368959;3980.2835489611857;10107.89892101077;10490.632827851065;10542.367457952547;10569.471526423647;11990.940045299718;1500.932458039391;1670.106493026225;1707.3853412771393;1715.905625190614;1735;8552.444091134057;8685.782855428602;8756.343274254456;8770.473771573663;8930.776730581723;1524.5121561100452;1527.3585094260438;1575.2045217165257;1585.5164174926642;1607.0679006176506;51633.74183129098;54259;54640;54999.450005500235;55121.9999999996;6084.787032453843;6090;6148.538859585549;6275.623462592259;6457.838554036187;7352.77941661751;7370.557766534025;7371.226021267689;7381.261873812576;7432.145303290083;4932.358793356841;4988.6507944444265;5007.799688012512;5016.372953380827;5036.244563315532;5128.743562821844;5147.716875571879;5152.536271735562;5155.200943853709;5169.224616307509;2863.498887694687;2880.1215629233284;2887.4946884295164;2900.0864727610733;2909.4617495762927;1004.9497525123714;1010.6563768318807;1010.9494525273707;1013.3109485549896;1059.8251288537306;322.55648483335415;401.90354314964196;405.3433437830733;406.8392984770999;434.03427374093025;9534.046595340411;10290.12533934624;10704.19718521114;10757.30077544957;10763.515641796137;411.8187997281187;413.6194700875202;416.4773209621966;419.24745082576845;427.6706935659525;5385.623006389594;5878.206442130343;5879.323877754027;5928.7332070056955;5940.940590594125;486585;492528;493919;502406;502656;65293.34706652968;67313.66343168351;67446.66276668585;67723.66138169277;67982;431.56843156843155;441.70405828095255;462.3596319098073;472.5085910652883;473.2380866804442;9328.95335523318;9341.673041443517;9425.575849086945;9579.233661307218;9637.036296370306;28982.710172898845;29736.256593585334;30619.846900765355;30762.53856192114;31312.373752525276;41576.168476630904;43202.35196471993;44513;44692;45388;5879.441453061952;5972.462478376967;5996.130561068708;6014.669193194416;6022.187004754477;9987.151092157248;10351.896481035394;10502.4223667699;10578.682639520826;10579.418132002813;9199.310051746279;9248.583813728534;9323;9439.19766819828;9465.810683786423;9022.90977090247;9126.680566180152;9280.814383712423;9326.813463730823;9499.050094990445;9292.535373231176;9295.024022477543;9362.438253704799;9538.85691714611;9662.516874156405;6038.064100064497;6045.879082418239;6072.392760723892;6080.361562035922;6099.695015249131;9413.246940244628;9474.910385305502;9621.037896210322;9642.807143857224;9818.214542836413 16:55:31 INFO - 2015-11-18 16:55:31,297 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1194.1402190422893;1635.8527732504072;1644.7615095811107;1676.103284742663;1691.205133587214;5725.4847063764255;6564.868702625945;6697.631630260334;6700.865982680343;6704.262531121579;6507.44686701631;6535.11775910252;6613;6632.535722499427;6633.767818126366;1650.7771450854102;1679;1680.1851102215476;2006.4983754061484;2023.9898800505978;1715.6825987192346;1723.2245489529698;1726.326732574297;1945.8248757611811;2000.469875482998;1944.572194117292;1947.0167565379463;1947.6494231038407;1948.3473036532778;1949.4638974282045;1921.3755529452915;2012.4767560434245;2018.8183063524352;2019.8889061101634;2021.5956808638184;1866.2814816295688;1885.3589779475044;1892.668782962976;1910.503269150031;1912.407153782332;6718.865622687519;6792.354726300993;6794.0827988221945;6796.932030679679;6799.796006119825;3975.6024397560013;4041.2725709372303;4044.2518134145275;4045.02919299369;4046.676265898721;2573.716891141973;2599.14228304659;2633.2626864477784;2637.591173368131;2680.7989400794822;793.4089103617785;802.5866678660494;804.2199066905092;805.8952336196257;814.4217605500102;9014.504202268872;9069.863952040725;9073.274138068873;9083.772905677344;9087;3629.709623230135;3657.2868290683596;3694.4273637586216;3695.094701798023;3749.4750734897134;7774.067111946602;7819.5699236541395;7824.804379890548;7835.843283134305;7842.176571460029;4033.7176397651883;4048.149888523443;4063.898402539901;4069.593040695907;4069.7761623111014;3691.427828686558;3702.278055779097;3710.703143748494;3715.238376132886;3725.720570957135;3203.871845126169;3205.8557364918634;3223.2103134731674;3268.428025095599;3274.2632907596076;901.1484147480568;930.5905401623264;935.0555938502026;999.4203362049993;1007.9798404031878;790.4229912164152;791;796.4345314826538;836.3936146293888;880.4365206267994;5857.531397488191;5980.880382392328;5988.490978266809;5992.0712289595185;6002.129691194839;959.9424034557949;974.1865542272282;979.3536266064364;981.0924894472585;997.3367710472454;4690.81236750533;4742;4805.207140821725;4819.397575303087;4829.806807727722;7787.727429539939;7977.601119944095;8053.677852885936;8058.35533157346;8067.435279530377;7887.171846956102;7947.880781788278;7948.920510794934;7953.880691789628;7970.561619110888;6059.6364218147055;6098.481629061579;6109.389061093855;6137.324894261627;6214.689265536705;5816.970915145397;5839.3868643793485;5847.707614619337;5857.619254748428;5859.472647461749;6872.209695885037;7074.893876591958;7187.31720486553;7264.055672762507;7274.854502910018;7279.417646588155;7412.925870741224;7429.219931907288;7517.699292028257;7540.208278130936;5590.608657393944;5644.52021578154;5645.9153112702525;5646.71766411686;5681.77272909079;6193.4425901669065;6205.968970155121;6224.906626400517;6231.906521402092;6296;5902.675352855634;5968.373320801254;5980.102984552352;6003.429674180946;6061.212042434456;4792.904141917073;5632.5775566831835;5687.914681279867;5757.136429535603;5978.192943952511;5806.216160818404;5809.79665711715;5823.388544202967;5834.795782147605;5846.590738648254;5492.725363731877;5571.637843540157;5595.384507704231;5620.185073164286;5626.043572592751;5249.343832020997;5534.667919924817;5554.583406244628;5604.551635869202;5625.690587017753 16:55:31 INFO - 2015-11-18 16:55:31,297 DEBUG : BROWSER_OUTPUT: |4;prototype.html;281.2883404985387;282.3266509375141;287.57438990294366;289.54685916540615;290.85166565051844;5004.274380214876;5151.124308867492;5311.49540793625;5352.1436570148735;5379.946200537994;5226.268322434853;5297.682139071659;5319.361676598804;5322.0154271459805;5325.3077099976945;4119.855805046824;4142.461480007595;4149.647279981205;4152.709310348277;4159.604837540429;3926.685865130797;4022.537408198051;4029;4143.6685065194715;4146.626803587692;4060.7360521566;4069.3285607874664;4080.6123418275215;4081.755094694313;4082.0815316553685;4070.9185816283803;4076.0625056236936;4079.122988557445;4081.755094694328;4084.5915408459064;3542.8582856685703;3557.2707594942976;3557.4485954677066;3557.786532808014;3561.1453251219523;5017.623678224148;5102.311187989611;5119.129747942859;5137.075326441239;5138.383393992707;4682.8126874924965;4686.156491831469;4690.1557719610455;4695.577398034159;4697.13103075932;5591.161325801162;5591.4688104629995;5601.439856014406;5602.327720673505;5604.523615492688;3691.058780011107;3755.042464171646;3796.316663000659;3875.360565506688;3876.186000939806;5822.214001109838;5882.382349853289;5896.528277737813;5918.23063001807;5921.763129474816;3924.744891582095;3926.587708290588;3930.3514920038447;3932.1545867638597;3944.5660977292473;3988.3020471417385;3991.1640645302905;3992.640662340345;3993.4409182714444;3996.4604778355133;4501.414816073955;4606.0097079128145;4607.262837945913;4608.239640459354;4612.884677883079;5600.5799565032785;5607.130894711327;5608.242887210256;5608.327000759935;5613.578981576398;1384.3286006286942;1398.7552178368744;1400.9772865808018;1401.1172961034483;1401.4604377314806;917.9632814687337;923.2844545477175;933.4772527384687;941.0589410589411;943.4999450291357;4909;4913.385826771653;4918.827841025619;4920.950790492121;4929.605631549467;5837.3287071986415;5838.007538718428;5838.67887266196;5838.737256823453;5841.853953651193;4907.730074845917;4919.4834542373255;4921.532454416824;4922.237053256751;4923.852284431473;3056.098450956973;3125.46867032605;3146.3707258548384;3155.9053228403186;3156.7474602031784;5551.528120109755;5559;5561.58288128392;5564.387917329172;5568.7215639217875;6056.152138700585;6057.3336932937345;6061.212042434543;6061.696915154224;6062.120992456069;5545.639533430314;5546.112621980464;5551.250581171571;5551.916721249185;5554.9722251387675;5752.137179422953;5856.560757943256;5885.911711324248;5892.057270836817;5899.764009439575;5531.751071201886;5646.124850648156;5747.109198074305;5747.798827041033;5748.741306641295;5414.783408663609;5508.476694713996;5535.474129957647;5537.390887002507;5550.7779688812;3916.236333914859;3962.9207415852097;3965.4646622705563;3966.3852102924093;3968.5832987537046;5849.210356601974;5852.385499522659;5853.9121913172185;5855.853603659943;5862.648241105548;5475.808346707846;5622.3815380307315;5628.971855140698;5664.235328230801;5678.290213723285;5658.179563963285;5658.773649053992;5669.801556945487;5670.432956704297;5678.602497825113;5538.418466061166;5543.667379957215;5544.944550554605;5550;5554.139108438037;5525.254090697705;5693.117566777156;5696.544276457957;5697.686627235542;5703.116017017203;5553.416891226363;5561.998840208801;5562.721863906708;5564.610477266552;5568.693721845338 16:55:31 INFO - 2015-11-18 16:55:31,299 DEBUG : BROWSER_OUTPUT: |5;yui.html;579.4813641790599;597.9790707325244;682.3756263019337;694.1323345817725;745.0909889934278;10780.946095269523;11140.665780026602;14213.64465888352;14487.92756036221;14577.635559111028;10157.187425006001;13689.794653080187;13703;13709.794353084711;13727.382267797948;606.4632799972023;789.5183937797939;798.9041315042174;799.5242830515863;800.9987515605493;784.1139512351035;799.3445374792673;799.9200079991983;801.8316153607749;802.3861745764494;643.1285608001161;650.9902351464732;651.1307404614845;829.7386323308139;838.7861095420659;644.6390021587903;645.4739387399254;811.7158994351988;835.4277320035795;835.7200337886816;619.8822223777513;620.3951147631069;620.70826711446;621.934696856828;622.2315440431064;12346.938265308705;12405.813912791315;12419.31693756843;12452.75094498105;12508.937455312756;11169.162312826571;11349.205555611028;11502.367369794658;11764.764704705944;11982.820257696141;9178.908210917938;9480.00459951709;9534.523273836281;9576.61693532258;9589.808203835884;3316.303576248991;3335.699787019156;3340.9665903340897;3342.665733426638;3368.7641865069454;42761.14477710459;43043.35434968478;43075.1384972302;43463;44030.55969440297;9327.720168394959;9636.566354514063;10027.548760305805;10055.798884022279;10127.64553240633;17799.377021804434;17815.46553603394;17819.643607128044;17836.55408614769;17844.286228550973;6436.774712885027;6519.3154718754795;6525.988471786881;6528.934710652833;6698;3403.846826892796;3423.1271025888736;3438.9312213756084;3476.7218622510645;3548.3435564420665;2792.148394739583;2831;2836.134978831476;2836.546152615572;2838.091810620582;419.5447938986173;434.1079082485459;437.0655301644462;437.49906357220806;437.56243756243754;550.1170621152992;555.0841112164879;557.2226743692607;571.5227784799739;586.3140126052529;7060.223375428699;7320.341169294683;7534.171241163468;7654.311111999947;7701.537907725555;487.3761585170987;559.8712296171822;599.78707558816;617.2592888533777;622.8131560531822;3700.5929347771726;3789.905252368713;3822.2928758179823;3925.6270654287796;3945.2898478274187;48946;52007.73996129995;52043;52072.739636302336;52099.218511722356;45114.77442612766;45570;45846.31230531545;46153;46525;42339.9415014621;43042;43253.35119973203;43257.567424325985;43465.56534434678;7459.813504662427;7536.8824578044405;7832.960835195788;7865.84268314619;7988.560629165451;31820.204494887814;32083.518747218342;32733.22422258661;32965.67034329626;33005.834970824995;38151.618483814804;41313.380299296135;41775;41986;42409;6474.255460622088;6738.056672065817;6774.898376524257;6780.32196780318;7102.933863749378;10733.195010374096;10739.868657665456;10749.408782516724;10893.509792059218;11021;10272.075513203548;10699.465026748787;10894;10908.40003799767;10909.945450272699;10284.742881428025;10449.84325235107;10479.564848545215;10510.684679459628;10933.562657493929;7854.646540905787;9106.499142547224;9340.252779777737;10492.055714985689;10541.894581054397;8680.522571258642;9028.729138125867;9235.12266334697;9523.047695230422;9768.120869121813;8412.663493460193;8590.613422395882;8885.42244754089;9084.137006984325;9092.59083341238 16:55:31 INFO - 2015-11-18 16:55:31,299 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:55:31 INFO - 2015-11-18 16:55:31,299 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:55:31 INFO - 2015-11-18 16:55:31,299 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 16:55:31 INFO - 2015-11-18 16:55:31,299 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:55:31 INFO - 2015-11-18 16:55:31,299 DEBUG : BROWSER_OUTPUT: __startTimestamp1447894531292__endTimestamp 16:55:31 INFO - 2015-11-18 16:55:31,300 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,300 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:55:31 INFO - 2015-11-18 16:55:31,300 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:55:31 INFO - 2015-11-18 16:55:31,300 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,300 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4655.12 Median:4768.28 stddev:488.45 (10.2%) stddev-sans-first:463.52 16:55:31 INFO - 2015-11-18 16:55:31,301 DEBUG : BROWSER_OUTPUT: Values: 2634.7 2721.8 2723.7 2728.4 2749.6 4487.0 4597.5 4702.0 4735.0 4760.1 4667.3 4682.8 4766.7 4770.5 4779.7 4305.9 4383.2 4384.5 4470.1 4485.3 4153.5 4395.0 4415.0 4459.8 4506.2 4194.6 4287.3 4291.6 4299.7 4336.5 4351.1 4375.5 4382.6 4391.0 4398.9 4132.4 4263.0 4332.9 4338.3 4381.3 4578.1 4675.5 4692.2 4696.1 4721.4 5126.8 5135.6 5137.8 5138.6 5178.4 4841.9 4964.4 4974.2 5163.9 5185.4 4703.4 4781.5 4788.9 4801.9 4841.7 5221.3 5238.8 5250.4 5284.3 5286.7 4763.0 4896.8 4900.1 5015.6 5035.6 4868.4 4952.1 4970.1 4974.2 4999.2 5014.6 5054.5 5058.1 5065.9 5104.2 4862.1 5006.1 5008.7 5030.1 5035.7 4091.5 4164.5 4177.8 4204.5 4213.3 3690.9 3691.9 3695.4 3725.0 3730.0 4194.0 4300.4 4350.8 4351.0 4380.1 4936.4 4983.3 5009.2 5012.4 5037.6 4342.0 4355.6 4356.8 4358.0 4403.5 4327.7 4459.4 4518.5 4520.7 4557.2 4621.7 4699.2 4711.3 4747.4 4761.6 5067.9 5088.5 5094.4 5095.1 5141.2 4581.3 4696.9 4817.0 4824.9 4855.8 4812.5 4907.0 4917.2 4934.2 4937.3 5089.8 5112.3 5115.0 5115.1 5152.5 4946.1 4948.8 4953.4 4957.2 4958.6 4710.1 4839.7 4845.8 4895.5 5033.0 4821.5 4852.5 4858.1 4860.8 4868.6 4954.2 4965.6 4966.9 4974.1 5007.8 4628.3 4692.6 4750.6 4754.6 4768.3 16:55:31 INFO - 2015-11-18 16:55:31,301 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,301 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42825.33 Median:33210.92 stddev:69117.45 (208.1%) stddev-sans-first:69238.48 16:55:31 INFO - 2015-11-18 16:55:31,301 DEBUG : BROWSER_OUTPUT: Values: 556.8 571.3 572.8 577.6 578.8 25229.7 25953.9 36755.8 37756.0 37785.0 39940.0 40511.0 40535.8 40543.8 40572.0 6835.9 7863.3 8005.8 8008.7 8009.2 6921.7 10074.5 10403.3 10419.8 10423.6 9984.7 10082.2 10094.6 10101.3 10118.9 7061.1 7259.5 9936.3 10069.2 10112.6 9788.1 9939.0 9944.3 9947.9 9952.3 37347.0 37583.2 37705.0 37882.0 37917.4 2861.9 2981.8 3038.4 3586.1 3623.3 27937.0 28181.4 28246.3 28505.1 28885.3 2946.2 2990.4 2997.3 3022.9 3095.9 224541.0 225412.0 227363.0 227533.9 227996.0 52211.5 52869.2 56694.1 57047.0 57164.0 66719.7 67675.7 68020.7 68112.0 68129.7 14555.7 14712.9 14722.1 14728.5 14736.7 11180.5 11244.5 11248.8 11266.2 11279.9 19484.7 19615.9 19721.7 19764.7 19849.3 7635.9 7912.2 7984.6 7988.9 8011.4 788.0 790.6 834.8 854.5 878.3 30241.0 31281.8 31696.0 31815.0 31951.0 909.4 911.5 918.4 921.5 935.7 13256.1 13341.8 13345.5 13347.3 13367.7 315826.0 316553.0 319600.0 321261.0 322343.0 46898.8 47500.0 47504.3 47559.3 47606.0 1154.9 1166.3 1191.4 1204.0 1206.2 24312.9 25064.2 25509.4 25548.4 25681.4 38988.4 39625.0 39672.2 39704.0 39799.6 230978.0 234899.0 239960.0 240985.0 242450.0 26989.6 27067.6 27158.7 27404.3 27459.3 34917.7 45329.8 46181.5 46613.8 47441.1 33199.0 33269.7 33463.5 34039.1 34420.7 33222.8 33360.8 33583.3 33640.3 34239.5 34196.7 34346.8 34489.0 38802.4 39531.6 29197.9 30692.8 31087.5 31139.7 31181.5 24005.0 24005.8 24039.8 24098.2 24337.9 16:55:31 INFO - 2015-11-18 16:55:31,301 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,302 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24314.51 Median:24974.94 stddev:81231.91 (325.3%) stddev-sans-first:81439.79 16:55:31 INFO - 2015-11-18 16:55:31,303 DEBUG : BROWSER_OUTPUT: Values: 310.8 311.0 311.7 315.3 320.0 13029.0 13038.1 13953.0 15257.0 15854.4 10296.8 10559.6 10568.3 10573.4 16547.8 3726.3 4238.8 4285.5 4293.8 4375.8 4281.3 4312.8 4319.7 4320.4 4322.7 3161.7 3236.1 3247.4 4267.9 4278.9 4490.4 4561.9 4610.6 4613.3 4614.5 3831.3 3973.0 3976.4 3976.7 3980.3 10107.9 10490.6 10542.4 10569.5 11990.9 1500.9 1670.1 1707.4 1715.9 1735.0 8552.4 8685.8 8756.3 8770.5 8930.8 1524.5 1527.4 1575.2 1585.5 1607.1 51633.7 54259.0 54640.0 54999.5 55122.0 6084.8 6090.0 6148.5 6275.6 6457.8 7352.8 7370.6 7371.2 7381.3 7432.1 4932.4 4988.7 5007.8 5016.4 5036.2 5128.7 5147.7 5152.5 5155.2 5169.2 2863.5 2880.1 2887.5 2900.1 2909.5 1004.9 1010.7 1010.9 1013.3 1059.8 322.6 401.9 405.3 406.8 434.0 9534.0 10290.1 10704.2 10757.3 10763.5 411.8 413.6 416.5 419.2 427.7 5385.6 5878.2 5879.3 5928.7 5940.9 486585.0 492528.0 493919.0 502406.0 502656.0 65293.3 67313.7 67446.7 67723.7 67982.0 431.6 441.7 462.4 472.5 473.2 9329.0 9341.7 9425.6 9579.2 9637.0 28982.7 29736.3 30619.8 30762.5 31312.4 41576.2 43202.4 44513.0 44692.0 45388.0 5879.4 5972.5 5996.1 6014.7 6022.2 9987.2 10351.9 10502.4 10578.7 10579.4 9199.3 9248.6 9323.0 9439.2 9465.8 9022.9 9126.7 9280.8 9326.8 9499.1 9292.5 9295.0 9362.4 9538.9 9662.5 6038.1 6045.9 6072.4 6080.4 6099.7 9413.2 9474.9 9621.0 9642.8 9818.2 16:55:31 INFO - 2015-11-18 16:55:31,303 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,303 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4617.23 Median:5837.09 stddev:2391.35 (41.0%) stddev-sans-first:2384.21 16:55:31 INFO - 2015-11-18 16:55:31,303 DEBUG : BROWSER_OUTPUT: Values: 1194.1 1635.9 1644.8 1676.1 1691.2 5725.5 6564.9 6697.6 6700.9 6704.3 6507.4 6535.1 6613.0 6632.5 6633.8 1650.8 1679.0 1680.2 2006.5 2024.0 1715.7 1723.2 1726.3 1945.8 2000.5 1944.6 1947.0 1947.6 1948.3 1949.5 1921.4 2012.5 2018.8 2019.9 2021.6 1866.3 1885.4 1892.7 1910.5 1912.4 6718.9 6792.4 6794.1 6796.9 6799.8 3975.6 4041.3 4044.3 4045.0 4046.7 2573.7 2599.1 2633.3 2637.6 2680.8 793.4 802.6 804.2 805.9 814.4 9014.5 9069.9 9073.3 9083.8 9087.0 3629.7 3657.3 3694.4 3695.1 3749.5 7774.1 7819.6 7824.8 7835.8 7842.2 4033.7 4048.1 4063.9 4069.6 4069.8 3691.4 3702.3 3710.7 3715.2 3725.7 3203.9 3205.9 3223.2 3268.4 3274.3 901.1 930.6 935.1 999.4 1008.0 790.4 791.0 796.4 836.4 880.4 5857.5 5980.9 5988.5 5992.1 6002.1 959.9 974.2 979.4 981.1 997.3 4690.8 4742.0 4805.2 4819.4 4829.8 7787.7 7977.6 8053.7 8058.4 8067.4 7887.2 7947.9 7948.9 7953.9 7970.6 6059.6 6098.5 6109.4 6137.3 6214.7 5817.0 5839.4 5847.7 5857.6 5859.5 6872.2 7074.9 7187.3 7264.1 7274.9 7279.4 7412.9 7429.2 7517.7 7540.2 5590.6 5644.5 5645.9 5646.7 5681.8 6193.4 6206.0 6224.9 6231.9 6296.0 5902.7 5968.4 5980.1 6003.4 6061.2 4792.9 5632.6 5687.9 5757.1 5978.2 5806.2 5809.8 5823.4 5834.8 5846.6 5492.7 5571.6 5595.4 5620.2 5626.0 5249.3 5534.7 5554.6 5604.6 5625.7 16:55:31 INFO - 2015-11-18 16:55:31,303 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,303 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4642.99 Median:5320.69 stddev:1391.33 (26.1%) stddev-sans-first:1356.17 16:55:31 INFO - 2015-11-18 16:55:31,304 DEBUG : BROWSER_OUTPUT: Values: 281.3 282.3 287.6 289.5 290.9 5004.3 5151.1 5311.5 5352.1 5379.9 5226.3 5297.7 5319.4 5322.0 5325.3 4119.9 4142.5 4149.6 4152.7 4159.6 3926.7 4022.5 4029.0 4143.7 4146.6 4060.7 4069.3 4080.6 4081.8 4082.1 4070.9 4076.1 4079.1 4081.8 4084.6 3542.9 3557.3 3557.4 3557.8 3561.1 5017.6 5102.3 5119.1 5137.1 5138.4 4682.8 4686.2 4690.2 4695.6 4697.1 5591.2 5591.5 5601.4 5602.3 5604.5 3691.1 3755.0 3796.3 3875.4 3876.2 5822.2 5882.4 5896.5 5918.2 5921.8 3924.7 3926.6 3930.4 3932.2 3944.6 3988.3 3991.2 3992.6 3993.4 3996.5 4501.4 4606.0 4607.3 4608.2 4612.9 5600.6 5607.1 5608.2 5608.3 5613.6 1384.3 1398.8 1401.0 1401.1 1401.5 918.0 923.3 933.5 941.1 943.5 4909.0 4913.4 4918.8 4921.0 4929.6 5837.3 5838.0 5838.7 5838.7 5841.9 4907.7 4919.5 4921.5 4922.2 4923.9 3056.1 3125.5 3146.4 3155.9 3156.7 5551.5 5559.0 5561.6 5564.4 5568.7 6056.2 6057.3 6061.2 6061.7 6062.1 5545.6 5546.1 5551.3 5551.9 5555.0 5752.1 5856.6 5885.9 5892.1 5899.8 5531.8 5646.1 5747.1 5747.8 5748.7 5414.8 5508.5 5535.5 5537.4 5550.8 3916.2 3962.9 3965.5 3966.4 3968.6 5849.2 5852.4 5853.9 5855.9 5862.6 5475.8 5622.4 5629.0 5664.2 5678.3 5658.2 5658.8 5669.8 5670.4 5678.6 5538.4 5543.7 5544.9 5550.0 5554.1 5525.3 5693.1 5696.5 5697.7 5703.1 5553.4 5562.0 5562.7 5564.6 5568.7 16:55:31 INFO - 2015-11-18 16:55:31,305 DEBUG : BROWSER_OUTPUT: 16:55:31 INFO - 2015-11-18 16:55:31,305 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12552.80 Median:45342.39 stddev:14516.13 (32.0%) stddev-sans-first:14529.01 16:55:31 INFO - 2015-11-18 16:55:31,305 DEBUG : BROWSER_OUTPUT: Values: 579.5 598.0 682.4 694.1 745.1 10780.9 11140.7 14213.6 14487.9 14577.6 10157.2 13689.8 13703.0 13709.8 13727.4 606.5 789.5 798.9 799.5 801.0 784.1 799.3 799.9 801.8 802.4 643.1 651.0 651.1 829.7 838.8 644.6 645.5 811.7 835.4 835.7 619.9 620.4 620.7 621.9 622.2 12346.9 12405.8 12419.3 12452.8 12508.9 11169.2 11349.2 11502.4 11764.8 11982.8 9178.9 9480.0 9534.5 9576.6 9589.8 3316.3 3335.7 3341.0 3342.7 3368.8 42761.1 43043.4 43075.1 43463.0 44030.6 9327.7 9636.6 10027.5 10055.8 10127.6 17799.4 17815.5 17819.6 17836.6 17844.3 6436.8 6519.3 6526.0 6528.9 6698.0 3403.8 3423.1 3438.9 3476.7 3548.3 2792.1 2831.0 2836.1 2836.5 2838.1 419.5 434.1 437.1 437.5 437.6 550.1 555.1 557.2 571.5 586.3 7060.2 7320.3 7534.2 7654.3 7701.5 487.4 559.9 599.8 617.3 622.8 3700.6 3789.9 3822.3 3925.6 3945.3 48946.0 52007.7 52043.0 52072.7 52099.2 45114.8 45570.0 45846.3 46153.0 46525.0 42339.9 43042.0 43253.4 43257.6 43465.6 7459.8 7536.9 7833.0 7865.8 7988.6 31820.2 32083.5 32733.2 32965.7 33005.8 38151.6 41313.4 41775.0 41986.0 42409.0 6474.3 6738.1 6774.9 6780.3 7102.9 10733.2 10739.9 10749.4 10893.5 11021.0 10272.1 10699.5 10894.0 10908.4 10909.9 10284.7 10449.8 10479.6 10510.7 10933.6 7854.6 9106.5 9340.3 10492.1 10541.9 8680.5 9028.7 9235.1 9523.0 9768.1 8412.7 8590.6 8885.4 9084.1 9092.6 16:55:31 INFO - 2015-11-18 16:55:31,305 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:55:31 INFO - 2015-11-18 16:55:31,305 DEBUG : BROWSER_OUTPUT: 16:55:32 INFO - 2015-11-18 16:55:32,002 INFO : Browser exited with error code: 0 16:55:32 INFO - 2015-11-18 16:55:32,018 INFO : Completed test dromaeo_css (00:18:38) 16:55:32 INFO - 2015-11-18 16:55:32,018 INFO : Starting test kraken 16:55:32 INFO - 2015-11-18 16:55:32,018 DEBUG : operating with platform_type : linux_ 16:55:32 INFO - 2015-11-18 16:55:32,018 INFO : Initialising browser for kraken test... 16:55:32 INFO - 2015-11-18 16:55:32,024 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0M3sLO/profile http://localhost:39197/getInfo.html 16:55:36 INFO - 2015-11-18 16:55:36,018 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:55:36 INFO - 2015-11-18 16:55:36,018 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:55:36 INFO - 2015-11-18 16:55:36,018 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:55:36 INFO - 2015-11-18 16:55:36,019 DEBUG : BROWSER_OUTPUT: __metrics 16:55:36 INFO - 2015-11-18 16:55:36,155 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:37 INFO - 2015-11-18 16:55:37,394 INFO : Browser initialized. 16:55:37 INFO - 2015-11-18 16:55:37,394 INFO : Running cycle 1/1 for kraken test... 16:55:37 INFO - 2015-11-18 16:55:37,394 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0M3sLO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:55:49 INFO - 2015-11-18 16:55:49,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 141926400 16:55:49 INFO - 2015-11-18 16:55:49,316 DEBUG : BROWSER_OUTPUT: 16:55:51 INFO - 2015-11-18 16:55:51,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39197/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:52 INFO - 2015-11-18 16:55:52,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 177238016 16:55:52 INFO - 2015-11-18 16:55:52,493 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-18 16:55:55,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39197/tests/kraken/driver.html?testName=audio-dft) 16:55:55 INFO - 2015-11-18 16:55:55,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 168243200 16:55:55 INFO - 2015-11-18 16:55:55,748 DEBUG : BROWSER_OUTPUT: 16:55:58 INFO - 2015-11-18 16:55:58,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39197/tests/kraken/driver.html?testName=audio-fft) 16:55:59 INFO - 2015-11-18 16:55:59,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 153313280 16:55:59 INFO - 2015-11-18 16:55:59,329 DEBUG : BROWSER_OUTPUT: 16:56:01 INFO - 2015-11-18 16:56:01,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39197/tests/kraken/driver.html?testName=audio-oscillator) 16:56:01 INFO - 2015-11-18 16:56:01,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 154030080 16:56:01 INFO - 2015-11-18 16:56:01,938 DEBUG : BROWSER_OUTPUT: 16:56:04 INFO - 2015-11-18 16:56:04,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39197/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:56:04 INFO - 2015-11-18 16:56:04,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 155525120 16:56:04 INFO - 2015-11-18 16:56:04,725 DEBUG : BROWSER_OUTPUT: 16:56:07 INFO - 2015-11-18 16:56:07,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39197/tests/kraken/driver.html?testName=imaging-darkroom) 16:56:08 INFO - 2015-11-18 16:56:08,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 157257728 16:56:08 INFO - 2015-11-18 16:56:08,240 DEBUG : BROWSER_OUTPUT: 16:56:11 INFO - 2015-11-18 16:56:11,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39197/tests/kraken/driver.html?testName=imaging-desaturate) 16:56:12 INFO - 2015-11-18 16:56:12,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 158478336 16:56:12 INFO - 2015-11-18 16:56:12,301 DEBUG : BROWSER_OUTPUT: 16:56:15 INFO - 2015-11-18 16:56:15,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39197/tests/kraken/driver.html?testName=json-parse-financial) 16:56:15 INFO - 2015-11-18 16:56:15,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 156983296 16:56:15 INFO - 2015-11-18 16:56:15,742 DEBUG : BROWSER_OUTPUT: 16:56:17 INFO - 2015-11-18 16:56:17,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39197/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:56:18 INFO - 2015-11-18 16:56:18,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 164896768 16:56:18 INFO - 2015-11-18 16:56:18,037 DEBUG : BROWSER_OUTPUT: 16:56:19 INFO - 2015-11-18 16:56:19,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:56:20 INFO - 2015-11-18 16:56:20,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 165494784 16:56:20 INFO - 2015-11-18 16:56:20,517 DEBUG : BROWSER_OUTPUT: 16:56:22 INFO - 2015-11-18 16:56:22,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:56:23 INFO - 2015-11-18 16:56:23,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 174469120 16:56:23 INFO - 2015-11-18 16:56:23,234 DEBUG : BROWSER_OUTPUT: 16:56:25 INFO - 2015-11-18 16:56:25,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:56:26 INFO - 2015-11-18 16:56:26,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 180043776 16:56:26 INFO - 2015-11-18 16:56:26,360 DEBUG : BROWSER_OUTPUT: 16:56:28 INFO - 2015-11-18 16:56:28,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:56:29 INFO - 2015-11-18 16:56:29,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 180109312 16:56:29 INFO - 2015-11-18 16:56:29,524 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39197/tests/kraken/driver.html?testName=ai-astar) 16:56:31 INFO - 2015-11-18 16:56:31,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 236896256 16:56:31 INFO - 2015-11-18 16:56:31,500 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,500 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:56:31 INFO - 2015-11-18 16:56:31,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:56:31 INFO - 2015-11-18 16:56:31,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:56:31 INFO - 2015-11-18 16:56:31,500 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:56:31 INFO - 2015-11-18 16:56:31,501 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;105;111;114;111;100;110;105;113 16:56:31 INFO - 2015-11-18 16:56:31,501 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;151;163;130;153;162;130;165;132 16:56:31 INFO - 2015-11-18 16:56:31,501 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;160;161;161;164;162;161;161 16:56:31 INFO - 2015-11-18 16:56:31,501 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;76;80;90;73;72;73;103;93;72 16:56:31 INFO - 2015-11-18 16:56:31,502 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;127;93;92;93;136;92;93;125 16:56:31 INFO - 2015-11-18 16:56:31,502 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;109;109;109;109;109 16:56:31 INFO - 2015-11-18 16:56:31,502 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;149;148;149;148;149;148;149 16:56:31 INFO - 2015-11-18 16:56:31,502 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;95;95;95;95;95;96;95;95 16:56:31 INFO - 2015-11-18 16:56:31,503 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;70;71;70;70;70;69;78;67;69 16:56:31 INFO - 2015-11-18 16:56:31,503 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;71;68;70;69;69;70;68;69;70 16:56:31 INFO - 2015-11-18 16:56:31,503 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;86;84;84;84;85;84;94;84 16:56:31 INFO - 2015-11-18 16:56:31,504 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;127;126;127;124;122;127;123;122;126 16:56:31 INFO - 2015-11-18 16:56:31,504 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;141;146;145;148;136;143;150;151;137 16:56:31 INFO - 2015-11-18 16:56:31,504 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;69;69;68;69;69;68;69;69 16:56:31 INFO - 2015-11-18 16:56:31,504 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:56:31 INFO - 2015-11-18 16:56:31,505 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:56:31 INFO - 2015-11-18 16:56:31,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,971 16:56:31 INFO - 2015-11-18 16:56:31,505 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:56:31 INFO - 2015-11-18 16:56:31,505 DEBUG : BROWSER_OUTPUT: __startTimestamp1447894591494__endTimestamp 16:56:31 INFO - 2015-11-18 16:56:31,505 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,506 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:56:31 INFO - 2015-11-18 16:56:31,506 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:56:31 INFO - 2015-11-18 16:56:31,506 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,506 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:111.50 stddev:4.55 (4.1%) stddev-sans-first:4.73 16:56:31 INFO - 2015-11-18 16:56:31,506 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 105.0 111.0 114.0 111.0 100.0 110.0 105.0 113.0 16:56:31 INFO - 2015-11-18 16:56:31,506 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,506 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:153.00 stddev:14.73 (9.6%) stddev-sans-first:15.46 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 151.0 163.0 130.0 153.0 162.0 130.0 165.0 132.0 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 160.0 161.0 161.0 164.0 162.0 161.0 161.0 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:74.50 stddev:10.99 (14.7%) stddev-sans-first:11.31 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 80.0 90.0 73.0 72.0 73.0 103.0 93.0 72.0 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:92.00 stddev:18.04 (19.6%) stddev-sans-first:18.65 16:56:31 INFO - 2015-11-18 16:56:31,508 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 127.0 93.0 92.0 93.0 136.0 92.0 93.0 125.0 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 149.0 148.0 149.0 148.0 149.0 148.0 149.0 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:56:31 INFO - 2015-11-18 16:56:31,509 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.30 Median:70.00 stddev:2.91 (4.2%) stddev-sans-first:3.05 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 70.0 70.0 70.0 69.0 78.0 67.0 69.0 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 68.0 70.0 69.0 69.0 70.0 68.0 69.0 70.0 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.50 stddev:3.16 (3.7%) stddev-sans-first:3.24 16:56:31 INFO - 2015-11-18 16:56:31,510 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 86.0 84.0 84.0 84.0 85.0 84.0 94.0 84.0 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.50 stddev:2.13 (1.7%) stddev-sans-first:2.15 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 126.0 127.0 124.0 122.0 127.0 123.0 122.0 126.0 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:145.50 stddev:5.81 (4.0%) stddev-sans-first:5.35 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: Values: 135.0 141.0 146.0 145.0 148.0 136.0 143.0 150.0 151.0 137.0 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 16:56:31 INFO - 2015-11-18 16:56:31,511 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 68.0 69.0 69.0 68.0 69.0 69.0 16:56:31 INFO - 2015-11-18 16:56:31,512 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:56:31 INFO - 2015-11-18 16:56:31,512 DEBUG : BROWSER_OUTPUT: 16:56:32 INFO - 2015-11-18 16:56:32,409 INFO : Browser exited with error code: 0 16:56:32 INFO - 2015-11-18 16:56:32,460 INFO : Completed test kraken (00:01:00) 16:56:32 INFO - 2015-11-18 16:56:32,460 INFO : Starting test v8_7 16:56:32 INFO - 2015-11-18 16:56:32,461 DEBUG : operating with platform_type : linux_ 16:56:32 INFO - 2015-11-18 16:56:32,461 INFO : Initialising browser for v8_7 test... 16:56:32 INFO - 2015-11-18 16:56:32,467 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRqz9SP/profile http://localhost:39197/getInfo.html 16:56:36 INFO - 2015-11-18 16:56:36,441 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:56:36 INFO - 2015-11-18 16:56:36,441 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:56:36 INFO - 2015-11-18 16:56:36,441 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:56:36 INFO - 2015-11-18 16:56:36,441 DEBUG : BROWSER_OUTPUT: __metrics 16:56:36 INFO - 2015-11-18 16:56:36,610 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: console.error: 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: Stack: 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 16:56:37 INFO - 2015-11-18 16:56:37,263 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 16:56:37 INFO - 2015-11-18 16:56:37,264 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 16:56:37 INFO - 2015-11-18 16:56:37,264 DEBUG : BROWSER_OUTPUT: 16:56:37 INFO - 2015-11-18 16:56:37,837 INFO : Browser initialized. 16:56:37 INFO - 2015-11-18 16:56:37,837 INFO : Running cycle 1/1 for v8_7 test... 16:56:37 INFO - 2015-11-18 16:56:37,837 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRqz9SP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:56:49 INFO - 2015-11-18 16:56:49,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 16:56:49 INFO - 2015-11-18 16:56:49,852 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39197/tests/v8_7/run.html (next: http://localhost:39197/tests/v8_7/run.html) 16:57:11 INFO - 2015-11-18 16:57:11,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 441798656 16:57:11 INFO - 2015-11-18 16:57:11,487 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,487 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:57:11 INFO - 2015-11-18 16:57:11,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:57:11 INFO - 2015-11-18 16:57:11,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:57:11 INFO - 2015-11-18 16:57:11,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:57:11 INFO - 2015-11-18 16:57:11,487 DEBUG : BROWSER_OUTPUT: |0;Richards;162.73393002441009 16:57:11 INFO - 2015-11-18 16:57:11,487 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.12295869356387 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5091.370558375635 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |5;Earley;791.304347826087 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |7;RegExp;26282.05128205128 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |8;Splay;618.0469715698393 16:57:11 INFO - 2015-11-18 16:57:11,488 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 16:57:11 INFO - 2015-11-18 16:57:11,489 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:57:11 INFO - 2015-11-18 16:57:11,489 DEBUG : BROWSER_OUTPUT: __startTimestamp1447894631479__endTimestamp 16:57:11 INFO - 2015-11-18 16:57:11,489 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,489 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:57:11 INFO - 2015-11-18 16:57:11,489 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:57:11 INFO - 2015-11-18 16:57:11,490 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,490 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.73 Median:162.73 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,490 DEBUG : BROWSER_OUTPUT: Values: 162.7 16:57:11 INFO - 2015-11-18 16:57:11,490 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,490 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.12 Median:192.12 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,490 DEBUG : BROWSER_OUTPUT: Values: 192.1 16:57:11 INFO - 2015-11-18 16:57:11,490 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,491 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,491 DEBUG : BROWSER_OUTPUT: Values: 278.8 16:57:11 INFO - 2015-11-18 16:57:11,491 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,491 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5091.37 Median:5091.37 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,491 DEBUG : BROWSER_OUTPUT: Values: 5091.4 16:57:11 INFO - 2015-11-18 16:57:11,491 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,491 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: Values: 1986.1 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.30 Median:791.30 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: Values: 791.3 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: Values: 12207.3 16:57:11 INFO - 2015-11-18 16:57:11,492 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,493 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26282.05 Median:26282.05 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,493 DEBUG : BROWSER_OUTPUT: Values: 26282.1 16:57:11 INFO - 2015-11-18 16:57:11,493 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,493 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.05 Median:618.05 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,493 DEBUG : BROWSER_OUTPUT: Values: 618.0 16:57:11 INFO - 2015-11-18 16:57:11,493 DEBUG : BROWSER_OUTPUT: 16:57:11 INFO - 2015-11-18 16:57:11,494 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 16:57:11 INFO - 2015-11-18 16:57:11,494 DEBUG : BROWSER_OUTPUT: Values: 4826.9 16:57:11 INFO - 2015-11-18 16:57:11,494 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:57:11 INFO - 2015-11-18 16:57:11,494 DEBUG : BROWSER_OUTPUT: 16:57:12 INFO - 2015-11-18 16:57:12,441 INFO : Browser exited with error code: 0 16:57:12 INFO - 2015-11-18 16:57:12,454 INFO : Completed test v8_7 (00:00:39) 16:57:12 INFO - 2015-11-18 16:57:12,532 INFO : Completed test suite (00:20:18) 16:57:12 INFO - 2015-11-18 16:57:12,532 DEBUG : Working with test: dromaeo_css 16:57:12 INFO - 2015-11-18 16:57:12,533 DEBUG : Generating results file: dromaeo_css 16:57:12 INFO - 2015-11-18 16:57:12,534 DEBUG : Working with test: kraken 16:57:12 INFO - 2015-11-18 16:57:12,534 DEBUG : Generating results file: kraken 16:57:12 INFO - 2015-11-18 16:57:12,534 INFO : javascript benchmark 16:57:12 INFO - 2015-11-18 16:57:12,534 DEBUG : Working with test: v8_7 16:57:12 INFO - 2015-11-18 16:57:12,534 DEBUG : Generating results file: v8_7 16:57:12 INFO - 2015-11-18 16:57:12,535 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:12 INFO - 2015-11-18 16:57:12,596 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 16:57:12 INFO - 2015-11-18 16:57:12,596 DEBUG : process_Request line: dromaeo_css 5947.06 graph.html#tests=[[72,131,35]] 16:57:12 INFO - 2015-11-18 16:57:12,596 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:12 INFO - 2015-11-18 16:57:12,641 DEBUG : process_Request line: kraken 1516.60 graph.html#tests=[[232,131,35]] 16:57:12 INFO - 2015-11-18 16:57:12,641 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:12 INFO - 2015-11-18 16:57:12,671 DEBUG : process_Request line: v8_7 19813.03 graph.html#tests=[[230,131,35]] 16:57:12 INFO - 2015-11-18 16:57:12,672 INFO : javascript benchmark 16:57:12 INFO - 2015-11-18 16:57:12,676 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.710181879993, 2721.7822574194065, 2723.6867760207583, 2728.3588356736163, 2749.615053892455, 4486.97756511217, 4597.5172606876295, 4702.0, 4735.029318989607, 4760.095581839448, 4667.276572131316, 4682.765861706909, 4766.73782941938, 4770.451398089221, 4779.689320194194, 4305.913881722364, 4383.189110014658, 4384.47386313642, 4470.083632855257, 4485.327200919872, 4153.460050193471, 4395.0, 4414.977925110386, 4459.777011149429, 4506.188886000518, 4194.601512856304, 4287.2711639021445, 4291.6137547620865, 4299.6775241856985, 4336.479622445295, 4351.0862718829085, 4375.47494300686, 4382.627476664487, 4391.0, 4398.868033958986, 4132.359484279911, 4263.040815816447, 4332.891677708051, 4338.262495375794, 4381.277089280265, 4578.130155270488, 4675.462321832964, 4692.178868697964, 4696.107739529512, 4721.3862197914395, 5126.846194614168, 5135.589152867761, 5137.7944882204665, 5138.588912886998, 5178.40448348441, 4841.878953026167, 4964.429090654585, 4974.154393753034, 5163.896722065538, 5185.377754669464, 4703.365045718819, 4781.497942715965, 4788.880277993078, 4801.9039619208115, 4841.709497430165, 5221.295125158131, 5238.7904483820985, 5250.369955605352, 5284.339457567804, 5286.656367336111, 4762.976185119052, 4896.804127834918, 4900.093482705711, 5015.623828212826, 5035.647504674711, 4868.440129385166, 4952.059108769322, 4970.080535101018, 4974.204127339608, 4999.175136102575, 5014.623903207274, 5054.494550544916, 5058.064258112261, 5065.924011139836, 5104.2088476286235, 4862.05189987949, 5006.148954677714, 5008.6744361616375, 5030.144875371196, 5035.748212589356, 4091.5294741105154, 4164.541900390955, 4177.791110444466, 4204.495460544754, 4213.304804707251, 3690.8523659053335, 3691.9446208306895, 3695.427208782643, 3725.0314918121485, 3730.0301921500604, 4194.0, 4300.4194433751045, 4350.825966961349, 4350.977520282731, 4380.145871555016, 4936.3829521309835, 4983.277424773388, 5009.173486374707, 5012.398512178489, 5037.647364684437, 4341.978290108529, 4355.629771469397, 4356.825726970949, 4357.975875669215, 4403.515613282536, 4327.740335579875, 4459.353393757887, 4518.480374756879, 4520.706154099973, 4557.225271703818, 4621.722696638145, 4699.15415225249, 4711.2933060039895, 4747.430308363018, 4761.5714585686765, 5067.949320506747, 5088.491150884882, 5094.388673359221, 5095.13382724945, 5141.2288156776785, 4581.2899000653615, 4696.882577935442, 4817.0, 4824.903501930012, 4855.781489833037, 4812.494688057704, 4907.0, 4917.237828136645, 4934.18585933317, 4937.333459982857, 5089.796408143633, 5112.309838171799, 5114.974425127999, 5115.104856649997, 5152.458991805806, 4946.060248552763, 4948.826791062295, 4953.356063711839, 4957.182064959241, 4958.553730164303, 4710.057988402402, 4839.7096174229655, 4845.781939812647, 4895.510448955076, 5033.0, 4821.493743156918, 4852.490488498657, 4858.149823780895, 4860.756962151949, 4868.561829435368, 4954.182559877724, 4965.577925876341, 4966.8758281043265, 4974.079795237748, 5007.84976450707, 4628.305754136906, 4692.554207350297, 4750.619950404029, 4754.619630429488, 4768.284757286296], "unit": "ms", "name": "dojo.html", "value": 4624.8576160308}, {"lowerIsBetter": false, "replicates": [556.7939862250968, 571.2545128607168, 572.8399990020212, 577.5927970780599, 578.849499130226, 25229.74770252297, 25953.870230648845, 36755.81622091886, 37756.0, 37785.0, 39940.0, 40511.0, 40535.79732101343, 40543.79728101363, 40572.0, 6835.931640683604, 7863.29230369268, 8005.839883202332, 8008.67965281388, 8009.159038300982, 6921.65391730414, 10074.546645400938, 10403.271770976035, 10419.843702344433, 10423.635172768954, 9984.700458986243, 10082.193424526056, 10094.586757853906, 10101.343412678189, 10118.949405252963, 7061.082059332254, 7259.491835571512, 9936.304458687895, 10069.244806639495, 10112.595496180144, 9788.070133337322, 9939.0, 9944.303898727092, 9947.850782238273, 9952.253580981383, 37347.0, 37583.248335033146, 37705.0, 37882.0, 37917.43123853144, 2861.899833505838, 2981.761459083268, 3038.4226996870525, 3586.1393265616066, 3623.3115708015393, 27937.0, 28181.436371272666, 28246.293842653893, 28505.144845654664, 28885.277868053257, 2946.1603443018635, 2990.4318179546035, 2997.325601739613, 3022.909312720622, 3095.90712278632, 224541.0, 225412.0, 227363.0, 227533.86233068895, 227996.0, 52211.47788522142, 52869.2069618956, 56694.14958775622, 57047.0, 57164.0, 66719.66640166866, 67675.66162169256, 68020.6598967002, 68112.0, 68129.65935170293, 14555.708885822225, 14712.852871471148, 14722.116672999655, 14728.484503042342, 14736.705265894836, 11180.496877640526, 11244.49399777012, 11248.775024499464, 11266.155038372155, 11279.887201127884, 19484.70772938407, 19615.901920490305, 19721.704174437396, 19764.70352944707, 19849.30527431533, 7635.885461718079, 7912.208779122157, 7984.640691168911, 7988.920110798934, 8011.357671677292, 787.9842403151905, 790.6205021589554, 834.7787836223406, 854.4574195385975, 878.2798105553512, 30241.0, 31281.843590782355, 31695.988881056262, 31815.0, 31951.0, 909.3634455880909, 911.5487833522317, 918.3846822628855, 921.5162039929091, 935.7192842147329, 13256.138351007154, 13341.799873001914, 13345.532906348231, 13347.332633368293, 13367.732645347038, 315826.0, 316553.0, 319600.0, 321261.0, 322343.0, 46898.76550617225, 47500.0, 47504.28743568849, 47559.28661070087, 47606.0, 1154.8960593546622, 1166.2943918929095, 1191.416206059025, 1204.0488014468472, 1206.2400687566776, 24312.905919233322, 25064.248072557853, 25509.3622659435, 25548.361290967874, 25681.357966050997, 38988.41517377185, 39625.0, 39672.20655586814, 39704.0, 39799.60200397959, 230978.0, 234899.0, 239960.0, 240985.0, 242450.0, 26989.595156072282, 27067.59398609062, 27158.72841271641, 27404.314892127855, 27459.31351716223, 34917.650823491436, 45329.77335113303, 46181.538184619065, 46613.766931165126, 47441.051178976915, 33199.0, 33269.667303326656, 33463.49804752882, 34039.149021273675, 34420.65579344275, 33222.83388583138, 33360.83319583387, 33583.328333432706, 33640.3271934555, 34239.48640770341, 34196.65803342034, 34346.82826585851, 34489.0, 38802.41796373113, 39531.60468395279, 29197.85401072981, 30692.846535767178, 31087.533686995164, 31139.688603114584, 31181.53227701632, 24005.0, 24005.759942400353, 24039.75960240445, 24098.15656452016, 24337.878310608332], "unit": "ms", "name": "ext.html", "value": 17499.555690366647}, {"lowerIsBetter": false, "replicates": [310.84302427274224, 311.02338656618207, 311.70543836074916, 315.34565776014773, 319.9600049993751, 13029.0, 13038.087333886631, 13953.023288369806, 15257.0, 15854.365825366986, 10296.794064118732, 10559.630412935549, 10568.313059651136, 10573.365598064122, 16547.751783723255, 3726.2920045191395, 4238.809253583596, 4285.47865507745, 4293.785310734466, 4375.824967001332, 4281.336392859096, 4312.849050283241, 4319.697621166504, 4320.438343015419, 4322.654187664995, 3161.7154456098947, 3236.1100697308193, 3247.447933851251, 4267.893302667442, 4278.893027674302, 4490.371348011281, 4561.885952851172, 4610.631149508032, 4613.308003799423, 4614.469336026366, 3831.3103641344546, 3973.0266084809405, 3976.3836605325932, 3976.701747368959, 3980.2835489611857, 10107.89892101077, 10490.632827851065, 10542.367457952547, 10569.471526423647, 11990.940045299718, 1500.932458039391, 1670.106493026225, 1707.3853412771393, 1715.905625190614, 1735.0, 8552.444091134057, 8685.782855428602, 8756.343274254456, 8770.473771573663, 8930.776730581723, 1524.5121561100452, 1527.3585094260438, 1575.2045217165257, 1585.5164174926642, 1607.0679006176506, 51633.74183129098, 54259.0, 54640.0, 54999.450005500235, 55121.9999999996, 6084.787032453843, 6090.0, 6148.538859585549, 6275.623462592259, 6457.838554036187, 7352.77941661751, 7370.557766534025, 7371.226021267689, 7381.261873812576, 7432.145303290083, 4932.358793356841, 4988.6507944444265, 5007.799688012512, 5016.372953380827, 5036.244563315532, 5128.743562821844, 5147.716875571879, 5152.536271735562, 5155.200943853709, 5169.224616307509, 2863.498887694687, 2880.1215629233284, 2887.4946884295164, 2900.0864727610733, 2909.4617495762927, 1004.9497525123714, 1010.6563768318807, 1010.9494525273707, 1013.3109485549896, 1059.8251288537306, 322.55648483335415, 401.90354314964196, 405.3433437830733, 406.8392984770999, 434.03427374093025, 9534.046595340411, 10290.12533934624, 10704.19718521114, 10757.30077544957, 10763.515641796137, 411.8187997281187, 413.6194700875202, 416.4773209621966, 419.24745082576845, 427.6706935659525, 5385.623006389594, 5878.206442130343, 5879.323877754027, 5928.7332070056955, 5940.940590594125, 486585.0, 492528.0, 493919.0, 502406.0, 502656.0, 65293.34706652968, 67313.66343168351, 67446.66276668585, 67723.66138169277, 67982.0, 431.56843156843155, 441.70405828095255, 462.3596319098073, 472.5085910652883, 473.2380866804442, 9328.95335523318, 9341.673041443517, 9425.575849086945, 9579.233661307218, 9637.036296370306, 28982.710172898845, 29736.256593585334, 30619.846900765355, 30762.53856192114, 31312.373752525276, 41576.168476630904, 43202.35196471993, 44513.0, 44692.0, 45388.0, 5879.441453061952, 5972.462478376967, 5996.130561068708, 6014.669193194416, 6022.187004754477, 9987.151092157248, 10351.896481035394, 10502.4223667699, 10578.682639520826, 10579.418132002813, 9199.310051746279, 9248.583813728534, 9323.0, 9439.19766819828, 9465.810683786423, 9022.90977090247, 9126.680566180152, 9280.814383712423, 9326.813463730823, 9499.050094990445, 9292.535373231176, 9295.024022477543, 9362.438253704799, 9538.85691714611, 9662.516874156405, 6038.064100064497, 6045.879082418239, 6072.392760723892, 6080.361562035922, 6099.695015249131, 9413.246940244628, 9474.910385305502, 9621.037896210322, 9642.807143857224, 9818.214542836413], "unit": "ms", "name": "jquery.html", "value": 6074.981516918207}, {"lowerIsBetter": false, "replicates": [1194.1402190422893, 1635.8527732504072, 1644.7615095811107, 1676.103284742663, 1691.205133587214, 5725.4847063764255, 6564.868702625945, 6697.631630260334, 6700.865982680343, 6704.262531121579, 6507.44686701631, 6535.11775910252, 6613.0, 6632.535722499427, 6633.767818126366, 1650.7771450854102, 1679.0, 1680.1851102215476, 2006.4983754061484, 2023.9898800505978, 1715.6825987192346, 1723.2245489529698, 1726.326732574297, 1945.8248757611811, 2000.469875482998, 1944.572194117292, 1947.0167565379463, 1947.6494231038407, 1948.3473036532778, 1949.4638974282045, 1921.3755529452915, 2012.4767560434245, 2018.8183063524352, 2019.8889061101634, 2021.5956808638184, 1866.2814816295688, 1885.3589779475044, 1892.668782962976, 1910.503269150031, 1912.407153782332, 6718.865622687519, 6792.354726300993, 6794.0827988221945, 6796.932030679679, 6799.796006119825, 3975.6024397560013, 4041.2725709372303, 4044.2518134145275, 4045.02919299369, 4046.676265898721, 2573.716891141973, 2599.14228304659, 2633.2626864477784, 2637.591173368131, 2680.7989400794822, 793.4089103617785, 802.5866678660494, 804.2199066905092, 805.8952336196257, 814.4217605500102, 9014.504202268872, 9069.863952040725, 9073.274138068873, 9083.772905677344, 9087.0, 3629.709623230135, 3657.2868290683596, 3694.4273637586216, 3695.094701798023, 3749.4750734897134, 7774.067111946602, 7819.5699236541395, 7824.804379890548, 7835.843283134305, 7842.176571460029, 4033.7176397651883, 4048.149888523443, 4063.898402539901, 4069.593040695907, 4069.7761623111014, 3691.427828686558, 3702.278055779097, 3710.703143748494, 3715.238376132886, 3725.720570957135, 3203.871845126169, 3205.8557364918634, 3223.2103134731674, 3268.428025095599, 3274.2632907596076, 901.1484147480568, 930.5905401623264, 935.0555938502026, 999.4203362049993, 1007.9798404031878, 790.4229912164152, 791.0, 796.4345314826538, 836.3936146293888, 880.4365206267994, 5857.531397488191, 5980.880382392328, 5988.490978266809, 5992.0712289595185, 6002.129691194839, 959.9424034557949, 974.1865542272282, 979.3536266064364, 981.0924894472585, 997.3367710472454, 4690.81236750533, 4742.0, 4805.207140821725, 4819.397575303087, 4829.806807727722, 7787.727429539939, 7977.601119944095, 8053.677852885936, 8058.35533157346, 8067.435279530377, 7887.171846956102, 7947.880781788278, 7948.920510794934, 7953.880691789628, 7970.561619110888, 6059.6364218147055, 6098.481629061579, 6109.389061093855, 6137.324894261627, 6214.689265536705, 5816.970915145397, 5839.3868643793485, 5847.707614619337, 5857.619254748428, 5859.472647461749, 6872.209695885037, 7074.893876591958, 7187.31720486553, 7264.055672762507, 7274.854502910018, 7279.417646588155, 7412.925870741224, 7429.219931907288, 7517.699292028257, 7540.208278130936, 5590.608657393944, 5644.52021578154, 5645.9153112702525, 5646.71766411686, 5681.77272909079, 6193.4425901669065, 6205.968970155121, 6224.906626400517, 6231.906521402092, 6296.0, 5902.675352855634, 5968.373320801254, 5980.102984552352, 6003.429674180946, 6061.212042434456, 4792.904141917073, 5632.5775566831835, 5687.914681279867, 5757.136429535603, 5978.192943952511, 5806.216160818404, 5809.79665711715, 5823.388544202967, 5834.795782147605, 5846.590738648254, 5492.725363731877, 5571.637843540157, 5595.384507704231, 5620.185073164286, 5626.043572592751, 5249.343832020997, 5534.667919924817, 5554.583406244628, 5604.551635869202, 5625.690587017753], "unit": "ms", "name": "mootools.html", "value": 3787.096842199942}, {"lowerIsBetter": false, "replicates": [281.2883404985387, 282.3266509375141, 287.57438990294366, 289.54685916540615, 290.85166565051844, 5004.274380214876, 5151.124308867492, 5311.49540793625, 5352.1436570148735, 5379.946200537994, 5226.268322434853, 5297.682139071659, 5319.361676598804, 5322.0154271459805, 5325.3077099976945, 4119.855805046824, 4142.461480007595, 4149.647279981205, 4152.709310348277, 4159.604837540429, 3926.685865130797, 4022.537408198051, 4029.0, 4143.6685065194715, 4146.626803587692, 4060.7360521566, 4069.3285607874664, 4080.6123418275215, 4081.755094694313, 4082.0815316553685, 4070.9185816283803, 4076.0625056236936, 4079.122988557445, 4081.755094694328, 4084.5915408459064, 3542.8582856685703, 3557.2707594942976, 3557.4485954677066, 3557.786532808014, 3561.1453251219523, 5017.623678224148, 5102.311187989611, 5119.129747942859, 5137.075326441239, 5138.383393992707, 4682.8126874924965, 4686.156491831469, 4690.1557719610455, 4695.577398034159, 4697.13103075932, 5591.161325801162, 5591.4688104629995, 5601.439856014406, 5602.327720673505, 5604.523615492688, 3691.058780011107, 3755.042464171646, 3796.316663000659, 3875.360565506688, 3876.186000939806, 5822.214001109838, 5882.382349853289, 5896.528277737813, 5918.23063001807, 5921.763129474816, 3924.744891582095, 3926.587708290588, 3930.3514920038447, 3932.1545867638597, 3944.5660977292473, 3988.3020471417385, 3991.1640645302905, 3992.640662340345, 3993.4409182714444, 3996.4604778355133, 4501.414816073955, 4606.0097079128145, 4607.262837945913, 4608.239640459354, 4612.884677883079, 5600.5799565032785, 5607.130894711327, 5608.242887210256, 5608.327000759935, 5613.578981576398, 1384.3286006286942, 1398.7552178368744, 1400.9772865808018, 1401.1172961034483, 1401.4604377314806, 917.9632814687337, 923.2844545477175, 933.4772527384687, 941.0589410589411, 943.4999450291357, 4909.0, 4913.385826771653, 4918.827841025619, 4920.950790492121, 4929.605631549467, 5837.3287071986415, 5838.007538718428, 5838.67887266196, 5838.737256823453, 5841.853953651193, 4907.730074845917, 4919.4834542373255, 4921.532454416824, 4922.237053256751, 4923.852284431473, 3056.098450956973, 3125.46867032605, 3146.3707258548384, 3155.9053228403186, 3156.7474602031784, 5551.528120109755, 5559.0, 5561.58288128392, 5564.387917329172, 5568.7215639217875, 6056.152138700585, 6057.3336932937345, 6061.212042434543, 6061.696915154224, 6062.120992456069, 5545.639533430314, 5546.112621980464, 5551.250581171571, 5551.916721249185, 5554.9722251387675, 5752.137179422953, 5856.560757943256, 5885.911711324248, 5892.057270836817, 5899.764009439575, 5531.751071201886, 5646.124850648156, 5747.109198074305, 5747.798827041033, 5748.741306641295, 5414.783408663609, 5508.476694713996, 5535.474129957647, 5537.390887002507, 5550.7779688812, 3916.236333914859, 3962.9207415852097, 3965.4646622705563, 3966.3852102924093, 3968.5832987537046, 5849.210356601974, 5852.385499522659, 5853.9121913172185, 5855.853603659943, 5862.648241105548, 5475.808346707846, 5622.3815380307315, 5628.971855140698, 5664.235328230801, 5678.290213723285, 5658.179563963285, 5658.773649053992, 5669.801556945487, 5670.432956704297, 5678.602497825113, 5538.418466061166, 5543.667379957215, 5544.944550554605, 5550.0, 5554.139108438037, 5525.254090697705, 5693.117566777156, 5696.544276457957, 5697.686627235542, 5703.116017017203, 5553.416891226363, 5561.998840208801, 5562.721863906708, 5564.610477266552, 5568.693721845338], "unit": "ms", "name": "prototype.html", "value": 4186.470039456519}, {"lowerIsBetter": false, "replicates": [579.4813641790599, 597.9790707325244, 682.3756263019337, 694.1323345817725, 745.0909889934278, 10780.946095269523, 11140.665780026602, 14213.64465888352, 14487.92756036221, 14577.635559111028, 10157.187425006001, 13689.794653080187, 13703.0, 13709.794353084711, 13727.382267797948, 606.4632799972023, 789.5183937797939, 798.9041315042174, 799.5242830515863, 800.9987515605493, 784.1139512351035, 799.3445374792673, 799.9200079991983, 801.8316153607749, 802.3861745764494, 643.1285608001161, 650.9902351464732, 651.1307404614845, 829.7386323308139, 838.7861095420659, 644.6390021587903, 645.4739387399254, 811.7158994351988, 835.4277320035795, 835.7200337886816, 619.8822223777513, 620.3951147631069, 620.70826711446, 621.934696856828, 622.2315440431064, 12346.938265308705, 12405.813912791315, 12419.31693756843, 12452.75094498105, 12508.937455312756, 11169.162312826571, 11349.205555611028, 11502.367369794658, 11764.764704705944, 11982.820257696141, 9178.908210917938, 9480.00459951709, 9534.523273836281, 9576.61693532258, 9589.808203835884, 3316.303576248991, 3335.699787019156, 3340.9665903340897, 3342.665733426638, 3368.7641865069454, 42761.14477710459, 43043.35434968478, 43075.1384972302, 43463.0, 44030.55969440297, 9327.720168394959, 9636.566354514063, 10027.548760305805, 10055.798884022279, 10127.64553240633, 17799.377021804434, 17815.46553603394, 17819.643607128044, 17836.55408614769, 17844.286228550973, 6436.774712885027, 6519.3154718754795, 6525.988471786881, 6528.934710652833, 6698.0, 3403.846826892796, 3423.1271025888736, 3438.9312213756084, 3476.7218622510645, 3548.3435564420665, 2792.148394739583, 2831.0, 2836.134978831476, 2836.546152615572, 2838.091810620582, 419.5447938986173, 434.1079082485459, 437.0655301644462, 437.49906357220806, 437.56243756243754, 550.1170621152992, 555.0841112164879, 557.2226743692607, 571.5227784799739, 586.3140126052529, 7060.223375428699, 7320.341169294683, 7534.171241163468, 7654.311111999947, 7701.537907725555, 487.3761585170987, 559.8712296171822, 599.78707558816, 617.2592888533777, 622.8131560531822, 3700.5929347771726, 3789.905252368713, 3822.2928758179823, 3925.6270654287796, 3945.2898478274187, 48946.0, 52007.73996129995, 52043.0, 52072.739636302336, 52099.218511722356, 45114.77442612766, 45570.0, 45846.31230531545, 46153.0, 46525.0, 42339.9415014621, 43042.0, 43253.35119973203, 43257.567424325985, 43465.56534434678, 7459.813504662427, 7536.8824578044405, 7832.960835195788, 7865.84268314619, 7988.560629165451, 31820.204494887814, 32083.518747218342, 32733.22422258661, 32965.67034329626, 33005.834970824995, 38151.618483814804, 41313.380299296135, 41775.0, 41986.0, 42409.0, 6474.255460622088, 6738.056672065817, 6774.898376524257, 6780.32196780318, 7102.933863749378, 10733.195010374096, 10739.868657665456, 10749.408782516724, 10893.509792059218, 11021.0, 10272.075513203548, 10699.465026748787, 10894.0, 10908.40003799767, 10909.945450272699, 10284.742881428025, 10449.84325235107, 10479.564848545215, 10510.684679459628, 10933.562657493929, 7854.646540905787, 9106.499142547224, 9340.252779777737, 10492.055714985689, 10541.894581054397, 8680.522571258642, 9028.729138125867, 9235.12266334697, 9523.047695230422, 9768.120869121813, 8412.663493460193, 8590.613422395882, 8885.42244754089, 9084.137006984325, 9092.59083341238], "unit": "ms", "name": "yui.html", "value": 5674.668076350415}], "name": "dromaeo_css", "value": 5947.056061770006}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 105.0, 111.0, 114.0, 111.0, 100.0, 110.0, 105.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 151.0, 163.0, 130.0, 153.0, 162.0, 130.0, 165.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 164.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 80.0, 90.0, 73.0, 72.0, 73.0, 103.0, 93.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 127.0, 93.0, 92.0, 93.0, 136.0, 92.0, 93.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 70.0, 70.0, 70.0, 69.0, 78.0, 67.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 70.0, 69.0, 69.0, 70.0, 68.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 84.0, 84.0, 84.0, 85.0, 84.0, 94.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 126.0, 127.0, 124.0, 122.0, 127.0, 123.0, 122.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [135.0, 141.0, 146.0, 145.0, 148.0, 136.0, 143.0, 150.0, 151.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1516.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.73393002441009], "unit": "score", "name": "Richards", "value": 216.93078999999992}, {"lowerIsBetter": false, "replicates": [192.12295869356387], "unit": "score", "name": "DeltaBlue", "value": 344.1441900000001}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5091.370558375635], "unit": "score", "name": "Decrypt", "value": 52.280814556330995}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [791.304347826087], "unit": "score", "name": "Earley", "value": 842.2334615384617}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26282.05128205128], "unit": "score", "name": "RegExp", "value": 34.66186829268295}, {"lowerIsBetter": false, "replicates": [618.0469715698393], "unit": "score", "name": "Splay", "value": 131.852438}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19813.026786855986}]} 16:57:12 INFO - RETURN: dromaeo_css: 5947.06 16:57:12 INFO - RETURN: kraken: 1516.60 16:57:12 INFO - RETURN: v8_7: 19813.03 16:57:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19813.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1516.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "5947.06"}}} 16:57:12 INFO - Return code: 0 16:57:12 INFO - # TBPL SUCCESS # 16:57:12 INFO - Running post-action listener: _resource_record_post_action 16:57:12 INFO - Running post-run listener: _resource_record_post_run 16:57:13 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513855488; Read time: 196; Write time: 640424 16:57:13 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 104910848; Read time: 0; Write time: 123904 16:57:13 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304488448; Read time: 196; Write time: 293584 16:57:13 INFO - Running post-run listener: _upload_blobber_files 16:57:13 INFO - Blob upload gear active. 16:57:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:57:13 INFO - Copying logs to upload dir... 16:57:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.767204 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 16:57:13.188784) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 16:57:13.192278) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008731 build_url: 'https://queue.taskcluster.net/v1/task/A0MQfbV1S4merpW1WY5lfQ/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-18 16:57:13.241233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:57:13.241646) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1447890338.297158-983049865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:57:13.292040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 16:57:13.292467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 16:57:13.292910) ========= ========= Total master_lag: 0.23 =========