builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1448355104.37 results: success (0) buildid: 20151124000634 builduid: 5a06975fc23548e095ca48c4c67bada6 revision: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.365992) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.366660) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.366960) ========= 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=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006591 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.399904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.400203) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.422543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.422847) ========= 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=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004682 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.490878) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.491223) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.491592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.491888) ========= 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=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 00:51:45-- 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% 43.9M=0s 2015-11-24 00:51:45 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196658 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:45.031535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:45.031844) ========= 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=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014456 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:45.085834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 00:51:45.089216) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 --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=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 00:51:45,460 truncating revision to first 12 chars 2015-11-24 00:51:45,460 Setting DEBUG logging. 2015-11-24 00:51:45,460 attempt 1/10 2015-11-24 00:51:45,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9a99168d92d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 00:51:46,518 unpacking tar archive at: fx-team-b9a99168d92d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.338458 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 00:51:46.440272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:46.440586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:46.448249) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:46.448581) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:46.449381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-24 00:51:46.449900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:51:46 INFO - MultiFileLogger online at 20151124 00:51:46 in /builds/slave/test 00:51:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:51:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:51:46 INFO - {'append_to_log': False, 00:51:46 INFO - 'base_work_dir': '/builds/slave/test', 00:51:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:51:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:51:46 INFO - 'branch': 'Fx-Team-Non-PGO', 00:51:46 INFO - 'buildbot_json_path': 'buildprops.json', 00:51:46 INFO - 'config_files': ('talos/linux_config.py',), 00:51:46 INFO - 'default_actions': ('clobber', 00:51:46 INFO - 'read-buildbot-config', 00:51:46 INFO - 'download-and-extract', 00:51:46 INFO - 'populate-webroot', 00:51:46 INFO - 'create-virtualenv', 00:51:46 INFO - 'install', 00:51:46 INFO - 'run-tests'), 00:51:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:51:46 INFO - 'download_minidump_stackwalk': True, 00:51:46 INFO - 'download_symbols': 'ondemand', 00:51:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:51:46 INFO - 'tooltool.py': '/tools/tooltool.py', 00:51:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:51:46 INFO - '/tools/misc-python/virtualenv.py')}, 00:51:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:51:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:51:46 INFO - 'installer_path': 'installer.exe', 00:51:46 INFO - 'log_level': 'info', 00:51:46 INFO - 'log_name': 'talos', 00:51:46 INFO - 'log_to_console': True, 00:51:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:51:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:51:46 INFO - 'opt_config_files': (), 00:51:46 INFO - 'pip_index': False, 00:51:46 INFO - 'sps_profile': False, 00:51:46 INFO - 'sps_profile_interval': 0, 00:51:46 INFO - 'suite': 'dromaeojs', 00:51:46 INFO - 'system_bits': '64', 00:51:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:51:46 INFO - 'title': 'talos-linux64-ix-002', 00:51:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:51:46 INFO - 'use_talos_json': True, 00:51:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:51:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:51:46 INFO - 'work_dir': 'build'} 00:51:46 INFO - ##### 00:51:46 INFO - ##### Running clobber step. 00:51:46 INFO - ##### 00:51:46 INFO - Running pre-action listener: _resource_record_pre_action 00:51:46 INFO - Running main action method: clobber 00:51:46 INFO - rmtree: /builds/slave/test/build 00:51:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:51:47 INFO - Running post-action listener: _resource_record_post_action 00:51:47 INFO - ##### 00:51:47 INFO - ##### Running read-buildbot-config step. 00:51:47 INFO - ##### 00:51:47 INFO - Running pre-action listener: _resource_record_pre_action 00:51:47 INFO - Running main action method: read_buildbot_config 00:51:47 INFO - Using buildbot properties: 00:51:47 INFO - { 00:51:47 INFO - "properties": { 00:51:47 INFO - "buildnumber": 1129, 00:51:47 INFO - "product": "firefox", 00:51:47 INFO - "script_repo_revision": "production", 00:51:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:51:47 INFO - "repository": "", 00:51:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:51:47 INFO - "buildid": "20151124000634", 00:51:47 INFO - "slavename": "talos-linux64-ix-002", 00:51:47 INFO - "pgo_build": "False", 00:51:47 INFO - "basedir": "/builds/slave/test", 00:51:47 INFO - "project": "", 00:51:47 INFO - "platform": "ubuntu64_hw", 00:51:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:51:47 INFO - "slavebuilddir": "test", 00:51:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:51:47 INFO - "branch": "fx-team", 00:51:47 INFO - "repo_path": "integration/fx-team", 00:51:47 INFO - "stage_platform": "linux64", 00:51:47 INFO - "builduid": "5a06975fc23548e095ca48c4c67bada6", 00:51:47 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 00:51:47 INFO - }, 00:51:47 INFO - "sourcestamp": { 00:51:47 INFO - "repository": "", 00:51:47 INFO - "hasPatch": false, 00:51:47 INFO - "project": "", 00:51:47 INFO - "branch": "fx-team-linux64-talos", 00:51:47 INFO - "changes": [ 00:51:47 INFO - { 00:51:47 INFO - "category": null, 00:51:47 INFO - "files": [ 00:51:47 INFO - { 00:51:47 INFO - "url": null, 00:51:47 INFO - "name": "https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:51:47 INFO - } 00:51:47 INFO - ], 00:51:47 INFO - "repository": "", 00:51:47 INFO - "rev": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55", 00:51:47 INFO - "who": "cbook@mozilla.com", 00:51:47 INFO - "when": 1448355060, 00:51:47 INFO - "number": 6699382, 00:51:47 INFO - "comments": "Bug 1216791 - Change the tooltip of the Hello icon in the toolbar. r=mikedeboer", 00:51:47 INFO - "project": "", 00:51:47 INFO - "at": "Tue 24 Nov 2015 00:51:00", 00:51:47 INFO - "branch": "fx-team-linux64-talos", 00:51:47 INFO - "revlink": "", 00:51:47 INFO - "properties": [ 00:51:47 INFO - [ 00:51:47 INFO - "buildid", 00:51:47 INFO - "20151124000634", 00:51:47 INFO - "Change" 00:51:47 INFO - ], 00:51:47 INFO - [ 00:51:47 INFO - "builduid", 00:51:47 INFO - "5a06975fc23548e095ca48c4c67bada6", 00:51:47 INFO - "Change" 00:51:47 INFO - ], 00:51:47 INFO - [ 00:51:47 INFO - "pgo_build", 00:51:47 INFO - "False", 00:51:47 INFO - "Change" 00:51:47 INFO - ] 00:51:47 INFO - ], 00:51:47 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 00:51:47 INFO - } 00:51:47 INFO - ], 00:51:47 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 00:51:47 INFO - } 00:51:47 INFO - } 00:51:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:51:47 INFO - Running post-action listener: _resource_record_post_action 00:51:47 INFO - ##### 00:51:47 INFO - ##### Running download-and-extract step. 00:51:47 INFO - ##### 00:51:47 INFO - Running pre-action listener: _resource_record_pre_action 00:51:47 INFO - Running main action method: download_and_extract 00:51:47 INFO - mkdir: /builds/slave/test/build/tests 00:51:47 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')]} 00:51:47 INFO - https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/test_packages.json 00:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/test_packages.json 00:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:51:48 INFO - Downloaded 1302 bytes. 00:51:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:51:48 INFO - Using the following test package requirements: 00:51:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:51:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:48 INFO - u'jsshell-linux-x86_64.zip'], 00:51:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:51:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:51:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:51:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:51:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:51:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:51:48 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')]} 00:51:48 INFO - https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:49 INFO - Downloaded 21341306 bytes. 00:51:49 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 00:51:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:49 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 00:51:50 INFO - Return code: 0 00:51:50 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 00:51:50 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')]} 00:51:50 INFO - https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:52 INFO - Downloaded 21341306 bytes. 00:51:52 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 00:51:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:52 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 00:51:53 INFO - Return code: 0 00:51: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')]} 00:51:53 INFO - https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:51:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:54 INFO - Downloaded 11130997 bytes. 00:51:54 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 00:51:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:54 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 00:51:54 INFO - Return code: 0 00:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:54 INFO - https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/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 00:51:56 INFO - Downloaded 56074717 bytes. 00:51:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:56 INFO - mkdir: /builds/slave/test/properties 00:51:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:51:56 INFO - Writing to file /builds/slave/test/properties/build_url 00:51:56 INFO - Contents: 00:51:56 INFO - build_url:https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:51:56 INFO - Running post-action listener: _resource_record_post_action 00:51:56 INFO - Running post-action listener: set_extra_try_arguments 00:51:56 INFO - ##### 00:51:56 INFO - ##### Running populate-webroot step. 00:51:56 INFO - ##### 00:51:56 INFO - Running pre-action listener: _resource_record_pre_action 00:51:56 INFO - Running main action method: populate_webroot 00:51:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:51:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:51:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:51:56 INFO - '../fennec_ids.txt'], 00:51:56 INFO - 'tests': ['tcheck2']}, 00:51:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:51:56 INFO - '--tppagecycles', 00:51:56 INFO - '7'], 00:51:56 INFO - 'tests': ['tsvgm']}}, 00:51:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:51:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:51:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:51:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:51:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:51:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'tests': ['damp', 'tps']}, 00:51:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['damp', 'tps']}, 00:51:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:51:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:51:56 INFO - 'other': {'tests': ['a11yr', 00:51:56 INFO - 'ts_paint', 00:51:56 INFO - 'tpaint', 00:51:56 INFO - 'sessionrestore', 00:51:56 INFO - 'sessionrestore_no_auto_restore']}, 00:51:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['a11yr', 00:51:56 INFO - 'ts_paint', 00:51:56 INFO - 'tpaint', 00:51:56 INFO - 'sessionrestore', 00:51:56 INFO - 'sessionrestore_no_auto_restore']}, 00:51:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['a11yr', 00:51:56 INFO - 'ts_paint', 00:51:56 INFO - 'tpaint', 00:51:56 INFO - 'sessionrestore', 00:51:56 INFO - 'sessionrestore_no_auto_restore']}, 00:51:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['a11yr', 00:51:56 INFO - 'ts_paint', 00:51:56 INFO - 'tpaint', 00:51:56 INFO - 'sessionrestore', 00:51:56 INFO - 'sessionrestore_no_auto_restore']}, 00:51:56 INFO - 'other_l64': {'tests': ['a11yr', 00:51:56 INFO - 'ts_paint', 00:51:56 INFO - 'tpaint', 00:51:56 INFO - 'sessionrestore', 00:51:56 INFO - 'sessionrestore_no_auto_restore']}, 00:51:56 INFO - 'other_nol64': {'tests': ['a11yr', 00:51:56 INFO - 'ts_paint', 00:51:56 INFO - 'tpaint', 00:51:56 INFO - 'sessionrestore', 00:51:56 INFO - 'sessionrestore_no_auto_restore']}, 00:51:56 INFO - 'svgr': {'tests': ['tsvgx', 00:51:56 INFO - 'tsvgr_opacity', 00:51:56 INFO - 'tart', 00:51:56 INFO - 'tscrollx', 00:51:56 INFO - 'cart']}, 00:51:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['tsvgx', 00:51:56 INFO - 'tsvgr_opacity', 00:51:56 INFO - 'tart', 00:51:56 INFO - 'tscrollx', 00:51:56 INFO - 'cart']}, 00:51:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'tests': ['tp5o']}, 00:51:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'talos_options': ['--e10s'], 00:51:56 INFO - 'tests': ['tp5o']}, 00:51:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'talos_options': ['--xperf_path', 00:51:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:56 INFO - 'tests': ['tp5n']}, 00:51:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:51:56 INFO - 'talos_options': ['--e10s', 00:51:56 INFO - '--xperf_path', 00:51:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:51:56 INFO - 'tests': ['tp5n']}}, 00:51:56 INFO - 'talos.zip': {'path': '', 00:51:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:51:56 INFO - Running post-action listener: _resource_record_post_action 00:51:56 INFO - ##### 00:51:56 INFO - ##### Running create-virtualenv step. 00:51:56 INFO - ##### 00:51:56 INFO - Running pre-action listener: _resource_record_pre_action 00:51:56 INFO - Running main action method: create_virtualenv 00:51:56 INFO - Creating virtualenv /builds/slave/test/build/venv 00:51:56 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 00:51:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:51:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:51:56 INFO - Using real prefix '/usr' 00:51:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:51:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:51:59 INFO - Installing pip.................done. 00:51:59 INFO - Return code: 0 00:51:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:59 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 0x7f24b43ffc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, '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': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', '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 00:51:59 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 00:51:59 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 00:51:59 INFO - Using env: {'DISPLAY': ':0', 00:51:59 INFO - 'HOME': '/home/cltbld', 00:51:59 INFO - 'LANG': 'en_US.UTF-8', 00:51:59 INFO - 'LANGUAGE': 'en_US:en', 00:51:59 INFO - 'LOGNAME': 'cltbld', 00:51:59 INFO - 'MAIL': '/var/mail/cltbld', 00:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:59 INFO - 'MOZ_NO_REMOTE': '1', 00:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:59 INFO - 'NO_EM_RESTART': '1', 00:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:59 INFO - 'PWD': '/builds/slave/test', 00:51:59 INFO - 'SHELL': '/bin/bash', 00:51:59 INFO - 'SHLVL': '1', 00:51:59 INFO - 'TERM': 'linux', 00:51:59 INFO - 'TMOUT': '86400', 00:51:59 INFO - 'USER': 'cltbld', 00:51:59 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:59 INFO - '_': '/tools/buildbot/bin/python'} 00:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:59 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 00:51:59 INFO - Cleaning up... 00:51:59 INFO - Return code: 0 00:51:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:59 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 0x7f24b43ffc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, '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': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', '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 00:51:59 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 00:51:59 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 00:51:59 INFO - Using env: {'DISPLAY': ':0', 00:51:59 INFO - 'HOME': '/home/cltbld', 00:51:59 INFO - 'LANG': 'en_US.UTF-8', 00:51:59 INFO - 'LANGUAGE': 'en_US:en', 00:51:59 INFO - 'LOGNAME': 'cltbld', 00:51:59 INFO - 'MAIL': '/var/mail/cltbld', 00:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:59 INFO - 'MOZ_NO_REMOTE': '1', 00:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:59 INFO - 'NO_EM_RESTART': '1', 00:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:59 INFO - 'PWD': '/builds/slave/test', 00:51:59 INFO - 'SHELL': '/bin/bash', 00:51:59 INFO - 'SHLVL': '1', 00:51:59 INFO - 'TERM': 'linux', 00:51:59 INFO - 'TMOUT': '86400', 00:51:59 INFO - 'USER': 'cltbld', 00:51:59 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:59 INFO - '_': '/tools/buildbot/bin/python'} 00:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:59 INFO - Downloading/unpacking psutil>=0.7.1 00:51:59 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 00:51:59 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 00:51:59 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 00:51:59 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 00:51:59 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 00:51:59 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 00:52:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:52:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:01 INFO - Installing collected packages: psutil 00:52:01 INFO - Running setup.py install for psutil 00:52:01 INFO - building 'psutil._psutil_linux' extension 00:52:01 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 00:52:01 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 00:52:01 INFO - building 'psutil._psutil_posix' extension 00:52:01 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 00:52:01 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 00:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:01 INFO - Successfully installed psutil 00:52:01 INFO - Cleaning up... 00:52:01 INFO - Return code: 0 00:52:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:52:01 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')]} 00:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:01 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')]} 00:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:01 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 0x7f24b43ffc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, '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': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', '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 00:52:01 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 00:52:01 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 00:52:01 INFO - Using env: {'DISPLAY': ':0', 00:52:01 INFO - 'HOME': '/home/cltbld', 00:52:01 INFO - 'LANG': 'en_US.UTF-8', 00:52:01 INFO - 'LANGUAGE': 'en_US:en', 00:52:01 INFO - 'LOGNAME': 'cltbld', 00:52:01 INFO - 'MAIL': '/var/mail/cltbld', 00:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:01 INFO - 'MOZ_NO_REMOTE': '1', 00:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:01 INFO - 'NO_EM_RESTART': '1', 00:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:01 INFO - 'PWD': '/builds/slave/test', 00:52:01 INFO - 'SHELL': '/bin/bash', 00:52:01 INFO - 'SHLVL': '1', 00:52:01 INFO - 'TERM': 'linux', 00:52:01 INFO - 'TMOUT': '86400', 00:52:01 INFO - 'USER': 'cltbld', 00:52:01 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:01 INFO - '_': '/tools/buildbot/bin/python'} 00:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:52:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:52:03 INFO - Installing collected packages: mozsystemmonitor 00:52:03 INFO - Running setup.py install for mozsystemmonitor 00:52:04 INFO - Successfully installed mozsystemmonitor 00:52:04 INFO - Cleaning up... 00:52:04 INFO - Return code: 0 00:52:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:04 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 0x7f24b43ffc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, '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': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', '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 00:52:04 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 00:52:04 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 00:52:04 INFO - Using env: {'DISPLAY': ':0', 00:52:04 INFO - 'HOME': '/home/cltbld', 00:52:04 INFO - 'LANG': 'en_US.UTF-8', 00:52:04 INFO - 'LANGUAGE': 'en_US:en', 00:52:04 INFO - 'LOGNAME': 'cltbld', 00:52:04 INFO - 'MAIL': '/var/mail/cltbld', 00:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:04 INFO - 'MOZ_NO_REMOTE': '1', 00:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:04 INFO - 'NO_EM_RESTART': '1', 00:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:04 INFO - 'PWD': '/builds/slave/test', 00:52:04 INFO - 'SHELL': '/bin/bash', 00:52:04 INFO - 'SHLVL': '1', 00:52:04 INFO - 'TERM': 'linux', 00:52:04 INFO - 'TMOUT': '86400', 00:52:04 INFO - 'USER': 'cltbld', 00:52:04 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:04 INFO - '_': '/tools/buildbot/bin/python'} 00:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:04 INFO - Downloading/unpacking blobuploader==1.2.4 00:52:04 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 00:52:04 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 00:52:04 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 00:52:04 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 00:52:04 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 00:52:04 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 00:52:05 INFO - Downloading blobuploader-1.2.4.tar.gz 00:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:52:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:52:06 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 00:52:06 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 00:52:06 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 00:52:06 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 00:52:06 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 00:52:06 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 00:52:06 INFO - Downloading docopt-0.6.1.tar.gz 00:52:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:52:06 INFO - Installing collected packages: blobuploader, requests, docopt 00:52:06 INFO - Running setup.py install for blobuploader 00:52:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:52:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:52:06 INFO - Running setup.py install for requests 00:52:07 INFO - Running setup.py install for docopt 00:52:07 INFO - Successfully installed blobuploader requests docopt 00:52:07 INFO - Cleaning up... 00:52:07 INFO - Return code: 0 00:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52: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')]} 00:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:07 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 0x7f24b43ffc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, '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': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', '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 00:52:07 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 00:52:07 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 00:52:07 INFO - Using env: {'DISPLAY': ':0', 00:52:07 INFO - 'HOME': '/home/cltbld', 00:52:07 INFO - 'LANG': 'en_US.UTF-8', 00:52:07 INFO - 'LANGUAGE': 'en_US:en', 00:52:07 INFO - 'LOGNAME': 'cltbld', 00:52:07 INFO - 'MAIL': '/var/mail/cltbld', 00:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:07 INFO - 'MOZ_NO_REMOTE': '1', 00:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:07 INFO - 'NO_EM_RESTART': '1', 00:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:07 INFO - 'PWD': '/builds/slave/test', 00:52:07 INFO - 'SHELL': '/bin/bash', 00:52:07 INFO - 'SHLVL': '1', 00:52:07 INFO - 'TERM': 'linux', 00:52:07 INFO - 'TMOUT': '86400', 00:52:07 INFO - 'USER': 'cltbld', 00:52:07 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:07 INFO - '_': '/tools/buildbot/bin/python'} 00:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:52:07 INFO - Running setup.py (path:/tmp/pip-to2IcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:52:07 INFO - Running setup.py (path:/tmp/pip-F8kHC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:52:07 INFO - Running setup.py (path:/tmp/pip-MsvHrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:52:07 INFO - Running setup.py (path:/tmp/pip-D7UMEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:52:07 INFO - Running setup.py (path:/tmp/pip-OPuhl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:52:07 INFO - Running setup.py (path:/tmp/pip-KU3qxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:52:07 INFO - Running setup.py (path:/tmp/pip-Dd4fY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:52:07 INFO - Running setup.py (path:/tmp/pip-zCZByy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:52:08 INFO - Running setup.py (path:/tmp/pip-5TYdFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:52:08 INFO - Running setup.py (path:/tmp/pip-07g7WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:52:08 INFO - Running setup.py (path:/tmp/pip-tYQMgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:52:08 INFO - Running setup.py (path:/tmp/pip-VZYhub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:52:08 INFO - Running setup.py (path:/tmp/pip-va4zPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:52:08 INFO - Running setup.py (path:/tmp/pip-Tcoi8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:08 INFO - Running setup.py (path:/tmp/pip-3SF72o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:52:08 INFO - Running setup.py (path:/tmp/pip-kPcFTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:52:08 INFO - Running setup.py (path:/tmp/pip-6BnqWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:52:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:52:08 INFO - Running setup.py install for manifestparser 00:52:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:52:08 INFO - Running setup.py install for mozcrash 00:52:08 INFO - Running setup.py install for mozdebug 00:52:08 INFO - Running setup.py install for mozdevice 00:52:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Running setup.py install for mozfile 00:52:09 INFO - Running setup.py install for mozhttpd 00:52:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Running setup.py install for mozinfo 00:52:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Running setup.py install for mozInstall 00:52:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Running setup.py install for mozleak 00:52:09 INFO - Running setup.py install for mozlog 00:52:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Running setup.py install for moznetwork 00:52:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Running setup.py install for mozprocess 00:52:09 INFO - Running setup.py install for mozprofile 00:52:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:52:09 INFO - Running setup.py install for mozrunner 00:52:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:52:10 INFO - Running setup.py install for mozscreenshot 00:52:10 INFO - Running setup.py install for moztest 00:52:10 INFO - Running setup.py install for mozversion 00:52:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:52:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:52:10 INFO - Cleaning up... 00:52:10 INFO - Return code: 0 00:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52: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')]} 00:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:10 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 0x7f24b43ffc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, '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': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', '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 00:52:10 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 00:52:10 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 00:52:10 INFO - Using env: {'DISPLAY': ':0', 00:52:10 INFO - 'HOME': '/home/cltbld', 00:52:10 INFO - 'LANG': 'en_US.UTF-8', 00:52:10 INFO - 'LANGUAGE': 'en_US:en', 00:52:10 INFO - 'LOGNAME': 'cltbld', 00:52:10 INFO - 'MAIL': '/var/mail/cltbld', 00:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:10 INFO - 'MOZ_NO_REMOTE': '1', 00:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:10 INFO - 'NO_EM_RESTART': '1', 00:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:10 INFO - 'PWD': '/builds/slave/test', 00:52:10 INFO - 'SHELL': '/bin/bash', 00:52:10 INFO - 'SHLVL': '1', 00:52:10 INFO - 'TERM': 'linux', 00:52:10 INFO - 'TMOUT': '86400', 00:52:10 INFO - 'USER': 'cltbld', 00:52:10 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:10 INFO - '_': '/tools/buildbot/bin/python'} 00:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:52:10 INFO - Running setup.py (path:/tmp/pip-VIXGGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:52:10 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)) 00:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:52:10 INFO - Running setup.py (path:/tmp/pip-WnTe_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:52:10 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)) 00:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:52:10 INFO - Running setup.py (path:/tmp/pip-l5RJ04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:52:10 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)) 00:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:52:10 INFO - Running setup.py (path:/tmp/pip-wLEkG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:52:10 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)) 00:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:52:10 INFO - Running setup.py (path:/tmp/pip-Lr6O6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:52:11 INFO - Running setup.py (path:/tmp/pip-sr9jBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:52:11 INFO - Running setup.py (path:/tmp/pip-aKfxDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:52:11 INFO - Running setup.py (path:/tmp/pip-s4nAzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:52:11 INFO - Running setup.py (path:/tmp/pip-RBni_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:52:11 INFO - Running setup.py (path:/tmp/pip-ySPMSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:52:11 INFO - Running setup.py (path:/tmp/pip-IGV3v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:52:11 INFO - Running setup.py (path:/tmp/pip-HwuLfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:52:11 INFO - Running setup.py (path:/tmp/pip-4EdXHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:52:11 INFO - Running setup.py (path:/tmp/pip-yThYWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:11 INFO - Running setup.py (path:/tmp/pip-vbyqE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:52:11 INFO - Running setup.py (path:/tmp/pip-I9Ozsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:52:11 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)) 00:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:52:11 INFO - Running setup.py (path:/tmp/pip-Nk5dGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:52:11 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)) 00:52:11 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)) 00:52:11 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)) 00:52:11 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)) 00:52:11 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)) 00:52:11 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)) 00:52:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:52:11 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 00:52:11 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 00:52:11 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 00:52:11 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 00:52:11 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 00:52:11 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 00:52:13 INFO - Downloading blessings-1.5.1.tar.gz 00:52:13 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 00:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:52:13 INFO - Installing collected packages: blessings 00:52:13 INFO - Running setup.py install for blessings 00:52:13 INFO - Successfully installed blessings 00:52:13 INFO - Cleaning up... 00:52:13 INFO - Return code: 0 00:52:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:52:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:52:13 INFO - Reading from file tmpfile_stdout 00:52:13 INFO - Current package versions: 00:52:13 INFO - argparse == 1.2.1 00:52:13 INFO - blessings == 1.5.1 00:52:13 INFO - blobuploader == 1.2.4 00:52:13 INFO - docopt == 0.6.1 00:52:13 INFO - manifestparser == 1.1 00:52:13 INFO - mozInstall == 1.12 00:52:13 INFO - mozcrash == 0.16 00:52:13 INFO - mozdebug == 0.1 00:52:13 INFO - mozdevice == 0.47 00:52:13 INFO - mozfile == 1.2 00:52:13 INFO - mozhttpd == 0.7 00:52:13 INFO - mozinfo == 0.9 00:52:13 INFO - mozleak == 0.1 00:52:13 INFO - mozlog == 3.1 00:52:13 INFO - moznetwork == 0.27 00:52:13 INFO - mozprocess == 0.22 00:52:13 INFO - mozprofile == 0.27 00:52:13 INFO - mozrunner == 6.11 00:52:13 INFO - mozscreenshot == 0.1 00:52:13 INFO - mozsystemmonitor == 0.0 00:52:13 INFO - moztest == 0.7 00:52:13 INFO - mozversion == 1.4 00:52:13 INFO - psutil == 3.1.1 00:52:13 INFO - requests == 1.2.3 00:52:13 INFO - wsgiref == 0.1.2 00:52:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f24b43ffc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1523900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, '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': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', '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 00:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 00:52:14 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 00:52:14 INFO - Using env: {'DISPLAY': ':0', 00:52:14 INFO - 'HOME': '/home/cltbld', 00:52:14 INFO - 'LANG': 'en_US.UTF-8', 00:52:14 INFO - 'LANGUAGE': 'en_US:en', 00:52:14 INFO - 'LOGNAME': 'cltbld', 00:52:14 INFO - 'MAIL': '/var/mail/cltbld', 00:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:14 INFO - 'MOZ_NO_REMOTE': '1', 00:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:14 INFO - 'NO_EM_RESTART': '1', 00:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:14 INFO - 'PWD': '/builds/slave/test', 00:52:14 INFO - 'SHELL': '/bin/bash', 00:52:14 INFO - 'SHLVL': '1', 00:52:14 INFO - 'TERM': 'linux', 00:52:14 INFO - 'TMOUT': '86400', 00:52:14 INFO - 'USER': 'cltbld', 00:52:14 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:14 INFO - '_': '/tools/buildbot/bin/python'} 00:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 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)) 00:52:14 INFO - Cleaning up... 00:52:14 INFO - Return code: 0 00:52:14 INFO - Running post-action listener: _resource_record_post_action 00:52:14 INFO - Running post-action listener: _start_resource_monitoring 00:52:14 INFO - Starting resource monitoring. 00:52:14 INFO - ##### 00:52:14 INFO - ##### Running install step. 00:52:14 INFO - ##### 00:52:14 INFO - Running pre-action listener: _resource_record_pre_action 00:52:14 INFO - Running main action method: install 00:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:52:14 INFO - Reading from file tmpfile_stdout 00:52:14 INFO - Detecting whether we're running mozinstall >=1.0... 00:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:52:14 INFO - Reading from file tmpfile_stdout 00:52:14 INFO - Output received: 00:52:14 INFO - Usage: mozinstall [options] installer 00:52:14 INFO - Options: 00:52:14 INFO - -h, --help show this help message and exit 00:52:14 INFO - -d DEST, --destination=DEST 00:52:14 INFO - Directory to install application into. [default: 00:52:14 INFO - "/builds/slave/test"] 00:52:14 INFO - --app=APP Application being installed. [default: firefox] 00:52:14 INFO - mkdir: /builds/slave/test/build/application 00:52:14 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'] 00:52:14 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 00:52:28 INFO - Reading from file tmpfile_stdout 00:52:28 INFO - Output received: 00:52:28 INFO - /builds/slave/test/build/application/firefox/firefox 00:52:28 INFO - Running post-action listener: _resource_record_post_action 00:52:28 INFO - ##### 00:52:28 INFO - ##### Running run-tests step. 00:52:28 INFO - ##### 00:52:28 INFO - Running pre-action listener: _resource_record_pre_action 00:52:28 INFO - Running main action method: run_tests 00:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:52:28 INFO - Python 2.7.3 00:52:28 INFO - Return code: 0 00:52:28 INFO - grabbing minidump binary from tooltool 00:52: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')]} 00:52:28 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 0x1569b70>, '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 0x15badc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bb250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:52:28 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 00:52:28 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 00:52:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:52:28 INFO - Return code: 0 00:52:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:52:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:52:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:52:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:52:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test/build 00:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 00:52:28 INFO - Using env: {'DISPLAY': ':0', 00:52:28 INFO - 'HOME': '/home/cltbld', 00:52:28 INFO - 'LANG': 'en_US.UTF-8', 00:52:28 INFO - 'LANGUAGE': 'en_US:en', 00:52:28 INFO - 'LOGNAME': 'cltbld', 00:52:28 INFO - 'MAIL': '/var/mail/cltbld', 00:52:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:52:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:28 INFO - 'MOZ_NO_REMOTE': '1', 00:52:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:28 INFO - 'NO_EM_RESTART': '1', 00:52:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:28 INFO - 'PWD': '/builds/slave/test', 00:52:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:52:28 INFO - 'SHELL': '/bin/bash', 00:52:28 INFO - 'SHLVL': '1', 00:52:28 INFO - 'TERM': 'linux', 00:52:28 INFO - 'TMOUT': '86400', 00:52:28 INFO - 'USER': 'cltbld', 00:52:28 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187', 00:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:28 INFO - '_': '/tools/buildbot/bin/python'} 00:52:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 00:52:28 INFO - mozversion INFO | application_buildid: 20151124000634 00:52:28 INFO - mozversion INFO | application_changeset: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 00:52:28 INFO - mozversion INFO | application_display_name: Nightly 00:52:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:52:28 INFO - mozversion INFO | application_name: Firefox 00:52:28 INFO - mozversion INFO | application_remotingname: firefox 00:52:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:52:28 INFO - mozversion INFO | application_vendor: Mozilla 00:52:28 INFO - mozversion INFO | application_version: 45.0a1 00:52:28 INFO - mozversion INFO | platform_buildid: 20151124000634 00:52:28 INFO - mozversion INFO | platform_changeset: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 00:52:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:52:28 INFO - mozversion INFO | platform_version: 45.0a1 00:52:28 INFO - 2015-11-24 00:52:28,958 DEBUG : using testdate: 1448355148 00:52:28 INFO - 2015-11-24 00:52:28,958 DEBUG : actual date: 1448355148 00:52:28 INFO - 2015-11-24 00:52:28,972 INFO : starting webserver on 'localhost:57929' 00:52:28 INFO - 2015-11-24 00:52:28,973 INFO : Starting test suite talos-linux64-ix-002 00:52:28 INFO - 2015-11-24 00:52:28,973 INFO : Starting test dromaeo_css 00:52:28 INFO - 2015-11-24 00:52:28,973 DEBUG : operating with platform_type : linux_ 00:52:28 INFO - 2015-11-24 00:52:28,974 INFO : Initialising browser for dromaeo_css test... 00:52:28 INFO - 2015-11-24 00:52:28,987 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLkltwW/profile http://localhost:57929/getInfo.html 00:52:33 INFO - 2015-11-24 00:52:33,346 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:52:33 INFO - 2015-11-24 00:52:33,346 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:52:33 INFO - 2015-11-24 00:52:33,346 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:52:33 INFO - 2015-11-24 00:52:33,346 DEBUG : BROWSER_OUTPUT: __metrics 00:52:33 INFO - 2015-11-24 00:52:33,468 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:52:35 INFO - 2015-11-24 00:52:35,056 INFO : Browser initialized. 00:52:35 INFO - 2015-11-24 00:52:35,056 INFO : Running cycle 1/1 for dromaeo_css test... 00:52:35 INFO - 2015-11-24 00:52:35,056 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLkltwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:52:46 INFO - 2015-11-24 00:52:46,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 139878400 00:52:46 INFO - 2015-11-24 00:52:46,990 DEBUG : BROWSER_OUTPUT: 00:53:38 INFO - 2015-11-24 00:53:38,132 DEBUG : BROWSER_OUTPUT: 1448355218127 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] 00:55:49 INFO - 2015-11-24 00:55:49,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57929/tests/dromaeo/cssquery-ext.html) 00:55:51 INFO - 2015-11-24 00:55:51,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 222822400 00:55:51 INFO - 2015-11-24 00:55:51,201 DEBUG : BROWSER_OUTPUT: 00:58:53 INFO - 2015-11-24 00:58:53,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/dromaeo/cssquery-ext.html (next: http://localhost:57929/tests/dromaeo/cssquery-jquery.html) 00:58:54 INFO - 2015-11-24 00:58:54,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 219185152 00:58:54 INFO - 2015-11-24 00:58:54,236 DEBUG : BROWSER_OUTPUT: 01:01:56 INFO - 2015-11-24 01:01:56,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57929/tests/dromaeo/cssquery-mootools.html) 01:01:56 INFO - 2015-11-24 01:01:56,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 212226048 01:01:56 INFO - 2015-11-24 01:01:56,828 DEBUG : BROWSER_OUTPUT: 01:04:58 INFO - 2015-11-24 01:04:58,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57929/tests/dromaeo/cssquery-prototype.html) 01:04:59 INFO - 2015-11-24 01:04:59,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 203694080 01:04:59 INFO - 2015-11-24 01:04:59,405 DEBUG : BROWSER_OUTPUT: 01:08:02 INFO - 2015-11-24 01:08:02,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57929/tests/dromaeo/cssquery-yui.html) 01:08:02 INFO - 2015-11-24 01:08:02,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 205287424 01:08:02 INFO - 2015-11-24 01:08:02,822 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/dromaeo/cssquery-yui.html (next: http://localhost:57929/tests/dromaeo/cssquery-dojo.html) 01:11:05 INFO - 2015-11-24 01:11:05,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 251318272 01:11:05 INFO - 2015-11-24 01:11:05,587 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,588 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:11:05 INFO - 2015-11-24 01:11:05,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:11:05 INFO - 2015-11-24 01:11:05,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:11:05 INFO - 2015-11-24 01:11:05,588 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:11:05 INFO - 2015-11-24 01:11:05,588 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2601.2586412872333;2679.986600066998;2684.5704687250045;2689.5965605159236;2699.973000269998;4527.773611319437;4564.543545645433;4597;4623.815047398104;4680.274557443602;4597.724136551801;4618.122556714222;4672.696274742148;4673.065386922621;4686.625069994401;4296.2481565725875;4298.914021719564;4305.052888364555;4332.935005974913;4352.97823510882;4205.873823785291;4380.649548036149;4393.714408563433;4411.139827733593;4424.80088396023;4203.5376108628025;4284.721493102938;4286.2499062664065;4312.741235525878;4313.82744690212;4340.500842403101;4374.1689079075195;4380.036391993756;4407.779611019436;4411.426514553087;4133.81397837095;4339.218940590692;4351.260285751398;4354.716943398669;4406.735595864258;4534.161180181644;4561.407017087758;4598.770061496912;4708.764561771932;4740.19416699162;5006.5744411725045;5034.89930201394;5035.144025515635;5037.798488060474;5074.517920797555;4819.228923372279;5050.191969284933;5059.747012649353;5060.316857224265;5065.316182315377;4582.358469814229;4597.7011494252765;4613.192691279013;4618.538146185355;4687.9765601171775;5136.1525348317855;5165.793368265227;5175.818846340435;5184;5221.765020574083;4712.976435117871;4949.430815456269;4956.801727930842;4960.429550601727;5006.123928312531;4865.148598995162;4907.509249075064;4925.729084900365;4929.87675308113;4979.402471703419;4908.042931628298;4915.827946021872;4917.262410638433;4920.21276595743;4948.480409557017;4954.909919817635;4964;4965.280034394992;4967.05625931072;4969.055879382906;4001.559828418872;4051.2707712611423;4051.918961620751;4093.836246550164;4233.30150525166;3609.115766637138;3614.963850361515;3627.4740162676794;3639.927201455956;3662.1027848176836;4292.892677683083;4293.570642935744;4300.849470268526;4326.502452217972;4327.675424343187;4806.879828004258;4920.21276595743;4925.581325587294;5004.124278251292;5004.149294619923;4221.97889010553;4295.334223195409;4305.418768466279;4339.891502712458;4341.630961368256;4386.692931494765;4465.4864690561;4482.686211965131;4498.797554110073;4529.071540334289;4564.634829213722;4773.474917759044;4797.4482934462985;4804.615630749532;4840.515948405131;4877.975610121926;4901.289313049517;4937.876553086202;4939;4973;4746.406699162605;4753.524647535219;4753.811547113221;4757.809687612456;4811.08589368019;4916.164252077084;4916.360873086476;4919.2129259318335;4922.335484709662;4958.801647934042;4790.305405716082;4948.925766113583;4960.7767650456535;4992.350994370709;5036.622253330942;4781.067691800205;4798.1123492154065;4844.4186697596515;4852.223644216909;4877.90244195107;4769.809207631656;4795.256735206049;4819.7108173508295;4824.252240902666;4854.490278520846;4579.564941330568;4668.253079507263;4708.552687494683;4711.175544279806;4760.952390476051;4751.477337492804;4782.665213435026;4819;4846.39420072491;4876.804927802848;4756.833510827105;4774.379330686988;4778.641601879804;4785.282207668877;4812.446568644651 01:11:05 INFO - 2015-11-24 01:11:05,588 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.6125553995513;571.8913406452772;573.6844735395529;580.05161560848;581.6161333519877;27641.308967275803;28102.718972810264;36053.91838244854;36610.633893661055;36623.26753464929;39682.80158599203;40300;40317.59682403175;40326.96730326966;40358.19283614326;6835.28229535899;6959.61722105284;7758.418118641111;7924.405669574805;7935.484193527431;9879.950600246988;10102.545385457672;10185.28702990791;10192.745181370488;10194.949025254864;9927.106560409562;10011.599536018586;10020.298579099466;10023.649172278972;10027.59889604415;6953.582785032914;7108.395786358165;7110.751123710697;7112.075430194093;9713.514324283793;9901.405915645084;10222.233332500093;10230.335028223217;10233.38599684014;10235.130013948823;36390.27219455596;36844.81577592095;36904.261914761555;36908.26183476316;36916;2604.0760748025873;2606.579414219255;2648.7218842021693;2726.4138210284686;3088.625561625078;27527.86236068827;27966.300842478897;28221.717782822114;28357.716422835714;28421.85789071062;3290.391277613649;3314.320564284316;3327.4177019021577;3343.3981883261004;3420.0936751760805;218222;220910;221068;221551.89224053937;221575;47610.5238947613;49183.50816491789;51851.74074129605;52216.73891630518;52254.21618675647;53573;54519.45480545144;54528.18207726887;54749.45250547523;54788;13530;13710.931445342709;13718.519851805138;13730.382132804049;13734.587962361145;10506.527206275736;10587.84118238227;10601.84097238542;10602.204834637432;10602.522886470128;16840.57898552546;16945.22075182113;16976.236069376908;17646.91176544109;17703.20335584902;6887.552309099892;7007.754728584475;7159.49650573375;7160.498765086498;7195.640217989079;900.4192295969063;906.3383729877227;917.5687426909342;994.1301361308855;1028.4703377760459;25941.74058259431;25972.74027259741;25990.09034683777;26208.8689556551;26306.342341441617;943.0616536546044;972.1785091597588;991.7818080022528;993.2798720927415;1044.2637940252105;13613.319334033258;14855.851441485447;14909.478168264059;15123;15140.470083547023;256779;260711;260935;261741;261847;44222.55777442249;44399.55600443954;44511;44575;44583;1202.8135638975973;1222.5720997650928;1224.1981502116128;1226.5289231474906;1229.0413477487573;25271.873640632413;25938;26684.19947401581;26851.194464166107;26856.462870742867;39671.40492892551;41456;41459;41461.170776584906;41468.37797432981;235752;241415;244233;252101;252260;26140.34649133787;26161.345966350993;26185.214443566725;26244.737552624993;26256.8687156563;34612.65387346094;34841.30317393689;35468;35821.64178358183;37788.43317350187;30706.692933070382;32443.675563244065;32706.83646581752;33094.83452582722;33412.83293583516;28668.42663146767;31673.8416307917;31901.68098318987;31995;32083.518747218342;31751.68248317487;32155.51766723454;32191.678083218867;32216.516752249205;32300.515492268103;25655.743442566083;27069.458610828067;27091.864540677958;27098.72901270962;27173;21398.465038374165;21609.459763506038;21654;21696.457588560414;21706.674399883697 01:11:05 INFO - 2015-11-24 01:11:05,588 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.59921794237937;333.628004774676;334.7924286942096;336.34245050925426;336.93092915952235;12533.49866005361;12880.74238515229;15310.693786124271;15611.650871232443;16964.4062457814;11804.173707840455;15441.536753897373;15552.144632045232;15718.528444146665;15719.292631831566;4818.518148185189;4929.8028078876805;4935.53112454318;4950.92573611397;5074.797008119671;3375.510550970108;3464.532288141094;4964.503549645025;4969.130402179622;5110.131277682803;5002.924956125643;5012.147934851084;5031.2453132030305;5051.0403023425615;5052.772625231855;4773.997460533257;4775.665703400763;4777.4267087949665;4828;5017.046761115376;4872.610191184696;4989.476105008995;5002.449240735384;5002.7248501332415;5012.799488020475;11552.191346605741;16810;18267.543311417186;18557.350492732825;18725.157367918477;1731.740238964153;1759.375421725282;1764.5323989142887;1794.1388133695768;1847.7690288713911;9056.13966673165;9105.180533751927;9247.306452016126;9326.580303886341;9454.716358509188;1683.6885176242433;1707.3256063854708;1734.80049794274;1740.7649967254513;1779.7597324361304;53672;56197;56662.7166864163;56720.43279567193;56893.43106568923;9383.5308234588;9669.323147379757;9775.51122443875;9811.460369679737;9819.312648114706;12501.124921255607;12506.624801255977;12510.499580016698;12532.81200781989;12538.122331436713;6484.351564843478;6591.472682185414;6670.032845237413;6943.340382663639;7093.538919970289;6173.104899789595;6326.2724786649205;6333.68331583419;6378.617282962944;6379.170707807955;4081.9387709184384;4170.979145104255;4181.1010632714115;4221.366794980716;4221.387898754725;1564.8982816116916;1602.7836242107167;1651.4880387080043;1664.8335166483498;1673.0798061066364;840.470503582739;847.9279261262861;865.7056600755773;908.822779557993;926.1016813690709;12411.952027915473;14052.297385130703;15043.187254165747;15049.473268435771;15890.682186356207;785.2030189357806;843.9746807595782;906.8911730592371;926.1942110364026;951.6431338248157;9013.18881300686;9230.953845230864;9242.584083716249;9270.629174832931;9329.673461428953;435967;436101.81949090684;457344;460104;463140;65765.34234657593;69044.6547767258;69256.30743692498;69445;69618.3038169622;1038.8285932821152;1040.573364920379;1044.7335929338121;1045.1325399917898;1051.0593019247883;14090.859091409366;14292.285385730464;14463.27683615836;14601.12393256408;14613.488527901472;29006.419871602873;29089.854550727112;30842.383152337276;32657.346853062332;33843.15392115217;35244.47133293054;36246;36554.634453655126;38631.42052869153;38866.6113338863;8963.462192268486;9029.864552031857;9067.95466022692;9123.087691230823;9341.065893410605;12681.619551413472;16348.427805026768;16383.098929558988;16809;16866.831331686528;13739.862601373858;13753.174809511462;13939.442422302995;14157.221352825694;14190.361433735714;13365.39855706515;13622.455101795817;13631.591052268448;13904.930475347559;14049.648758780704;9598.776538323116;12398.132130751123;13204.405801739136;14358.85641143617;14467.059641123293;8799.428037177562;8991.865122023306;9011.774705632411;9080.228180604458;9124.27005839518;9331.67339143154;9553.283503737108;12027.579034733742;13400.731985360433;14344.49794257196 01:11:05 INFO - 2015-11-24 01:11:05,589 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1193.2184419205412;1597.3929906635478;1626.7641192027156;1658.6848498785237;1664.658744957284;5777.277840269966;6447.065175549548;6768.037269191928;6771.322867713232;6775.966120169404;6536.509761767875;6651.534392592521;6664;6668.099806526117;6675.499337549691;1698.2527687817383;1715.4596302164841;1715.8884672496247;1935.4290484307094;1956.5597740508342;1744.0669241955557;1747.3709464592737;2041.4794227471973;2096.748390193179;2106.5260316428758;1950.6781381072105;1953.3846838245906;1953.4139758072592;1953.8143876331796;1956.1197461142472;1982.851286153537;2039.7246371739848;2040.6224848403092;2046.928357507495;2047.0481226229874;2027.1384661518796;2033.918643254268;2062.4328309714797;2066.9379918602467;2068.1003763362987;6867.381935625767;6899.48253880961;6907.758228461979;6940.583564986117;6952.374286314256;3896.980515097435;3954.4661470701662;3963.742356746802;3966.365381538969;3967.5834037425943;2688.731126887315;2738.1101142128887;2772.223777342327;2778.8332700038063;2788.2750484873877;853.2295486864718;862.310151878501;865.4071960706935;867.5705525764723;915.2357781252662;9126.26989840811;9167.495787731672;9173.816523669557;9195.21840643546;9211.53942302889;3751.15598990225;3779.3952967525065;3877.379619260961;3937.330653788863;3943.8225279862477;8008.679652813938;8013.599320033975;8022.679092836338;8031.437799354106;8036.357091432671;3980.7213495055066;3995.640392364643;3998.9200215996098;4002;4005.3991901214467;3627.4921510988484;3631.455281707712;3634.127809325743;3635.236600313911;3642.8360723767496;3334.5164951081956;3340.0814775936324;3350.748693847971;3384.695377415995;3390.067731373892;880.2649787427441;928.6378312458012;1054.3146954479496;1060.6022741471947;1071.8660167479065;887.9955600221957;893.1024320557798;895.1048951048951;933.5425641435647;1096.7751610919743;6456.935430645727;6513.12072870166;6516.348365163541;6520.836979075466;6524.249711283168;929;931.5202670624634;965.0687086961116;1022.1414012229615;1040.505759764106;5104.617153713486;5203.7918483261;5228.843134705965;5232.869178270574;5236.92144617831;7879.054513458422;8017.7995550110545;8101.675932962733;8118.553479558681;8122.309603683753;7893.289603935674;7901.17037711032;7929.286364227132;7931;7948.841023179504;6472.288048314682;6566.868662626816;6582.144321238304;6602.735890564323;6607.57050791697;6543.083968244545;6595;6608.603483790988;6611.2727599963;6618.702158402787;7081.398081163159;7353.411727061929;7405.148407933157;7409.37020353276;7410.925890741024;7517.849643007218;7524.962375188089;7733.613319334123;7764.61176941162;7839.490433121829;6182.783602573888;6183.443490085914;6183.752649893954;6184.257889053162;6211.844703882439;6683.097781799589;6737.865242695217;6753.831154221184;6757.459403247827;6770.796876093725;5454.834447612305;5507.173923911445;5532.474414930575;6237.469815065589;6290.496760259077;6051.062085376773;6071.908921366271;6108.57239993214;6115.602485838406;6131.601445906002;6262.060690896402;6285.717142728497;6308.148399965946;6324.525660575568;6324.557280990287;5745.770169193185;5853.736581853912;5875.706214689163;5877.529797616266;5880;5864.794732184353;5877.471027607536;5897.026990546512;5904.822855314175;5905.055191169392 01:11:05 INFO - 2015-11-24 01:11:05,592 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.4684848363847;315.4038866542236;316.3041309119936;319.05400487554414;322.6966651347731;5274.498922602352;5285.762140703668;5435.673859568424;5459.918101228474;5491.313585801775;5222.060029194743;5389.272448219489;5392.460753924605;5403.945960540394;5418.078926582481;3984.980075099635;4059.391091336294;4215.515215750182;4219.641330486897;4220.641245494121;4089.1208390196102;4147.813348399314;4148.253314403406;4149.04571948452;4150.460440142777;4098;4106.7125301228925;4107.1580326033245;4111.650509706678;4112.05422752767;4103.753774773523;4130.359794231914;4154.480689913761;4160.625543701081;4164.3961625564125;3615.4215325547784;3621.619729928372;3624.637536246354;3625.4380571011534;3632;5065.417476990119;5257.553107985826;5271.103912334874;5280.709560974145;5284.128118860383;4793.568578827887;4795.544423279818;4798.304245884327;4798.952010479886;4800.927986080212;5429.104197807357;5588.888222235573;5717.085266357363;5718.628289161233;5722.113072473773;3825.464434979105;3860.961390386088;3872.8644497442738;3878.166194268246;3880.185161116169;5896.439838215363;6009.639421634716;6011.819645410601;6016.278046634432;6020.247469066323;4092.07928216149;4093.4473846030405;4093.713440059167;4093.7543747375253;4094.0174358154422;4029.879103626896;4130.648894843912;4149.460570125864;4154.376843473503;4154.771487568213;4731.1720448921305;4765.213739732905;4766.928496072562;4767.73777442237;4768.451628062748;5700.4299570043495;5701.629394089371;5702.173184888168;5702.7718891243885;5715.685637289906;1442.2500299844232;1473.6315921019745;1475.2697414779752;1476.5275111964067;1477.3573495529479;933.9626414943463;984.1880448629909;990.4997976022063;1004.1966426858484;1011.5397494140149;5013.273075404119;5021.974890125599;5025.6482046256415;5026.773795179226;5030.89938201234;5912.970435147797;5923.141144534018;5923.911141332884;5924.555658325643;5924.7333869975955;4978.925316120261;5006.374203224597;5014.699118052856;5029.974850125726;5034.0686972910125;3117.703818137273;3168.1446009577285;3204.0387883634817;3204.7436205103536;3210.2295449092517;5601.131824567117;5607.271054762855;5609.074502707089;5616.606837521416;5621.184928185472;6077.969610151921;6081.391860813972;6085.269767627825;6090;6097.664628445389;5607.635503692247;5612.326520817446;5615.6630602164005;5617.410171931889;5617.747201375948;5652.180433837153;5810.709464526842;5840.620359676607;5966.940330596639;6006;5637.887242255214;5830.183774271521;5834.766609335748;5850.5027072699295;5853.473187413153;5658.490735833795;5659.26429564154;5661.885962720405;5662.886742265214;5669.177969194526;4071.7353372030725;4140.254754144283;4140.896477588084;4142.730722503027;4147.129102888307;5832.950068987623;5968.22413086296;5997.580169388101;5998.970005149947;6006.699665016644;5741.62679425836;5747.655140691572;5756.16535602327;5757.877213943241;5760.683162425939;5734.483896449339;5746.965546201556;5747.19539264495;5755.510781583444;5762.798302059576;5423.29497165366;5616;5635.9436405635415;5641.915371269516;5644.745986430703;5770.942290577041;5772.278465191851;5775.5090817281;5782.797602084075;5789.884202315846;5662.03745363281;5662.292213473316;5664.065429204135;5664.405237450009;5669.688167150846 01:11:05 INFO - 2015-11-24 01:11:05,592 DEBUG : BROWSER_OUTPUT: |5;yui.html;701.2776839854948;715.4419552748855;747.137056699512;759.8822182561705;777.953322800632;11673.41632918354;11914.880851191485;11940.880591194085;11948.701282467942;11976.580819671313;11143.609973650924;11218.887811121886;11241.100711943045;11279;11292.096632269418;586.5424968524536;600.582595096406;750.827309718765;768.3430666779907;769.4767558060516;758.457702742539;761.3604572159385;766.7431410477469;767.2595944913157;767.4205974489281;608.7838817219889;625.2715586341906;781.0432220529834;789.4118881433341;790.8220650353653;785.2500861677084;800.9399295052895;801.2508304735092;801.4510060608502;801.6953557648114;591.470633782762;592.8606777407306;593.7268856326095;594.3818428834007;594.8542607061254;11909.94045029778;11934.22427542207;12052.698682532919;12058.819117713241;12059.57791477294;10816.296940698829;11704;11761.176717629769;11892.881071189264;12107.93946030273;9414.905850941472;9547.236221102296;9562.091601297865;9629.807403851884;10830.458477076194;3159.921001974946;3170.144061103489;3173.666764989689;3207.3585282943504;3265.6571060038827;43900.341494877604;44123.77938110321;44721;44830.32754508685;44837.327440088426;9242.630294788267;9283.814323713488;9408.764780880396;9417.90582094184;9428.764280892896;15922.76115858263;15946.04323740556;15950.601234968986;15963.521094367188;15982.280797364147;6278;6288.151099601587;6333.398327158912;6365.2361716594305;6523.18460192476;3469.6356882527475;3544.929101417957;3552.715782737375;3563.2160924596546;3585;2644.457886133338;2649.417128231786;2655.7875369970357;2668.066176838091;2669.692985306676;468.68363854398825;480.7548150443299;482.3753239554715;489.18550613229286;496.4291065274963;409.4268024765352;415.4412315435734;420.5962276214868;441.1860118082133;442.75427137938755;6300.558960872695;6496.447801936888;6584.8024559263295;6714.093597364294;6717.462602991749;465.72056765940164;552.1469329885336;567.8495198772329;573.6615396915756;577.177522031104;3129.8122112673313;3301.8679252830098;3306.966930330714;3690.870819521304;3751.9249615007548;48705.26942095871;49061.75469122631;49263.75368123136;49438;49450.50549494459;41074.589254107676;42106.578934210265;42216.57783422188;42654.78672606679;42693.146137077085;40679.7966010168;41770.58229417667;41783;42137.1572568553;42546.936326591465;7044.29557044312;7414.4439167063765;7484.962575187089;7602.011738473963;7798.610069496389;30612.540811888284;30802;31396.37207255888;31469;31493.212669682525;38878.805605971786;41022.679180462306;41338.379924301764;41355;41698.58301416947;9144.862827057466;9487.241020718464;9621.615135394786;9632.422054676741;9679;9774.31579789408;9780.266480013885;9839.065288797552;10013.048760367754;10166.745831354276;9235.538223088954;9391.906080939376;9400.905990940277;9412.764680883032;9423.528823558932;9327.06729327089;9352.625894964398;9378.577963991773;9385.765355866159;9396.483193424427;9694.85457718149;9788.070133337322;9827.606895724091;9833.557489912828;9834.164096051916;8273.669053237803;8309.459885107448;8339.916600833914;8508.106648801786;8743.03826579063;7903.644336004779;8161.347092232489;8252.752417427488;8361.790955225924;8384.245417912418 01:11:05 INFO - 2015-11-24 01:11:05,592 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:11:05 INFO - 2015-11-24 01:11:05,593 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:11:05 INFO - 2015-11-24 01:11:05,593 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1103 01:11:05 INFO - 2015-11-24 01:11:05,593 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:11:05 INFO - 2015-11-24 01:11:05,593 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356265581__endTimestamp 01:11:05 INFO - 2015-11-24 01:11:05,594 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:11:05 INFO - 2015-11-24 01:11:05,594 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:11:05 INFO - 2015-11-24 01:11:05,594 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,596 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4598.62 Median:4751.48 stddev:474.78 (10.0%) stddev-sans-first:449.64 01:11:05 INFO - 2015-11-24 01:11:05,596 DEBUG : BROWSER_OUTPUT: Values: 2601.3 2680.0 2684.6 2689.6 2700.0 4527.8 4564.5 4597.0 4623.8 4680.3 4597.7 4618.1 4672.7 4673.1 4686.6 4296.2 4298.9 4305.1 4332.9 4353.0 4205.9 4380.6 4393.7 4411.1 4424.8 4203.5 4284.7 4286.2 4312.7 4313.8 4340.5 4374.2 4380.0 4407.8 4411.4 4133.8 4339.2 4351.3 4354.7 4406.7 4534.2 4561.4 4598.8 4708.8 4740.2 5006.6 5034.9 5035.1 5037.8 5074.5 4819.2 5050.2 5059.7 5060.3 5065.3 4582.4 4597.7 4613.2 4618.5 4688.0 5136.2 5165.8 5175.8 5184.0 5221.8 4713.0 4949.4 4956.8 4960.4 5006.1 4865.1 4907.5 4925.7 4929.9 4979.4 4908.0 4915.8 4917.3 4920.2 4948.5 4954.9 4964.0 4965.3 4967.1 4969.1 4001.6 4051.3 4051.9 4093.8 4233.3 3609.1 3615.0 3627.5 3639.9 3662.1 4292.9 4293.6 4300.8 4326.5 4327.7 4806.9 4920.2 4925.6 5004.1 5004.1 4222.0 4295.3 4305.4 4339.9 4341.6 4386.7 4465.5 4482.7 4498.8 4529.1 4564.6 4773.5 4797.4 4804.6 4840.5 4878.0 4901.3 4937.9 4939.0 4973.0 4746.4 4753.5 4753.8 4757.8 4811.1 4916.2 4916.4 4919.2 4922.3 4958.8 4790.3 4948.9 4960.8 4992.4 5036.6 4781.1 4798.1 4844.4 4852.2 4877.9 4769.8 4795.3 4819.7 4824.3 4854.5 4579.6 4668.3 4708.6 4711.2 4761.0 4751.5 4782.7 4819.0 4846.4 4876.8 4756.8 4774.4 4778.6 4785.3 4812.4 01:11:05 INFO - 2015-11-24 01:11:05,596 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,597 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39777.71 Median:29687.56 stddev:63122.67 (212.6%) stddev-sans-first:63231.08 01:11:05 INFO - 2015-11-24 01:11:05,598 DEBUG : BROWSER_OUTPUT: Values: 565.6 571.9 573.7 580.1 581.6 27641.3 28102.7 36053.9 36610.6 36623.3 39682.8 40300.0 40317.6 40327.0 40358.2 6835.3 6959.6 7758.4 7924.4 7935.5 9880.0 10102.5 10185.3 10192.7 10194.9 9927.1 10011.6 10020.3 10023.6 10027.6 6953.6 7108.4 7110.8 7112.1 9713.5 9901.4 10222.2 10230.3 10233.4 10235.1 36390.3 36844.8 36904.3 36908.3 36916.0 2604.1 2606.6 2648.7 2726.4 3088.6 27527.9 27966.3 28221.7 28357.7 28421.9 3290.4 3314.3 3327.4 3343.4 3420.1 218222.0 220910.0 221068.0 221551.9 221575.0 47610.5 49183.5 51851.7 52216.7 52254.2 53573.0 54519.5 54528.2 54749.5 54788.0 13530.0 13710.9 13718.5 13730.4 13734.6 10506.5 10587.8 10601.8 10602.2 10602.5 16840.6 16945.2 16976.2 17646.9 17703.2 6887.6 7007.8 7159.5 7160.5 7195.6 900.4 906.3 917.6 994.1 1028.5 25941.7 25972.7 25990.1 26208.9 26306.3 943.1 972.2 991.8 993.3 1044.3 13613.3 14855.9 14909.5 15123.0 15140.5 256779.0 260711.0 260935.0 261741.0 261847.0 44222.6 44399.6 44511.0 44575.0 44583.0 1202.8 1222.6 1224.2 1226.5 1229.0 25271.9 25938.0 26684.2 26851.2 26856.5 39671.4 41456.0 41459.0 41461.2 41468.4 235752.0 241415.0 244233.0 252101.0 252260.0 26140.3 26161.3 26185.2 26244.7 26256.9 34612.7 34841.3 35468.0 35821.6 37788.4 30706.7 32443.7 32706.8 33094.8 33412.8 28668.4 31673.8 31901.7 31995.0 32083.5 31751.7 32155.5 32191.7 32216.5 32300.5 25655.7 27069.5 27091.9 27098.7 27173.0 21398.5 21609.5 21654.0 21696.5 21706.7 01:11:05 INFO - 2015-11-24 01:11:05,598 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,598 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24862.79 Median:4176.04 stddev:73610.04 (1762.7%) stddev-sans-first:73793.49 01:11:05 INFO - 2015-11-24 01:11:05,598 DEBUG : BROWSER_OUTPUT: Values: 332.6 333.6 334.8 336.3 336.9 12533.5 12880.7 15310.7 15611.7 16964.4 11804.2 15441.5 15552.1 15718.5 15719.3 4818.5 4929.8 4935.5 4950.9 5074.8 3375.5 3464.5 4964.5 4969.1 5110.1 5002.9 5012.1 5031.2 5051.0 5052.8 4774.0 4775.7 4777.4 4828.0 5017.0 4872.6 4989.5 5002.4 5002.7 5012.8 11552.2 16810.0 18267.5 18557.4 18725.2 1731.7 1759.4 1764.5 1794.1 1847.8 9056.1 9105.2 9247.3 9326.6 9454.7 1683.7 1707.3 1734.8 1740.8 1779.8 53672.0 56197.0 56662.7 56720.4 56893.4 9383.5 9669.3 9775.5 9811.5 9819.3 12501.1 12506.6 12510.5 12532.8 12538.1 6484.4 6591.5 6670.0 6943.3 7093.5 6173.1 6326.3 6333.7 6378.6 6379.2 4081.9 4171.0 4181.1 4221.4 4221.4 1564.9 1602.8 1651.5 1664.8 1673.1 840.5 847.9 865.7 908.8 926.1 12412.0 14052.3 15043.2 15049.5 15890.7 785.2 844.0 906.9 926.2 951.6 9013.2 9231.0 9242.6 9270.6 9329.7 435967.0 436101.8 457344.0 460104.0 463140.0 65765.3 69044.7 69256.3 69445.0 69618.3 1038.8 1040.6 1044.7 1045.1 1051.1 14090.9 14292.3 14463.3 14601.1 14613.5 29006.4 29089.9 30842.4 32657.3 33843.2 35244.5 36246.0 36554.6 38631.4 38866.6 8963.5 9029.9 9068.0 9123.1 9341.1 12681.6 16348.4 16383.1 16809.0 16866.8 13739.9 13753.2 13939.4 14157.2 14190.4 13365.4 13622.5 13631.6 13904.9 14049.6 9598.8 12398.1 13204.4 14358.9 14467.1 8799.4 8991.9 9011.8 9080.2 9124.3 9331.7 9553.3 12027.6 13400.7 14344.5 01:11:05 INFO - 2015-11-24 01:11:05,598 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,599 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4795.84 Median:6183.11 stddev:2469.36 (39.9%) stddev-sans-first:2461.44 01:11:05 INFO - 2015-11-24 01:11:05,599 DEBUG : BROWSER_OUTPUT: Values: 1193.2 1597.4 1626.8 1658.7 1664.7 5777.3 6447.1 6768.0 6771.3 6776.0 6536.5 6651.5 6664.0 6668.1 6675.5 1698.3 1715.5 1715.9 1935.4 1956.6 1744.1 1747.4 2041.5 2096.7 2106.5 1950.7 1953.4 1953.4 1953.8 1956.1 1982.9 2039.7 2040.6 2046.9 2047.0 2027.1 2033.9 2062.4 2066.9 2068.1 6867.4 6899.5 6907.8 6940.6 6952.4 3897.0 3954.5 3963.7 3966.4 3967.6 2688.7 2738.1 2772.2 2778.8 2788.3 853.2 862.3 865.4 867.6 915.2 9126.3 9167.5 9173.8 9195.2 9211.5 3751.2 3779.4 3877.4 3937.3 3943.8 8008.7 8013.6 8022.7 8031.4 8036.4 3980.7 3995.6 3998.9 4002.0 4005.4 3627.5 3631.5 3634.1 3635.2 3642.8 3334.5 3340.1 3350.7 3384.7 3390.1 880.3 928.6 1054.3 1060.6 1071.9 888.0 893.1 895.1 933.5 1096.8 6456.9 6513.1 6516.3 6520.8 6524.2 929.0 931.5 965.1 1022.1 1040.5 5104.6 5203.8 5228.8 5232.9 5236.9 7879.1 8017.8 8101.7 8118.6 8122.3 7893.3 7901.2 7929.3 7931.0 7948.8 6472.3 6566.9 6582.1 6602.7 6607.6 6543.1 6595.0 6608.6 6611.3 6618.7 7081.4 7353.4 7405.1 7409.4 7410.9 7517.8 7525.0 7733.6 7764.6 7839.5 6182.8 6183.4 6183.8 6184.3 6211.8 6683.1 6737.9 6753.8 6757.5 6770.8 5454.8 5507.2 5532.5 6237.5 6290.5 6051.1 6071.9 6108.6 6115.6 6131.6 6262.1 6285.7 6308.1 6324.5 6324.6 5745.8 5853.7 5875.7 5877.5 5880.0 5864.8 5877.5 5897.0 5904.8 5905.1 01:11:05 INFO - 2015-11-24 01:11:05,599 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,599 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4729.78 Median:5390.87 stddev:1400.45 (26.0%) stddev-sans-first:1364.43 01:11:05 INFO - 2015-11-24 01:11:05,600 DEBUG : BROWSER_OUTPUT: Values: 305.5 315.4 316.3 319.1 322.7 5274.5 5285.8 5435.7 5459.9 5491.3 5222.1 5389.3 5392.5 5403.9 5418.1 3985.0 4059.4 4215.5 4219.6 4220.6 4089.1 4147.8 4148.3 4149.0 4150.5 4098.0 4106.7 4107.2 4111.7 4112.1 4103.8 4130.4 4154.5 4160.6 4164.4 3615.4 3621.6 3624.6 3625.4 3632.0 5065.4 5257.6 5271.1 5280.7 5284.1 4793.6 4795.5 4798.3 4799.0 4800.9 5429.1 5588.9 5717.1 5718.6 5722.1 3825.5 3861.0 3872.9 3878.2 3880.2 5896.4 6009.6 6011.8 6016.3 6020.2 4092.1 4093.4 4093.7 4093.8 4094.0 4029.9 4130.6 4149.5 4154.4 4154.8 4731.2 4765.2 4766.9 4767.7 4768.5 5700.4 5701.6 5702.2 5702.8 5715.7 1442.3 1473.6 1475.3 1476.5 1477.4 934.0 984.2 990.5 1004.2 1011.5 5013.3 5022.0 5025.6 5026.8 5030.9 5913.0 5923.1 5923.9 5924.6 5924.7 4978.9 5006.4 5014.7 5030.0 5034.1 3117.7 3168.1 3204.0 3204.7 3210.2 5601.1 5607.3 5609.1 5616.6 5621.2 6078.0 6081.4 6085.3 6090.0 6097.7 5607.6 5612.3 5615.7 5617.4 5617.7 5652.2 5810.7 5840.6 5966.9 6006.0 5637.9 5830.2 5834.8 5850.5 5853.5 5658.5 5659.3 5661.9 5662.9 5669.2 4071.7 4140.3 4140.9 4142.7 4147.1 5833.0 5968.2 5997.6 5999.0 6006.7 5741.6 5747.7 5756.2 5757.9 5760.7 5734.5 5747.0 5747.2 5755.5 5762.8 5423.3 5616.0 5635.9 5641.9 5644.7 5770.9 5772.3 5775.5 5782.8 5789.9 5662.0 5662.3 5664.1 5664.4 5669.7 01:11:05 INFO - 2015-11-24 01:11:05,600 DEBUG : BROWSER_OUTPUT: 01:11:05 INFO - 2015-11-24 01:11:05,600 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12086.23 Median:570.76 stddev:14056.59 (2462.8%) stddev-sans-first:14070.02 01:11:05 INFO - 2015-11-24 01:11:05,602 DEBUG : BROWSER_OUTPUT: Values: 701.3 715.4 747.1 759.9 778.0 11673.4 11914.9 11940.9 11948.7 11976.6 11143.6 11218.9 11241.1 11279.0 11292.1 586.5 600.6 750.8 768.3 769.5 758.5 761.4 766.7 767.3 767.4 608.8 625.3 781.0 789.4 790.8 785.3 800.9 801.3 801.5 801.7 591.5 592.9 593.7 594.4 594.9 11909.9 11934.2 12052.7 12058.8 12059.6 10816.3 11704.0 11761.2 11892.9 12107.9 9414.9 9547.2 9562.1 9629.8 10830.5 3159.9 3170.1 3173.7 3207.4 3265.7 43900.3 44123.8 44721.0 44830.3 44837.3 9242.6 9283.8 9408.8 9417.9 9428.8 15922.8 15946.0 15950.6 15963.5 15982.3 6278.0 6288.2 6333.4 6365.2 6523.2 3469.6 3544.9 3552.7 3563.2 3585.0 2644.5 2649.4 2655.8 2668.1 2669.7 468.7 480.8 482.4 489.2 496.4 409.4 415.4 420.6 441.2 442.8 6300.6 6496.4 6584.8 6714.1 6717.5 465.7 552.1 567.8 573.7 577.2 3129.8 3301.9 3307.0 3690.9 3751.9 48705.3 49061.8 49263.8 49438.0 49450.5 41074.6 42106.6 42216.6 42654.8 42693.1 40679.8 41770.6 41783.0 42137.2 42546.9 7044.3 7414.4 7485.0 7602.0 7798.6 30612.5 30802.0 31396.4 31469.0 31493.2 38878.8 41022.7 41338.4 41355.0 41698.6 9144.9 9487.2 9621.6 9632.4 9679.0 9774.3 9780.3 9839.1 10013.0 10166.7 9235.5 9391.9 9400.9 9412.8 9423.5 9327.1 9352.6 9378.6 9385.8 9396.5 9694.9 9788.1 9827.6 9833.6 9834.2 8273.7 8309.5 8339.9 8508.1 8743.0 7903.6 8161.3 8252.8 8361.8 8384.2 01:11:05 INFO - 2015-11-24 01:11:05,602 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:11:05 INFO - 2015-11-24 01:11:05,602 DEBUG : BROWSER_OUTPUT: 01:11:06 INFO - 2015-11-24 01:11:06,357 INFO : Browser exited with error code: 0 01:11:06 INFO - 2015-11-24 01:11:06,381 INFO : Completed test dromaeo_css (00:18:37) 01:11:06 INFO - 2015-11-24 01:11:06,381 INFO : Starting test kraken 01:11:06 INFO - 2015-11-24 01:11:06,381 DEBUG : operating with platform_type : linux_ 01:11:06 INFO - 2015-11-24 01:11:06,381 INFO : Initialising browser for kraken test... 01:11:06 INFO - 2015-11-24 01:11:06,387 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcK8T6c/profile http://localhost:57929/getInfo.html 01:11:10 INFO - 2015-11-24 01:11:10,392 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:11:10 INFO - 2015-11-24 01:11:10,392 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:11:10 INFO - 2015-11-24 01:11:10,392 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:11:10 INFO - 2015-11-24 01:11:10,393 DEBUG : BROWSER_OUTPUT: __metrics 01:11:10 INFO - 2015-11-24 01:11:10,549 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:11:11 INFO - 2015-11-24 01:11:11,908 INFO : Browser initialized. 01:11:11 INFO - 2015-11-24 01:11:11,909 INFO : Running cycle 1/1 for kraken test... 01:11:11 INFO - 2015-11-24 01:11:11,909 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcK8T6c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:11:23 INFO - 2015-11-24 01:11:23,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 140468224 01:11:23 INFO - 2015-11-24 01:11:23,859 DEBUG : BROWSER_OUTPUT: 01:11:26 INFO - 2015-11-24 01:11:26,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57929/tests/kraken/driver.html?testName=audio-beat-detection) 01:11:27 INFO - 2015-11-24 01:11:27,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 180101120 01:11:27 INFO - 2015-11-24 01:11:27,069 DEBUG : BROWSER_OUTPUT: 01:11:29 INFO - 2015-11-24 01:11:29,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57929/tests/kraken/driver.html?testName=audio-dft) 01:11:30 INFO - 2015-11-24 01:11:30,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 169058304 01:11:30 INFO - 2015-11-24 01:11:30,335 DEBUG : BROWSER_OUTPUT: 01:11:33 INFO - 2015-11-24 01:11:33,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57929/tests/kraken/driver.html?testName=audio-fft) 01:11:33 INFO - 2015-11-24 01:11:33,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 153645056 01:11:33 INFO - 2015-11-24 01:11:33,924 DEBUG : BROWSER_OUTPUT: 01:11:35 INFO - 2015-11-24 01:11:35,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57929/tests/kraken/driver.html?testName=audio-oscillator) 01:11:36 INFO - 2015-11-24 01:11:36,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 154697728 01:11:36 INFO - 2015-11-24 01:11:36,561 DEBUG : BROWSER_OUTPUT: 01:11:38 INFO - 2015-11-24 01:11:38,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:11:39 INFO - 2015-11-24 01:11:39,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 157548544 01:11:39 INFO - 2015-11-24 01:11:39,381 DEBUG : BROWSER_OUTPUT: 01:11:42 INFO - 2015-11-24 01:11:42,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57929/tests/kraken/driver.html?testName=imaging-darkroom) 01:11:42 INFO - 2015-11-24 01:11:42,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 156061696 01:11:42 INFO - 2015-11-24 01:11:42,991 DEBUG : BROWSER_OUTPUT: 01:11:46 INFO - 2015-11-24 01:11:46,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57929/tests/kraken/driver.html?testName=imaging-desaturate) 01:11:46 INFO - 2015-11-24 01:11:46,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 157683712 01:11:46 INFO - 2015-11-24 01:11:46,983 DEBUG : BROWSER_OUTPUT: 01:11:49 INFO - 2015-11-24 01:11:49,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57929/tests/kraken/driver.html?testName=json-parse-financial) 01:11:50 INFO - 2015-11-24 01:11:50,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 157024256 01:11:50 INFO - 2015-11-24 01:11:50,385 DEBUG : BROWSER_OUTPUT: 01:11:52 INFO - 2015-11-24 01:11:52,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:11:52 INFO - 2015-11-24 01:11:52,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 166178816 01:11:52 INFO - 2015-11-24 01:11:52,717 DEBUG : BROWSER_OUTPUT: 01:11:54 INFO - 2015-11-24 01:11:54,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:11:55 INFO - 2015-11-24 01:11:55,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 165318656 01:11:55 INFO - 2015-11-24 01:11:55,200 DEBUG : BROWSER_OUTPUT: 01:11:57 INFO - 2015-11-24 01:11:57,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:11:57 INFO - 2015-11-24 01:11:57,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 174977024 01:11:57 INFO - 2015-11-24 01:11:57,915 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-11-24 01:12:00,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:12:01 INFO - 2015-11-24 01:12:01,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 181637120 01:12:01 INFO - 2015-11-24 01:12:01,046 DEBUG : BROWSER_OUTPUT: 01:12:03 INFO - 2015-11-24 01:12:03,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:12:04 INFO - 2015-11-24 01:12:04,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 180486144 01:12:04 INFO - 2015-11-24 01:12:04,252 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57929/tests/kraken/driver.html?testName=ai-astar) 01:12:06 INFO - 2015-11-24 01:12:06,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 239398912 01:12:06 INFO - 2015-11-24 01:12:06,251 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,251 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:12:06 INFO - 2015-11-24 01:12:06,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:12:06 INFO - 2015-11-24 01:12:06,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:12:06 INFO - 2015-11-24 01:12:06,251 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:12:06 INFO - 2015-11-24 01:12:06,252 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;106;122;114;113;105;112;113;106 01:12:06 INFO - 2015-11-24 01:12:06,252 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;151;164;130;150;155;131;167;131 01:12:06 INFO - 2015-11-24 01:12:06,252 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;159;161;160;163;161;162;161 01:12:06 INFO - 2015-11-24 01:12:06,252 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;88;110;71;72;74;97;91;72 01:12:06 INFO - 2015-11-24 01:12:06,252 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;129;93;94;94;137;94;94;131 01:12:06 INFO - 2015-11-24 01:12:06,254 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;109;109;111;109;112 01:12:06 INFO - 2015-11-24 01:12:06,254 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;146;147;147;147;153;147;146;147 01:12:06 INFO - 2015-11-24 01:12:06,254 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;96;96;95;96 01:12:06 INFO - 2015-11-24 01:12:06,254 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;72;72;70;71;72;79;69;81 01:12:06 INFO - 2015-11-24 01:12:06,254 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;68;69;68;68;68;68 01:12:06 INFO - 2015-11-24 01:12:06,254 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;91;83;85;84;84;85;85;84 01:12:06 INFO - 2015-11-24 01:12:06,254 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;128;127;119;124;124;128;131;122;129 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;148;148;153;152;137;155;147;155;137 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;69;70;71;70;70;68;70;72 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,977 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356326250__endTimestamp 01:12:06 INFO - 2015-11-24 01:12:06,255 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:5.03 (4.5%) stddev-sans-first:5.32 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 106.0 122.0 114.0 113.0 105.0 112.0 113.0 106.0 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.20 Median:152.00 stddev:14.52 (9.6%) stddev-sans-first:15.19 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 151.0 164.0 130.0 150.0 155.0 131.0 167.0 131.0 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 01:12:06 INFO - 2015-11-24 01:12:06,259 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 159.0 161.0 160.0 163.0 161.0 162.0 161.0 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:73.00 stddev:13.95 (19.1%) stddev-sans-first:14.25 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 88.0 110.0 71.0 72.0 74.0 97.0 91.0 72.0 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:94.00 stddev:18.63 (19.8%) stddev-sans-first:19.29 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 129.0 93.0 94.0 94.0 137.0 94.0 94.0 131.0 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:109.50 stddev:1.06 (1.0%) stddev-sans-first:1.12 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 109.0 109.0 111.0 109.0 112.0 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:2.07 (1.4%) stddev-sans-first:2.18 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 146.0 147.0 147.0 147.0 153.0 147.0 146.0 147.0 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 01:12:06 INFO - 2015-11-24 01:12:06,260 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.90 Median:72.00 stddev:3.90 (5.4%) stddev-sans-first:4.12 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 72.0 70.0 71.0 72.0 79.0 69.0 81.0 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 68.0 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:2.55 (3.0%) stddev-sans-first:2.35 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 91.0 83.0 85.0 84.0 84.0 85.0 85.0 84.0 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:127.50 stddev:3.69 (2.9%) stddev-sans-first:3.80 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: Values: 123.0 128.0 127.0 119.0 124.0 124.0 128.0 131.0 122.0 129.0 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:152.00 stddev:6.64 (4.4%) stddev-sans-first:6.91 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: Values: 152.0 148.0 148.0 153.0 152.0 137.0 155.0 147.0 155.0 137.0 01:12:06 INFO - 2015-11-24 01:12:06,261 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,262 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 01:12:06 INFO - 2015-11-24 01:12:06,262 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 70.0 71.0 70.0 70.0 68.0 70.0 72.0 01:12:06 INFO - 2015-11-24 01:12:06,262 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:12:06 INFO - 2015-11-24 01:12:06,262 DEBUG : BROWSER_OUTPUT: 01:12:07 INFO - 2015-11-24 01:12:07,121 INFO : Browser exited with error code: 0 01:12:07 INFO - 2015-11-24 01:12:07,172 INFO : Completed test kraken (00:01:00) 01:12:07 INFO - 2015-11-24 01:12:07,172 INFO : Starting test v8_7 01:12:07 INFO - 2015-11-24 01:12:07,172 DEBUG : operating with platform_type : linux_ 01:12:07 INFO - 2015-11-24 01:12:07,173 INFO : Initialising browser for v8_7 test... 01:12:07 INFO - 2015-11-24 01:12:07,179 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeSV_Y/profile http://localhost:57929/getInfo.html 01:12:11 INFO - 2015-11-24 01:12:11,137 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:12:11 INFO - 2015-11-24 01:12:11,137 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:12:11 INFO - 2015-11-24 01:12:11,137 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:12:11 INFO - 2015-11-24 01:12:11,137 DEBUG : BROWSER_OUTPUT: __metrics 01:12:11 INFO - 2015-11-24 01:12:11,274 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:12:12 INFO - 2015-11-24 01:12:12,598 INFO : Browser initialized. 01:12:12 INFO - 2015-11-24 01:12:12,599 INFO : Running cycle 1/1 for v8_7 test... 01:12:12 INFO - 2015-11-24 01:12:12,599 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeSV_Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:12:24 INFO - 2015-11-24 01:12:24,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 140271616 01:12:24 INFO - 2015-11-24 01:12:24,535 DEBUG : BROWSER_OUTPUT: 01:12:45 INFO - 2015-11-24 01:12:45,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57929/tests/v8_7/run.html (next: http://localhost:57929/tests/v8_7/run.html) 01:12:46 INFO - 2015-11-24 01:12:46,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 441958400 01:12:46 INFO - 2015-11-24 01:12:46,237 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,238 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:12:46 INFO - 2015-11-24 01:12:46,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:12:46 INFO - 2015-11-24 01:12:46,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |0;Richards;195.92476489028212 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.32246108228318 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4990.049751243781 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |5;Earley;797.4481658692185 01:12:46 INFO - 2015-11-24 01:12:46,239 DEBUG : BROWSER_OUTPUT: |6;Boyer;12506.172839506173 01:12:46 INFO - 2015-11-24 01:12:46,240 DEBUG : BROWSER_OUTPUT: |7;RegExp;26421.052631578947 01:12:46 INFO - 2015-11-24 01:12:46,240 DEBUG : BROWSER_OUTPUT: |8;Splay;615.6670746634027 01:12:46 INFO - 2015-11-24 01:12:46,240 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 01:12:46 INFO - 2015-11-24 01:12:46,240 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:12:46 INFO - 2015-11-24 01:12:46,240 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356366237__endTimestamp 01:12:46 INFO - 2015-11-24 01:12:46,241 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,241 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:12:46 INFO - 2015-11-24 01:12:46,241 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:12:46 INFO - 2015-11-24 01:12:46,241 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,241 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:195.92 Median:195.92 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,241 DEBUG : BROWSER_OUTPUT: Values: 195.9 01:12:46 INFO - 2015-11-24 01:12:46,242 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.32 Median:185.32 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: Values: 185.3 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: Values: 279.6 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4990.05 Median:4990.05 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: Values: 4990.0 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: Values: 1972.4 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: Values: 797.4 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,243 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: Values: 12506.2 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26421.05 Median:26421.05 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: Values: 26421.1 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.67 Median:615.67 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: Values: 615.7 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: Values: 4830.9 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:12:46 INFO - 2015-11-24 01:12:46,244 DEBUG : BROWSER_OUTPUT: 01:12:47 INFO - 2015-11-24 01:12:47,150 INFO : Browser exited with error code: 0 01:12:47 INFO - 2015-11-24 01:12:47,166 INFO : Completed test v8_7 (00:00:39) 01:12:47 INFO - 2015-11-24 01:12:47,211 INFO : Completed test suite (00:20:18) 01:12:47 INFO - 2015-11-24 01:12:47,211 DEBUG : Working with test: dromaeo_css 01:12:47 INFO - 2015-11-24 01:12:47,211 DEBUG : Generating results file: dromaeo_css 01:12:47 INFO - 2015-11-24 01:12:47,212 DEBUG : Working with test: kraken 01:12:47 INFO - 2015-11-24 01:12:47,212 DEBUG : Generating results file: kraken 01:12:47 INFO - 2015-11-24 01:12:47,213 INFO : javascript benchmark 01:12:47 INFO - 2015-11-24 01:12:47,213 DEBUG : Working with test: v8_7 01:12:47 INFO - 2015-11-24 01:12:47,213 DEBUG : Generating results file: v8_7 01:12:47 INFO - 2015-11-24 01:12:47,214 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:12:47 INFO - 2015-11-24 01:12:47,339 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 01:12:47 INFO - 2015-11-24 01:12:47,339 DEBUG : process_Request line: dromaeo_css 6196.56 graph.html#tests=[[72,132,35]] 01:12:47 INFO - 2015-11-24 01:12:47,339 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:12:47 INFO - 2015-11-24 01:12:47,367 DEBUG : process_Request line: kraken 1528.30 graph.html#tests=[[232,132,35]] 01:12:47 INFO - 2015-11-24 01:12:47,367 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:12:47 INFO - 2015-11-24 01:12:47,397 DEBUG : process_Request line: v8_7 19499.38 graph.html#tests=[[230,132,35]] 01:12:47 INFO - 2015-11-24 01:12:47,398 INFO : javascript benchmark 01:12:47 INFO - 2015-11-24 01:12:47,402 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2601.2586412872333, 2679.986600066998, 2684.5704687250045, 2689.5965605159236, 2699.973000269998, 4527.773611319437, 4564.543545645433, 4597.0, 4623.815047398104, 4680.274557443602, 4597.724136551801, 4618.122556714222, 4672.696274742148, 4673.065386922621, 4686.625069994401, 4296.2481565725875, 4298.914021719564, 4305.052888364555, 4332.935005974913, 4352.97823510882, 4205.873823785291, 4380.649548036149, 4393.714408563433, 4411.139827733593, 4424.80088396023, 4203.5376108628025, 4284.721493102938, 4286.2499062664065, 4312.741235525878, 4313.82744690212, 4340.500842403101, 4374.1689079075195, 4380.036391993756, 4407.779611019436, 4411.426514553087, 4133.81397837095, 4339.218940590692, 4351.260285751398, 4354.716943398669, 4406.735595864258, 4534.161180181644, 4561.407017087758, 4598.770061496912, 4708.764561771932, 4740.19416699162, 5006.5744411725045, 5034.89930201394, 5035.144025515635, 5037.798488060474, 5074.517920797555, 4819.228923372279, 5050.191969284933, 5059.747012649353, 5060.316857224265, 5065.316182315377, 4582.358469814229, 4597.7011494252765, 4613.192691279013, 4618.538146185355, 4687.9765601171775, 5136.1525348317855, 5165.793368265227, 5175.818846340435, 5184.0, 5221.765020574083, 4712.976435117871, 4949.430815456269, 4956.801727930842, 4960.429550601727, 5006.123928312531, 4865.148598995162, 4907.509249075064, 4925.729084900365, 4929.87675308113, 4979.402471703419, 4908.042931628298, 4915.827946021872, 4917.262410638433, 4920.21276595743, 4948.480409557017, 4954.909919817635, 4964.0, 4965.280034394992, 4967.05625931072, 4969.055879382906, 4001.559828418872, 4051.2707712611423, 4051.918961620751, 4093.836246550164, 4233.30150525166, 3609.115766637138, 3614.963850361515, 3627.4740162676794, 3639.927201455956, 3662.1027848176836, 4292.892677683083, 4293.570642935744, 4300.849470268526, 4326.502452217972, 4327.675424343187, 4806.879828004258, 4920.21276595743, 4925.581325587294, 5004.124278251292, 5004.149294619923, 4221.97889010553, 4295.334223195409, 4305.418768466279, 4339.891502712458, 4341.630961368256, 4386.692931494765, 4465.4864690561, 4482.686211965131, 4498.797554110073, 4529.071540334289, 4564.634829213722, 4773.474917759044, 4797.4482934462985, 4804.615630749532, 4840.515948405131, 4877.975610121926, 4901.289313049517, 4937.876553086202, 4939.0, 4973.0, 4746.406699162605, 4753.524647535219, 4753.811547113221, 4757.809687612456, 4811.08589368019, 4916.164252077084, 4916.360873086476, 4919.2129259318335, 4922.335484709662, 4958.801647934042, 4790.305405716082, 4948.925766113583, 4960.7767650456535, 4992.350994370709, 5036.622253330942, 4781.067691800205, 4798.1123492154065, 4844.4186697596515, 4852.223644216909, 4877.90244195107, 4769.809207631656, 4795.256735206049, 4819.7108173508295, 4824.252240902666, 4854.490278520846, 4579.564941330568, 4668.253079507263, 4708.552687494683, 4711.175544279806, 4760.952390476051, 4751.477337492804, 4782.665213435026, 4819.0, 4846.39420072491, 4876.804927802848, 4756.833510827105, 4774.379330686988, 4778.641601879804, 4785.282207668877, 4812.446568644651], "unit": "ms", "name": "dojo.html", "value": 4569.278639751576}, {"lowerIsBetter": false, "replicates": [565.6125553995513, 571.8913406452772, 573.6844735395529, 580.05161560848, 581.6161333519877, 27641.308967275803, 28102.718972810264, 36053.91838244854, 36610.633893661055, 36623.26753464929, 39682.80158599203, 40300.0, 40317.59682403175, 40326.96730326966, 40358.19283614326, 6835.28229535899, 6959.61722105284, 7758.418118641111, 7924.405669574805, 7935.484193527431, 9879.950600246988, 10102.545385457672, 10185.28702990791, 10192.745181370488, 10194.949025254864, 9927.106560409562, 10011.599536018586, 10020.298579099466, 10023.649172278972, 10027.59889604415, 6953.582785032914, 7108.395786358165, 7110.751123710697, 7112.075430194093, 9713.514324283793, 9901.405915645084, 10222.233332500093, 10230.335028223217, 10233.38599684014, 10235.130013948823, 36390.27219455596, 36844.81577592095, 36904.261914761555, 36908.26183476316, 36916.0, 2604.0760748025873, 2606.579414219255, 2648.7218842021693, 2726.4138210284686, 3088.625561625078, 27527.86236068827, 27966.300842478897, 28221.717782822114, 28357.716422835714, 28421.85789071062, 3290.391277613649, 3314.320564284316, 3327.4177019021577, 3343.3981883261004, 3420.0936751760805, 218222.0, 220910.0, 221068.0, 221551.89224053937, 221575.0, 47610.5238947613, 49183.50816491789, 51851.74074129605, 52216.73891630518, 52254.21618675647, 53573.0, 54519.45480545144, 54528.18207726887, 54749.45250547523, 54788.0, 13530.0, 13710.931445342709, 13718.519851805138, 13730.382132804049, 13734.587962361145, 10506.527206275736, 10587.84118238227, 10601.84097238542, 10602.204834637432, 10602.522886470128, 16840.57898552546, 16945.22075182113, 16976.236069376908, 17646.91176544109, 17703.20335584902, 6887.552309099892, 7007.754728584475, 7159.49650573375, 7160.498765086498, 7195.640217989079, 900.4192295969063, 906.3383729877227, 917.5687426909342, 994.1301361308855, 1028.4703377760459, 25941.74058259431, 25972.74027259741, 25990.09034683777, 26208.8689556551, 26306.342341441617, 943.0616536546044, 972.1785091597588, 991.7818080022528, 993.2798720927415, 1044.2637940252105, 13613.319334033258, 14855.851441485447, 14909.478168264059, 15123.0, 15140.470083547023, 256779.0, 260711.0, 260935.0, 261741.0, 261847.0, 44222.55777442249, 44399.55600443954, 44511.0, 44575.0, 44583.0, 1202.8135638975973, 1222.5720997650928, 1224.1981502116128, 1226.5289231474906, 1229.0413477487573, 25271.873640632413, 25938.0, 26684.19947401581, 26851.194464166107, 26856.462870742867, 39671.40492892551, 41456.0, 41459.0, 41461.170776584906, 41468.37797432981, 235752.0, 241415.0, 244233.0, 252101.0, 252260.0, 26140.34649133787, 26161.345966350993, 26185.214443566725, 26244.737552624993, 26256.8687156563, 34612.65387346094, 34841.30317393689, 35468.0, 35821.64178358183, 37788.43317350187, 30706.692933070382, 32443.675563244065, 32706.83646581752, 33094.83452582722, 33412.83293583516, 28668.42663146767, 31673.8416307917, 31901.68098318987, 31995.0, 32083.518747218342, 31751.68248317487, 32155.51766723454, 32191.678083218867, 32216.516752249205, 32300.515492268103, 25655.743442566083, 27069.458610828067, 27091.864540677958, 27098.72901270962, 27173.0, 21398.465038374165, 21609.459763506038, 21654.0, 21696.457588560414, 21706.674399883697], "unit": "ms", "name": "ext.html", "value": 16718.96707848381}, {"lowerIsBetter": false, "replicates": [332.59921794237937, 333.628004774676, 334.7924286942096, 336.34245050925426, 336.93092915952235, 12533.49866005361, 12880.74238515229, 15310.693786124271, 15611.650871232443, 16964.4062457814, 11804.173707840455, 15441.536753897373, 15552.144632045232, 15718.528444146665, 15719.292631831566, 4818.518148185189, 4929.8028078876805, 4935.53112454318, 4950.92573611397, 5074.797008119671, 3375.510550970108, 3464.532288141094, 4964.503549645025, 4969.130402179622, 5110.131277682803, 5002.924956125643, 5012.147934851084, 5031.2453132030305, 5051.0403023425615, 5052.772625231855, 4773.997460533257, 4775.665703400763, 4777.4267087949665, 4828.0, 5017.046761115376, 4872.610191184696, 4989.476105008995, 5002.449240735384, 5002.7248501332415, 5012.799488020475, 11552.191346605741, 16810.0, 18267.543311417186, 18557.350492732825, 18725.157367918477, 1731.740238964153, 1759.375421725282, 1764.5323989142887, 1794.1388133695768, 1847.7690288713911, 9056.13966673165, 9105.180533751927, 9247.306452016126, 9326.580303886341, 9454.716358509188, 1683.6885176242433, 1707.3256063854708, 1734.80049794274, 1740.7649967254513, 1779.7597324361304, 53672.0, 56197.0, 56662.7166864163, 56720.43279567193, 56893.43106568923, 9383.5308234588, 9669.323147379757, 9775.51122443875, 9811.460369679737, 9819.312648114706, 12501.124921255607, 12506.624801255977, 12510.499580016698, 12532.81200781989, 12538.122331436713, 6484.351564843478, 6591.472682185414, 6670.032845237413, 6943.340382663639, 7093.538919970289, 6173.104899789595, 6326.2724786649205, 6333.68331583419, 6378.617282962944, 6379.170707807955, 4081.9387709184384, 4170.979145104255, 4181.1010632714115, 4221.366794980716, 4221.387898754725, 1564.8982816116916, 1602.7836242107167, 1651.4880387080043, 1664.8335166483498, 1673.0798061066364, 840.470503582739, 847.9279261262861, 865.7056600755773, 908.822779557993, 926.1016813690709, 12411.952027915473, 14052.297385130703, 15043.187254165747, 15049.473268435771, 15890.682186356207, 785.2030189357806, 843.9746807595782, 906.8911730592371, 926.1942110364026, 951.6431338248157, 9013.18881300686, 9230.953845230864, 9242.584083716249, 9270.629174832931, 9329.673461428953, 435967.0, 436101.81949090684, 457344.0, 460104.0, 463140.0, 65765.34234657593, 69044.6547767258, 69256.30743692498, 69445.0, 69618.3038169622, 1038.8285932821152, 1040.573364920379, 1044.7335929338121, 1045.1325399917898, 1051.0593019247883, 14090.859091409366, 14292.285385730464, 14463.27683615836, 14601.12393256408, 14613.488527901472, 29006.419871602873, 29089.854550727112, 30842.383152337276, 32657.346853062332, 33843.15392115217, 35244.47133293054, 36246.0, 36554.634453655126, 38631.42052869153, 38866.6113338863, 8963.462192268486, 9029.864552031857, 9067.95466022692, 9123.087691230823, 9341.065893410605, 12681.619551413472, 16348.427805026768, 16383.098929558988, 16809.0, 16866.831331686528, 13739.862601373858, 13753.174809511462, 13939.442422302995, 14157.221352825694, 14190.361433735714, 13365.39855706515, 13622.455101795817, 13631.591052268448, 13904.930475347559, 14049.648758780704, 9598.776538323116, 12398.132130751123, 13204.405801739136, 14358.85641143617, 14467.059641123293, 8799.428037177562, 8991.865122023306, 9011.774705632411, 9080.228180604458, 9124.27005839518, 9331.67339143154, 9553.283503737108, 12027.579034733742, 13400.731985360433, 14344.49794257196], "unit": "ms", "name": "jquery.html", "value": 8032.1374663801225}, {"lowerIsBetter": false, "replicates": [1193.2184419205412, 1597.3929906635478, 1626.7641192027156, 1658.6848498785237, 1664.658744957284, 5777.277840269966, 6447.065175549548, 6768.037269191928, 6771.322867713232, 6775.966120169404, 6536.509761767875, 6651.534392592521, 6664.0, 6668.099806526117, 6675.499337549691, 1698.2527687817383, 1715.4596302164841, 1715.8884672496247, 1935.4290484307094, 1956.5597740508342, 1744.0669241955557, 1747.3709464592737, 2041.4794227471973, 2096.748390193179, 2106.5260316428758, 1950.6781381072105, 1953.3846838245906, 1953.4139758072592, 1953.8143876331796, 1956.1197461142472, 1982.851286153537, 2039.7246371739848, 2040.6224848403092, 2046.928357507495, 2047.0481226229874, 2027.1384661518796, 2033.918643254268, 2062.4328309714797, 2066.9379918602467, 2068.1003763362987, 6867.381935625767, 6899.48253880961, 6907.758228461979, 6940.583564986117, 6952.374286314256, 3896.980515097435, 3954.4661470701662, 3963.742356746802, 3966.365381538969, 3967.5834037425943, 2688.731126887315, 2738.1101142128887, 2772.223777342327, 2778.8332700038063, 2788.2750484873877, 853.2295486864718, 862.310151878501, 865.4071960706935, 867.5705525764723, 915.2357781252662, 9126.26989840811, 9167.495787731672, 9173.816523669557, 9195.21840643546, 9211.53942302889, 3751.15598990225, 3779.3952967525065, 3877.379619260961, 3937.330653788863, 3943.8225279862477, 8008.679652813938, 8013.599320033975, 8022.679092836338, 8031.437799354106, 8036.357091432671, 3980.7213495055066, 3995.640392364643, 3998.9200215996098, 4002.0, 4005.3991901214467, 3627.4921510988484, 3631.455281707712, 3634.127809325743, 3635.236600313911, 3642.8360723767496, 3334.5164951081956, 3340.0814775936324, 3350.748693847971, 3384.695377415995, 3390.067731373892, 880.2649787427441, 928.6378312458012, 1054.3146954479496, 1060.6022741471947, 1071.8660167479065, 887.9955600221957, 893.1024320557798, 895.1048951048951, 933.5425641435647, 1096.7751610919743, 6456.935430645727, 6513.12072870166, 6516.348365163541, 6520.836979075466, 6524.249711283168, 929.0, 931.5202670624634, 965.0687086961116, 1022.1414012229615, 1040.505759764106, 5104.617153713486, 5203.7918483261, 5228.843134705965, 5232.869178270574, 5236.92144617831, 7879.054513458422, 8017.7995550110545, 8101.675932962733, 8118.553479558681, 8122.309603683753, 7893.289603935674, 7901.17037711032, 7929.286364227132, 7931.0, 7948.841023179504, 6472.288048314682, 6566.868662626816, 6582.144321238304, 6602.735890564323, 6607.57050791697, 6543.083968244545, 6595.0, 6608.603483790988, 6611.2727599963, 6618.702158402787, 7081.398081163159, 7353.411727061929, 7405.148407933157, 7409.37020353276, 7410.925890741024, 7517.849643007218, 7524.962375188089, 7733.613319334123, 7764.61176941162, 7839.490433121829, 6182.783602573888, 6183.443490085914, 6183.752649893954, 6184.257889053162, 6211.844703882439, 6683.097781799589, 6737.865242695217, 6753.831154221184, 6757.459403247827, 6770.796876093725, 5454.834447612305, 5507.173923911445, 5532.474414930575, 6237.469815065589, 6290.496760259077, 6051.062085376773, 6071.908921366271, 6108.57239993214, 6115.602485838406, 6131.601445906002, 6262.060690896402, 6285.717142728497, 6308.148399965946, 6324.525660575568, 6324.557280990287, 5745.770169193185, 5853.736581853912, 5875.706214689163, 5877.529797616266, 5880.0, 5864.794732184353, 5877.471027607536, 5897.026990546512, 5904.822855314175, 5905.055191169392], "unit": "ms", "name": "mootools.html", "value": 3938.4537827220133}, {"lowerIsBetter": false, "replicates": [305.4684848363847, 315.4038866542236, 316.3041309119936, 319.05400487554414, 322.6966651347731, 5274.498922602352, 5285.762140703668, 5435.673859568424, 5459.918101228474, 5491.313585801775, 5222.060029194743, 5389.272448219489, 5392.460753924605, 5403.945960540394, 5418.078926582481, 3984.980075099635, 4059.391091336294, 4215.515215750182, 4219.641330486897, 4220.641245494121, 4089.1208390196102, 4147.813348399314, 4148.253314403406, 4149.04571948452, 4150.460440142777, 4098.0, 4106.7125301228925, 4107.1580326033245, 4111.650509706678, 4112.05422752767, 4103.753774773523, 4130.359794231914, 4154.480689913761, 4160.625543701081, 4164.3961625564125, 3615.4215325547784, 3621.619729928372, 3624.637536246354, 3625.4380571011534, 3632.0, 5065.417476990119, 5257.553107985826, 5271.103912334874, 5280.709560974145, 5284.128118860383, 4793.568578827887, 4795.544423279818, 4798.304245884327, 4798.952010479886, 4800.927986080212, 5429.104197807357, 5588.888222235573, 5717.085266357363, 5718.628289161233, 5722.113072473773, 3825.464434979105, 3860.961390386088, 3872.8644497442738, 3878.166194268246, 3880.185161116169, 5896.439838215363, 6009.639421634716, 6011.819645410601, 6016.278046634432, 6020.247469066323, 4092.07928216149, 4093.4473846030405, 4093.713440059167, 4093.7543747375253, 4094.0174358154422, 4029.879103626896, 4130.648894843912, 4149.460570125864, 4154.376843473503, 4154.771487568213, 4731.1720448921305, 4765.213739732905, 4766.928496072562, 4767.73777442237, 4768.451628062748, 5700.4299570043495, 5701.629394089371, 5702.173184888168, 5702.7718891243885, 5715.685637289906, 1442.2500299844232, 1473.6315921019745, 1475.2697414779752, 1476.5275111964067, 1477.3573495529479, 933.9626414943463, 984.1880448629909, 990.4997976022063, 1004.1966426858484, 1011.5397494140149, 5013.273075404119, 5021.974890125599, 5025.6482046256415, 5026.773795179226, 5030.89938201234, 5912.970435147797, 5923.141144534018, 5923.911141332884, 5924.555658325643, 5924.7333869975955, 4978.925316120261, 5006.374203224597, 5014.699118052856, 5029.974850125726, 5034.0686972910125, 3117.703818137273, 3168.1446009577285, 3204.0387883634817, 3204.7436205103536, 3210.2295449092517, 5601.131824567117, 5607.271054762855, 5609.074502707089, 5616.606837521416, 5621.184928185472, 6077.969610151921, 6081.391860813972, 6085.269767627825, 6090.0, 6097.664628445389, 5607.635503692247, 5612.326520817446, 5615.6630602164005, 5617.410171931889, 5617.747201375948, 5652.180433837153, 5810.709464526842, 5840.620359676607, 5966.940330596639, 6006.0, 5637.887242255214, 5830.183774271521, 5834.766609335748, 5850.5027072699295, 5853.473187413153, 5658.490735833795, 5659.26429564154, 5661.885962720405, 5662.886742265214, 5669.177969194526, 4071.7353372030725, 4140.254754144283, 4140.896477588084, 4142.730722503027, 4147.129102888307, 5832.950068987623, 5968.22413086296, 5997.580169388101, 5998.970005149947, 6006.699665016644, 5741.62679425836, 5747.655140691572, 5756.16535602327, 5757.877213943241, 5760.683162425939, 5734.483896449339, 5746.965546201556, 5747.19539264495, 5755.510781583444, 5762.798302059576, 5423.29497165366, 5616.0, 5635.9436405635415, 5641.915371269516, 5644.745986430703, 5770.942290577041, 5772.278465191851, 5775.5090817281, 5782.797602084075, 5789.884202315846, 5662.03745363281, 5662.292213473316, 5664.065429204135, 5664.405237450009, 5669.688167150846], "unit": "ms", "name": "prototype.html", "value": 4281.723158635505}, {"lowerIsBetter": false, "replicates": [701.2776839854948, 715.4419552748855, 747.137056699512, 759.8822182561705, 777.953322800632, 11673.41632918354, 11914.880851191485, 11940.880591194085, 11948.701282467942, 11976.580819671313, 11143.609973650924, 11218.887811121886, 11241.100711943045, 11279.0, 11292.096632269418, 586.5424968524536, 600.582595096406, 750.827309718765, 768.3430666779907, 769.4767558060516, 758.457702742539, 761.3604572159385, 766.7431410477469, 767.2595944913157, 767.4205974489281, 608.7838817219889, 625.2715586341906, 781.0432220529834, 789.4118881433341, 790.8220650353653, 785.2500861677084, 800.9399295052895, 801.2508304735092, 801.4510060608502, 801.6953557648114, 591.470633782762, 592.8606777407306, 593.7268856326095, 594.3818428834007, 594.8542607061254, 11909.94045029778, 11934.22427542207, 12052.698682532919, 12058.819117713241, 12059.57791477294, 10816.296940698829, 11704.0, 11761.176717629769, 11892.881071189264, 12107.93946030273, 9414.905850941472, 9547.236221102296, 9562.091601297865, 9629.807403851884, 10830.458477076194, 3159.921001974946, 3170.144061103489, 3173.666764989689, 3207.3585282943504, 3265.6571060038827, 43900.341494877604, 44123.77938110321, 44721.0, 44830.32754508685, 44837.327440088426, 9242.630294788267, 9283.814323713488, 9408.764780880396, 9417.90582094184, 9428.764280892896, 15922.76115858263, 15946.04323740556, 15950.601234968986, 15963.521094367188, 15982.280797364147, 6278.0, 6288.151099601587, 6333.398327158912, 6365.2361716594305, 6523.18460192476, 3469.6356882527475, 3544.929101417957, 3552.715782737375, 3563.2160924596546, 3585.0, 2644.457886133338, 2649.417128231786, 2655.7875369970357, 2668.066176838091, 2669.692985306676, 468.68363854398825, 480.7548150443299, 482.3753239554715, 489.18550613229286, 496.4291065274963, 409.4268024765352, 415.4412315435734, 420.5962276214868, 441.1860118082133, 442.75427137938755, 6300.558960872695, 6496.447801936888, 6584.8024559263295, 6714.093597364294, 6717.462602991749, 465.72056765940164, 552.1469329885336, 567.8495198772329, 573.6615396915756, 577.177522031104, 3129.8122112673313, 3301.8679252830098, 3306.966930330714, 3690.870819521304, 3751.9249615007548, 48705.26942095871, 49061.75469122631, 49263.75368123136, 49438.0, 49450.50549494459, 41074.589254107676, 42106.578934210265, 42216.57783422188, 42654.78672606679, 42693.146137077085, 40679.7966010168, 41770.58229417667, 41783.0, 42137.1572568553, 42546.936326591465, 7044.29557044312, 7414.4439167063765, 7484.962575187089, 7602.011738473963, 7798.610069496389, 30612.540811888284, 30802.0, 31396.37207255888, 31469.0, 31493.212669682525, 38878.805605971786, 41022.679180462306, 41338.379924301764, 41355.0, 41698.58301416947, 9144.862827057466, 9487.241020718464, 9621.615135394786, 9632.422054676741, 9679.0, 9774.31579789408, 9780.266480013885, 9839.065288797552, 10013.048760367754, 10166.745831354276, 9235.538223088954, 9391.906080939376, 9400.905990940277, 9412.764680883032, 9423.528823558932, 9327.06729327089, 9352.625894964398, 9378.577963991773, 9385.765355866159, 9396.483193424427, 9694.85457718149, 9788.070133337322, 9827.606895724091, 9833.557489912828, 9834.164096051916, 8273.669053237803, 8309.459885107448, 8339.916600833914, 8508.106648801786, 8743.03826579063, 7903.644336004779, 8161.347092232489, 8252.752417427488, 8361.790955225924, 8384.245417912418], "unit": "ms", "name": "yui.html", "value": 5470.474085414967}], "name": "dromaeo_css", "value": 6196.558130903215}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 106.0, 122.0, 114.0, 113.0, 105.0, 112.0, 113.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 151.0, 164.0, 130.0, 150.0, 155.0, 131.0, 167.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 159.0, 161.0, 160.0, 163.0, 161.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 88.0, 110.0, 71.0, 72.0, 74.0, 97.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 129.0, 93.0, 94.0, 94.0, 137.0, 94.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 111.0, 109.0, 112.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 153.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 72.0, 70.0, 71.0, 72.0, 79.0, 69.0, 81.0], "unit": "ms", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 91.0, 83.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 127.0, 119.0, 124.0, 124.0, 128.0, 131.0, 122.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [152.0, 148.0, 148.0, 153.0, 152.0, 137.0, 155.0, 147.0, 155.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 70.0, 71.0, 70.0, 70.0, 68.0, 70.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1528.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [195.92476489028212], "unit": "score", "name": "Richards", "value": 180.18140800000006}, {"lowerIsBetter": false, "replicates": [185.32246108228318], "unit": "score", "name": "DeltaBlue", "value": 356.77272800000003}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [4990.049751243781], "unit": "score", "name": "Decrypt", "value": 53.34235393818545}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [26421.052631578947], "unit": "score", "name": "RegExp", "value": 34.47951195219122}, {"lowerIsBetter": false, "replicates": [615.6670746634027], "unit": "score", "name": "Splay", "value": 132.3621212723658}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19499.38102185505}]} 01:12:47 INFO - RETURN: dromaeo_css: 6196.56 01:12:47 INFO - RETURN: kraken: 1528.30 01:12:47 INFO - RETURN: v8_7: 19499.38 01:12:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19499.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6196.56"}}} 01:12:47 INFO - Return code: 0 01:12:47 INFO - # TBPL SUCCESS # 01:12:47 INFO - Running post-action listener: _resource_record_post_action 01:12:47 INFO - Running post-run listener: _resource_record_post_run 01:12:48 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 12288; Write bytes: 502820864; Read time: 400; Write time: 405712 01:12:48 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 94220288; Read time: 0; Write time: 99696 01:12:48 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278257664; Read time: 160; Write time: 154616 01:12:48 INFO - Running post-run listener: _upload_blobber_files 01:12:48 INFO - Blob upload gear active. 01:12:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:12:48 INFO - Copying logs to upload dir... 01:12:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.785838 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-24 01:12:48.252679) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:12:48.256473) ========= 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=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009980 build_url: 'https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/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-24 01:12:48.307643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:12:48.308006) ========= 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=dd132779db58144225c4cf24000001c8-1448355049.912767-2012770187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:12:48.357792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:12:48.358093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:12:48.358376) ========= ========= Total master_lag: 0.59 =========