builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1448355104.45 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.454628) ========= 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.455262) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.455558) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006545 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.484402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.484777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.842530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.842822) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.893058) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.893333) ========= 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.893682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:44.893952) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 00:51:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-24 00:51:46 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:45.057202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:45.057512) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019200 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:45.112361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 00:51:45.112691) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 00:51:46,346 truncating revision to first 12 chars 2015-11-24 00:51:46,346 Setting DEBUG logging. 2015-11-24 00:51:46,346 attempt 1/10 2015-11-24 00:51:46,346 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:47,338 unpacking tar archive at: fx-team-b9a99168d92d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327236 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 00:51:46.454591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:46.454900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:46.464638) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 00:51:46.464953) ========= 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.465412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-24 00:51:46.465755) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:51:47 INFO - MultiFileLogger online at 20151124 00:51:47 in /builds/slave/test 00:51:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:51:47 INFO - {'append_to_log': False, 00:51:47 INFO - 'base_work_dir': '/builds/slave/test', 00:51:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:51:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:51:47 INFO - 'branch': 'Fx-Team-Non-PGO', 00:51:47 INFO - 'buildbot_json_path': 'buildprops.json', 00:51:47 INFO - 'config_files': ('talos/linux_config.py',), 00:51:47 INFO - 'default_actions': ('clobber', 00:51:47 INFO - 'read-buildbot-config', 00:51:47 INFO - 'download-and-extract', 00:51:47 INFO - 'populate-webroot', 00:51:47 INFO - 'create-virtualenv', 00:51:47 INFO - 'install', 00:51:47 INFO - 'run-tests'), 00:51:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:51:47 INFO - 'download_minidump_stackwalk': True, 00:51:47 INFO - 'download_symbols': 'ondemand', 00:51:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:51:47 INFO - 'tooltool.py': '/tools/tooltool.py', 00:51:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:51:47 INFO - '/tools/misc-python/virtualenv.py')}, 00:51:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:51:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:51:47 INFO - 'installer_path': 'installer.exe', 00:51:47 INFO - 'log_level': 'info', 00:51:47 INFO - 'log_name': 'talos', 00:51:47 INFO - 'log_to_console': True, 00:51:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:51:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:51:47 INFO - 'opt_config_files': (), 00:51:47 INFO - 'pip_index': False, 00:51:47 INFO - 'sps_profile': False, 00:51:47 INFO - 'sps_profile_interval': 0, 00:51:47 INFO - 'suite': 'dromaeojs-e10s', 00:51:47 INFO - 'system_bits': '64', 00:51:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:51:47 INFO - 'title': 'talos-linux64-ix-041', 00:51:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:51:47 INFO - 'use_talos_json': True, 00:51:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:51:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:51:47 INFO - 'work_dir': 'build'} 00:51:47 INFO - ##### 00:51:47 INFO - ##### Running clobber 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: clobber 00:51:47 INFO - rmtree: /builds/slave/test/build 00:51:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:51:48 INFO - Running post-action listener: _resource_record_post_action 00:51:48 INFO - ##### 00:51:48 INFO - ##### Running read-buildbot-config step. 00:51:48 INFO - ##### 00:51:48 INFO - Running pre-action listener: _resource_record_pre_action 00:51:48 INFO - Running main action method: read_buildbot_config 00:51:48 INFO - Using buildbot properties: 00:51:48 INFO - { 00:51:48 INFO - "properties": { 00:51:48 INFO - "buildnumber": 507, 00:51:48 INFO - "product": "firefox", 00:51:48 INFO - "script_repo_revision": "production", 00:51:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:51:48 INFO - "repository": "", 00:51:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:51:48 INFO - "buildid": "20151124000634", 00:51:48 INFO - "slavename": "talos-linux64-ix-041", 00:51:48 INFO - "pgo_build": "False", 00:51:48 INFO - "basedir": "/builds/slave/test", 00:51:48 INFO - "project": "", 00:51:48 INFO - "platform": "ubuntu64_hw", 00:51:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:51:48 INFO - "slavebuilddir": "test", 00:51:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:51:48 INFO - "branch": "fx-team", 00:51:48 INFO - "repo_path": "integration/fx-team", 00:51:48 INFO - "stage_platform": "linux64", 00:51:48 INFO - "builduid": "5a06975fc23548e095ca48c4c67bada6", 00:51:48 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 00:51:48 INFO - }, 00:51:48 INFO - "sourcestamp": { 00:51:48 INFO - "repository": "", 00:51:48 INFO - "hasPatch": false, 00:51:48 INFO - "project": "", 00:51:48 INFO - "branch": "fx-team-linux64-talos", 00:51:48 INFO - "changes": [ 00:51:48 INFO - { 00:51:48 INFO - "category": null, 00:51:48 INFO - "files": [ 00:51:48 INFO - { 00:51:48 INFO - "url": null, 00:51:48 INFO - "name": "https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:51:48 INFO - } 00:51:48 INFO - ], 00:51:48 INFO - "repository": "", 00:51:48 INFO - "rev": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55", 00:51:48 INFO - "who": "cbook@mozilla.com", 00:51:48 INFO - "when": 1448355060, 00:51:48 INFO - "number": 6699382, 00:51:48 INFO - "comments": "Bug 1216791 - Change the tooltip of the Hello icon in the toolbar. r=mikedeboer", 00:51:48 INFO - "project": "", 00:51:48 INFO - "at": "Tue 24 Nov 2015 00:51:00", 00:51:48 INFO - "branch": "fx-team-linux64-talos", 00:51:48 INFO - "revlink": "", 00:51:48 INFO - "properties": [ 00:51:48 INFO - [ 00:51:48 INFO - "buildid", 00:51:48 INFO - "20151124000634", 00:51:48 INFO - "Change" 00:51:48 INFO - ], 00:51:48 INFO - [ 00:51:48 INFO - "builduid", 00:51:48 INFO - "5a06975fc23548e095ca48c4c67bada6", 00:51:48 INFO - "Change" 00:51:48 INFO - ], 00:51:48 INFO - [ 00:51:48 INFO - "pgo_build", 00:51:48 INFO - "False", 00:51:48 INFO - "Change" 00:51:48 INFO - ] 00:51:48 INFO - ], 00:51:48 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 00:51:48 INFO - } 00:51:48 INFO - ], 00:51:48 INFO - "revision": "b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55" 00:51:48 INFO - } 00:51:48 INFO - } 00:51:48 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:48 INFO - Running post-action listener: _resource_record_post_action 00:51:48 INFO - ##### 00:51:48 INFO - ##### Running download-and-extract step. 00:51:48 INFO - ##### 00:51:48 INFO - Running pre-action listener: _resource_record_pre_action 00:51:48 INFO - Running main action method: download_and_extract 00:51:48 INFO - mkdir: /builds/slave/test/build/tests 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/test_packages.json 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/test_packages.json 00:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/test_packages.json 00:51:48 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:48 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:49 INFO - Downloaded 1302 bytes. 00:51:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:51:49 INFO - Using the following test package requirements: 00:51:49 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:51:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:49 INFO - u'jsshell-linux-x86_64.zip'], 00:51:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:51:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:51:49 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:51:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:51:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:51:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:51:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:51:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:51:49 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:49 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:49 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:49 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:49 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:49 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:51 INFO - Downloaded 21341306 bytes. 00:51:51 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:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:51 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:52 INFO - Return code: 0 00:51:52 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:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:52 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:52 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:52 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:52 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:52 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:53 INFO - Downloaded 21341306 bytes. 00:51:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:51:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:51:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:54 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:55 INFO - Downloaded 11130997 bytes. 00:51:55 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:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:51:55 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:56 INFO - Return code: 0 00:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:56 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:56 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:56 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:56 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:56 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:52:28 WARNING - Socket error when accessing 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: The read operation timed out 00:52:28 INFO - retry: attempt #1 caught exception: The read operation timed out 00:52:28 INFO - retry: Failed, sleeping 30 seconds before retrying 00:52:58 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 #2 00:52:59 INFO - Downloaded 56074717 bytes. 00:52:59 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:52:59 INFO - mkdir: /builds/slave/test/properties 00:52:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:52:59 INFO - Writing to file /builds/slave/test/properties/build_url 00:52:59 INFO - Contents: 00:52:59 INFO - build_url:https://queue.taskcluster.net/v1/task/FtpW0XwHTz6xQligf2ANBg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:52:59 INFO - Running post-action listener: _resource_record_post_action 00:52:59 INFO - Running post-action listener: set_extra_try_arguments 00:52:59 INFO - ##### 00:52:59 INFO - ##### Running populate-webroot step. 00:52:59 INFO - ##### 00:52:59 INFO - Running pre-action listener: _resource_record_pre_action 00:52:59 INFO - Running main action method: populate_webroot 00:52:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:52:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:52:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:52:59 INFO - '../fennec_ids.txt'], 00:52:59 INFO - 'tests': ['tcheck2']}, 00:52:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:52:59 INFO - '--tppagecycles', 00:52:59 INFO - '7'], 00:52:59 INFO - 'tests': ['tsvgm']}}, 00:52:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:52:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:52:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'tests': ['damp', 'tps']}, 00:52:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['damp', 'tps']}, 00:52:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:52:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:52:59 INFO - 'other': {'tests': ['a11yr', 00:52:59 INFO - 'ts_paint', 00:52:59 INFO - 'tpaint', 00:52:59 INFO - 'sessionrestore', 00:52:59 INFO - 'sessionrestore_no_auto_restore']}, 00:52:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['a11yr', 00:52:59 INFO - 'ts_paint', 00:52:59 INFO - 'tpaint', 00:52:59 INFO - 'sessionrestore', 00:52:59 INFO - 'sessionrestore_no_auto_restore']}, 00:52:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['a11yr', 00:52:59 INFO - 'ts_paint', 00:52:59 INFO - 'tpaint', 00:52:59 INFO - 'sessionrestore', 00:52:59 INFO - 'sessionrestore_no_auto_restore']}, 00:52:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['a11yr', 00:52:59 INFO - 'ts_paint', 00:52:59 INFO - 'tpaint', 00:52:59 INFO - 'sessionrestore', 00:52:59 INFO - 'sessionrestore_no_auto_restore']}, 00:52:59 INFO - 'other_l64': {'tests': ['a11yr', 00:52:59 INFO - 'ts_paint', 00:52:59 INFO - 'tpaint', 00:52:59 INFO - 'sessionrestore', 00:52:59 INFO - 'sessionrestore_no_auto_restore']}, 00:52:59 INFO - 'other_nol64': {'tests': ['a11yr', 00:52:59 INFO - 'ts_paint', 00:52:59 INFO - 'tpaint', 00:52:59 INFO - 'sessionrestore', 00:52:59 INFO - 'sessionrestore_no_auto_restore']}, 00:52:59 INFO - 'svgr': {'tests': ['tsvgx', 00:52:59 INFO - 'tsvgr_opacity', 00:52:59 INFO - 'tart', 00:52:59 INFO - 'tscrollx', 00:52:59 INFO - 'cart']}, 00:52:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['tsvgx', 00:52:59 INFO - 'tsvgr_opacity', 00:52:59 INFO - 'tart', 00:52:59 INFO - 'tscrollx', 00:52:59 INFO - 'cart']}, 00:52:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'tests': ['tp5o']}, 00:52:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'talos_options': ['--e10s'], 00:52:59 INFO - 'tests': ['tp5o']}, 00:52:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'talos_options': ['--xperf_path', 00:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:59 INFO - 'tests': ['tp5n']}, 00:52:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:59 INFO - 'talos_options': ['--e10s', 00:52:59 INFO - '--xperf_path', 00:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:59 INFO - 'tests': ['tp5n']}}, 00:52:59 INFO - 'talos.zip': {'path': '', 00:52:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:52:59 INFO - Running post-action listener: _resource_record_post_action 00:52:59 INFO - ##### 00:52:59 INFO - ##### Running create-virtualenv step. 00:52:59 INFO - ##### 00:52:59 INFO - Running pre-action listener: _resource_record_pre_action 00:52:59 INFO - Running main action method: create_virtualenv 00:52:59 INFO - Creating virtualenv /builds/slave/test/build/venv 00:52:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:52:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:52:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:52:59 INFO - Using real prefix '/usr' 00:52:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:53:00 INFO - Installing distribute.............................................................................................................................................................................................done. 00:53:02 INFO - Installing pip.................done. 00:53:02 INFO - Return code: 0 00:53:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc3fc9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18816c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, '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': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', '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:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:53:02 INFO - Using env: {'DISPLAY': ':0', 00:53:02 INFO - 'HOME': '/home/cltbld', 00:53:02 INFO - 'LANG': 'en_US.UTF-8', 00:53:02 INFO - 'LANGUAGE': 'en_US:en', 00:53:02 INFO - 'LOGNAME': 'cltbld', 00:53:02 INFO - 'MAIL': '/var/mail/cltbld', 00:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:02 INFO - 'MOZ_NO_REMOTE': '1', 00:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:02 INFO - 'NO_EM_RESTART': '1', 00:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:02 INFO - 'PWD': '/builds/slave/test', 00:53:02 INFO - 'SHELL': '/bin/bash', 00:53:02 INFO - 'SHLVL': '1', 00:53:02 INFO - 'TERM': 'linux', 00:53:02 INFO - 'TMOUT': '86400', 00:53:02 INFO - 'USER': 'cltbld', 00:53:02 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:02 INFO - '_': '/tools/buildbot/bin/python'} 00:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:53:02 INFO - Cleaning up... 00:53:02 INFO - Return code: 0 00:53:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc3fc9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18816c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, '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': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', '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:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:53:02 INFO - Using env: {'DISPLAY': ':0', 00:53:02 INFO - 'HOME': '/home/cltbld', 00:53:02 INFO - 'LANG': 'en_US.UTF-8', 00:53:02 INFO - 'LANGUAGE': 'en_US:en', 00:53:02 INFO - 'LOGNAME': 'cltbld', 00:53:02 INFO - 'MAIL': '/var/mail/cltbld', 00:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:02 INFO - 'MOZ_NO_REMOTE': '1', 00:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:02 INFO - 'NO_EM_RESTART': '1', 00:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:02 INFO - 'PWD': '/builds/slave/test', 00:53:02 INFO - 'SHELL': '/bin/bash', 00:53:02 INFO - 'SHLVL': '1', 00:53:02 INFO - 'TERM': 'linux', 00:53:02 INFO - 'TMOUT': '86400', 00:53:02 INFO - 'USER': 'cltbld', 00:53:02 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:02 INFO - '_': '/tools/buildbot/bin/python'} 00:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:02 INFO - Downloading/unpacking psutil>=0.7.1 00:53: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:53: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:53: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:53: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:53: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:53: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:53:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:04 INFO - Installing collected packages: psutil 00:53:04 INFO - Running setup.py install for psutil 00:53:04 INFO - building 'psutil._psutil_linux' extension 00:53:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:53:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:53:04 INFO - building 'psutil._psutil_posix' extension 00:53:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:53:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:53:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:53:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:53:05 INFO - Successfully installed psutil 00:53:05 INFO - Cleaning up... 00:53:05 INFO - Return code: 0 00:53:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc3fc9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18816c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, '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': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', '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:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:53:05 INFO - Using env: {'DISPLAY': ':0', 00:53:05 INFO - 'HOME': '/home/cltbld', 00:53:05 INFO - 'LANG': 'en_US.UTF-8', 00:53:05 INFO - 'LANGUAGE': 'en_US:en', 00:53:05 INFO - 'LOGNAME': 'cltbld', 00:53:05 INFO - 'MAIL': '/var/mail/cltbld', 00:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:05 INFO - 'MOZ_NO_REMOTE': '1', 00:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:05 INFO - 'NO_EM_RESTART': '1', 00:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:05 INFO - 'PWD': '/builds/slave/test', 00:53:05 INFO - 'SHELL': '/bin/bash', 00:53:05 INFO - 'SHLVL': '1', 00:53:05 INFO - 'TERM': 'linux', 00:53:05 INFO - 'TMOUT': '86400', 00:53:05 INFO - 'USER': 'cltbld', 00:53:05 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:05 INFO - '_': '/tools/buildbot/bin/python'} 00:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:53: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:53: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:53: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:53: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:53: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:53: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:53:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:53:07 INFO - Installing collected packages: mozsystemmonitor 00:53:07 INFO - Running setup.py install for mozsystemmonitor 00:53:07 INFO - Successfully installed mozsystemmonitor 00:53:07 INFO - Cleaning up... 00:53:07 INFO - Return code: 0 00:53:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:53: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:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc3fc9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18816c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, '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': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', '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:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:53:07 INFO - Using env: {'DISPLAY': ':0', 00:53:07 INFO - 'HOME': '/home/cltbld', 00:53:07 INFO - 'LANG': 'en_US.UTF-8', 00:53:07 INFO - 'LANGUAGE': 'en_US:en', 00:53:07 INFO - 'LOGNAME': 'cltbld', 00:53:07 INFO - 'MAIL': '/var/mail/cltbld', 00:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:07 INFO - 'MOZ_NO_REMOTE': '1', 00:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:07 INFO - 'NO_EM_RESTART': '1', 00:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:07 INFO - 'PWD': '/builds/slave/test', 00:53:07 INFO - 'SHELL': '/bin/bash', 00:53:07 INFO - 'SHLVL': '1', 00:53:07 INFO - 'TERM': 'linux', 00:53:07 INFO - 'TMOUT': '86400', 00:53:07 INFO - 'USER': 'cltbld', 00:53:07 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:07 INFO - '_': '/tools/buildbot/bin/python'} 00:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:07 INFO - Downloading/unpacking blobuploader==1.2.4 00:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:09 INFO - Downloading blobuploader-1.2.4.tar.gz 00:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:53:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:53:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:09 INFO - Downloading docopt-0.6.1.tar.gz 00:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:53:09 INFO - Installing collected packages: blobuploader, requests, docopt 00:53:09 INFO - Running setup.py install for blobuploader 00:53:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:53:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:53:10 INFO - Running setup.py install for requests 00:53:10 INFO - Running setup.py install for docopt 00:53:10 INFO - Successfully installed blobuploader requests docopt 00:53:10 INFO - Cleaning up... 00:53:10 INFO - Return code: 0 00:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:53: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:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc3fc9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18816c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, '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': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', '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:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:53:10 INFO - Using env: {'DISPLAY': ':0', 00:53:10 INFO - 'HOME': '/home/cltbld', 00:53:10 INFO - 'LANG': 'en_US.UTF-8', 00:53:10 INFO - 'LANGUAGE': 'en_US:en', 00:53:10 INFO - 'LOGNAME': 'cltbld', 00:53:10 INFO - 'MAIL': '/var/mail/cltbld', 00:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:10 INFO - 'MOZ_NO_REMOTE': '1', 00:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:10 INFO - 'NO_EM_RESTART': '1', 00:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:10 INFO - 'PWD': '/builds/slave/test', 00:53:10 INFO - 'SHELL': '/bin/bash', 00:53:10 INFO - 'SHLVL': '1', 00:53:10 INFO - 'TERM': 'linux', 00:53:10 INFO - 'TMOUT': '86400', 00:53:10 INFO - 'USER': 'cltbld', 00:53:10 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:10 INFO - '_': '/tools/buildbot/bin/python'} 00:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:53:10 INFO - Running setup.py (path:/tmp/pip-CltdY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:53:10 INFO - Running setup.py (path:/tmp/pip-HD7EtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:53:10 INFO - Running setup.py (path:/tmp/pip-tpjgVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:53:10 INFO - Running setup.py (path:/tmp/pip-njrpqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:53:11 INFO - Running setup.py (path:/tmp/pip-Ks1L6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:53:11 INFO - Running setup.py (path:/tmp/pip-W6icxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:53:11 INFO - Running setup.py (path:/tmp/pip-m9jqUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:53:11 INFO - Running setup.py (path:/tmp/pip-8D2LYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:53:11 INFO - Running setup.py (path:/tmp/pip-e7igq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:53:11 INFO - Running setup.py (path:/tmp/pip-PAqHvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:53:11 INFO - Running setup.py (path:/tmp/pip-HmGiu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:53:11 INFO - Running setup.py (path:/tmp/pip-wit8_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:53:11 INFO - Running setup.py (path:/tmp/pip-VR_3VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:53:11 INFO - Running setup.py (path:/tmp/pip-_9IIKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:11 INFO - Running setup.py (path:/tmp/pip-OKTY4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:53:11 INFO - Running setup.py (path:/tmp/pip-rLdnSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:53:11 INFO - Running setup.py (path:/tmp/pip-sizPkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:53:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:53:11 INFO - Running setup.py install for manifestparser 00:53:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Running setup.py install for mozcrash 00:53:12 INFO - Running setup.py install for mozdebug 00:53:12 INFO - Running setup.py install for mozdevice 00:53:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Running setup.py install for mozfile 00:53:12 INFO - Running setup.py install for mozhttpd 00:53:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Running setup.py install for mozinfo 00:53:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Running setup.py install for mozInstall 00:53:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Running setup.py install for mozleak 00:53:12 INFO - Running setup.py install for mozlog 00:53:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:53:12 INFO - Running setup.py install for moznetwork 00:53:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:53:13 INFO - Running setup.py install for mozprocess 00:53:13 INFO - Running setup.py install for mozprofile 00:53:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:53:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:53:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:53:13 INFO - Running setup.py install for mozrunner 00:53:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:53:13 INFO - Running setup.py install for mozscreenshot 00:53:13 INFO - Running setup.py install for moztest 00:53:13 INFO - Running setup.py install for mozversion 00:53:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:53:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:53:13 INFO - Cleaning up... 00:53:13 INFO - Return code: 0 00:53:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:53: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:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc3fc9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18816c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, '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': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', '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:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:53:13 INFO - Using env: {'DISPLAY': ':0', 00:53:13 INFO - 'HOME': '/home/cltbld', 00:53:13 INFO - 'LANG': 'en_US.UTF-8', 00:53:13 INFO - 'LANGUAGE': 'en_US:en', 00:53:13 INFO - 'LOGNAME': 'cltbld', 00:53:13 INFO - 'MAIL': '/var/mail/cltbld', 00:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:13 INFO - 'MOZ_NO_REMOTE': '1', 00:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:13 INFO - 'NO_EM_RESTART': '1', 00:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:13 INFO - 'PWD': '/builds/slave/test', 00:53:13 INFO - 'SHELL': '/bin/bash', 00:53:13 INFO - 'SHLVL': '1', 00:53:13 INFO - 'TERM': 'linux', 00:53:13 INFO - 'TMOUT': '86400', 00:53:13 INFO - 'USER': 'cltbld', 00:53:13 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:13 INFO - '_': '/tools/buildbot/bin/python'} 00:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:53:13 INFO - Running setup.py (path:/tmp/pip-COEkjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:53:14 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:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:53:14 INFO - Running setup.py (path:/tmp/pip-XyhegO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:53:14 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:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:53:14 INFO - Running setup.py (path:/tmp/pip-T570LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:53:14 INFO - Running setup.py (path:/tmp/pip-k3RKCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:53:14 INFO - Running setup.py (path:/tmp/pip-jOYSbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:53:14 INFO - Running setup.py (path:/tmp/pip-fGFZoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:53:14 INFO - Running setup.py (path:/tmp/pip-FG0a9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:53:14 INFO - Running setup.py (path:/tmp/pip-j5baQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:53:14 INFO - Running setup.py (path:/tmp/pip-Ktp5As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:53:14 INFO - Running setup.py (path:/tmp/pip-MeA3kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:53:14 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:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:53:14 INFO - Running setup.py (path:/tmp/pip-zxJ43X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:53:14 INFO - Running setup.py (path:/tmp/pip-enoSBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:53:14 INFO - Running setup.py (path:/tmp/pip-JPMZsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:53:14 INFO - Running setup.py (path:/tmp/pip-zaG1bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:14 INFO - Running setup.py (path:/tmp/pip-Fov93_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:53:15 INFO - Running setup.py (path:/tmp/pip-2XikT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:53:15 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:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:53:15 INFO - Running setup.py (path:/tmp/pip-J2rNeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:53:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:16 INFO - Downloading blessings-1.5.1.tar.gz 00:53:16 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:53:16 INFO - Installing collected packages: blessings 00:53:16 INFO - Running setup.py install for blessings 00:53:17 INFO - Successfully installed blessings 00:53:17 INFO - Cleaning up... 00:53:17 INFO - Return code: 0 00:53:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:53:17 INFO - Reading from file tmpfile_stdout 00:53:17 INFO - Current package versions: 00:53:17 INFO - argparse == 1.2.1 00:53:17 INFO - blessings == 1.5.1 00:53:17 INFO - blobuploader == 1.2.4 00:53:17 INFO - docopt == 0.6.1 00:53:17 INFO - manifestparser == 1.1 00:53:17 INFO - mozInstall == 1.12 00:53:17 INFO - mozcrash == 0.16 00:53:17 INFO - mozdebug == 0.1 00:53:17 INFO - mozdevice == 0.47 00:53:17 INFO - mozfile == 1.2 00:53:17 INFO - mozhttpd == 0.7 00:53:17 INFO - mozinfo == 0.9 00:53:17 INFO - mozleak == 0.1 00:53:17 INFO - mozlog == 3.1 00:53:17 INFO - moznetwork == 0.27 00:53:17 INFO - mozprocess == 0.22 00:53:17 INFO - mozprofile == 0.27 00:53:17 INFO - mozrunner == 6.11 00:53:17 INFO - mozscreenshot == 0.1 00:53:17 INFO - mozsystemmonitor == 0.0 00:53:17 INFO - moztest == 0.7 00:53:17 INFO - mozversion == 1.4 00:53:17 INFO - psutil == 3.1.1 00:53:17 INFO - requests == 1.2.3 00:53:17 INFO - wsgiref == 0.1.2 00:53:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbc3fc9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18816c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1932900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, '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': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', '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:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:53:17 INFO - Using env: {'DISPLAY': ':0', 00:53:17 INFO - 'HOME': '/home/cltbld', 00:53:17 INFO - 'LANG': 'en_US.UTF-8', 00:53:17 INFO - 'LANGUAGE': 'en_US:en', 00:53:17 INFO - 'LOGNAME': 'cltbld', 00:53:17 INFO - 'MAIL': '/var/mail/cltbld', 00:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:17 INFO - 'MOZ_NO_REMOTE': '1', 00:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:17 INFO - 'NO_EM_RESTART': '1', 00:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:17 INFO - 'PWD': '/builds/slave/test', 00:53:17 INFO - 'SHELL': '/bin/bash', 00:53:17 INFO - 'SHLVL': '1', 00:53:17 INFO - 'TERM': 'linux', 00:53:17 INFO - 'TMOUT': '86400', 00:53:17 INFO - 'USER': 'cltbld', 00:53:17 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:17 INFO - '_': '/tools/buildbot/bin/python'} 00:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:53:17 INFO - Cleaning up... 00:53:17 INFO - Return code: 0 00:53:17 INFO - Running post-action listener: _resource_record_post_action 00:53:17 INFO - Running post-action listener: _start_resource_monitoring 00:53:17 INFO - Starting resource monitoring. 00:53:17 INFO - ##### 00:53:17 INFO - ##### Running install step. 00:53:17 INFO - ##### 00:53:17 INFO - Running pre-action listener: _resource_record_pre_action 00:53:17 INFO - Running main action method: install 00:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:53:17 INFO - Reading from file tmpfile_stdout 00:53:17 INFO - Detecting whether we're running mozinstall >=1.0... 00:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:53:17 INFO - Reading from file tmpfile_stdout 00:53:17 INFO - Output received: 00:53:17 INFO - Usage: mozinstall [options] installer 00:53:17 INFO - Options: 00:53:17 INFO - -h, --help show this help message and exit 00:53:17 INFO - -d DEST, --destination=DEST 00:53:17 INFO - Directory to install application into. [default: 00:53:17 INFO - "/builds/slave/test"] 00:53:17 INFO - --app=APP Application being installed. [default: firefox] 00:53:17 INFO - mkdir: /builds/slave/test/build/application 00:53:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:53:31 INFO - Reading from file tmpfile_stdout 00:53:31 INFO - Output received: 00:53:31 INFO - /builds/slave/test/build/application/firefox/firefox 00:53:31 INFO - Running post-action listener: _resource_record_post_action 00:53:31 INFO - ##### 00:53:31 INFO - ##### Running run-tests step. 00:53:31 INFO - ##### 00:53:31 INFO - Running pre-action listener: _resource_record_pre_action 00:53:31 INFO - Running main action method: run_tests 00:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:53:31 INFO - Python 2.7.3 00:53:31 INFO - Return code: 0 00:53:31 INFO - grabbing minidump binary from tooltool 00:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1978b70>, '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 0x19c9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ca250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:53:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:53:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:53:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:32 INFO - Return code: 0 00:53:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:53:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:53:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:53:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:53:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:53:32 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-e10s', '--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-041', '--webServer', 'localhost'] in /builds/slave/test/build 00:53:32 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-e10s --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-041 --webServer localhost 00:53:32 INFO - Using env: {'DISPLAY': ':0', 00:53:32 INFO - 'HOME': '/home/cltbld', 00:53:32 INFO - 'LANG': 'en_US.UTF-8', 00:53:32 INFO - 'LANGUAGE': 'en_US:en', 00:53:32 INFO - 'LOGNAME': 'cltbld', 00:53:32 INFO - 'MAIL': '/var/mail/cltbld', 00:53:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:53:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:32 INFO - 'MOZ_NO_REMOTE': '1', 00:53:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:32 INFO - 'NO_EM_RESTART': '1', 00:53:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:32 INFO - 'PWD': '/builds/slave/test', 00:53:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:53:32 INFO - 'SHELL': '/bin/bash', 00:53:32 INFO - 'SHLVL': '1', 00:53:32 INFO - 'TERM': 'linux', 00:53:32 INFO - 'TMOUT': '86400', 00:53:32 INFO - 'USER': 'cltbld', 00:53:32 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876', 00:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:32 INFO - '_': '/tools/buildbot/bin/python'} 00:53:32 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-e10s', '--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-041', '--webServer', 'localhost'] with output_timeout 3600 00:53:32 INFO - mozversion INFO | application_buildid: 20151124000634 00:53:32 INFO - mozversion INFO | application_changeset: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 00:53:32 INFO - mozversion INFO | application_display_name: Nightly 00:53:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:32 INFO - mozversion INFO | application_name: Firefox 00:53:32 INFO - mozversion INFO | application_remotingname: firefox 00:53:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:53:32 INFO - mozversion INFO | application_vendor: Mozilla 00:53:32 INFO - mozversion INFO | application_version: 45.0a1 00:53:32 INFO - mozversion INFO | platform_buildid: 20151124000634 00:53:32 INFO - mozversion INFO | platform_changeset: b9a99168d92dbd5b6aa46bd13ee69ea1144a6f55 00:53:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:53:32 INFO - mozversion INFO | platform_version: 45.0a1 00:53:32 INFO - 2015-11-24 00:53:32,198 DEBUG : using testdate: 1448355212 00:53:32 INFO - 2015-11-24 00:53:32,198 DEBUG : actual date: 1448355212 00:53:32 INFO - 2015-11-24 00:53:32,207 INFO : starting webserver on 'localhost:45503' 00:53:32 INFO - 2015-11-24 00:53:32,208 INFO : Starting test suite talos-linux64-ix-041.e 00:53:32 INFO - 2015-11-24 00:53:32,208 INFO : Starting test dromaeo_css 00:53:32 INFO - 2015-11-24 00:53:32,208 DEBUG : operating with platform_type : linux_ 00:53:32 INFO - 2015-11-24 00:53:32,209 INFO : Initialising browser for dromaeo_css test... 00:53:32 INFO - 2015-11-24 00:53:32,218 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvRPZZ/profile http://localhost:45503/getInfo.html 00:53:37 INFO - 2015-11-24 00:53:37,780 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:53:37 INFO - 2015-11-24 00:53:37,780 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:53:37 INFO - 2015-11-24 00:53:37,780 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:53:37 INFO - 2015-11-24 00:53:37,780 DEBUG : BROWSER_OUTPUT: __metrics 00:53:38 INFO - 2015-11-24 00:53:38,921 INFO : Browser initialized. 00:53:38 INFO - 2015-11-24 00:53:38,922 INFO : Running cycle 1/1 for dromaeo_css test... 00:53:38 INFO - 2015-11-24 00:53:38,922 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvRPZZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:53:50 INFO - 2015-11-24 00:53:50,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 141709312 00:53:50 INFO - 2015-11-24 00:53:50,910 DEBUG : BROWSER_OUTPUT: 00:54:40 INFO - 2015-11-24 00:54:40,569 DEBUG : BROWSER_OUTPUT: 1448355280568 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:56:51 INFO - 2015-11-24 00:56:51,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45503/tests/dromaeo/cssquery-ext.html) 00:56:53 INFO - 2015-11-24 00:56:53,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 145416192 00:56:53 INFO - 2015-11-24 00:56:53,019 DEBUG : BROWSER_OUTPUT: 00:59:54 INFO - 2015-11-24 00:59:54,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/dromaeo/cssquery-ext.html (next: http://localhost:45503/tests/dromaeo/cssquery-jquery.html) 00:59:55 INFO - 2015-11-24 00:59:55,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 144261120 00:59:55 INFO - 2015-11-24 00:59:55,569 DEBUG : BROWSER_OUTPUT: 01:02:57 INFO - 2015-11-24 01:02:57,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45503/tests/dromaeo/cssquery-mootools.html) 01:02:57 INFO - 2015-11-24 01:02:57,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 143253504 01:02:57 INFO - 2015-11-24 01:02:57,941 DEBUG : BROWSER_OUTPUT: 01:05:59 INFO - 2015-11-24 01:05:59,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45503/tests/dromaeo/cssquery-prototype.html) 01:06:00 INFO - 2015-11-24 01:06:00,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 141275136 01:06:00 INFO - 2015-11-24 01:06:00,279 DEBUG : BROWSER_OUTPUT: 01:09:02 INFO - 2015-11-24 01:09:02,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45503/tests/dromaeo/cssquery-yui.html) 01:09:03 INFO - 2015-11-24 01:09:03,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 141860864 01:09:03 INFO - 2015-11-24 01:09:03,545 DEBUG : BROWSER_OUTPUT: 01:12:05 INFO - 2015-11-24 01:12:05,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/dromaeo/cssquery-yui.html (next: http://localhost:45503/tests/dromaeo/cssquery-dojo.html) 01:12:06 INFO - 2015-11-24 01:12:06,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 144494592 01:12:06 INFO - 2015-11-24 01:12:06,027 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,027 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:12:06 INFO - 2015-11-24 01:12:06,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:12:06 INFO - 2015-11-24 01:12:06,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:12:06 INFO - 2015-11-24 01:12:06,027 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:12:06 INFO - 2015-11-24 01:12:06,028 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2625.1468272811335;2644.259607309954;2672.0247109804914;2676.544987352151;2692.2865440658225;4521.276595744682;4657.720536767796;4668.696534725241;4676.321933319667;4680.719156850587;4546.249868771649;4595.540445955403;4595.7242565446095;4652.139354219464;4675.041616468624;4149.605787450188;4201.555764752508;4226.133642603274;4292.055747735493;4357.259265924785;4341.45731783527;4393.714408563433;4407.2507673695545;4407.405000324963;4410.4266445362055;4136.855210067663;4219.135077309144;4251.957480425187;4258.403823464687;4324.870253892388;4306.978465107654;4330.848420305306;4335.588119128678;4351.804168812411;4384.0355121873135;4297.333913243452;4307.633851122627;4315.805788739514;4347.782620866163;4377.846775362847;4412.955870441287;4527.230370836965;4543.5002149763495;4591.931121033187;4709.693869898446;4980.377452818398;4986.252062190701;4991.425986011619;4999.925001124986;5027.673201241944;5010.674306170124;5013.774380152902;5014.899702005976;5015.3730783652045;5018.723970181639;4429;4530;4562.931556026662;4592.931106033412;4637.443506779208;5061.316722242524;5066.898662026739;5080.288759573663;5083.822066227738;5092.694438333712;4709.95290047102;4897.3878265216845;4898.338724272249;4903.215485522299;4945.357103576512;4894.437139728977;4923.48303428142;4950.6782059166035;4954.9752251238515;5014.423341315795;4910.06708725341;4916.729579873141;4925.901481970341;4938.604911607063;4957.958828645953;4688.718676879398;4784.856454306377;4885.755712214375;4892.608591312757;4949.034938187091;4049.57479464652;4095.815688294034;4113.773742444194;4125.8968525787095;4143.834246630161;3631.654992775682;3637.108908317426;3652.160003199279;3655.2324011957253;3676.816159192083;4179.456670632799;4263.467066616673;4358.4769827620885;4368.257396242647;4375.824967001348;4804.807807687724;4808.08646357191;4819.108464933998;4859.781309841065;4900.975495122501;4323.200207961537;4351.782410879443;4359.12817436514;4365.890852728708;4384.56154384559;4191.140816132685;4305.203537345601;4329.264025115738;4450.577195166454;4456.77716114193;4756.7145971241835;4757.785899634525;4763.2140696784645;4774.30772537987;4786.784594693317;5002.899942001212;5026.472220416804;5029.497050294941;5034.647574669738;5082.593392528663;4550.044490656999;4578.771061446981;4689.085628302449;4731.574158325767;4773.928391074067;4931.0630980113665;4945.282933974481;4962.131626965339;4978.103941290602;5012.072766538202;5011.298418221379;5022.422421421583;5035.874103147451;5038.874028149326;5095;4629.444466664022;4695.906081878412;4746.976265118652;4766.118268120409;4814.5907597854575;4835.032993401263;4844.346013288302;4852.8786780329365;4855.271709243641;4881.560659540658;4720.032393359422;4751.762411879323;4756.738379389167;4758.64310176745;4772.642051846195;4599.080183963154;4734.644901632322;4740.762961851962;4755.239161734106;4815.253635686474;4739;4782.760861956818;4786.234202527578;4790.7365094920115;4806.687565308243 01:12:06 INFO - 2015-11-24 01:12:06,029 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.7138156186412;569.8660814708545;581.3111462916444;586.8620874094587;586.9970650146752;35749.46375804365;36565.63434365656;36583.817080914625;36767.26465470689;36821.44767828485;39474.21051578974;39908.201835963264;39915.40126898099;40140.59859401405;40154;7811.531308121516;7903.0911445183965;7995.120536740983;8021.959890200541;8035.95982020092;7685.923140768577;7807.921920780805;7881.369490440751;7889.447738658268;7910.920890791105;7806.180351063113;7870.134285228649;7870.212978702141;7877.172896845835;7887.053553573579;7802.063752349726;7826.726064587769;7838.216178382173;7843.803904902395;7852.764417067498;7798.571078590675;7900.683972641087;7919.287264146197;7946.841063178704;7954.880676789853;36439.08902277438;36642.26715465703;36736.448953265724;36749.63250367489;36751.876090532336;2581;2604.7265037171014;2610.2691246450836;2755.9802872937144;3142.2615685314163;27502;27561.173164805088;27633.86183069072;27910.581341279896;28182.859085704644;3290.4735242361107;3296.752743544244;3324;3346.983265083659;3373.122988023107;222659;224091;224620.99999999837;225581;225748.81135103537;36319.45520817137;36949;50439.243411348856;50734;50839;36384.272314553564;36567.63432365642;36574.52542008505;36769.26461470756;36812.815935920684;12244.877551224374;12367.134300599051;12390.690232744073;12395.442205100791;12420.565280215149;9427.387219830689;9431.245500359955;9448.338616296931;9474.95262523683;9514.714558563253;12833.294168820805;13002.414891329912;13013.869861301266;13020.869791302155;13049.347532623331;5370.543503802142;5452.890942181134;5460.535854452337;5475.370332411823;5504.2294078829;857.8970523537215;981.2003217377815;992.6376872441651;1012.2256473797551;1031.896810318962;25755.613665795026;25954;25969.35076623062;26046.34884127874;26178.34554136124;928.2202949522433;958.8897276813116;958.9952050239843;973.3186769261546;1041.796849614318;12908.354582271037;12920.095593308379;13137.60587182386;13243.536476223286;13271.734565308832;328492;334628;336732;337797;337821;45493.772531137794;45498;45818.541814581426;46039.76980115078;46215.537844621125;1212.7331986962854;1216.2763155922212;1217.933013684256;1227.6010296653624;1233.1860971758597;24586;24756.38109047288;24949.750502494742;24990.500189995735;24991;36576.634233658384;36631.45052824263;36688.63311366959;36822.26355472929;36971.63028369682;239597;240317;240887;242387;242691;28411.857940710164;28797.712022879503;40637;41778.79110604549;41787.1642567153;38593.807030964665;38940.41589376105;39137.8043109794;39792.801035994635;40034.39948400718;32786.50820237746;32906.5064024035;33220.66779332176;33831;34280.314393712484;33755.83122084374;35380;35835.82082089573;37994.62005379911;38478.23043539058;33443;33643.663563364054;33949;34055.82972085124;34220.48669270013;29010;29826.701732982394;30090.699093009665;30725.385492290476;31008.22479438032;23703.64444533299;23998.40003999844;24164;24229.51540969206;24496.87751561231 01:12:06 INFO - 2015-11-24 01:12:06,034 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.69300243775734;334.93971085204663;336.6465211527895;337.8040736372904;338.70025027850346;15152.772708409382;15279.083255004694;15433.691326173484;15895.761563576556;16479.093649849252;14352.354144063516;14363.138211707279;14376.353064112114;14514;14804.6298842529;4017.658499027586;4571.634269258459;5295.232191332255;5296.020236256305;6166.599171053889;6376.681165941684;6385.361463853601;6407.487401007908;6429.196350456193;6436.967815160918;6293.5279854010905;6336.809895703113;6361;6472.611643301393;6478.190226221723;6464.095026696219;6498;6507.446867016286;6515.902261466105;6522;5812.186293918855;6448.387403196689;6459.5478316517865;6462.063000864895;6466.870662586722;20107.39677809668;20221;20535.691964620542;20925.686114708293;21068.683969740465;1746.2665680414257;1780.2789870102629;1821.726740988849;1828.1133650179652;1834.3121329501437;13412.061155719104;13433.19400835953;13492.527761528398;13866.791998120036;14120.576382708536;1825.4249911277905;1881.3321270948752;1893.252165394675;1906.1136571494183;1921.0586812461934;58945;62707.6864615674;63295.88576742543;64155.67922160359;65022.3497765021;15726.449574264845;15732.842671573366;15750.212489375486;15829.366825326859;15944.681106377808;23197.188098416813;23255.3023409298;23475.94358253883;23476.178333758235;23492.53014939726;8140.104588495261;8173.060098088796;8187.754367368989;8204.425690201748;8455.323574114056;6865.41643960269;6920.273371295942;6935.202451718016;6939.063226464363;6953.617551034742;4073.9796301018305;4231.978840105779;4289.892752681208;7613.352865006425;7850.097238817495;1703.7188863837575;1753.2461041751915;1773.5832079461316;1782.0911335219132;1786.3479829862267;820.4461988158089;839.9328053755808;849;892.9910700893038;917.2066162769156;15138.697226055418;15186;15278.15970121654;15336.693266134615;15744.448944286894;786.9842603147905;840.2102024097329;867.7917299848117;906.1346414174448;932.4778124250306;8617.267532259828;8721;8735.383953968536;8747.781305467413;8987.46075235488;312223;318425;318472;463200;464179;66477.33522664712;69011.65494172598;70166;70496.29503704897;70694;1029.4543891737392;1055.514463346869;1056.6988408303596;1068.3162775823635;1068.8824229334766;14252.714945701235;14281.428742850585;14391.856081439051;14407.711845762817;14494.275286235857;30975.380492390475;31436.52845207278;31907;33221.50167747437;33455.49816752702;42889.142217156106;42891.142177155656;43346;44329.335059973484;45771.77114114408;7786.2213778623955;8757.562121894007;8945.329100317373;9030.954845225731;9076.863847042168;10042.096211341015;10201.081902628799;12478;14914.77627835605;15380.769288460458;12507.437165327765;12916.547920822726;13027.609171724864;13029.543965961146;13288.202707837561;12650.30423326726;12712.364381781059;12760;12854.807177892526;12934.870651293366;13045.934770326467;13072.542461013818;13558.457661693816;13567.50516041005;13851.30743462843;5273.551748101454;8444.873326899979;8641.56792160402;9035.45787252767;9038.322125840457;8576.528290944058;10434.478276086014;12627.684307892376;13377.592033434075;13659.590212293648 01:12:06 INFO - 2015-11-24 01:12:06,034 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1484.0427923989034;1560.1887018750251;1612.089169619165;1626.5364371154224;1640.1635166065303;5813.09896965971;6125.356837532062;6661.16735408074;7107.253738357469;7116.039334689815;6631.137952066237;6793.694283757231;6819.522633415663;6839.521233513656;6907.067545881305;1993.1628715939305;2047.897605119738;2049.549099198174;2051.138521820839;2052.568960518293;2067.9379618611465;2079.1995081893506;2094.0786054136206;2097.979020209801;2098.045389347843;1996.0718266006304;2035.7964203579597;2036.7148599196125;2040.8673436226597;2046.3451695457459;2006.6889632106975;2024.3623258673472;2025.0887100804623;2027.2195204846093;2030.878147311166;2047.4574237826987;2078.366098340006;2081.427607407975;2082.822960048398;2086.8330533557278;6898.344657257552;6974.267701891279;7005.054317667101;7005.474589405815;7026.051483049774;4047.271491131595;4096.5903409658795;4109.794510274504;4120.938185927213;4131.876043718693;2692.5826496893014;2717.578775289833;2730.2082396105106;2769.1000424862;2769.8615069246457;835.9791005224857;839.0015881101531;839.4669384940546;864.5331520978664;864.8183881384916;9080.954595226982;9106.681266155652;9118.589663465094;9147.542622868896;9171.358004939657;3813.313603551332;3827.024108852225;3868.477755502971;3907.27715372657;3930.5283365996265;7931.206879312138;7988.520688758693;7991.081025682005;8005.759827205193;8008.879866802003;4084.5302790178916;4106.835726570964;4124.154548317588;4142.2543942090115;4153.91692166155;3107.0523490335663;3181.0456862941023;3580.3018411410044;3750.7937063461773;3771.07608635886;3188.3782662380613;3303.554020207241;3312.9171770705925;3334.483155110962;3355.8825441109443;1048.0776916313596;1064.1539975719322;1072.4423299884172;1074.9301295415773;1080.0765345629532;952.642758965388;999.1457304005116;1011.0092109732503;1026.14829691356;1026.7895081508273;6376.553641245068;6390.265119511223;6400;6431.324710905381;6438.163038805019;452.7034792211107;454.0963482669464;456.5229335344573;1078.962236321725;1098.774751176007;5147.845564633067;5151.793928242903;5181.326427564468;5247.685138891678;5268.104422248227;8150.2664760171865;8329.541875196923;8364.03813561436;8383.95808020956;8394.8321033579;8186.590670466572;8187.1812818718845;8198.303144232688;8210.30212431938;8365.874511882326;6328.11406403104;6504.38208370204;6514.9674251629385;6547.836304092436;6556.147700798961;6235.438810506895;6240.687965601611;6259.1550140730415;6259.6870156492905;6264.248290205204;7230.819229519094;7317.707291708272;7321.816954576178;7366.337029667356;7425;7148.106486689164;7314.378277846443;7362.705491780269;7400.223946252968;7483.251674832473;5639.802606908738;5736.340320863154;5842.766289348378;5849.5612829037145;5927.199828023334;6375.5218358624215;6402.743890244525;6414.198225221848;6435.83910402225;6441.3880681335195;5956.821295361146;6035.668038257938;6078.54410919174;6120;6203.658798766111;5920.940790592212;5931;5982.7008649568215;5985.40145985398;6030.185924900083;6053.273607167168;6195.070739389128;6197.380261973766;6198.070289456437;6220.098085777628;5755.5683323750045;5776.884462310814;5790.10253410722;5820.30156381237;5827.8834423310445;5770.567207459373;5779.739911703899;5825.446582574648;5827.825165245049;5827.912581311369 01:12:06 INFO - 2015-11-24 01:12:06,037 DEBUG : BROWSER_OUTPUT: |4;prototype.html;307.3913650971077;313.2044606698985;314.34929695530263;317.3478501679049;317.4397188961483;5548.833534993952;5601.439856014402;5668.829935101949;5671.319441667006;5676.375598684152;5560.86097847554;5581.441855814416;5594.104943209088;5602.803901863435;5610.635308704931;4241;4337.175936572041;4363.54182810805;4369.934450983238;4371.519132895379;4318.244307246235;4357.085012147453;4365.192439398706;4371.73769573825;4392.604665580097;4315.82736690532;4330.761808100553;4334.826606935734;4336.6530677545725;4344.4786625604975;4307.923019245189;4338.544452832454;4346.304591265398;4349.26062569364;4350.108227813323;3652.3243200008083;3783.5838057813617;3791.317562838688;3791.469194312771;3794.1273507093247;5274.156135018378;5413;5432.185172224158;5443.482869127427;5446.673199607996;4892.535209155125;4925.310456536088;4929.975350123263;4930.704157750546;4934.1611925972675;5905.143754155666;5934.614250073774;5940.46535811779;5963.582549221556;5966.0454327307425;3965.8413663453425;4026.5973402659793;4047.4738284023183;4060.167665628539;4068.5524592294823;6142.416470435302;6144.109104179914;6167;6243.1883855099;6245.718942647592;4190.706650534434;4194;4198.475190601175;4200.705950583491;4219.388188712681;4252.510961239435;4266.957330426656;4271.615554600101;4277.059047009653;4278.251306021434;4782.258749893772;4904.2643603459765;4907.852764417074;4917.459079501252;4931.9753401232765;5881.38245484218;5920.082387229986;5921.28944526651;5932.2584676915385;5932.79235226765;1489.2330449818353;1521.9771703424458;1527.2363818090955;1529.9694006119814;1532.8926975111635;1007.3730924556788;1025.6974192613197;1032.6592224565875;1035.6329644868852;1039.0336986602533;5124.052050370693;5153.793848246029;5153.922691159561;5169.888473978112;5171.5862730981435;6101.328853826076;6101.359357267512;6108.389161083945;6152.477039451607;6175.2589689237575;5090.312807770903;5131.332926719502;5132.358455193101;5140.383154021467;5149.150390185578;3246.756493263015;3304.6364899860996;3341.766076374679;3345.8661653533586;3356.194513316835;5683.460071293221;5832.562557808182;5858.945389829872;5864.739081097585;5874.148248504029;6376.266729326187;6389.520785941073;6392.744290228339;6403.48772098231;6421.807345779541;5811.012127938261;5813;5826.737796799239;5846.298444186725;5846.6784326862435;5998.730057147526;6171.6297022178815;6183.165272688309;6210.192674952408;6243.8126856194385;6027.60820546663;6037.879242415215;6045.909311360245;6071.119687645355;6100.359462256577;5829.854253643693;5858.062709966385;5870.0607902735355;5873.3832947541605;5880.176775251553;4309.095090031004;4369.934450983174;4371.540988196193;4377.627901628397;4386.670999675101;5964.940350596438;6073.939260607337;6116.2660480740815;6119.388061193845;6120.357362477054;5842.649441033552;5880.676562788916;5883.264591926009;5901.232839730807;5907.409259074058;5832.3292821326095;5846.41535846412;5849.64902105875;5890.057590785454;5898.64608123514;5650.519705825051;5756.56825738063;5763.7406316715005;5820.94179058204;5831.125331200354;5966.105084237225;5972.313183983897;5984.341722410444;5984.581079324405;5990.7304171311525;5842;5846.064629659234;5857.092150716646;5859.765609375748;5872.1778950946045 01:12:06 INFO - 2015-11-24 01:12:06,039 DEBUG : BROWSER_OUTPUT: |5;yui.html;618.270440879762;638.4222278837652;661.1570247933887;725.6915810780418;738.8805958972155;9470.810583788329;9607.855882161773;9734.464604446752;9739.464329461885;9791.11879930806;11286.492107855145;11440.885591144086;11794.410279486014;12002;12013.579524716637;738.0847748791514;745.4483682075279;760.6919197724931;760.7033257029735;760.8592410404066;743.1453828097677;744.4528271720309;745.4595418321727;745.6681776609411;748.4573684079027;781.4607920534842;785.0814546980018;786.3591173193857;790.6244533846434;791.1771757372326;767.4742801181209;773.4856320546829;774.7288449042818;775.2867362026949;776.1462391369505;575.9280089988752;576.1127863090835;577.777555641077;579.1284117403324;579.5740131003708;11707.94146029273;11720.706982325424;11801.055915526736;11818.231814932087;11832.822507662391;10103.343282686601;10570.312929659547;10598.78802423955;11164.553417863275;11610;9153.54232288383;9382.577783999737;9638.42169469827;9675.301420556305;9716.90283097167;3200.391925534141;3234.433974054531;3240.270939038721;3258.038878530839;3270.640229574745;42713.57286427127;42803.929901752395;42847;43263.78368108139;43460.3480947786;8547.487150770974;8807.427517211489;9103.499307538017;9143.131402516883;9218.262538996863;16038.358465661242;16038.438654647265;16079;16096.356145754273;16119.27463264156;5880.176775251468;5999.760009599567;6145.84635384119;6225.564210505221;6299.181106456132;3375.8312084395684;3384.1708781348725;3407.4207384744655;3424.2124311408515;3502.649735026477;2542.41524449374;2570.4088059746364;2579.4583137541326;2581.251437083225;2593.351662084479;470.28986230791065;475.8239451403003;482.7586206896552;482.826182574273;482.9396325459318;434.6566212692001;508.54739282039014;553.532265235875;560.4731552340787;609.1106983803696;6480.287168411471;6552.213734351908;6644.534882558174;6645.867082658417;6702.296258892844;437.16501482168906;441.34239982426595;466.63835527466483;494.2758858272648;585.5754577930966;3064.586280852101;3179.4753865611915;3192.888248911277;3276.6559511251453;3373.308471763283;55543.44456555383;55560.44439555633;55727.442725572226;56315;56434.717826411426;47334;48205.75897120492;48572.757136214095;48575;48674.51325486771;42893.57106428958;42915;43748.3437748434;44036.3394549082;44312.77843610826;6663.267040625624;6741.797746067626;6748.763793267409;6769;6827.351401616838;32076.19809504688;32111.35777284488;32141.196470088435;32144.839275804406;32326.19184520406;37066;37452;37579;37942.620573795015;38646.42030369603;9123.178913897782;9175.954120229357;9245.445273283625;9401.200897923753;9807.680786052444;9484.668036618685;9948.900510995087;10279.17766578657;10312.535935882754;10352.896471035194;8820.25027872638;8896.332775041768;8934.50860202695;8937.106289371011;9049.321300902327;8787.253083487974;8851.911480885108;9055.501947392957;9198;9430.434173949585;9005.099490050943;9173.587188576663;9246.445213287225;9275.6289748412;9360.906390936276;8210.630521626661;8445.831083378422;8451.746447606582;8505.319574434154;8546.102659220693;7812.53124812513;8063.959680201561;8257.95871020641;8259.463134896452;8310.958445207978 01:12:06 INFO - 2015-11-24 01:12:06,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:12:06 INFO - 2015-11-24 01:12:06,039 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:12:06 INFO - 2015-11-24 01:12:06,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 01:12:06 INFO - 2015-11-24 01:12:06,040 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:12:06 INFO - 2015-11-24 01:12:06,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356326026__endTimestamp 01:12:06 INFO - 2015-11-24 01:12:06,040 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,041 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:12:06 INFO - 2015-11-24 01:12:06,041 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:12:06 INFO - 2015-11-24 01:12:06,041 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,041 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4581.08 Median:4709.95 stddev:472.09 (10.0%) stddev-sans-first:447.90 01:12:06 INFO - 2015-11-24 01:12:06,042 DEBUG : BROWSER_OUTPUT: Values: 2625.1 2644.3 2672.0 2676.5 2692.3 4521.3 4657.7 4668.7 4676.3 4680.7 4546.2 4595.5 4595.7 4652.1 4675.0 4149.6 4201.6 4226.1 4292.1 4357.3 4341.5 4393.7 4407.3 4407.4 4410.4 4136.9 4219.1 4252.0 4258.4 4324.9 4307.0 4330.8 4335.6 4351.8 4384.0 4297.3 4307.6 4315.8 4347.8 4377.8 4413.0 4527.2 4543.5 4591.9 4709.7 4980.4 4986.3 4991.4 4999.9 5027.7 5010.7 5013.8 5014.9 5015.4 5018.7 4429.0 4530.0 4562.9 4592.9 4637.4 5061.3 5066.9 5080.3 5083.8 5092.7 4710.0 4897.4 4898.3 4903.2 4945.4 4894.4 4923.5 4950.7 4955.0 5014.4 4910.1 4916.7 4925.9 4938.6 4958.0 4688.7 4784.9 4885.8 4892.6 4949.0 4049.6 4095.8 4113.8 4125.9 4143.8 3631.7 3637.1 3652.2 3655.2 3676.8 4179.5 4263.5 4358.5 4368.3 4375.8 4804.8 4808.1 4819.1 4859.8 4901.0 4323.2 4351.8 4359.1 4365.9 4384.6 4191.1 4305.2 4329.3 4450.6 4456.8 4756.7 4757.8 4763.2 4774.3 4786.8 5002.9 5026.5 5029.5 5034.6 5082.6 4550.0 4578.8 4689.1 4731.6 4773.9 4931.1 4945.3 4962.1 4978.1 5012.1 5011.3 5022.4 5035.9 5038.9 5095.0 4629.4 4695.9 4747.0 4766.1 4814.6 4835.0 4844.3 4852.9 4855.3 4881.6 4720.0 4751.8 4756.7 4758.6 4772.6 4599.1 4734.6 4740.8 4755.2 4815.3 4739.0 4782.8 4786.2 4790.7 4806.7 01:12:06 INFO - 2015-11-24 01:12:06,042 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,042 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41462.61 Median:36411.68 stddev:71127.56 (195.3%) stddev-sans-first:71260.75 01:12:06 INFO - 2015-11-24 01:12:06,044 DEBUG : BROWSER_OUTPUT: Values: 546.7 569.9 581.3 586.9 587.0 35749.5 36565.6 36583.8 36767.3 36821.4 39474.2 39908.2 39915.4 40140.6 40154.0 7811.5 7903.1 7995.1 8022.0 8036.0 7685.9 7807.9 7881.4 7889.4 7910.9 7806.2 7870.1 7870.2 7877.2 7887.1 7802.1 7826.7 7838.2 7843.8 7852.8 7798.6 7900.7 7919.3 7946.8 7954.9 36439.1 36642.3 36736.4 36749.6 36751.9 2581.0 2604.7 2610.3 2756.0 3142.3 27502.0 27561.2 27633.9 27910.6 28182.9 3290.5 3296.8 3324.0 3347.0 3373.1 222659.0 224091.0 224621.0 225581.0 225748.8 36319.5 36949.0 50439.2 50734.0 50839.0 36384.3 36567.6 36574.5 36769.3 36812.8 12244.9 12367.1 12390.7 12395.4 12420.6 9427.4 9431.2 9448.3 9475.0 9514.7 12833.3 13002.4 13013.9 13020.9 13049.3 5370.5 5452.9 5460.5 5475.4 5504.2 857.9 981.2 992.6 1012.2 1031.9 25755.6 25954.0 25969.4 26046.3 26178.3 928.2 958.9 959.0 973.3 1041.8 12908.4 12920.1 13137.6 13243.5 13271.7 328492.0 334628.0 336732.0 337797.0 337821.0 45493.8 45498.0 45818.5 46039.8 46215.5 1212.7 1216.3 1217.9 1227.6 1233.2 24586.0 24756.4 24949.8 24990.5 24991.0 36576.6 36631.5 36688.6 36822.3 36971.6 239597.0 240317.0 240887.0 242387.0 242691.0 28411.9 28797.7 40637.0 41778.8 41787.2 38593.8 38940.4 39137.8 39792.8 40034.4 32786.5 32906.5 33220.7 33831.0 34280.3 33755.8 35380.0 35835.8 37994.6 38478.2 33443.0 33643.7 33949.0 34055.8 34220.5 29010.0 29826.7 30090.7 30725.4 31008.2 23703.6 23998.4 24164.0 24229.5 24496.9 01:12:06 INFO - 2015-11-24 01:12:06,044 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,044 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24052.20 Median:16777.60 stddev:62681.72 (373.6%) stddev-sans-first:62832.26 01:12:06 INFO - 2015-11-24 01:12:06,045 DEBUG : BROWSER_OUTPUT: Values: 333.7 334.9 336.6 337.8 338.7 15152.8 15279.1 15433.7 15895.8 16479.1 14352.4 14363.1 14376.4 14514.0 14804.6 4017.7 4571.6 5295.2 5296.0 6166.6 6376.7 6385.4 6407.5 6429.2 6437.0 6293.5 6336.8 6361.0 6472.6 6478.2 6464.1 6498.0 6507.4 6515.9 6522.0 5812.2 6448.4 6459.5 6462.1 6466.9 20107.4 20221.0 20535.7 20925.7 21068.7 1746.3 1780.3 1821.7 1828.1 1834.3 13412.1 13433.2 13492.5 13866.8 14120.6 1825.4 1881.3 1893.3 1906.1 1921.1 58945.0 62707.7 63295.9 64155.7 65022.3 15726.4 15732.8 15750.2 15829.4 15944.7 23197.2 23255.3 23475.9 23476.2 23492.5 8140.1 8173.1 8187.8 8204.4 8455.3 6865.4 6920.3 6935.2 6939.1 6953.6 4074.0 4232.0 4289.9 7613.4 7850.1 1703.7 1753.2 1773.6 1782.1 1786.3 820.4 839.9 849.0 893.0 917.2 15138.7 15186.0 15278.2 15336.7 15744.4 787.0 840.2 867.8 906.1 932.5 8617.3 8721.0 8735.4 8747.8 8987.5 312223.0 318425.0 318472.0 463200.0 464179.0 66477.3 69011.7 70166.0 70496.3 70694.0 1029.5 1055.5 1056.7 1068.3 1068.9 14252.7 14281.4 14391.9 14407.7 14494.3 30975.4 31436.5 31907.0 33221.5 33455.5 42889.1 42891.1 43346.0 44329.3 45771.8 7786.2 8757.6 8945.3 9031.0 9076.9 10042.1 10201.1 12478.0 14914.8 15380.8 12507.4 12916.5 13027.6 13029.5 13288.2 12650.3 12712.4 12760.0 12854.8 12934.9 13045.9 13072.5 13558.5 13567.5 13851.3 5273.6 8444.9 8641.6 9035.5 9038.3 8576.5 10434.5 12627.7 13377.6 13659.6 01:12:06 INFO - 2015-11-24 01:12:06,045 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,046 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4781.70 Median:5835.34 stddev:2452.91 (42.0%) stddev-sans-first:2447.27 01:12:06 INFO - 2015-11-24 01:12:06,046 DEBUG : BROWSER_OUTPUT: Values: 1484.0 1560.2 1612.1 1626.5 1640.2 5813.1 6125.4 6661.2 7107.3 7116.0 6631.1 6793.7 6819.5 6839.5 6907.1 1993.2 2047.9 2049.5 2051.1 2052.6 2067.9 2079.2 2094.1 2098.0 2098.0 1996.1 2035.8 2036.7 2040.9 2046.3 2006.7 2024.4 2025.1 2027.2 2030.9 2047.5 2078.4 2081.4 2082.8 2086.8 6898.3 6974.3 7005.1 7005.5 7026.1 4047.3 4096.6 4109.8 4120.9 4131.9 2692.6 2717.6 2730.2 2769.1 2769.9 836.0 839.0 839.5 864.5 864.8 9081.0 9106.7 9118.6 9147.5 9171.4 3813.3 3827.0 3868.5 3907.3 3930.5 7931.2 7988.5 7991.1 8005.8 8008.9 4084.5 4106.8 4124.2 4142.3 4153.9 3107.1 3181.0 3580.3 3750.8 3771.1 3188.4 3303.6 3312.9 3334.5 3355.9 1048.1 1064.2 1072.4 1074.9 1080.1 952.6 999.1 1011.0 1026.1 1026.8 6376.6 6390.3 6400.0 6431.3 6438.2 452.7 454.1 456.5 1079.0 1098.8 5147.8 5151.8 5181.3 5247.7 5268.1 8150.3 8329.5 8364.0 8384.0 8394.8 8186.6 8187.2 8198.3 8210.3 8365.9 6328.1 6504.4 6515.0 6547.8 6556.1 6235.4 6240.7 6259.2 6259.7 6264.2 7230.8 7317.7 7321.8 7366.3 7425.0 7148.1 7314.4 7362.7 7400.2 7483.3 5639.8 5736.3 5842.8 5849.6 5927.2 6375.5 6402.7 6414.2 6435.8 6441.4 5956.8 6035.7 6078.5 6120.0 6203.7 5920.9 5931.0 5982.7 5985.4 6030.2 6053.3 6195.1 6197.4 6198.1 6220.1 5755.6 5776.9 5790.1 5820.3 5827.9 5770.6 5779.7 5825.4 5827.8 5827.9 01:12:06 INFO - 2015-11-24 01:12:06,046 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,046 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4906.35 Median:5554.85 stddev:1447.88 (26.1%) stddev-sans-first:1410.20 01:12:06 INFO - 2015-11-24 01:12:06,047 DEBUG : BROWSER_OUTPUT: Values: 307.4 313.2 314.3 317.3 317.4 5548.8 5601.4 5668.8 5671.3 5676.4 5560.9 5581.4 5594.1 5602.8 5610.6 4241.0 4337.2 4363.5 4369.9 4371.5 4318.2 4357.1 4365.2 4371.7 4392.6 4315.8 4330.8 4334.8 4336.7 4344.5 4307.9 4338.5 4346.3 4349.3 4350.1 3652.3 3783.6 3791.3 3791.5 3794.1 5274.2 5413.0 5432.2 5443.5 5446.7 4892.5 4925.3 4930.0 4930.7 4934.2 5905.1 5934.6 5940.5 5963.6 5966.0 3965.8 4026.6 4047.5 4060.2 4068.6 6142.4 6144.1 6167.0 6243.2 6245.7 4190.7 4194.0 4198.5 4200.7 4219.4 4252.5 4267.0 4271.6 4277.1 4278.3 4782.3 4904.3 4907.9 4917.5 4932.0 5881.4 5920.1 5921.3 5932.3 5932.8 1489.2 1522.0 1527.2 1530.0 1532.9 1007.4 1025.7 1032.7 1035.6 1039.0 5124.1 5153.8 5153.9 5169.9 5171.6 6101.3 6101.4 6108.4 6152.5 6175.3 5090.3 5131.3 5132.4 5140.4 5149.2 3246.8 3304.6 3341.8 3345.9 3356.2 5683.5 5832.6 5858.9 5864.7 5874.1 6376.3 6389.5 6392.7 6403.5 6421.8 5811.0 5813.0 5826.7 5846.3 5846.7 5998.7 6171.6 6183.2 6210.2 6243.8 6027.6 6037.9 6045.9 6071.1 6100.4 5829.9 5858.1 5870.1 5873.4 5880.2 4309.1 4369.9 4371.5 4377.6 4386.7 5964.9 6073.9 6116.3 6119.4 6120.4 5842.6 5880.7 5883.3 5901.2 5907.4 5832.3 5846.4 5849.6 5890.1 5898.6 5650.5 5756.6 5763.7 5820.9 5831.1 5966.1 5972.3 5984.3 5984.6 5990.7 5842.0 5846.1 5857.1 5859.8 5872.2 01:12:06 INFO - 2015-11-24 01:12:06,047 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,047 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12225.77 Median:582.57 stddev:14896.32 (2557.0%) stddev-sans-first:14912.61 01:12:06 INFO - 2015-11-24 01:12:06,047 DEBUG : BROWSER_OUTPUT: Values: 618.3 638.4 661.2 725.7 738.9 9470.8 9607.9 9734.5 9739.5 9791.1 11286.5 11440.9 11794.4 12002.0 12013.6 738.1 745.4 760.7 760.7 760.9 743.1 744.5 745.5 745.7 748.5 781.5 785.1 786.4 790.6 791.2 767.5 773.5 774.7 775.3 776.1 575.9 576.1 577.8 579.1 579.6 11707.9 11720.7 11801.1 11818.2 11832.8 10103.3 10570.3 10598.8 11164.6 11610.0 9153.5 9382.6 9638.4 9675.3 9716.9 3200.4 3234.4 3240.3 3258.0 3270.6 42713.6 42803.9 42847.0 43263.8 43460.3 8547.5 8807.4 9103.5 9143.1 9218.3 16038.4 16038.4 16079.0 16096.4 16119.3 5880.2 5999.8 6145.8 6225.6 6299.2 3375.8 3384.2 3407.4 3424.2 3502.6 2542.4 2570.4 2579.5 2581.3 2593.4 470.3 475.8 482.8 482.8 482.9 434.7 508.5 553.5 560.5 609.1 6480.3 6552.2 6644.5 6645.9 6702.3 437.2 441.3 466.6 494.3 585.6 3064.6 3179.5 3192.9 3276.7 3373.3 55543.4 55560.4 55727.4 56315.0 56434.7 47334.0 48205.8 48572.8 48575.0 48674.5 42893.6 42915.0 43748.3 44036.3 44312.8 6663.3 6741.8 6748.8 6769.0 6827.4 32076.2 32111.4 32141.2 32144.8 32326.2 37066.0 37452.0 37579.0 37942.6 38646.4 9123.2 9176.0 9245.4 9401.2 9807.7 9484.7 9948.9 10279.2 10312.5 10352.9 8820.3 8896.3 8934.5 8937.1 9049.3 8787.3 8851.9 9055.5 9198.0 9430.4 9005.1 9173.6 9246.4 9275.6 9360.9 8210.6 8445.8 8451.7 8505.3 8546.1 7812.5 8064.0 8258.0 8259.5 8311.0 01:12:06 INFO - 2015-11-24 01:12:06,048 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:12:06 INFO - 2015-11-24 01:12:06,048 DEBUG : BROWSER_OUTPUT: 01:12:06 INFO - 2015-11-24 01:12:06,785 INFO : Browser exited with error code: 0 01:12:06 INFO - 2015-11-24 01:12:06,804 INFO : Completed test dromaeo_css (00:18:34) 01:12:06 INFO - 2015-11-24 01:12:06,804 INFO : Starting test kraken 01:12:06 INFO - 2015-11-24 01:12:06,804 DEBUG : operating with platform_type : linux_ 01:12:06 INFO - 2015-11-24 01:12:06,805 INFO : Initialising browser for kraken test... 01:12:06 INFO - 2015-11-24 01:12:06,811 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMWYfzk/profile http://localhost:45503/getInfo.html 01:12:11 INFO - 2015-11-24 01:12:11,958 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:12:11 INFO - 2015-11-24 01:12:11,958 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:12:11 INFO - 2015-11-24 01:12:11,958 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:12:11 INFO - 2015-11-24 01:12:11,958 DEBUG : BROWSER_OUTPUT: __metrics 01:12:13 INFO - 2015-11-24 01:12:13,101 INFO : Browser initialized. 01:12:13 INFO - 2015-11-24 01:12:13,102 INFO : Running cycle 1/1 for kraken test... 01:12:13 INFO - 2015-11-24 01:12:13,102 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMWYfzk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:12:25 INFO - 2015-11-24 01:12:25,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 140652544 01:12:25 INFO - 2015-11-24 01:12:25,077 DEBUG : BROWSER_OUTPUT: 01:12:27 INFO - 2015-11-24 01:12:27,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45503/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:28 INFO - 2015-11-24 01:12:28,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 142213120 01:12:28 INFO - 2015-11-24 01:12:28,300 DEBUG : BROWSER_OUTPUT: 01:12:31 INFO - 2015-11-24 01:12:31,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45503/tests/kraken/driver.html?testName=audio-dft) 01:12:31 INFO - 2015-11-24 01:12:31,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 142671872 01:12:31 INFO - 2015-11-24 01:12:31,681 DEBUG : BROWSER_OUTPUT: 01:12:34 INFO - 2015-11-24 01:12:34,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45503/tests/kraken/driver.html?testName=audio-fft) 01:12:35 INFO - 2015-11-24 01:12:35,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 138444800 01:12:35 INFO - 2015-11-24 01:12:35,195 DEBUG : BROWSER_OUTPUT: 01:12:37 INFO - 2015-11-24 01:12:37,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45503/tests/kraken/driver.html?testName=audio-oscillator) 01:12:37 INFO - 2015-11-24 01:12:37,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 138293248 01:12:37 INFO - 2015-11-24 01:12:37,867 DEBUG : BROWSER_OUTPUT: 01:12:40 INFO - 2015-11-24 01:12:40,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45503/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:12:40 INFO - 2015-11-24 01:12:40,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 01:12:40 INFO - 2015-11-24 01:12:40,708 DEBUG : BROWSER_OUTPUT: 01:12:43 INFO - 2015-11-24 01:12:43,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45503/tests/kraken/driver.html?testName=imaging-darkroom) 01:12:44 INFO - 2015-11-24 01:12:44,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 140361728 01:12:44 INFO - 2015-11-24 01:12:44,337 DEBUG : BROWSER_OUTPUT: 01:12:47 INFO - 2015-11-24 01:12:47,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45503/tests/kraken/driver.html?testName=imaging-desaturate) 01:12:48 INFO - 2015-11-24 01:12:48,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 01:12:48 INFO - 2015-11-24 01:12:48,412 DEBUG : BROWSER_OUTPUT: 01:12:51 INFO - 2015-11-24 01:12:51,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45503/tests/kraken/driver.html?testName=json-parse-financial) 01:12:51 INFO - 2015-11-24 01:12:51,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 138711040 01:12:51 INFO - 2015-11-24 01:12:51,924 DEBUG : BROWSER_OUTPUT: 01:12:53 INFO - 2015-11-24 01:12:53,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45503/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:12:54 INFO - 2015-11-24 01:12:54,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 139534336 01:12:54 INFO - 2015-11-24 01:12:54,327 DEBUG : BROWSER_OUTPUT: 01:12:56 INFO - 2015-11-24 01:12:56,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:12:56 INFO - 2015-11-24 01:12:56,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 139890688 01:12:56 INFO - 2015-11-24 01:12:56,837 DEBUG : BROWSER_OUTPUT: 01:12:59 INFO - 2015-11-24 01:12:59,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:12:59 INFO - 2015-11-24 01:12:59,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 01:12:59 INFO - 2015-11-24 01:12:59,662 DEBUG : BROWSER_OUTPUT: 01:13:02 INFO - 2015-11-24 01:13:02,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:13:02 INFO - 2015-11-24 01:13:02,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 139595776 01:13:02 INFO - 2015-11-24 01:13:02,844 DEBUG : BROWSER_OUTPUT: 01:13:05 INFO - 2015-11-24 01:13:05,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:13:06 INFO - 2015-11-24 01:13:06,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 139325440 01:13:06 INFO - 2015-11-24 01:13:06,101 DEBUG : BROWSER_OUTPUT: 01:13:07 INFO - 2015-11-24 01:13:07,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45503/tests/kraken/driver.html?testName=ai-astar) 01:13:08 INFO - 2015-11-24 01:13:08,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 01:13:08 INFO - 2015-11-24 01:13:08,146 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,148 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:08 INFO - 2015-11-24 01:13:08,148 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:08 INFO - 2015-11-24 01:13:08,148 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:08 INFO - 2015-11-24 01:13:08,148 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:08 INFO - 2015-11-24 01:13:08,148 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;110;114;112;114;126;114;114;113;116 01:13:08 INFO - 2015-11-24 01:13:08,148 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;131;156;164;132;168;159;132;183;137 01:13:08 INFO - 2015-11-24 01:13:08,149 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;164;163;167;169;170;164;165;164 01:13:08 INFO - 2015-11-24 01:13:08,149 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;72;140;72;73;75;73;90 01:13:08 INFO - 2015-11-24 01:13:08,149 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;126;94;96;95;128;95;94;132 01:13:08 INFO - 2015-11-24 01:13:08,149 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;111;110;110;110;111;122 01:13:08 INFO - 2015-11-24 01:13:08,149 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;147;148;148;149;149;147;148;148 01:13:08 INFO - 2015-11-24 01:13:08,149 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;102;95;96;96;97;97;97;95 01:13:08 INFO - 2015-11-24 01:13:08,149 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;77;75;75;77;77;74;74;76;77 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;70;69;69;69;69;69;69;70 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;85;93;84;84;83;83;93;97 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;120;119;122;122;128;130;129;127;137 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;160;149;151;162;154;147;135;147;152;150 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;73;77;71;70;71;71;70;72;71 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:13:08 INFO - 2015-11-24 01:13:08,150 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,781 01:13:08 INFO - 2015-11-24 01:13:08,151 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:13:08 INFO - 2015-11-24 01:13:08,151 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356388146__endTimestamp 01:13:08 INFO - 2015-11-24 01:13:08,151 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,154 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:08 INFO - 2015-11-24 01:13:08,154 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:13:08 INFO - 2015-11-24 01:13:08,154 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.26 (3.7%) stddev-sans-first:4.52 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: Values: 115.0 110.0 114.0 112.0 114.0 126.0 114.0 114.0 113.0 116.0 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.40 Median:157.50 stddev:17.91 (11.4%) stddev-sans-first:19.00 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: Values: 152.0 131.0 156.0 164.0 132.0 168.0 159.0 132.0 183.0 137.0 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:2.50 (1.5%) stddev-sans-first:2.60 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 164.0 163.0 167.0 169.0 170.0 164.0 165.0 164.0 01:13:08 INFO - 2015-11-24 01:13:08,155 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:73.00 stddev:21.25 (29.1%) stddev-sans-first:22.31 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 72.0 140.0 72.0 73.0 75.0 73.0 90.0 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:94.50 stddev:16.41 (17.4%) stddev-sans-first:17.08 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 126.0 94.0 96.0 95.0 128.0 95.0 94.0 132.0 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.40 Median:110.00 stddev:3.75 (3.4%) stddev-sans-first:3.94 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 122.0 01:13:08 INFO - 2015-11-24 01:13:08,156 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,157 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 01:13:08 INFO - 2015-11-24 01:13:08,157 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 147.0 148.0 148.0 149.0 149.0 147.0 148.0 148.0 01:13:08 INFO - 2015-11-24 01:13:08,157 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,157 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.50 stddev:1.99 (2.1%) stddev-sans-first:2.11 01:13:08 INFO - 2015-11-24 01:13:08,157 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 102.0 95.0 96.0 96.0 97.0 97.0 97.0 95.0 01:13:08 INFO - 2015-11-24 01:13:08,157 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,158 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.80 Median:76.50 stddev:1.23 (1.6%) stddev-sans-first:1.30 01:13:08 INFO - 2015-11-24 01:13:08,158 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 75.0 75.0 77.0 77.0 74.0 74.0 76.0 77.0 01:13:08 INFO - 2015-11-24 01:13:08,158 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,158 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 01:13:08 INFO - 2015-11-24 01:13:08,158 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 69.0 70.0 01:13:08 INFO - 2015-11-24 01:13:08,158 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:84.50 stddev:5.44 (6.4%) stddev-sans-first:5.49 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 85.0 93.0 84.0 84.0 83.0 83.0 93.0 97.0 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.50 stddev:5.47 (4.3%) stddev-sans-first:5.79 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: Values: 125.0 120.0 119.0 122.0 122.0 128.0 130.0 129.0 127.0 137.0 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:151.50 stddev:7.48 (4.9%) stddev-sans-first:7.14 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: Values: 160.0 149.0 151.0 162.0 154.0 147.0 135.0 147.0 152.0 150.0 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: 01:13:08 INFO - 2015-11-24 01:13:08,159 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:2.12 (3.0%) stddev-sans-first:2.17 01:13:08 INFO - 2015-11-24 01:13:08,160 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 77.0 71.0 70.0 71.0 71.0 70.0 72.0 71.0 01:13:08 INFO - 2015-11-24 01:13:08,160 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:08 INFO - 2015-11-24 01:13:08,160 DEBUG : BROWSER_OUTPUT: 01:13:09 INFO - 2015-11-24 01:13:09,121 INFO : Browser exited with error code: 0 01:13:09 INFO - 2015-11-24 01:13:09,176 INFO : Completed test kraken (00:01:02) 01:13:09 INFO - 2015-11-24 01:13:09,176 INFO : Starting test v8_7 01:13:09 INFO - 2015-11-24 01:13:09,176 DEBUG : operating with platform_type : linux_ 01:13:09 INFO - 2015-11-24 01:13:09,176 INFO : Initialising browser for v8_7 test... 01:13:09 INFO - 2015-11-24 01:13:09,182 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA0NZzw/profile http://localhost:45503/getInfo.html 01:13:14 INFO - 2015-11-24 01:13:14,462 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:13:14 INFO - 2015-11-24 01:13:14,462 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:13:14 INFO - 2015-11-24 01:13:14,462 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:13:14 INFO - 2015-11-24 01:13:14,462 DEBUG : BROWSER_OUTPUT: __metrics 01:13:15 INFO - 2015-11-24 01:13:15,629 INFO : Browser initialized. 01:13:15 INFO - 2015-11-24 01:13:15,630 INFO : Running cycle 1/1 for v8_7 test... 01:13:15 INFO - 2015-11-24 01:13:15,630 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA0NZzw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:13:27 INFO - 2015-11-24 01:13:27,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 142036992 01:13:27 INFO - 2015-11-24 01:13:27,604 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45503/tests/v8_7/run.html (next: http://localhost:45503/tests/v8_7/run.html) 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 138887168 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: |0;Richards;186.74136321195144 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.11406844106463 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 01:13:49 INFO - 2015-11-24 01:13:49,373 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1040.5827263267429 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: |5;Earley;710.7320540156361 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: |8;Splay;596.7837998808815 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356429366__endTimestamp 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,374 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.74 Median:186.74 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: Values: 186.7 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: Values: 190.1 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: Values: 279.2 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: Values: 5015.0 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1040.58 Median:1040.58 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: Values: 1040.6 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:710.73 Median:710.73 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,375 DEBUG : BROWSER_OUTPUT: Values: 710.7 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: Values: 12207.3 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: Values: 25350.0 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:596.78 Median:596.78 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: Values: 596.8 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: Values: 4854.4 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:49 INFO - 2015-11-24 01:13:49,376 DEBUG : BROWSER_OUTPUT: 01:13:50 INFO - 2015-11-24 01:13:50,277 INFO : Browser exited with error code: 0 01:13:50 INFO - 2015-11-24 01:13:50,292 INFO : Completed test v8_7 (00:00:41) 01:13:50 INFO - 2015-11-24 01:13:50,377 INFO : Completed test suite (00:20:18) 01:13:50 INFO - 2015-11-24 01:13:50,377 DEBUG : Working with test: dromaeo_css 01:13:50 INFO - 2015-11-24 01:13:50,378 DEBUG : Generating results file: dromaeo_css 01:13:50 INFO - 2015-11-24 01:13:50,379 DEBUG : Working with test: kraken 01:13:50 INFO - 2015-11-24 01:13:50,379 DEBUG : Generating results file: kraken 01:13:50 INFO - 2015-11-24 01:13:50,379 INFO : javascript benchmark 01:13:50 INFO - 2015-11-24 01:13:50,379 DEBUG : Working with test: v8_7 01:13:50 INFO - 2015-11-24 01:13:50,379 DEBUG : Generating results file: v8_7 01:13:50 INFO - 2015-11-24 01:13:50,380 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:50 INFO - 2015-11-24 01:13:50,441 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 01:13:50 INFO - 2015-11-24 01:13:50,441 DEBUG : process_Request line: dromaeo_css 6283.41 graph.html#tests=[[72,132,43]] 01:13:50 INFO - 2015-11-24 01:13:50,441 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:50 INFO - 2015-11-24 01:13:50,470 DEBUG : process_Request line: kraken 1554.20 graph.html#tests=[[232,132,43]] 01:13:50 INFO - 2015-11-24 01:13:50,470 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:50 INFO - 2015-11-24 01:13:50,506 DEBUG : process_Request line: v8_7 21264.55 graph.html#tests=[[230,132,43]] 01:13:50 INFO - 2015-11-24 01:13:50,508 INFO : javascript benchmark 01:13:50 INFO - 2015-11-24 01:13:50,512 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2625.1468272811335, 2644.259607309954, 2672.0247109804914, 2676.544987352151, 2692.2865440658225, 4521.276595744682, 4657.720536767796, 4668.696534725241, 4676.321933319667, 4680.719156850587, 4546.249868771649, 4595.540445955403, 4595.7242565446095, 4652.139354219464, 4675.041616468624, 4149.605787450188, 4201.555764752508, 4226.133642603274, 4292.055747735493, 4357.259265924785, 4341.45731783527, 4393.714408563433, 4407.2507673695545, 4407.405000324963, 4410.4266445362055, 4136.855210067663, 4219.135077309144, 4251.957480425187, 4258.403823464687, 4324.870253892388, 4306.978465107654, 4330.848420305306, 4335.588119128678, 4351.804168812411, 4384.0355121873135, 4297.333913243452, 4307.633851122627, 4315.805788739514, 4347.782620866163, 4377.846775362847, 4412.955870441287, 4527.230370836965, 4543.5002149763495, 4591.931121033187, 4709.693869898446, 4980.377452818398, 4986.252062190701, 4991.425986011619, 4999.925001124986, 5027.673201241944, 5010.674306170124, 5013.774380152902, 5014.899702005976, 5015.3730783652045, 5018.723970181639, 4429.0, 4530.0, 4562.931556026662, 4592.931106033412, 4637.443506779208, 5061.316722242524, 5066.898662026739, 5080.288759573663, 5083.822066227738, 5092.694438333712, 4709.95290047102, 4897.3878265216845, 4898.338724272249, 4903.215485522299, 4945.357103576512, 4894.437139728977, 4923.48303428142, 4950.6782059166035, 4954.9752251238515, 5014.423341315795, 4910.06708725341, 4916.729579873141, 4925.901481970341, 4938.604911607063, 4957.958828645953, 4688.718676879398, 4784.856454306377, 4885.755712214375, 4892.608591312757, 4949.034938187091, 4049.57479464652, 4095.815688294034, 4113.773742444194, 4125.8968525787095, 4143.834246630161, 3631.654992775682, 3637.108908317426, 3652.160003199279, 3655.2324011957253, 3676.816159192083, 4179.456670632799, 4263.467066616673, 4358.4769827620885, 4368.257396242647, 4375.824967001348, 4804.807807687724, 4808.08646357191, 4819.108464933998, 4859.781309841065, 4900.975495122501, 4323.200207961537, 4351.782410879443, 4359.12817436514, 4365.890852728708, 4384.56154384559, 4191.140816132685, 4305.203537345601, 4329.264025115738, 4450.577195166454, 4456.77716114193, 4756.7145971241835, 4757.785899634525, 4763.2140696784645, 4774.30772537987, 4786.784594693317, 5002.899942001212, 5026.472220416804, 5029.497050294941, 5034.647574669738, 5082.593392528663, 4550.044490656999, 4578.771061446981, 4689.085628302449, 4731.574158325767, 4773.928391074067, 4931.0630980113665, 4945.282933974481, 4962.131626965339, 4978.103941290602, 5012.072766538202, 5011.298418221379, 5022.422421421583, 5035.874103147451, 5038.874028149326, 5095.0, 4629.444466664022, 4695.906081878412, 4746.976265118652, 4766.118268120409, 4814.5907597854575, 4835.032993401263, 4844.346013288302, 4852.8786780329365, 4855.271709243641, 4881.560659540658, 4720.032393359422, 4751.762411879323, 4756.738379389167, 4758.64310176745, 4772.642051846195, 4599.080183963154, 4734.644901632322, 4740.762961851962, 4755.239161734106, 4815.253635686474, 4739.0, 4782.760861956818, 4786.234202527578, 4790.7365094920115, 4806.687565308243], "unit": "ms", "name": "dojo.html", "value": 4552.000358357669}, {"lowerIsBetter": false, "replicates": [546.7138156186412, 569.8660814708545, 581.3111462916444, 586.8620874094587, 586.9970650146752, 35749.46375804365, 36565.63434365656, 36583.817080914625, 36767.26465470689, 36821.44767828485, 39474.21051578974, 39908.201835963264, 39915.40126898099, 40140.59859401405, 40154.0, 7811.531308121516, 7903.0911445183965, 7995.120536740983, 8021.959890200541, 8035.95982020092, 7685.923140768577, 7807.921920780805, 7881.369490440751, 7889.447738658268, 7910.920890791105, 7806.180351063113, 7870.134285228649, 7870.212978702141, 7877.172896845835, 7887.053553573579, 7802.063752349726, 7826.726064587769, 7838.216178382173, 7843.803904902395, 7852.764417067498, 7798.571078590675, 7900.683972641087, 7919.287264146197, 7946.841063178704, 7954.880676789853, 36439.08902277438, 36642.26715465703, 36736.448953265724, 36749.63250367489, 36751.876090532336, 2581.0, 2604.7265037171014, 2610.2691246450836, 2755.9802872937144, 3142.2615685314163, 27502.0, 27561.173164805088, 27633.86183069072, 27910.581341279896, 28182.859085704644, 3290.4735242361107, 3296.752743544244, 3324.0, 3346.983265083659, 3373.122988023107, 222659.0, 224091.0, 224620.99999999837, 225581.0, 225748.81135103537, 36319.45520817137, 36949.0, 50439.243411348856, 50734.0, 50839.0, 36384.272314553564, 36567.63432365642, 36574.52542008505, 36769.26461470756, 36812.815935920684, 12244.877551224374, 12367.134300599051, 12390.690232744073, 12395.442205100791, 12420.565280215149, 9427.387219830689, 9431.245500359955, 9448.338616296931, 9474.95262523683, 9514.714558563253, 12833.294168820805, 13002.414891329912, 13013.869861301266, 13020.869791302155, 13049.347532623331, 5370.543503802142, 5452.890942181134, 5460.535854452337, 5475.370332411823, 5504.2294078829, 857.8970523537215, 981.2003217377815, 992.6376872441651, 1012.2256473797551, 1031.896810318962, 25755.613665795026, 25954.0, 25969.35076623062, 26046.34884127874, 26178.34554136124, 928.2202949522433, 958.8897276813116, 958.9952050239843, 973.3186769261546, 1041.796849614318, 12908.354582271037, 12920.095593308379, 13137.60587182386, 13243.536476223286, 13271.734565308832, 328492.0, 334628.0, 336732.0, 337797.0, 337821.0, 45493.772531137794, 45498.0, 45818.541814581426, 46039.76980115078, 46215.537844621125, 1212.7331986962854, 1216.2763155922212, 1217.933013684256, 1227.6010296653624, 1233.1860971758597, 24586.0, 24756.38109047288, 24949.750502494742, 24990.500189995735, 24991.0, 36576.634233658384, 36631.45052824263, 36688.63311366959, 36822.26355472929, 36971.63028369682, 239597.0, 240317.0, 240887.0, 242387.0, 242691.0, 28411.857940710164, 28797.712022879503, 40637.0, 41778.79110604549, 41787.1642567153, 38593.807030964665, 38940.41589376105, 39137.8043109794, 39792.801035994635, 40034.39948400718, 32786.50820237746, 32906.5064024035, 33220.66779332176, 33831.0, 34280.314393712484, 33755.83122084374, 35380.0, 35835.82082089573, 37994.62005379911, 38478.23043539058, 33443.0, 33643.663563364054, 33949.0, 34055.82972085124, 34220.48669270013, 29010.0, 29826.701732982394, 30090.699093009665, 30725.385492290476, 31008.22479438032, 23703.64444533299, 23998.40003999844, 24164.0, 24229.51540969206, 24496.87751561231], "unit": "ms", "name": "ext.html", "value": 16274.114355484644}, {"lowerIsBetter": false, "replicates": [333.69300243775734, 334.93971085204663, 336.6465211527895, 337.8040736372904, 338.70025027850346, 15152.772708409382, 15279.083255004694, 15433.691326173484, 15895.761563576556, 16479.093649849252, 14352.354144063516, 14363.138211707279, 14376.353064112114, 14514.0, 14804.6298842529, 4017.658499027586, 4571.634269258459, 5295.232191332255, 5296.020236256305, 6166.599171053889, 6376.681165941684, 6385.361463853601, 6407.487401007908, 6429.196350456193, 6436.967815160918, 6293.5279854010905, 6336.809895703113, 6361.0, 6472.611643301393, 6478.190226221723, 6464.095026696219, 6498.0, 6507.446867016286, 6515.902261466105, 6522.0, 5812.186293918855, 6448.387403196689, 6459.5478316517865, 6462.063000864895, 6466.870662586722, 20107.39677809668, 20221.0, 20535.691964620542, 20925.686114708293, 21068.683969740465, 1746.2665680414257, 1780.2789870102629, 1821.726740988849, 1828.1133650179652, 1834.3121329501437, 13412.061155719104, 13433.19400835953, 13492.527761528398, 13866.791998120036, 14120.576382708536, 1825.4249911277905, 1881.3321270948752, 1893.252165394675, 1906.1136571494183, 1921.0586812461934, 58945.0, 62707.6864615674, 63295.88576742543, 64155.67922160359, 65022.3497765021, 15726.449574264845, 15732.842671573366, 15750.212489375486, 15829.366825326859, 15944.681106377808, 23197.188098416813, 23255.3023409298, 23475.94358253883, 23476.178333758235, 23492.53014939726, 8140.104588495261, 8173.060098088796, 8187.754367368989, 8204.425690201748, 8455.323574114056, 6865.41643960269, 6920.273371295942, 6935.202451718016, 6939.063226464363, 6953.617551034742, 4073.9796301018305, 4231.978840105779, 4289.892752681208, 7613.352865006425, 7850.097238817495, 1703.7188863837575, 1753.2461041751915, 1773.5832079461316, 1782.0911335219132, 1786.3479829862267, 820.4461988158089, 839.9328053755808, 849.0, 892.9910700893038, 917.2066162769156, 15138.697226055418, 15186.0, 15278.15970121654, 15336.693266134615, 15744.448944286894, 786.9842603147905, 840.2102024097329, 867.7917299848117, 906.1346414174448, 932.4778124250306, 8617.267532259828, 8721.0, 8735.383953968536, 8747.781305467413, 8987.46075235488, 312223.0, 318425.0, 318472.0, 463200.0, 464179.0, 66477.33522664712, 69011.65494172598, 70166.0, 70496.29503704897, 70694.0, 1029.4543891737392, 1055.514463346869, 1056.6988408303596, 1068.3162775823635, 1068.8824229334766, 14252.714945701235, 14281.428742850585, 14391.856081439051, 14407.711845762817, 14494.275286235857, 30975.380492390475, 31436.52845207278, 31907.0, 33221.50167747437, 33455.49816752702, 42889.142217156106, 42891.142177155656, 43346.0, 44329.335059973484, 45771.77114114408, 7786.2213778623955, 8757.562121894007, 8945.329100317373, 9030.954845225731, 9076.863847042168, 10042.096211341015, 10201.081902628799, 12478.0, 14914.77627835605, 15380.769288460458, 12507.437165327765, 12916.547920822726, 13027.609171724864, 13029.543965961146, 13288.202707837561, 12650.30423326726, 12712.364381781059, 12760.0, 12854.807177892526, 12934.870651293366, 13045.934770326467, 13072.542461013818, 13558.457661693816, 13567.50516041005, 13851.30743462843, 5273.551748101454, 8444.873326899979, 8641.56792160402, 9035.45787252767, 9038.322125840457, 8576.528290944058, 10434.478276086014, 12627.684307892376, 13377.592033434075, 13659.590212293648], "unit": "ms", "name": "jquery.html", "value": 8813.939567721565}, {"lowerIsBetter": false, "replicates": [1484.0427923989034, 1560.1887018750251, 1612.089169619165, 1626.5364371154224, 1640.1635166065303, 5813.09896965971, 6125.356837532062, 6661.16735408074, 7107.253738357469, 7116.039334689815, 6631.137952066237, 6793.694283757231, 6819.522633415663, 6839.521233513656, 6907.067545881305, 1993.1628715939305, 2047.897605119738, 2049.549099198174, 2051.138521820839, 2052.568960518293, 2067.9379618611465, 2079.1995081893506, 2094.0786054136206, 2097.979020209801, 2098.045389347843, 1996.0718266006304, 2035.7964203579597, 2036.7148599196125, 2040.8673436226597, 2046.3451695457459, 2006.6889632106975, 2024.3623258673472, 2025.0887100804623, 2027.2195204846093, 2030.878147311166, 2047.4574237826987, 2078.366098340006, 2081.427607407975, 2082.822960048398, 2086.8330533557278, 6898.344657257552, 6974.267701891279, 7005.054317667101, 7005.474589405815, 7026.051483049774, 4047.271491131595, 4096.5903409658795, 4109.794510274504, 4120.938185927213, 4131.876043718693, 2692.5826496893014, 2717.578775289833, 2730.2082396105106, 2769.1000424862, 2769.8615069246457, 835.9791005224857, 839.0015881101531, 839.4669384940546, 864.5331520978664, 864.8183881384916, 9080.954595226982, 9106.681266155652, 9118.589663465094, 9147.542622868896, 9171.358004939657, 3813.313603551332, 3827.024108852225, 3868.477755502971, 3907.27715372657, 3930.5283365996265, 7931.206879312138, 7988.520688758693, 7991.081025682005, 8005.759827205193, 8008.879866802003, 4084.5302790178916, 4106.835726570964, 4124.154548317588, 4142.2543942090115, 4153.91692166155, 3107.0523490335663, 3181.0456862941023, 3580.3018411410044, 3750.7937063461773, 3771.07608635886, 3188.3782662380613, 3303.554020207241, 3312.9171770705925, 3334.483155110962, 3355.8825441109443, 1048.0776916313596, 1064.1539975719322, 1072.4423299884172, 1074.9301295415773, 1080.0765345629532, 952.642758965388, 999.1457304005116, 1011.0092109732503, 1026.14829691356, 1026.7895081508273, 6376.553641245068, 6390.265119511223, 6400.0, 6431.324710905381, 6438.163038805019, 452.7034792211107, 454.0963482669464, 456.5229335344573, 1078.962236321725, 1098.774751176007, 5147.845564633067, 5151.793928242903, 5181.326427564468, 5247.685138891678, 5268.104422248227, 8150.2664760171865, 8329.541875196923, 8364.03813561436, 8383.95808020956, 8394.8321033579, 8186.590670466572, 8187.1812818718845, 8198.303144232688, 8210.30212431938, 8365.874511882326, 6328.11406403104, 6504.38208370204, 6514.9674251629385, 6547.836304092436, 6556.147700798961, 6235.438810506895, 6240.687965601611, 6259.1550140730415, 6259.6870156492905, 6264.248290205204, 7230.819229519094, 7317.707291708272, 7321.816954576178, 7366.337029667356, 7425.0, 7148.106486689164, 7314.378277846443, 7362.705491780269, 7400.223946252968, 7483.251674832473, 5639.802606908738, 5736.340320863154, 5842.766289348378, 5849.5612829037145, 5927.199828023334, 6375.5218358624215, 6402.743890244525, 6414.198225221848, 6435.83910402225, 6441.3880681335195, 5956.821295361146, 6035.668038257938, 6078.54410919174, 6120.0, 6203.658798766111, 5920.940790592212, 5931.0, 5982.7008649568215, 5985.40145985398, 6030.185924900083, 6053.273607167168, 6195.070739389128, 6197.380261973766, 6198.070289456437, 6220.098085777628, 5755.5683323750045, 5776.884462310814, 5790.10253410722, 5820.30156381237, 5827.8834423310445, 5770.567207459373, 5779.739911703899, 5825.446582574648, 5827.825165245049, 5827.912581311369], "unit": "ms", "name": "mootools.html", "value": 3926.422811452247}, {"lowerIsBetter": false, "replicates": [307.3913650971077, 313.2044606698985, 314.34929695530263, 317.3478501679049, 317.4397188961483, 5548.833534993952, 5601.439856014402, 5668.829935101949, 5671.319441667006, 5676.375598684152, 5560.86097847554, 5581.441855814416, 5594.104943209088, 5602.803901863435, 5610.635308704931, 4241.0, 4337.175936572041, 4363.54182810805, 4369.934450983238, 4371.519132895379, 4318.244307246235, 4357.085012147453, 4365.192439398706, 4371.73769573825, 4392.604665580097, 4315.82736690532, 4330.761808100553, 4334.826606935734, 4336.6530677545725, 4344.4786625604975, 4307.923019245189, 4338.544452832454, 4346.304591265398, 4349.26062569364, 4350.108227813323, 3652.3243200008083, 3783.5838057813617, 3791.317562838688, 3791.469194312771, 3794.1273507093247, 5274.156135018378, 5413.0, 5432.185172224158, 5443.482869127427, 5446.673199607996, 4892.535209155125, 4925.310456536088, 4929.975350123263, 4930.704157750546, 4934.1611925972675, 5905.143754155666, 5934.614250073774, 5940.46535811779, 5963.582549221556, 5966.0454327307425, 3965.8413663453425, 4026.5973402659793, 4047.4738284023183, 4060.167665628539, 4068.5524592294823, 6142.416470435302, 6144.109104179914, 6167.0, 6243.1883855099, 6245.718942647592, 4190.706650534434, 4194.0, 4198.475190601175, 4200.705950583491, 4219.388188712681, 4252.510961239435, 4266.957330426656, 4271.615554600101, 4277.059047009653, 4278.251306021434, 4782.258749893772, 4904.2643603459765, 4907.852764417074, 4917.459079501252, 4931.9753401232765, 5881.38245484218, 5920.082387229986, 5921.28944526651, 5932.2584676915385, 5932.79235226765, 1489.2330449818353, 1521.9771703424458, 1527.2363818090955, 1529.9694006119814, 1532.8926975111635, 1007.3730924556788, 1025.6974192613197, 1032.6592224565875, 1035.6329644868852, 1039.0336986602533, 5124.052050370693, 5153.793848246029, 5153.922691159561, 5169.888473978112, 5171.5862730981435, 6101.328853826076, 6101.359357267512, 6108.389161083945, 6152.477039451607, 6175.2589689237575, 5090.312807770903, 5131.332926719502, 5132.358455193101, 5140.383154021467, 5149.150390185578, 3246.756493263015, 3304.6364899860996, 3341.766076374679, 3345.8661653533586, 3356.194513316835, 5683.460071293221, 5832.562557808182, 5858.945389829872, 5864.739081097585, 5874.148248504029, 6376.266729326187, 6389.520785941073, 6392.744290228339, 6403.48772098231, 6421.807345779541, 5811.012127938261, 5813.0, 5826.737796799239, 5846.298444186725, 5846.6784326862435, 5998.730057147526, 6171.6297022178815, 6183.165272688309, 6210.192674952408, 6243.8126856194385, 6027.60820546663, 6037.879242415215, 6045.909311360245, 6071.119687645355, 6100.359462256577, 5829.854253643693, 5858.062709966385, 5870.0607902735355, 5873.3832947541605, 5880.176775251553, 4309.095090031004, 4369.934450983174, 4371.540988196193, 4377.627901628397, 4386.670999675101, 5964.940350596438, 6073.939260607337, 6116.2660480740815, 6119.388061193845, 6120.357362477054, 5842.649441033552, 5880.676562788916, 5883.264591926009, 5901.232839730807, 5907.409259074058, 5832.3292821326095, 5846.41535846412, 5849.64902105875, 5890.057590785454, 5898.64608123514, 5650.519705825051, 5756.56825738063, 5763.7406316715005, 5820.94179058204, 5831.125331200354, 5966.105084237225, 5972.313183983897, 5984.341722410444, 5984.581079324405, 5990.7304171311525, 5842.0, 5846.064629659234, 5857.092150716646, 5859.765609375748, 5872.1778950946045], "unit": "ms", "name": "prototype.html", "value": 4438.681556337258}, {"lowerIsBetter": false, "replicates": [618.270440879762, 638.4222278837652, 661.1570247933887, 725.6915810780418, 738.8805958972155, 9470.810583788329, 9607.855882161773, 9734.464604446752, 9739.464329461885, 9791.11879930806, 11286.492107855145, 11440.885591144086, 11794.410279486014, 12002.0, 12013.579524716637, 738.0847748791514, 745.4483682075279, 760.6919197724931, 760.7033257029735, 760.8592410404066, 743.1453828097677, 744.4528271720309, 745.4595418321727, 745.6681776609411, 748.4573684079027, 781.4607920534842, 785.0814546980018, 786.3591173193857, 790.6244533846434, 791.1771757372326, 767.4742801181209, 773.4856320546829, 774.7288449042818, 775.2867362026949, 776.1462391369505, 575.9280089988752, 576.1127863090835, 577.777555641077, 579.1284117403324, 579.5740131003708, 11707.94146029273, 11720.706982325424, 11801.055915526736, 11818.231814932087, 11832.822507662391, 10103.343282686601, 10570.312929659547, 10598.78802423955, 11164.553417863275, 11610.0, 9153.54232288383, 9382.577783999737, 9638.42169469827, 9675.301420556305, 9716.90283097167, 3200.391925534141, 3234.433974054531, 3240.270939038721, 3258.038878530839, 3270.640229574745, 42713.57286427127, 42803.929901752395, 42847.0, 43263.78368108139, 43460.3480947786, 8547.487150770974, 8807.427517211489, 9103.499307538017, 9143.131402516883, 9218.262538996863, 16038.358465661242, 16038.438654647265, 16079.0, 16096.356145754273, 16119.27463264156, 5880.176775251468, 5999.760009599567, 6145.84635384119, 6225.564210505221, 6299.181106456132, 3375.8312084395684, 3384.1708781348725, 3407.4207384744655, 3424.2124311408515, 3502.649735026477, 2542.41524449374, 2570.4088059746364, 2579.4583137541326, 2581.251437083225, 2593.351662084479, 470.28986230791065, 475.8239451403003, 482.7586206896552, 482.826182574273, 482.9396325459318, 434.6566212692001, 508.54739282039014, 553.532265235875, 560.4731552340787, 609.1106983803696, 6480.287168411471, 6552.213734351908, 6644.534882558174, 6645.867082658417, 6702.296258892844, 437.16501482168906, 441.34239982426595, 466.63835527466483, 494.2758858272648, 585.5754577930966, 3064.586280852101, 3179.4753865611915, 3192.888248911277, 3276.6559511251453, 3373.308471763283, 55543.44456555383, 55560.44439555633, 55727.442725572226, 56315.0, 56434.717826411426, 47334.0, 48205.75897120492, 48572.757136214095, 48575.0, 48674.51325486771, 42893.57106428958, 42915.0, 43748.3437748434, 44036.3394549082, 44312.77843610826, 6663.267040625624, 6741.797746067626, 6748.763793267409, 6769.0, 6827.351401616838, 32076.19809504688, 32111.35777284488, 32141.196470088435, 32144.839275804406, 32326.19184520406, 37066.0, 37452.0, 37579.0, 37942.620573795015, 38646.42030369603, 9123.178913897782, 9175.954120229357, 9245.445273283625, 9401.200897923753, 9807.680786052444, 9484.668036618685, 9948.900510995087, 10279.17766578657, 10312.535935882754, 10352.896471035194, 8820.25027872638, 8896.332775041768, 8934.50860202695, 8937.106289371011, 9049.321300902327, 8787.253083487974, 8851.911480885108, 9055.501947392957, 9198.0, 9430.434173949585, 9005.099490050943, 9173.587188576663, 9246.445213287225, 9275.6289748412, 9360.906390936276, 8210.630521626661, 8445.831083378422, 8451.746447606582, 8505.319574434154, 8546.102659220693, 7812.53124812513, 8063.959680201561, 8257.95871020641, 8259.463134896452, 8310.958445207978], "unit": "ms", "name": "yui.html", "value": 5407.615852871405}], "name": "dromaeo_css", "value": 6283.409088866979}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 114.0, 112.0, 114.0, 126.0, 114.0, 114.0, 113.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [152.0, 131.0, 156.0, 164.0, 132.0, 168.0, 159.0, 132.0, 183.0, 137.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 164.0, 163.0, 167.0, 169.0, 170.0, 164.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 165.3}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 72.0, 140.0, 72.0, 73.0, 75.0, 73.0, 90.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 126.0, 94.0, 96.0, 95.0, 128.0, 95.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 122.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 111.4}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 102.0, 95.0, 96.0, 96.0, 97.0, 97.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 75.0, 75.0, 77.0, 77.0, 74.0, 74.0, 76.0, 77.0], "unit": "ms", "name": "json-parse-financial", "value": 75.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 85.0, 93.0, 84.0, 84.0, 83.0, 83.0, 93.0, 97.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 119.0, 122.0, 122.0, 128.0, 130.0, 129.0, 127.0, 137.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [160.0, 149.0, 151.0, 162.0, 154.0, 147.0, 135.0, 147.0, 152.0, 150.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 77.0, 71.0, 70.0, 71.0, 71.0, 70.0, 72.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1554.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [186.74136321195144], "unit": "score", "name": "Richards", "value": 189.04221}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5015.0], "unit": "score", "name": "Decrypt", "value": 53.07696909272185}, {"lowerIsBetter": false, "replicates": [1040.5827263267429], "unit": "score", "name": "RayTrace", "value": 711.1294289999997}, {"lowerIsBetter": false, "replicates": [710.7320540156361], "unit": "score", "name": "Earley", "value": 937.7134409999999}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25350.0], "unit": "score", "name": "RegExp", "value": 35.936291913214966}, {"lowerIsBetter": false, "replicates": [596.7837998808815], "unit": "score", "name": "Splay", "value": 136.55028842315363}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21264.550315964945}]} 01:13:50 INFO - RETURN: dromaeo_css: 6283.41 01:13:50 INFO - RETURN: kraken: 1554.20 01:13:50 INFO - RETURN: v8_7: 21264.55 01:13:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21264.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1554.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6283.41"}}} 01:13:50 INFO - Return code: 0 01:13:50 INFO - # TBPL SUCCESS # 01:13:50 INFO - Running post-action listener: _resource_record_post_action 01:13:50 INFO - Running post-run listener: _resource_record_post_run 01:13:51 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277217280; Read time: 20; Write time: 169308 01:13:51 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 479232; Read time: 0; Write time: 40 01:13:51 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 264159232; Read time: 0; Write time: 166692 01:13:51 INFO - Running post-run listener: _upload_blobber_files 01:13:51 INFO - Blob upload gear active. 01:13:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:13:51 INFO - Copying logs to upload dir... 01:13:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1324.068949 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-24 01:13:50.551628) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:13:50.555509) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 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.009997 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:13:50.606362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:13:50.606732) ========= 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=7f67ac1ceef7774224e327f2000001f6-1448354958.242640-718310876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:13:50.655906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:13:50.656241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:13:50.656548) ========= ========= Total master_lag: 0.24 =========