builder: ash_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1446048555.22 results: success (0) buildid: 20151028080504 builduid: 6998b3d683b841b6a64fc9b6d4e28674 revision: 363f841f4135909e8cdeab151d97502000f8c904 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.223259) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.223705) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.224125) ========= 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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006743 basedir: '/builds/slave/test' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.304499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.304854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.342761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.343171) ========= 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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026254 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.390975) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.391297) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.391666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.391955) ========= 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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-28 09:09:15-- 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% 227M=0s 2015-10-28 09:09:15 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161536 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.569031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.569360) ========= 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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.059367 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.640507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:15.640887) ========= bash -c 'python archiver_client.py mozharness --repo projects/ash --rev 363f841f4135909e8cdeab151d97502000f8c904 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/ash --rev 363f841f4135909e8cdeab151d97502000f8c904 --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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-28 09:09:15,686 truncating revision to first 12 chars 2015-10-28 09:09:15,686 Setting DEBUG logging. 2015-10-28 09:09:15,686 attempt 1/10 2015-10-28 09:09:15,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/ash/363f841f4135?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-28 09:09:15,935 unpacking tar archive at: ash-363f841f4135/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511247 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:16.164558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:16.164872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:16.175097) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:16.175555) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 09:09:16.176172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-10-28 09:09:16.176592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Ash-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Ash-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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:09:16 INFO - MultiFileLogger online at 20151028 09:09:16 in /builds/slave/test 09:09:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO 09:09:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:16 INFO - {'append_to_log': False, 09:09:16 INFO - 'base_work_dir': '/builds/slave/test', 09:09:16 INFO - 'blob_upload_branch': 'Ash-Non-PGO', 09:09:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:16 INFO - 'branch': 'Ash-Non-PGO', 09:09:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:16 INFO - 'config_files': ('talos/linux_config.py',), 09:09:16 INFO - 'default_actions': ('clobber', 09:09:16 INFO - 'read-buildbot-config', 09:09:16 INFO - 'download-and-extract', 09:09:16 INFO - 'populate-webroot', 09:09:16 INFO - 'create-virtualenv', 09:09:16 INFO - 'install', 09:09:16 INFO - 'run-tests'), 09:09:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:16 INFO - 'download_minidump_stackwalk': True, 09:09:16 INFO - 'download_symbols': 'ondemand', 09:09:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:16 INFO - 'installer_path': 'installer.exe', 09:09:16 INFO - 'log_level': 'info', 09:09:16 INFO - 'log_name': 'talos', 09:09:16 INFO - 'log_to_console': True, 09:09:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:09:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:09:16 INFO - 'opt_config_files': (), 09:09:16 INFO - 'pip_index': False, 09:09:16 INFO - 'sps_profile': False, 09:09:16 INFO - 'sps_profile_interval': 0, 09:09:16 INFO - 'suite': 'dromaeojs', 09:09:16 INFO - 'system_bits': '64', 09:09:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:16 INFO - 'title': 'talos-linux64-ix-006', 09:09:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:16 INFO - 'use_talos_json': True, 09:09:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:16 INFO - 'work_dir': 'build'} 09:09:16 INFO - ##### 09:09:16 INFO - ##### Running clobber step. 09:09:16 INFO - ##### 09:09:16 INFO - Running pre-action listener: _resource_record_pre_action 09:09:16 INFO - Running main action method: clobber 09:09:16 INFO - rmtree: /builds/slave/test/build 09:09:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:21 INFO - Running post-action listener: _resource_record_post_action 09:09:21 INFO - ##### 09:09:21 INFO - ##### Running read-buildbot-config step. 09:09:21 INFO - ##### 09:09:21 INFO - Running pre-action listener: _resource_record_pre_action 09:09:21 INFO - Running main action method: read_buildbot_config 09:09:21 INFO - Using buildbot properties: 09:09:21 INFO - { 09:09:21 INFO - "properties": { 09:09:21 INFO - "buildnumber": 1, 09:09:21 INFO - "product": "firefox", 09:09:21 INFO - "script_repo_revision": "production", 09:09:21 INFO - "builddir": "ash_ubuntu64_hw_test-dromaeojs", 09:09:21 INFO - "repository": "", 09:09:21 INFO - "buildername": "Ubuntu HW 12.04 x64 ash talos dromaeojs", 09:09:21 INFO - "buildid": "20151028080504", 09:09:21 INFO - "slavename": "talos-linux64-ix-006", 09:09:21 INFO - "pgo_build": "False", 09:09:21 INFO - "basedir": "/builds/slave/test", 09:09:21 INFO - "project": "", 09:09:21 INFO - "platform": "ubuntu64_hw", 09:09:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:09:21 INFO - "slavebuilddir": "test", 09:09:21 INFO - "scheduler": "tests-ash-linux64-talos", 09:09:21 INFO - "branch": "ash", 09:09:21 INFO - "repo_path": "projects/ash", 09:09:21 INFO - "stage_platform": "linux64", 09:09:21 INFO - "builduid": "6998b3d683b841b6a64fc9b6d4e28674", 09:09:21 INFO - "revision": "363f841f4135909e8cdeab151d97502000f8c904" 09:09:21 INFO - }, 09:09:21 INFO - "sourcestamp": { 09:09:21 INFO - "repository": "", 09:09:21 INFO - "hasPatch": false, 09:09:21 INFO - "project": "", 09:09:21 INFO - "branch": "ash-linux64-talos", 09:09:21 INFO - "changes": [ 09:09:21 INFO - { 09:09:21 INFO - "category": null, 09:09:21 INFO - "files": [ 09:09:21 INFO - { 09:09:21 INFO - "url": null, 09:09:21 INFO - "name": "https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2" 09:09:21 INFO - } 09:09:21 INFO - ], 09:09:21 INFO - "repository": "", 09:09:21 INFO - "rev": "363f841f4135909e8cdeab151d97502000f8c904", 09:09:21 INFO - "who": "catlee@mozilla.com", 09:09:21 INFO - "when": 1446048422, 09:09:21 INFO - "number": 6587612, 09:09:21 INFO - "comments": "merged from m-c", 09:09:21 INFO - "project": "", 09:09:21 INFO - "at": "Wed 28 Oct 2015 09:07:02", 09:09:21 INFO - "branch": "ash-linux64-talos", 09:09:21 INFO - "revlink": "", 09:09:21 INFO - "properties": [ 09:09:21 INFO - [ 09:09:21 INFO - "buildid", 09:09:21 INFO - "20151028080504", 09:09:21 INFO - "Change" 09:09:21 INFO - ], 09:09:21 INFO - [ 09:09:21 INFO - "builduid", 09:09:21 INFO - "6998b3d683b841b6a64fc9b6d4e28674", 09:09:21 INFO - "Change" 09:09:21 INFO - ], 09:09:21 INFO - [ 09:09:21 INFO - "pgo_build", 09:09:21 INFO - "False", 09:09:21 INFO - "Change" 09:09:21 INFO - ] 09:09:21 INFO - ], 09:09:21 INFO - "revision": "363f841f4135909e8cdeab151d97502000f8c904" 09:09:21 INFO - } 09:09:21 INFO - ], 09:09:21 INFO - "revision": "363f841f4135909e8cdeab151d97502000f8c904" 09:09:21 INFO - } 09:09:21 INFO - } 09:09:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2. 09:09:21 INFO - Running post-action listener: _resource_record_post_action 09:09:21 INFO - ##### 09:09:21 INFO - ##### Running download-and-extract step. 09:09:21 INFO - ##### 09:09:21 INFO - Running pre-action listener: _resource_record_pre_action 09:09:21 INFO - Running main action method: download_and_extract 09:09:21 INFO - mkdir: /builds/slave/test/build/tests 09:09:21 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')]} 09:09:21 INFO - https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/test_packages.json 09:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/test_packages.json 09:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:09:22 INFO - Downloaded 1302 bytes. 09:09:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:09:22 INFO - Using the following test package requirements: 09:09:22 INFO - {u'common': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:22 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:22 INFO - u'firefox-44.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:09:22 INFO - u'jittest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:22 INFO - u'jsshell-linux-x86_64.zip'], 09:09:22 INFO - u'mochitest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:22 INFO - u'firefox-44.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:09:22 INFO - u'mozbase': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:22 INFO - u'reftest': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:22 INFO - u'firefox-44.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:09:22 INFO - u'talos': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:22 INFO - u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:09:22 INFO - u'web-platform': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:22 INFO - u'firefox-44.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:09:22 INFO - u'webapprt': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:22 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:22 INFO - u'firefox-44.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:09:22 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:22 INFO - https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:09:23 INFO - Downloaded 22665458 bytes. 09:09:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:09:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:09:24 INFO - Return code: 0 09:09:24 INFO - Downloading packages: [u'firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:24 INFO - https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:09:25 INFO - Downloaded 22665458 bytes. 09:09:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:09:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip 09:09:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:09:28 INFO - Return code: 0 09:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:28 INFO - https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:09:29 INFO - Downloaded 11131307 bytes. 09:09:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:09:29 INFO - Return code: 0 09:09:29 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')]} 09:09:29 INFO - https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 09:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 09:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 09:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:09:31 INFO - Downloaded 51165149 bytes. 09:09:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 09:09:31 INFO - mkdir: /builds/slave/test/properties 09:09:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:09:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:09:31 INFO - Contents: 09:09:31 INFO - build_url:https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 09:09:31 INFO - Running post-action listener: _resource_record_post_action 09:09:31 INFO - Running post-action listener: set_extra_try_arguments 09:09:31 INFO - ##### 09:09:31 INFO - ##### Running populate-webroot step. 09:09:31 INFO - ##### 09:09:31 INFO - Running pre-action listener: _resource_record_pre_action 09:09:31 INFO - Running main action method: populate_webroot 09:09:31 INFO - Guessing talos json url... 09:09: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')]} 09:09:31 INFO - https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 09:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 09:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt 09:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt to /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.txt 09:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.txt'}, attempt #1 09:09:32 INFO - Downloaded 96 bytes. 09:09:32 INFO - Reading from file /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.txt 09:09:32 INFO - Contents: 09:09:32 INFO - 20151028080504 09:09:32 INFO - https://hg.mozilla.org/projects/ash/rev/363f841f4135909e8cdeab151d97502000f8c904 09:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:32 INFO - trying https://hg.mozilla.org/projects/ash/raw-file/363f841f41/testing/talos/talos.json 09:09:32 INFO - Downloading https://hg.mozilla.org/projects/ash/raw-file/363f841f41/testing/talos/talos.json to /builds/slave/test/build/talos.json 09:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/projects/ash/raw-file/363f841f41/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 09:09:32 INFO - Downloaded 4264 bytes. 09:09:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:09:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:09:32 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:09:32 INFO - '../fennec_ids.txt'], 09:09:32 INFO - 'tests': ['tcheck2']}, 09:09:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:09:32 INFO - '--tppagecycles', 09:09:32 INFO - '7'], 09:09:32 INFO - 'tests': ['tsvgm']}}, 09:09:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:09:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:09:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:09:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:09:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'tests': ['damp', 'tps']}, 09:09:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['damp', 'tps']}, 09:09:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:09:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:09:32 INFO - 'other': {'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore']}, 09:09:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore']}, 09:09:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore']}, 09:09:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore']}, 09:09:32 INFO - 'other_l64': {'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore']}, 09:09:32 INFO - 'other_nol64': {'tests': ['a11yr', 09:09:32 INFO - 'ts_paint', 09:09:32 INFO - 'tpaint', 09:09:32 INFO - 'sessionrestore', 09:09:32 INFO - 'sessionrestore_no_auto_restore']}, 09:09:32 INFO - 'svgr': {'tests': ['tsvgx', 09:09:32 INFO - 'tsvgr_opacity', 09:09:32 INFO - 'tart', 09:09:32 INFO - 'tscrollx', 09:09:32 INFO - 'cart']}, 09:09:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['tsvgx', 09:09:32 INFO - 'tsvgr_opacity', 09:09:32 INFO - 'tart', 09:09:32 INFO - 'tscrollx', 09:09:32 INFO - 'cart']}, 09:09:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'tests': ['tp5o']}, 09:09:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'talos_options': ['--e10s'], 09:09:32 INFO - 'tests': ['tp5o']}, 09:09:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'talos_options': ['--xperf_path', 09:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:32 INFO - 'tests': ['tp5n']}, 09:09:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:32 INFO - 'talos_options': ['--e10s', 09:09:32 INFO - '--xperf_path', 09:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:09:32 INFO - 'C:/slave/talos-data/talos/xperf.config'], 09:09:32 INFO - 'tests': ['tp5n']}}, 09:09:32 INFO - 'talos.zip': {'path': '', 09:09:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:09:32 INFO - Running post-action listener: _resource_record_post_action 09:09:32 INFO - ##### 09:09:32 INFO - ##### Running create-virtualenv step. 09:09:32 INFO - ##### 09:09:32 INFO - Running pre-action listener: _resource_record_pre_action 09:09:32 INFO - Running main action method: create_virtualenv 09:09:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:09:32 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 09:09:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:09:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:09:33 INFO - Using real prefix '/usr' 09:09:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:09:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:09:36 INFO - Installing pip.................done. 09:09:36 INFO - Return code: 0 09:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f730f71ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dfae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, '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': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', '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 09:09:36 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 09:09:36 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 09:09:36 INFO - Using env: {'DISPLAY': ':0', 09:09:36 INFO - 'HOME': '/home/cltbld', 09:09:36 INFO - 'LANG': 'en_US.UTF-8', 09:09:36 INFO - 'LANGUAGE': 'en_US:en', 09:09:36 INFO - 'LOGNAME': 'cltbld', 09:09:36 INFO - 'MAIL': '/var/mail/cltbld', 09:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:36 INFO - 'MOZ_NO_REMOTE': '1', 09:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:36 INFO - 'NO_EM_RESTART': '1', 09:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:36 INFO - 'PWD': '/builds/slave/test', 09:09:36 INFO - 'SHELL': '/bin/bash', 09:09:36 INFO - 'SHLVL': '1', 09:09:36 INFO - 'TERM': 'linux', 09:09:36 INFO - 'TMOUT': '86400', 09:09:36 INFO - 'USER': 'cltbld', 09:09:36 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:36 INFO - '_': '/tools/buildbot/bin/python'} 09:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:36 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 09:09:36 INFO - Cleaning up... 09:09:36 INFO - Return code: 0 09:09:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f730f71ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dfae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, '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': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', '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 09:09:36 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 09:09:36 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 09:09:36 INFO - Using env: {'DISPLAY': ':0', 09:09:36 INFO - 'HOME': '/home/cltbld', 09:09:36 INFO - 'LANG': 'en_US.UTF-8', 09:09:36 INFO - 'LANGUAGE': 'en_US:en', 09:09:36 INFO - 'LOGNAME': 'cltbld', 09:09:36 INFO - 'MAIL': '/var/mail/cltbld', 09:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:36 INFO - 'MOZ_NO_REMOTE': '1', 09:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:36 INFO - 'NO_EM_RESTART': '1', 09:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:36 INFO - 'PWD': '/builds/slave/test', 09:09:36 INFO - 'SHELL': '/bin/bash', 09:09:36 INFO - 'SHLVL': '1', 09:09:36 INFO - 'TERM': 'linux', 09:09:36 INFO - 'TMOUT': '86400', 09:09:36 INFO - 'USER': 'cltbld', 09:09:36 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:36 INFO - '_': '/tools/buildbot/bin/python'} 09:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:36 INFO - Downloading/unpacking psutil>=0.7.1 09:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:38 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:09:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:38 INFO - Installing collected packages: psutil 09:09:38 INFO - Running setup.py install for psutil 09:09:38 INFO - building 'psutil._psutil_linux' extension 09:09:38 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 09:09:40 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 09:09:40 INFO - building 'psutil._psutil_posix' extension 09:09:40 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 09:09:40 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 09:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:40 INFO - Successfully installed psutil 09:09:40 INFO - Cleaning up... 09:09:40 INFO - Return code: 0 09:09:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:09:40 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')]} 09:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:40 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')]} 09:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:40 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 0x7f730f71ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dfae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, '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': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', '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 09:09:40 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 09:09:40 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 09:09:40 INFO - Using env: {'DISPLAY': ':0', 09:09:40 INFO - 'HOME': '/home/cltbld', 09:09:40 INFO - 'LANG': 'en_US.UTF-8', 09:09:40 INFO - 'LANGUAGE': 'en_US:en', 09:09:40 INFO - 'LOGNAME': 'cltbld', 09:09:40 INFO - 'MAIL': '/var/mail/cltbld', 09:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:40 INFO - 'MOZ_NO_REMOTE': '1', 09:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:40 INFO - 'NO_EM_RESTART': '1', 09:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:40 INFO - 'PWD': '/builds/slave/test', 09:09:40 INFO - 'SHELL': '/bin/bash', 09:09:40 INFO - 'SHLVL': '1', 09:09:40 INFO - 'TERM': 'linux', 09:09:40 INFO - 'TMOUT': '86400', 09:09:40 INFO - 'USER': 'cltbld', 09:09:40 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:40 INFO - '_': '/tools/buildbot/bin/python'} 09:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:09:40 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 09:09:40 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 09:09:40 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 09:09:40 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 09:09:40 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 09:09:40 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 09:09:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:09:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:09:42 INFO - Installing collected packages: mozsystemmonitor 09:09:42 INFO - Running setup.py install for mozsystemmonitor 09:09:42 INFO - Successfully installed mozsystemmonitor 09:09:42 INFO - Cleaning up... 09:09:42 INFO - Return code: 0 09:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09:42 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')]} 09:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:42 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')]} 09:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:42 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 0x7f730f71ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dfae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, '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': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', '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 09:09:42 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 09:09:42 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 09:09:42 INFO - Using env: {'DISPLAY': ':0', 09:09:42 INFO - 'HOME': '/home/cltbld', 09:09:42 INFO - 'LANG': 'en_US.UTF-8', 09:09:42 INFO - 'LANGUAGE': 'en_US:en', 09:09:42 INFO - 'LOGNAME': 'cltbld', 09:09:42 INFO - 'MAIL': '/var/mail/cltbld', 09:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:42 INFO - 'MOZ_NO_REMOTE': '1', 09:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:42 INFO - 'NO_EM_RESTART': '1', 09:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:42 INFO - 'PWD': '/builds/slave/test', 09:09:42 INFO - 'SHELL': '/bin/bash', 09:09:42 INFO - 'SHLVL': '1', 09:09:42 INFO - 'TERM': 'linux', 09:09:42 INFO - 'TMOUT': '86400', 09:09:42 INFO - 'USER': 'cltbld', 09:09:42 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:42 INFO - '_': '/tools/buildbot/bin/python'} 09:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:09:42 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 09:09:42 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 09:09:42 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 09:09:42 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 09:09:42 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 09:09:42 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 09:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 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 09:09:44 INFO - Downloading docopt-0.6.1.tar.gz 09:09:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:45 INFO - Running setup.py install for blobuploader 09:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:45 INFO - Running setup.py install for requests 09:09:45 INFO - Running setup.py install for docopt 09:09:45 INFO - Successfully installed blobuploader requests docopt 09:09:45 INFO - Cleaning up... 09:09:45 INFO - Return code: 0 09:09:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:45 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')]} 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:45 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')]} 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:45 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 0x7f730f71ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dfae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, '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': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', '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 09:09:45 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 09:09:45 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 09:09:45 INFO - Using env: {'DISPLAY': ':0', 09:09:45 INFO - 'HOME': '/home/cltbld', 09:09:45 INFO - 'LANG': 'en_US.UTF-8', 09:09:45 INFO - 'LANGUAGE': 'en_US:en', 09:09:45 INFO - 'LOGNAME': 'cltbld', 09:09:45 INFO - 'MAIL': '/var/mail/cltbld', 09:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:45 INFO - 'MOZ_NO_REMOTE': '1', 09:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:45 INFO - 'NO_EM_RESTART': '1', 09:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:45 INFO - 'PWD': '/builds/slave/test', 09:09:45 INFO - 'SHELL': '/bin/bash', 09:09:45 INFO - 'SHLVL': '1', 09:09:45 INFO - 'TERM': 'linux', 09:09:45 INFO - 'TMOUT': '86400', 09:09:45 INFO - 'USER': 'cltbld', 09:09:45 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:45 INFO - '_': '/tools/buildbot/bin/python'} 09:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:45 INFO - Running setup.py (path:/tmp/pip-7BakPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:45 INFO - Running setup.py (path:/tmp/pip-wMZqGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:46 INFO - Running setup.py (path:/tmp/pip-3qY9OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:46 INFO - Running setup.py (path:/tmp/pip-aHKEuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:46 INFO - Running setup.py (path:/tmp/pip-Ba5JjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:46 INFO - Running setup.py (path:/tmp/pip-R9Ul0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:46 INFO - Running setup.py (path:/tmp/pip-FUnO12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:46 INFO - Running setup.py (path:/tmp/pip-8FU7om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:46 INFO - Running setup.py (path:/tmp/pip-1SG20A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:46 INFO - Running setup.py (path:/tmp/pip-4SkBOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:46 INFO - Running setup.py (path:/tmp/pip-EhfMrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:46 INFO - Running setup.py (path:/tmp/pip-w7uHO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:46 INFO - Running setup.py (path:/tmp/pip-rrYCKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:46 INFO - Running setup.py (path:/tmp/pip-uf8GWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:46 INFO - Running setup.py (path:/tmp/pip-2sZr8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:46 INFO - Running setup.py (path:/tmp/pip-j2Md8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:47 INFO - Running setup.py (path:/tmp/pip-qBrB4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:47 INFO - Running setup.py install for manifestparser 09:09:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Running setup.py install for mozcrash 09:09:47 INFO - Running setup.py install for mozdebug 09:09:47 INFO - Running setup.py install for mozdevice 09:09:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Running setup.py install for mozfile 09:09:47 INFO - Running setup.py install for mozhttpd 09:09:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Running setup.py install for mozinfo 09:09:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Running setup.py install for mozInstall 09:09:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Running setup.py install for mozleak 09:09:47 INFO - Running setup.py install for mozlog 09:09:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for moznetwork 09:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozprocess 09:09:48 INFO - Running setup.py install for mozprofile 09:09:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozrunner 09:09:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozscreenshot 09:09:48 INFO - Running setup.py install for moztest 09:09:48 INFO - Running setup.py install for mozversion 09:09:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:48 INFO - Cleaning up... 09:09:48 INFO - Return code: 0 09:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:48 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 0x7f730f71ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dfae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, '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': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', '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 09:09:48 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 09:09:48 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 09:09:48 INFO - Using env: {'DISPLAY': ':0', 09:09:48 INFO - 'HOME': '/home/cltbld', 09:09:48 INFO - 'LANG': 'en_US.UTF-8', 09:09:48 INFO - 'LANGUAGE': 'en_US:en', 09:09:48 INFO - 'LOGNAME': 'cltbld', 09:09:48 INFO - 'MAIL': '/var/mail/cltbld', 09:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:48 INFO - 'MOZ_NO_REMOTE': '1', 09:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:48 INFO - 'NO_EM_RESTART': '1', 09:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:48 INFO - 'PWD': '/builds/slave/test', 09:09:48 INFO - 'SHELL': '/bin/bash', 09:09:48 INFO - 'SHLVL': '1', 09:09:48 INFO - 'TERM': 'linux', 09:09:48 INFO - 'TMOUT': '86400', 09:09:48 INFO - 'USER': 'cltbld', 09:09:48 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:48 INFO - '_': '/tools/buildbot/bin/python'} 09:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:49 INFO - Running setup.py (path:/tmp/pip-cFdc5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:49 INFO - Running setup.py (path:/tmp/pip-JHfz_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:49 INFO - Running setup.py (path:/tmp/pip-8oZesT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:49 INFO - Running setup.py (path:/tmp/pip-UCGC7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:49 INFO - Running setup.py (path:/tmp/pip-4YARmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:49 INFO - Running setup.py (path:/tmp/pip-Rj6_fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:49 INFO - Running setup.py (path:/tmp/pip-4eLNhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:49 INFO - Running setup.py (path:/tmp/pip-4wt0VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:49 INFO - Running setup.py (path:/tmp/pip-fjeN9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:49 INFO - Running setup.py (path:/tmp/pip-BPsMI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:49 INFO - Running setup.py (path:/tmp/pip-xCcu28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:49 INFO - Running setup.py (path:/tmp/pip-D7yBfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:49 INFO - Running setup.py (path:/tmp/pip-S5LcdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:50 INFO - Running setup.py (path:/tmp/pip-HwAWJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:50 INFO - Running setup.py (path:/tmp/pip-pMNCcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:50 INFO - Running setup.py (path:/tmp/pip-GsvFaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:50 INFO - Running setup.py (path:/tmp/pip-j_29Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:50 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)) 09:09:50 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)) 09:09:50 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)) 09:09:50 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)) 09:09:50 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:50 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:50 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 09:09:50 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 09:09:50 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 09:09:50 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 09:09:50 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 09:09:50 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 09:09:51 INFO - Downloading blessings-1.5.1.tar.gz 09:09:51 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 09:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:52 INFO - Installing collected packages: blessings 09:09:52 INFO - Running setup.py install for blessings 09:09:52 INFO - Successfully installed blessings 09:09:52 INFO - Cleaning up... 09:09:52 INFO - Return code: 0 09:09:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:52 INFO - Reading from file tmpfile_stdout 09:09:52 INFO - Current package versions: 09:09:52 INFO - argparse == 1.2.1 09:09:52 INFO - blessings == 1.5.1 09:09:52 INFO - blobuploader == 1.2.4 09:09:52 INFO - docopt == 0.6.1 09:09:52 INFO - manifestparser == 1.1 09:09:52 INFO - mozInstall == 1.12 09:09:52 INFO - mozcrash == 0.16 09:09:52 INFO - mozdebug == 0.1 09:09:52 INFO - mozdevice == 0.46 09:09:52 INFO - mozfile == 1.2 09:09:52 INFO - mozhttpd == 0.7 09:09:52 INFO - mozinfo == 0.8 09:09:52 INFO - mozleak == 0.1 09:09:52 INFO - mozlog == 3.0 09:09:52 INFO - moznetwork == 0.27 09:09:52 INFO - mozprocess == 0.22 09:09:52 INFO - mozprofile == 0.27 09:09:52 INFO - mozrunner == 6.11 09:09:52 INFO - mozscreenshot == 0.1 09:09:52 INFO - mozsystemmonitor == 0.0 09:09:52 INFO - moztest == 0.7 09:09:52 INFO - mozversion == 1.4 09:09:52 INFO - psutil == 3.1.1 09:09:52 INFO - requests == 1.2.3 09:09:52 INFO - wsgiref == 0.1.2 09:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:52 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 0x7f730f71ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dfae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, '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': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', '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 09:09:52 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 09:09:52 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 09:09:52 INFO - Using env: {'DISPLAY': ':0', 09:09:52 INFO - 'HOME': '/home/cltbld', 09:09:52 INFO - 'LANG': 'en_US.UTF-8', 09:09:52 INFO - 'LANGUAGE': 'en_US:en', 09:09:52 INFO - 'LOGNAME': 'cltbld', 09:09:52 INFO - 'MAIL': '/var/mail/cltbld', 09:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:52 INFO - 'MOZ_NO_REMOTE': '1', 09:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:52 INFO - 'NO_EM_RESTART': '1', 09:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:52 INFO - 'PWD': '/builds/slave/test', 09:09:52 INFO - 'SHELL': '/bin/bash', 09:09:52 INFO - 'SHLVL': '1', 09:09:52 INFO - 'TERM': 'linux', 09:09:52 INFO - 'TMOUT': '86400', 09:09:52 INFO - 'USER': 'cltbld', 09:09:52 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:52 INFO - '_': '/tools/buildbot/bin/python'} 09:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 INFO - Cleaning up... 09:09:52 INFO - Return code: 0 09:09:52 INFO - Running post-action listener: _resource_record_post_action 09:09:52 INFO - Running post-action listener: _start_resource_monitoring 09:09:52 INFO - Starting resource monitoring. 09:09:52 INFO - ##### 09:09:52 INFO - ##### Running install step. 09:09:52 INFO - ##### 09:09:52 INFO - Running pre-action listener: _resource_record_pre_action 09:09:52 INFO - Running main action method: install 09:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:52 INFO - Reading from file tmpfile_stdout 09:09:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:52 INFO - Reading from file tmpfile_stdout 09:09:52 INFO - Output received: 09:09:52 INFO - Usage: mozinstall [options] installer 09:09:52 INFO - Options: 09:09:52 INFO - -h, --help show this help message and exit 09:09:52 INFO - -d DEST, --destination=DEST 09:09:52 INFO - Directory to install application into. [default: 09:09:52 INFO - "/builds/slave/test"] 09:09:52 INFO - --app=APP Application being installed. [default: firefox] 09:09:52 INFO - mkdir: /builds/slave/test/build/application 09:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:10:07 INFO - Reading from file tmpfile_stdout 09:10:07 INFO - Output received: 09:10:07 INFO - /builds/slave/test/build/application/firefox/firefox 09:10:07 INFO - Running post-action listener: _resource_record_post_action 09:10:07 INFO - ##### 09:10:07 INFO - ##### Running run-tests step. 09:10:07 INFO - ##### 09:10:07 INFO - Running pre-action listener: _resource_record_pre_action 09:10:07 INFO - Running main action method: run_tests 09:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:07 INFO - Python 2.7.3 09:10:07 INFO - Return code: 0 09:10:07 INFO - grabbing minidump binary from tooltool 09:10: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')]} 09:10:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74a30>, '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 0x19de0b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19de540>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:10:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:10:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:07 INFO - Return code: 0 09:10:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:10:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:10:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] in /builds/slave/test/build 09:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Ash-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost 09:10:07 INFO - Using env: {'DISPLAY': ':0', 09:10:07 INFO - 'HOME': '/home/cltbld', 09:10:07 INFO - 'LANG': 'en_US.UTF-8', 09:10:07 INFO - 'LANGUAGE': 'en_US:en', 09:10:07 INFO - 'LOGNAME': 'cltbld', 09:10:07 INFO - 'MAIL': '/var/mail/cltbld', 09:10:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:07 INFO - 'MOZ_NO_REMOTE': '1', 09:10:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:07 INFO - 'NO_EM_RESTART': '1', 09:10:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:07 INFO - 'PWD': '/builds/slave/test', 09:10:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:07 INFO - 'SHELL': '/bin/bash', 09:10:07 INFO - 'SHLVL': '1', 09:10:07 INFO - 'TERM': 'linux', 09:10:07 INFO - 'TMOUT': '86400', 09:10:07 INFO - 'USER': 'cltbld', 09:10:07 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541', 09:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:07 INFO - '_': '/tools/buildbot/bin/python'} 09:10:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] with output_timeout 3600 09:10:08 INFO - mozversion INFO | application_buildid: 20151028080504 09:10:08 INFO - mozversion INFO | application_changeset: 363f841f4135909e8cdeab151d97502000f8c904 09:10:08 INFO - mozversion INFO | application_display_name: Nightly 09:10:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:08 INFO - mozversion INFO | application_name: Firefox 09:10:08 INFO - mozversion INFO | application_remotingname: firefox 09:10:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/ash 09:10:08 INFO - mozversion INFO | application_vendor: Mozilla 09:10:08 INFO - mozversion INFO | application_version: 44.0a1 09:10:08 INFO - mozversion INFO | platform_buildid: 20151028080504 09:10:08 INFO - mozversion INFO | platform_changeset: 363f841f4135909e8cdeab151d97502000f8c904 09:10:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/ash 09:10:08 INFO - mozversion INFO | platform_version: 44.0a1 09:10:08 INFO - 2015-10-28 09:10:08,259 DEBUG : using testdate: 1446048608 09:10:08 INFO - 2015-10-28 09:10:08,259 DEBUG : actual date: 1446048608 09:10:08 INFO - 2015-10-28 09:10:08,333 INFO : starting webserver on 'localhost:45947' 09:10:08 INFO - 2015-10-28 09:10:08,334 INFO : Starting test suite talos-linux64-ix-006 09:10:08 INFO - 2015-10-28 09:10:08,334 INFO : Starting test dromaeo_css 09:10:08 INFO - 2015-10-28 09:10:08,335 DEBUG : operating with platform_type : linux_ 09:10:08 INFO - 2015-10-28 09:10:08,335 INFO : Initialising browser for dromaeo_css test... 09:10:08 INFO - 2015-10-28 09:10:08,348 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN315Zo/profile http://localhost:45947/getInfo.html 09:10:13 INFO - 2015-10-28 09:10:13,573 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:10:13 INFO - 2015-10-28 09:10:13,573 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:10:13 INFO - 2015-10-28 09:10:13,573 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:10:13 INFO - 2015-10-28 09:10:13,573 DEBUG : BROWSER_OUTPUT: __metrics 09:10:13 INFO - 2015-10-28 09:10:13,690 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:16 INFO - 2015-10-28 09:10:16,417 INFO : Browser initialized. 09:10:16 INFO - 2015-10-28 09:10:16,418 INFO : Running cycle 1/1 for dromaeo_css test... 09:10:16 INFO - 2015-10-28 09:10:16,418 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN315Zo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:10:28 INFO - 2015-10-28 09:10:28,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 149065728 09:10:28 INFO - 2015-10-28 09:10:28,349 DEBUG : BROWSER_OUTPUT: 09:11:19 INFO - 2015-10-28 09:11:19,669 DEBUG : BROWSER_OUTPUT: 1446048679668 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] 09:13:31 INFO - 2015-10-28 09:13:31,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45947/tests/dromaeo/cssquery-ext.html) 09:13:32 INFO - 2015-10-28 09:13:32,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 247418880 09:13:32 INFO - 2015-10-28 09:13:32,750 DEBUG : BROWSER_OUTPUT: 09:16:35 INFO - 2015-10-28 09:16:35,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-ext.html (next: http://localhost:45947/tests/dromaeo/cssquery-jquery.html) 09:16:35 INFO - 2015-10-28 09:16:35,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 233197568 09:16:35 INFO - 2015-10-28 09:16:35,804 DEBUG : BROWSER_OUTPUT: 09:19:37 INFO - 2015-10-28 09:19:37,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45947/tests/dromaeo/cssquery-mootools.html) 09:19:38 INFO - 2015-10-28 09:19:38,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 224763904 09:19:38 INFO - 2015-10-28 09:19:38,381 DEBUG : BROWSER_OUTPUT: 09:22:40 INFO - 2015-10-28 09:22:40,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45947/tests/dromaeo/cssquery-prototype.html) 09:22:40 INFO - 2015-10-28 09:22:40,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 211357696 09:22:40 INFO - 2015-10-28 09:22:40,856 DEBUG : BROWSER_OUTPUT: 09:25:43 INFO - 2015-10-28 09:25:43,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45947/tests/dromaeo/cssquery-yui.html) 09:25:44 INFO - 2015-10-28 09:25:44,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 217964544 09:25:44 INFO - 2015-10-28 09:25:44,164 DEBUG : BROWSER_OUTPUT: 09:28:46 INFO - 2015-10-28 09:28:46,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/dromaeo/cssquery-yui.html (next: http://localhost:45947/tests/dromaeo/cssquery-dojo.html) 09:28:47 INFO - 2015-10-28 09:28:47,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 268537856 09:28:47 INFO - 2015-10-28 09:28:47,037 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,037 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:28:47 INFO - 2015-10-28 09:28:47,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:28:47 INFO - 2015-10-28 09:28:47,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:28:47 INFO - 2015-10-28 09:28:47,038 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:28:47 INFO - 2015-10-28 09:28:47,038 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2586.0389853617608;2698.4468184022276;2716.9320766980836;2730.9044183453584;2733.2346942855984;4614.976925115369;4743.573078422941;4887.095887260854;4999.1501444754385;5022.096022715905;4744.549267819561;4807.2789081637775;4882.218844984804;4892.877678058041;4894.094592500381;4420.845270415536;4428.557144285562;4496.505384407721;4556.863294101166;4594.517575654559;4266.210751011057;4531.637469002472;4551.613112885409;4559.9740058486905;4605.30920361945;4388.517263101056;4416;4432.601065904084;4488.438945131858;4516.277395616686;4493.5281795411665;4509.278515437547;4515.932261016087;4523.36672865799;4562.224421848294;4466.419365482499;4479.865604031885;4492.3710680504755;4499.707519011254;4533.116042371739;4601.332806743037;4725.456572494173;4726.692764970266;4728.054389122155;4861.368022157132;5132.076226279269;5170.715610641413;5171.612129090333;5175.223716442526;5181.093308671006;5195.792168313263;5199.220116982445;5199.688018718889;5263.736813159365;5265.578753699733;4601.792919318638;4657.04530571232;4737;4741.051789642085;4782.713037217778;5260.684358938476;5328.8401347959625;5335;5339.385970613429;5377.300950876361;5106.4893510648635;5116.411612664591;5119;5123.180291153472;5124.436312005676;4837.758112094381;4945.629077819178;4956.628252880976;5043.420006699276;5194.168932970707;5105.387353517602;5120.052790233819;5121.8719532012;5127.051495473349;5147.948520514822;5070.7464626768515;5075.746212689424;5094.592432605383;5102.642815002914;5133.512316329943;4082.6121518456293;4185.162967406531;4187.623113919762;4265.97867010663;4349.891252718644;3722.962770372316;3723.8510459581853;3738;3753.0804952786198;3758.774473531597;4055.3511438169753;4067.3085575452246;4069.8168582413864;4095.97952010244;4110.630043296118;4844.709317440965;4946.752662366867;4957.231629097496;4961.50384961501;5182.6372153949615;3921.039345360405;3944;3946.881593552198;4004.8798536043964;4034.3545032794614;4635.258358662665;4647.465541462708;4660.883477913079;4667.299905014207;4710.646701497401;4914.729689867092;4924.162892308316;4928.654994150375;4940.555350018516;4951.702897826142;4925.138100832269;4980.701157930535;5077.593792496517;5083.110455670317;5112.3865136183895;4900;4907.533784290486;4909.263610458317;4913.213885778258;4955.975220124021;5133.2300154975555;5136.666116702552;5141.126008578625;5141.408737995029;5146.433892271922;4933.407991041098;5040.899182016413;5052.5705315048635;5063.240513922941;5173.3533308336455;4999.700017998932;5063.898722025612;5086.313347698014;5092.185250359925;5123.410807757155;5056.62075344358;5060.1903695408555;5067.721275329893;5068.189089745623;5070.6957582545165;4587.0596527712405;4713.528647135259;4716.5990890774665;4748.453927798348;4874.7562621868055;5001.049800537886;5009.148444764472;5012.47369026247;5020.3724534433195;5020.598352131748;4897.877553061059;4898.24077268024;4900.387451568554;4903.362562866804;4949.7030178189425 09:28:47 INFO - 2015-10-28 09:28:47,038 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.9945000549994;553.5129086403966;558.2881825672267;558.5057224356444;565.2510423688614;28810.711892881063;29366.265843353925;37589.872303830896;38386.80806595963;38394.61605383952;40671.59328406715;41207;41214.793926030325;41228;41296;7149.213586505481;7280;7696.769096927087;7874.370050395954;7876.842463150733;10205.744856378577;10414.583416663325;10430.63492777753;10432.061114499693;10433.686989390331;10052.74868128299;10112.443815590139;10134.391936483798;10140.138088262469;10148.543315550782;7344.045274114357;7552.69789208431;10267.743306417324;10466.21503387249;10744.462776861204;10176.694699159038;10325.122364599018;10337.22470814692;10338.172946164288;10346.12057975073;37535;37930.43104353437;37961;37966.240675186615;37968.62031379678;2713.118236573102;2752.8898844046216;2786.5541513357966;2816.7605753510975;3277.459219228824;26956.821692637477;27260.727392726018;27913.720862791317;28483.287917802012;30036.348000859944;2376.4652953085592;2405.6992875890514;2535.2774459279017;2569.5117927593697;2579.097315939425;221120;221782;221888.9999999984;222739;223266;51968;52700;54345;55993.16010259849;56408.15387769187;58431;58658.41341586615;58749.706251468466;58842.11736823951;58918;13226.140300880605;13359.799603005962;13442.462301508025;13454.730905381837;13469.259190744408;9894.505274736235;9929.900700993043;9952.253580981456;9957.701268961942;9961.452120133317;18709.158087886077;18821.247150114115;18833.434996950113;18910.243590256512;18911.959842208536;8111.837763244702;8281.917180828115;8365.205305495969;8394.79013024667;8408;761.2235519769914;785.9842803143905;821.2485575698289;823.3536673711108;937.8593211018265;26603.46793064128;26738.73261267401;26956.865215673795;26985.1904442867;27090.5936410954;887.3300658003295;927.7263207353847;950.5627411390699;1064.6205730193012;1066.0512144191675;13962.371693273826;14086.647833804032;14124.929375353264;14287;14317.78523322151;263527;268804;268847;268854;268878;45747.31379029317;46170.5382946173;46397.30404043942;46435.53564464312;46454.07091858212;1142.3431526872082;1151.1078913841839;1152.988470115288;1155.3241353808116;1155.6590805712335;21788;25337;25479.61780573256;26573.867130664225;27275.86362068177;37338.62661373351;37709.622903770614;37761.62238377691;37767.62232377641;37778;224838;225283;226267;226297;226300;23720.288391348287;28383.29041773972;28526;29004.7099529002;29030.41939161247;33969.830150849084;34363.48454773131;34512.65487345094;35053.123671908405;35393.81455669002;30111;30408;38496.422553662276;39985.2002959945;40725;34327.65672343344;34492.482612761334;35032.64967350396;35055.82472087623;35178.296434071686;34839.12902177466;34890.302193956486;35110.64889351074;35787.46318805272;36631.81684091563;29342.41315173642;30806;30993;31408.685913140576;31463.84268078645;24043;24235;24345.634815478137;24563.140290090476;24604.261872143863 09:28:47 INFO - 2015-10-28 09:28:47,038 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.8026403233946;317.12947957855675;317.2971867313899;319.825694996227;325.48248285226487;12685.238885666866;13095.803562946563;15350.616234594141;15610.609734756623;15689.215539223036;13191.868081319208;13740.519081832137;14909.701805963874;15621.765673514907;15625.218739063059;3810.1998580298173;4754.9762251188695;4867.464578896319;4872.0499502597;4889.291052797343;4843.297721830332;4943.159662857305;4949.4060712714345;4950.480199579047;4951.653384263103;4780.952190478086;4910.288008238803;4922.187839006559;4926.507349265081;4927.1870141426625;4862.951370486303;4910.386201724785;4910.631702622282;4911.852644420655;4913.017396520692;4216.2199993001395;4305.763183024964;4325.870223893288;4327.653787696977;4329.610335069859;19457.51356216106;19577.412677619694;19779.406617801487;20275.898620506803;20546.07542660584;1666.4584010196734;1715.2795825753215;1754.561359660085;1767.3902503636225;1835.7246413038017;12394.380280986004;12568.120231583793;12710.23738575679;13020.609381718468;13041;1666.5500314915025;1668.382698401587;1735.6268402293567;1790.54341143009;1803.962721435167;55534;56019.43980560183;56020.43979560193;57246.42753572453;57391.71304143452;15029.774553381709;15997.28012239452;16072.919635401748;16107.516774496784;16133.919330403507;19339.323123690883;19692.212311507665;21586.35240942774;23572.528549428916;23644;7966.362690984707;8070.556119413372;8187.3040791533385;8326.04250511187;8328;6891.620960847101;6931.792046238621;6933.826654333581;6978.720851165896;6983.685734141975;7615;7726.38188944883;7755.961220193975;7771.455998080193;7798.610069496503;3110.5023196288485;3153.984230078835;3189.2983543620367;3207.3905957867933;3217.51737239416;387.7654019318328;397.15406184826713;403;415.3582714705727;419.1909614444152;10594.31136976094;10622.893771062345;10768.658382320238;10881.183911206692;11188.104951603853;425.27915183763224;430.694207112947;431.33358960406247;440.0275391385011;443.2110842699999;5169.586433085344;5957.9427615129725;6038.758449662052;6084.665343406066;6094.573379863456;484479;487794;488524;495327;509322;53752.46247537553;61718.69140654268;69064;70475.64762176259;70678.64660676663;474.99287510687367;478.84437557793854;479.0610403608965;480.52908150013184;480.5818937524376;10183.13443357323;10190.337628054152;10230.795384092426;10252.538635761259;10359.015893490106;32769.50845737364;32881.177970550925;33138.33723325568;34450.31099377948;34453.82773086119;42691.78654106834;44245.55754442414;44546;44838.327425088;45457.54542454533;5798.768049277982;6007.189029480965;6027.78902738402;6069.939300606938;6090.908636370546;11213.71965700864;11390.430478475877;11427.314361138358;11453.141014424118;11574.6527604172;10093.091621754078;10114.848277275994;10158.695239142837;10240.436775977094;10324.48377581133;9743.025697430201;9885.406875587487;10011.449370284705;10070.295079344376;10299.227557933335;10176.898231017594;10205.081542661195;10306.12397946153;10389.53247103867;10438.269321147447;6097.494485886383;6145.10895920098;6147.754089836357;6155.784547540815;6168.722407491584;9849.212063034796;9851.507424628597;10107.3430227035;10116.59533618647;10181.541830617789 09:28:47 INFO - 2015-10-28 09:28:47,038 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1452.2158034661284;1677.1195122560655;1743.0413272700011;1763.7971633262175;1777.9288828446863;5733.140028995647;6750.122484077069;6882.174139103302;6892.724291028353;6903.068085808414;6996.335348141931;7092.893606595905;7103.325184107502;7103.325184107502;7105.396041336493;2019.8182163605309;2028.6449871272541;2043.0193507116594;2043.2439997200981;2045.7033730109126;2111.68324751287;2112.42964399612;2119.2476670781803;2135.0819147766456;2145.678148277763;1999.5900840327697;2017.193122750904;2025.6758918573032;2027.3005812994493;2034.3185033013958;2032.227753453693;2040.2858999350258;2047.0276618606117;2047.0788145334584;2049.5900819836093;2022.3326302320347;2023.5345870449733;2066.3077868913783;2069.1309649946907;2072.274703853654;5615.0454422748235;5738.340090889517;7039.648017599099;7067.681954312017;7074.292570742936;3987.5414327352437;4098.385242213662;4099.077707515815;4100.753954762724;4110.23960567293;2526.3557792762726;2534.9239522814346;2574.4979728952862;2577.6262441946;2583.302508322742;752.6838727734365;766.6626684258908;767.5931756169239;779.9610019499003;784.4979213303491;9503.477308748015;9579.329446938717;9580.185684216849;9589.424634521882;9595.28035397348;3870.283997460479;3895.9610403896163;3984.362501999666;3992.0818211811447;3994.580569040267;7677.539347639159;7710.96144519285;7720;7723.691052357955;7733.342665873463;4111.157212771374;4137.937930931039;4150.937735933963;4151.709380343407;4154.210699966997;3769.962300377016;3780.3762379207124;3781.4327850822046;3787;3791.75353602015;3048.7713421493477;3072.9078127656207;3081.506958886612;3107.300857307133;3115.4236466253815;931.6599441204047;939.2532936315646;946.8059047895165;954.6801821389773;954.708813811794;1146.6731981385265;1167.048855183023;1171.6016554371383;1174.0607513988775;1194.4804010255566;6476.514261430411;6583.144191255106;6589.53873228879;6603.570767900071;6689.4982876284475;408.58324509001244;412.37319274702287;416.11990639796613;416.3463362520813;416.65417703306184;5350.545203657655;5362.383325917492;5403.459654034644;5404.054290499225;5404.83785486436;6867.2102708188195;7009.088818453569;8028.076771171273;8120.796980075427;8133.389995750343;8033;8036.316913062338;8046.919530804617;8054.838903221903;8074.192580741878;6216.564840461215;6297.590656607306;6358.872822543523;6446.097546343516;6448.871022579522;6690.59856408617;6750.898736519054;6760.864782704417;6765.8985115224295;6767.763128290486;7500.399968002437;7598.962005189938;7699.8075048122;7703.922960770545;7705.036870391201;7229.783106506813;7334.816629584303;7342.926570734438;7347.926520734724;7847.332976697045;6059.6364218147055;6107.511399087974;6114.082887566723;6133.233345831771;6139.600925939978;6802.387785099365;6843.520953533205;6845.418139458202;6850.760223392157;6857;6375;6409.455196308179;6448.935510645021;6560.343965603402;6580.934190658032;6260.593061450991;6284.465820405317;6286.528510361833;6366.554341196072;6412.422881940461;6393.328700486382;6442.677866106769;6446.580972236789;6458.095866578588;6461.515386346136;5942.73257703413;5944.8811023780145;5972.940270597239;5978.282606087298;5986;5993.400659933972;6038.426349496791;6101.84745381369;6111.327753946974;6116.14373987651 09:28:47 INFO - 2015-10-28 09:28:47,038 DEBUG : BROWSER_OUTPUT: |4;prototype.html;288.8526851305834;290.74414515226596;292.3407715601319;295.9778016648752;297.5239616613418;5184.11869982103;5227.424983251844;5231.633785635002;5235.921461178081;5319.069162896487;5139.100657384962;5191.480851914816;5196.766145523451;5208.453112423198;5212.635115541913;3995.98002009991;4014.4379786829795;4019.6181362770635;4027.3958906164016;4027.919441611166;3810.4474851146565;3860.9806950965344;3946.881593552198;4008.078142027321;4010.4585880905997;3942.6845852331744;3943.605639436062;3947.7631342119566;3950.9012274693077;3952.664023558001;3775.62243775623;3822.57951625321;3951.9209615807667;3954.0707933635717;3954.920901581981;3389.4576867701294;3420.8973730788116;3426.0920855973186;3433.6909678128836;3438.6561343865665;4898.461169271413;4920.384951881015;4925.113479573675;4927.679700819435;4930.383702037246;4411.669124815651;4413.933790993137;4416.094700586372;4417.447819022622;4417.602415782563;5090.261912022773;5237.633365664405;5239.79040838366;5240;5248.343957005374;3703.2223233121076;3706.5366829146355;3707.4624179494094;3708.647678470541;3716.9442458363146;5563.554915606742;5628.690422026828;5633.943660563383;5635.746391412396;5636.070048442002;3771.9245615087543;3774.6225377462033;3775.0562359410146;3777.0557360659836;3779.4141908004303;3821.980890095532;3827.75119617224;3829.9850539607028;3830.4637350770913;3833.5399752029934;4293.957060429419;4414.3157810539415;4415.977920110443;4427.911441771146;4435.911281774346;5367.677939323653;5382.273393091961;5389.541888939406;5390.164524498709;5391.3799913009725;1366.706158175997;1379.3861731529373;1380.1374141161773;1380.5444203412849;1381.4543255414055;889.6886089868494;907.4101833807946;911.5260064766417;912.0059135542291;912.6258234123977;4337.37108119321;4338.58783415575;4342.240107981091;4342.261815491374;4343.326784348431;5506.284183056177;5543.695096769717;5545.112781954948;5548.0845660466375;5553.111502159635;4328.783560822009;4334.544872788312;4337.175936572041;4337.240982827992;4337.37108119321;2993.9101826945225;3042.209025653302;3067.217859445827;3068.2329417645587;3069.9386012280074;5266.210068489757;5281.39263984639;5285.603579731459;5285.735713214324;5288;5731.369549349568;5733.369329373765;5733.741981610838;5734.426557344233;5741.282339707536;5275.947240527546;5276.34045744282;5280.86797830042;5284.920726189111;5287.180487024518;5410.513053825174;5513.834584962297;5537.280153580009;5548.944510555004;5561.304836895388;5416.729163541886;5425.647332923348;5425.6744595322825;5426.620136590559;5427.565794736491;5255.973720131375;5264.52619264268;5267.525922666979;5280.471952804843;5280.551153151871;3762.2663580602616;3785.356489396864;3787.715921305968;3789;3789.6589306962505;5403.0544654686055;5515.4760297771645;5520.613557050968;5523.6409633373705;5527.778888844401;5327.227552005015;5329.333833270841;5330.120530112488;5333.653312534673;5334.093204155225;5305.495977882095;5310.070737620978;5310.654807437504;5312.309399778004;5328.920066198933;5092.083424983539;5147;5186.092433824141;5225.895482090261;5243.318368612056;5451.754671039892;5451.781928722807;5452.863678408072;5462.91805622908;5464.781408743765;5082.364704411949;5152.536271735562;5231.764570594256;5327.254184414108;5337.279467271868 09:28:47 INFO - 2015-10-28 09:28:47,039 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.1772784019975;705.7635692043166;727.6725473536907;739.1278291615893;780.9843803123935;12039.879601203997;12285.69285767854;12332.81500777489;12334.383280835968;12376.81434778479;11061.612843550478;11153;11156.832647510273;11156.944215278912;11164;624.5565648389648;641.1920979565734;786.1862971824163;803.505843905998;818.2267756969666;821.195228675898;823.4194892600732;828.1966492502263;828.3083625172987;829.1418381974657;663.4161937494997;858.6093327535956;864.4683519635411;865;865.5672163918041;673.8315421144714;834.4284165346756;854.0989256334565;854.5641722721394;854.9273311768507;629.0187307799802;629.295189387884;629.559308484063;629.804760524239;630.1461519640912;12182;12366.258024518467;12427.813582796265;12433.3783310835;12436.316002619942;11401.885981140165;11872.347020913847;11901.345426001566;11918.940405297919;12072.698182545419;9232.723018309462;9492.95253523735;9565.713028609152;9619.230461563058;9722.659706910295;3240.951385729216;3274.885379011747;3308.3714094322004;3327.317899830529;3404.3701915145775;40508.79745601253;40723.796381017906;40926.38610420876;41062.38406423906;41134.38298425526;9474.478903660365;9829.262805289633;9886.555105020292;9894.851577226347;9906.455144966953;17109;17130.571735706708;17151.056691881815;17158.48524544266;17163.828361716223;6517.837054073591;6653.068570400148;6769.966150169316;6770.966145169243;6796.558223715443;3590.1024743814046;3613.5663720353728;3619.9638003620153;3636.854390866921;3680.9631903681156;2696.0968075694864;2731.617573539706;2737.9589306160424;2739.4794988952035;2762.4337010912714;535.5340853457517;541.7453796715538;549.228334190455;555.089652969131;555.2032832884823;430.9827606895752;547.4361407750024;609.3936533149545;610.7618028968706;613;6792.21889482706;6866.141732283465;6965.094537710065;6999.545029573062;7033.8944915826305;496.16487330960024;571.2630706388795;581.8109114537792;599.2838557923327;614.1432701381636;3491.511188433621;3507.824608769551;3526.7002304803864;3599.1002249437643;3616.87340943071;48510;53480.465195348326;53646.73176634092;53801.1929821053;53919.73040134774;41617.1676566467;41996.160076798296;42189.57810421918;42225.57774422278;42464.36303455451;40374.39438408426;42550;42580.78709606432;42593;44098.338524922154;7425.7029718810645;8013.4791238569305;8100.918990810253;8198.672053118047;8215.958920205361;32881.17797054997;33242.16894577558;34009.65990340065;34059.14852128716;34357.312853743286;40579.18841623092;43450.565494345916;43709.78145109381;43721.34417983669;44085;9934.056264654846;10109.747256318651;10266.230032747722;10271.640492582725;10467.214958877963;10681;10983.066439352744;11017.44912754343;11157.832632510357;11222.10223182127;10137.594496220363;10246.692599222035;10631.096356809758;10922.453877306261;10998.34009959405;10745.355278683304;10807.405592692163;11251.156163287622;11279.266847654877;11378.203525753117;9669.564869581027;9811.411315321104;9880.110790028932;10059.849102263619;10474.738131546772;8870.15733505316;8973.685920992733;9340.392874463138;9467.384619999679;9967;7446.8510629786015;7789.376849852111;8161.918380816353;8327.167283271625;8421.789455263422 09:28:47 INFO - 2015-10-28 09:28:47,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:28:47 INFO - 2015-10-28 09:28:47,039 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:28:47 INFO - 2015-10-28 09:28:47,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,834 09:28:47 INFO - 2015-10-28 09:28:47,039 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:28:47 INFO - 2015-10-28 09:28:47,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1446049727033__endTimestamp 09:28:47 INFO - 2015-10-28 09:28:47,040 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,040 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:28:47 INFO - 2015-10-28 09:28:47,040 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:28:47 INFO - 2015-10-28 09:28:47,040 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,040 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4722.85 Median:4900.00 stddev:523.43 (10.7%) stddev-sans-first:497.47 09:28:47 INFO - 2015-10-28 09:28:47,041 DEBUG : BROWSER_OUTPUT: Values: 2586.0 2698.4 2716.9 2730.9 2733.2 4615.0 4743.6 4887.1 4999.2 5022.1 4744.5 4807.3 4882.2 4892.9 4894.1 4420.8 4428.6 4496.5 4556.9 4594.5 4266.2 4531.6 4551.6 4560.0 4605.3 4388.5 4416.0 4432.6 4488.4 4516.3 4493.5 4509.3 4515.9 4523.4 4562.2 4466.4 4479.9 4492.4 4499.7 4533.1 4601.3 4725.5 4726.7 4728.1 4861.4 5132.1 5170.7 5171.6 5175.2 5181.1 5195.8 5199.2 5199.7 5263.7 5265.6 4601.8 4657.0 4737.0 4741.1 4782.7 5260.7 5328.8 5335.0 5339.4 5377.3 5106.5 5116.4 5119.0 5123.2 5124.4 4837.8 4945.6 4956.6 5043.4 5194.2 5105.4 5120.1 5121.9 5127.1 5147.9 5070.7 5075.7 5094.6 5102.6 5133.5 4082.6 4185.2 4187.6 4266.0 4349.9 3723.0 3723.9 3738.0 3753.1 3758.8 4055.4 4067.3 4069.8 4096.0 4110.6 4844.7 4946.8 4957.2 4961.5 5182.6 3921.0 3944.0 3946.9 4004.9 4034.4 4635.3 4647.5 4660.9 4667.3 4710.6 4914.7 4924.2 4928.7 4940.6 4951.7 4925.1 4980.7 5077.6 5083.1 5112.4 4900.0 4907.5 4909.3 4913.2 4956.0 5133.2 5136.7 5141.1 5141.4 5146.4 4933.4 5040.9 5052.6 5063.2 5173.4 4999.7 5063.9 5086.3 5092.2 5123.4 5056.6 5060.2 5067.7 5068.2 5070.7 4587.1 4713.5 4716.6 4748.5 4874.8 5001.0 5009.1 5012.5 5020.4 5020.6 4897.9 4898.2 4900.4 4903.4 4949.7 09:28:47 INFO - 2015-10-28 09:28:47,041 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,041 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40316.35 Median:29701.31 stddev:62237.14 (209.5%) stddev-sans-first:62340.11 09:28:47 INFO - 2015-10-28 09:28:47,041 DEBUG : BROWSER_OUTPUT: Values: 550.0 553.5 558.3 558.5 565.3 28810.7 29366.3 37589.9 38386.8 38394.6 40671.6 41207.0 41214.8 41228.0 41296.0 7149.2 7280.0 7696.8 7874.4 7876.8 10205.7 10414.6 10430.6 10432.1 10433.7 10052.7 10112.4 10134.4 10140.1 10148.5 7344.0 7552.7 10267.7 10466.2 10744.5 10176.7 10325.1 10337.2 10338.2 10346.1 37535.0 37930.4 37961.0 37966.2 37968.6 2713.1 2752.9 2786.6 2816.8 3277.5 26956.8 27260.7 27913.7 28483.3 30036.3 2376.5 2405.7 2535.3 2569.5 2579.1 221120.0 221782.0 221889.0 222739.0 223266.0 51968.0 52700.0 54345.0 55993.2 56408.2 58431.0 58658.4 58749.7 58842.1 58918.0 13226.1 13359.8 13442.5 13454.7 13469.3 9894.5 9929.9 9952.3 9957.7 9961.5 18709.2 18821.2 18833.4 18910.2 18912.0 8111.8 8281.9 8365.2 8394.8 8408.0 761.2 786.0 821.2 823.4 937.9 26603.5 26738.7 26956.9 26985.2 27090.6 887.3 927.7 950.6 1064.6 1066.1 13962.4 14086.6 14124.9 14287.0 14317.8 263527.0 268804.0 268847.0 268854.0 268878.0 45747.3 46170.5 46397.3 46435.5 46454.1 1142.3 1151.1 1153.0 1155.3 1155.7 21788.0 25337.0 25479.6 26573.9 27275.9 37338.6 37709.6 37761.6 37767.6 37778.0 224838.0 225283.0 226267.0 226297.0 226300.0 23720.3 28383.3 28526.0 29004.7 29030.4 33969.8 34363.5 34512.7 35053.1 35393.8 30111.0 30408.0 38496.4 39985.2 40725.0 34327.7 34492.5 35032.6 35055.8 35178.3 34839.1 34890.3 35110.6 35787.5 36631.8 29342.4 30806.0 30993.0 31408.7 31463.8 24043.0 24235.0 24345.6 24563.1 24604.3 09:28:47 INFO - 2015-10-28 09:28:47,042 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,042 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26043.75 Median:417.27 stddev:80543.72 (19302.3%) stddev-sans-first:80746.48 09:28:47 INFO - 2015-10-28 09:28:47,042 DEBUG : BROWSER_OUTPUT: Values: 310.8 317.1 317.3 319.8 325.5 12685.2 13095.8 15350.6 15610.6 15689.2 13191.9 13740.5 14909.7 15621.8 15625.2 3810.2 4755.0 4867.5 4872.0 4889.3 4843.3 4943.2 4949.4 4950.5 4951.7 4781.0 4910.3 4922.2 4926.5 4927.2 4863.0 4910.4 4910.6 4911.9 4913.0 4216.2 4305.8 4325.9 4327.7 4329.6 19457.5 19577.4 19779.4 20275.9 20546.1 1666.5 1715.3 1754.6 1767.4 1835.7 12394.4 12568.1 12710.2 13020.6 13041.0 1666.6 1668.4 1735.6 1790.5 1804.0 55534.0 56019.4 56020.4 57246.4 57391.7 15029.8 15997.3 16072.9 16107.5 16133.9 19339.3 19692.2 21586.4 23572.5 23644.0 7966.4 8070.6 8187.3 8326.0 8328.0 6891.6 6931.8 6933.8 6978.7 6983.7 7615.0 7726.4 7756.0 7771.5 7798.6 3110.5 3154.0 3189.3 3207.4 3217.5 387.8 397.2 403.0 415.4 419.2 10594.3 10622.9 10768.7 10881.2 11188.1 425.3 430.7 431.3 440.0 443.2 5169.6 5957.9 6038.8 6084.7 6094.6 484479.0 487794.0 488524.0 495327.0 509322.0 53752.5 61718.7 69064.0 70475.6 70678.6 475.0 478.8 479.1 480.5 480.6 10183.1 10190.3 10230.8 10252.5 10359.0 32769.5 32881.2 33138.3 34450.3 34453.8 42691.8 44245.6 44546.0 44838.3 45457.5 5798.8 6007.2 6027.8 6069.9 6090.9 11213.7 11390.4 11427.3 11453.1 11574.7 10093.1 10114.8 10158.7 10240.4 10324.5 9743.0 9885.4 10011.4 10070.3 10299.2 10176.9 10205.1 10306.1 10389.5 10438.3 6097.5 6145.1 6147.8 6155.8 6168.7 9849.2 9851.5 10107.3 10116.6 10181.5 09:28:47 INFO - 2015-10-28 09:28:47,042 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,042 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4844.39 Median:6124.69 stddev:2508.32 (41.0%) stddev-sans-first:2502.40 09:28:47 INFO - 2015-10-28 09:28:47,043 DEBUG : BROWSER_OUTPUT: Values: 1452.2 1677.1 1743.0 1763.8 1777.9 5733.1 6750.1 6882.2 6892.7 6903.1 6996.3 7092.9 7103.3 7103.3 7105.4 2019.8 2028.6 2043.0 2043.2 2045.7 2111.7 2112.4 2119.2 2135.1 2145.7 1999.6 2017.2 2025.7 2027.3 2034.3 2032.2 2040.3 2047.0 2047.1 2049.6 2022.3 2023.5 2066.3 2069.1 2072.3 5615.0 5738.3 7039.6 7067.7 7074.3 3987.5 4098.4 4099.1 4100.8 4110.2 2526.4 2534.9 2574.5 2577.6 2583.3 752.7 766.7 767.6 780.0 784.5 9503.5 9579.3 9580.2 9589.4 9595.3 3870.3 3896.0 3984.4 3992.1 3994.6 7677.5 7711.0 7720.0 7723.7 7733.3 4111.2 4137.9 4150.9 4151.7 4154.2 3770.0 3780.4 3781.4 3787.0 3791.8 3048.8 3072.9 3081.5 3107.3 3115.4 931.7 939.3 946.8 954.7 954.7 1146.7 1167.0 1171.6 1174.1 1194.5 6476.5 6583.1 6589.5 6603.6 6689.5 408.6 412.4 416.1 416.3 416.7 5350.5 5362.4 5403.5 5404.1 5404.8 6867.2 7009.1 8028.1 8120.8 8133.4 8033.0 8036.3 8046.9 8054.8 8074.2 6216.6 6297.6 6358.9 6446.1 6448.9 6690.6 6750.9 6760.9 6765.9 6767.8 7500.4 7599.0 7699.8 7703.9 7705.0 7229.8 7334.8 7342.9 7347.9 7847.3 6059.6 6107.5 6114.1 6133.2 6139.6 6802.4 6843.5 6845.4 6850.8 6857.0 6375.0 6409.5 6448.9 6560.3 6580.9 6260.6 6284.5 6286.5 6366.6 6412.4 6393.3 6442.7 6446.6 6458.1 6461.5 5942.7 5944.9 5972.9 5978.3 5986.0 5993.4 6038.4 6101.8 6111.3 6116.1 09:28:47 INFO - 2015-10-28 09:28:47,043 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,043 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4417.50 Median:5168.33 stddev:1306.88 (25.3%) stddev-sans-first:1273.27 09:28:47 INFO - 2015-10-28 09:28:47,043 DEBUG : BROWSER_OUTPUT: Values: 288.9 290.7 292.3 296.0 297.5 5184.1 5227.4 5231.6 5235.9 5319.1 5139.1 5191.5 5196.8 5208.5 5212.6 3996.0 4014.4 4019.6 4027.4 4027.9 3810.4 3861.0 3946.9 4008.1 4010.5 3942.7 3943.6 3947.8 3950.9 3952.7 3775.6 3822.6 3951.9 3954.1 3954.9 3389.5 3420.9 3426.1 3433.7 3438.7 4898.5 4920.4 4925.1 4927.7 4930.4 4411.7 4413.9 4416.1 4417.4 4417.6 5090.3 5237.6 5239.8 5240.0 5248.3 3703.2 3706.5 3707.5 3708.6 3716.9 5563.6 5628.7 5633.9 5635.7 5636.1 3771.9 3774.6 3775.1 3777.1 3779.4 3822.0 3827.8 3830.0 3830.5 3833.5 4294.0 4414.3 4416.0 4427.9 4435.9 5367.7 5382.3 5389.5 5390.2 5391.4 1366.7 1379.4 1380.1 1380.5 1381.5 889.7 907.4 911.5 912.0 912.6 4337.4 4338.6 4342.2 4342.3 4343.3 5506.3 5543.7 5545.1 5548.1 5553.1 4328.8 4334.5 4337.2 4337.2 4337.4 2993.9 3042.2 3067.2 3068.2 3069.9 5266.2 5281.4 5285.6 5285.7 5288.0 5731.4 5733.4 5733.7 5734.4 5741.3 5275.9 5276.3 5280.9 5284.9 5287.2 5410.5 5513.8 5537.3 5548.9 5561.3 5416.7 5425.6 5425.7 5426.6 5427.6 5256.0 5264.5 5267.5 5280.5 5280.6 3762.3 3785.4 3787.7 3789.0 3789.7 5403.1 5515.5 5520.6 5523.6 5527.8 5327.2 5329.3 5330.1 5333.7 5334.1 5305.5 5310.1 5310.7 5312.3 5328.9 5092.1 5147.0 5186.1 5225.9 5243.3 5451.8 5451.8 5452.9 5462.9 5464.8 5082.4 5152.5 5231.8 5327.3 5337.3 09:28:47 INFO - 2015-10-28 09:28:47,043 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,043 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12508.17 Median:44091.67 stddev:14333.12 (32.5%) stddev-sans-first:14345.71 09:28:47 INFO - 2015-10-28 09:28:47,043 DEBUG : BROWSER_OUTPUT: Values: 658.2 705.8 727.7 739.1 781.0 12039.9 12285.7 12332.8 12334.4 12376.8 11061.6 11153.0 11156.8 11156.9 11164.0 624.6 641.2 786.2 803.5 818.2 821.2 823.4 828.2 828.3 829.1 663.4 858.6 864.5 865.0 865.6 673.8 834.4 854.1 854.6 854.9 629.0 629.3 629.6 629.8 630.1 12182.0 12366.3 12427.8 12433.4 12436.3 11401.9 11872.3 11901.3 11918.9 12072.7 9232.7 9493.0 9565.7 9619.2 9722.7 3241.0 3274.9 3308.4 3327.3 3404.4 40508.8 40723.8 40926.4 41062.4 41134.4 9474.5 9829.3 9886.6 9894.9 9906.5 17109.0 17130.6 17151.1 17158.5 17163.8 6517.8 6653.1 6770.0 6771.0 6796.6 3590.1 3613.6 3620.0 3636.9 3681.0 2696.1 2731.6 2738.0 2739.5 2762.4 535.5 541.7 549.2 555.1 555.2 431.0 547.4 609.4 610.8 613.0 6792.2 6866.1 6965.1 6999.5 7033.9 496.2 571.3 581.8 599.3 614.1 3491.5 3507.8 3526.7 3599.1 3616.9 48510.0 53480.5 53646.7 53801.2 53919.7 41617.2 41996.2 42189.6 42225.6 42464.4 40374.4 42550.0 42580.8 42593.0 44098.3 7425.7 8013.5 8100.9 8198.7 8216.0 32881.2 33242.2 34009.7 34059.1 34357.3 40579.2 43450.6 43709.8 43721.3 44085.0 9934.1 10109.7 10266.2 10271.6 10467.2 10681.0 10983.1 11017.4 11157.8 11222.1 10137.6 10246.7 10631.1 10922.5 10998.3 10745.4 10807.4 11251.2 11279.3 11378.2 9669.6 9811.4 9880.1 10059.8 10474.7 8870.2 8973.7 9340.4 9467.4 9967.0 7446.9 7789.4 8161.9 8327.2 8421.8 09:28:47 INFO - 2015-10-28 09:28:47,044 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:28:47 INFO - 2015-10-28 09:28:47,044 DEBUG : BROWSER_OUTPUT: 09:28:47 INFO - 2015-10-28 09:28:47,770 INFO : Browser exited with error code: 0 09:28:47 INFO - 2015-10-28 09:28:47,786 INFO : Completed test dromaeo_css (00:18:39) 09:28:47 INFO - 2015-10-28 09:28:47,786 INFO : Starting test kraken 09:28:47 INFO - 2015-10-28 09:28:47,786 DEBUG : operating with platform_type : linux_ 09:28:47 INFO - 2015-10-28 09:28:47,786 INFO : Initialising browser for kraken test... 09:28:47 INFO - 2015-10-28 09:28:47,792 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmw4nO7/profile http://localhost:45947/getInfo.html 09:28:51 INFO - 2015-10-28 09:28:51,712 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:28:51 INFO - 2015-10-28 09:28:51,712 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:28:51 INFO - 2015-10-28 09:28:51,712 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:28:51 INFO - 2015-10-28 09:28:51,712 DEBUG : BROWSER_OUTPUT: __metrics 09:28:51 INFO - 2015-10-28 09:28:51,841 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:28:53 INFO - 2015-10-28 09:28:53,011 INFO : Browser initialized. 09:28:53 INFO - 2015-10-28 09:28:53,011 INFO : Running cycle 1/1 for kraken test... 09:28:53 INFO - 2015-10-28 09:28:53,012 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmw4nO7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:29:04 INFO - 2015-10-28 09:29:04,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 149102592 09:29:04 INFO - 2015-10-28 09:29:04,932 DEBUG : BROWSER_OUTPUT: 09:29:07 INFO - 2015-10-28 09:29:07,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:08 INFO - 2015-10-28 09:29:08,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 183574528 09:29:08 INFO - 2015-10-28 09:29:08,191 DEBUG : BROWSER_OUTPUT: 09:29:10 INFO - 2015-10-28 09:29:10,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-dft) 09:29:11 INFO - 2015-10-28 09:29:11,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 177299456 09:29:11 INFO - 2015-10-28 09:29:11,355 DEBUG : BROWSER_OUTPUT: 09:29:14 INFO - 2015-10-28 09:29:14,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-fft) 09:29:14 INFO - 2015-10-28 09:29:14,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 159358976 09:29:14 INFO - 2015-10-28 09:29:14,930 DEBUG : BROWSER_OUTPUT: 09:29:16 INFO - 2015-10-28 09:29:16,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45947/tests/kraken/driver.html?testName=audio-oscillator) 09:29:17 INFO - 2015-10-28 09:29:17,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 162893824 09:29:17 INFO - 2015-10-28 09:29:17,436 DEBUG : BROWSER_OUTPUT: 09:29:19 INFO - 2015-10-28 09:29:19,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:20 INFO - 2015-10-28 09:29:20,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 164474880 09:29:20 INFO - 2015-10-28 09:29:20,265 DEBUG : BROWSER_OUTPUT: 09:29:23 INFO - 2015-10-28 09:29:23,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45947/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:23 INFO - 2015-10-28 09:29:23,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 158363648 09:29:23 INFO - 2015-10-28 09:29:23,801 DEBUG : BROWSER_OUTPUT: 09:29:27 INFO - 2015-10-28 09:29:27,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45947/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:27 INFO - 2015-10-28 09:29:27,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 163528704 09:29:27 INFO - 2015-10-28 09:29:27,812 DEBUG : BROWSER_OUTPUT: 09:29:30 INFO - 2015-10-28 09:29:30,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45947/tests/kraken/driver.html?testName=json-parse-financial) 09:29:31 INFO - 2015-10-28 09:29:31,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 166187008 09:29:31 INFO - 2015-10-28 09:29:31,177 DEBUG : BROWSER_OUTPUT: 09:29:32 INFO - 2015-10-28 09:29:32,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:33 INFO - 2015-10-28 09:29:33,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 170385408 09:29:33 INFO - 2015-10-28 09:29:33,465 DEBUG : BROWSER_OUTPUT: 09:29:35 INFO - 2015-10-28 09:29:35,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:29:35 INFO - 2015-10-28 09:29:35,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 173547520 09:29:35 INFO - 2015-10-28 09:29:35,917 DEBUG : BROWSER_OUTPUT: 09:29:38 INFO - 2015-10-28 09:29:38,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:29:38 INFO - 2015-10-28 09:29:38,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 182398976 09:29:38 INFO - 2015-10-28 09:29:38,611 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-10-28 09:29:41,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:29:41 INFO - 2015-10-28 09:29:41,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 190013440 09:29:41 INFO - 2015-10-28 09:29:41,701 DEBUG : BROWSER_OUTPUT: 09:29:44 INFO - 2015-10-28 09:29:44,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:29:44 INFO - 2015-10-28 09:29:44,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 188280832 09:29:44 INFO - 2015-10-28 09:29:44,807 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45947/tests/kraken/driver.html?testName=ai-astar) 09:29:46 INFO - 2015-10-28 09:29:46,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 241582080 09:29:46 INFO - 2015-10-28 09:29:46,832 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,833 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:29:46 INFO - 2015-10-28 09:29:46,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:29:46 INFO - 2015-10-28 09:29:46,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:29:46 INFO - 2015-10-28 09:29:46,833 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:29:46 INFO - 2015-10-28 09:29:46,834 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;116;107;112;115;113;102;113;106;114 09:29:46 INFO - 2015-10-28 09:29:46,834 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;131;127;137;147;132;141;137;129;147;128 09:29:46 INFO - 2015-10-28 09:29:46,834 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;158;157;159;157;158;159;158;161;161 09:29:46 INFO - 2015-10-28 09:29:46,834 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;71;81;71;73;70;71;78;71 09:29:46 INFO - 2015-10-28 09:29:46,834 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;141;95;94;94;128;94;93;135 09:29:46 INFO - 2015-10-28 09:29:46,835 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;110;110;111;110;110 09:29:46 INFO - 2015-10-28 09:29:46,835 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;148;148;147;147;147;148;147 09:29:46 INFO - 2015-10-28 09:29:46,835 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;95;95;96;95 09:29:46 INFO - 2015-10-28 09:29:46,835 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;69;69;69;69;68;69;78;66;66 09:29:46 INFO - 2015-10-28 09:29:46,835 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;69;68;72;70;68 09:29:46 INFO - 2015-10-28 09:29:46,835 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;82;81;82;81;84;83;85;85 09:29:46 INFO - 2015-10-28 09:29:46,835 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;119;132;117;133;119;124;122;125;123 09:29:46 INFO - 2015-10-28 09:29:46,836 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;139;136;138;143;138;138;137;137;147 09:29:46 INFO - 2015-10-28 09:29:46,836 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;72;71;70;71;70;69;70;69 09:29:46 INFO - 2015-10-28 09:29:46,836 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:29:46 INFO - 2015-10-28 09:29:46,836 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:29:46 INFO - 2015-10-28 09:29:46,836 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 09:29:46 INFO - 2015-10-28 09:29:46,836 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:29:46 INFO - 2015-10-28 09:29:46,836 DEBUG : BROWSER_OUTPUT: __startTimestamp1446049786832__endTimestamp 09:29:46 INFO - 2015-10-28 09:29:46,837 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,844 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:29:46 INFO - 2015-10-28 09:29:46,844 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:29:46 INFO - 2015-10-28 09:29:46,844 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,844 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:113.50 stddev:4.59 (4.0%) stddev-sans-first:4.76 09:29:46 INFO - 2015-10-28 09:29:46,844 DEBUG : BROWSER_OUTPUT: Values: 114.0 116.0 107.0 112.0 115.0 113.0 102.0 113.0 106.0 114.0 09:29:46 INFO - 2015-10-28 09:29:46,844 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,844 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.60 Median:137.00 stddev:7.47 (5.5%) stddev-sans-first:7.74 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: Values: 131.0 127.0 137.0 147.0 132.0 141.0 137.0 129.0 147.0 128.0 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:158.70 Median:159.00 stddev:1.42 (0.9%) stddev-sans-first:1.50 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: Values: 159.0 158.0 157.0 159.0 157.0 158.0 159.0 158.0 161.0 161.0 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:72.60 Median:71.00 stddev:3.81 (5.4%) stddev-sans-first:3.92 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 81.0 71.0 73.0 70.0 71.0 78.0 71.0 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:94.00 stddev:19.89 (21.2%) stddev-sans-first:20.60 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 141.0 95.0 94.0 94.0 128.0 94.0 93.0 135.0 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 110.0 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:29:46 INFO - 2015-10-28 09:29:46,845 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.30 Median:69.00 stddev:3.33 (4.8%) stddev-sans-first:3.53 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 69.0 69.0 68.0 69.0 78.0 66.0 66.0 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.27 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 69.0 68.0 72.0 70.0 68.0 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:1.62 (1.9%) stddev-sans-first:1.58 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 82.0 81.0 82.0 81.0 84.0 83.0 85.0 85.0 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:123.50 stddev:5.48 (4.4%) stddev-sans-first:5.59 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: Values: 119.0 119.0 132.0 117.0 133.0 119.0 124.0 122.0 125.0 123.0 09:29:46 INFO - 2015-10-28 09:29:46,846 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,847 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:138.00 stddev:3.40 (2.5%) stddev-sans-first:3.53 09:29:46 INFO - 2015-10-28 09:29:46,847 DEBUG : BROWSER_OUTPUT: Values: 137.0 139.0 136.0 138.0 143.0 138.0 138.0 137.0 137.0 147.0 09:29:46 INFO - 2015-10-28 09:29:46,847 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-10-28 09:29:46,847 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.07 (1.5%) stddev-sans-first:1.13 09:29:46 INFO - 2015-10-28 09:29:46,847 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 72.0 71.0 70.0 71.0 70.0 69.0 70.0 69.0 09:29:46 INFO - 2015-10-28 09:29:46,847 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:29:46 INFO - 2015-10-28 09:29:46,847 DEBUG : BROWSER_OUTPUT: 09:29:47 INFO - 2015-10-28 09:29:47,749 INFO : Browser exited with error code: 0 09:29:47 INFO - 2015-10-28 09:29:47,802 INFO : Completed test kraken (00:01:00) 09:29:47 INFO - 2015-10-28 09:29:47,802 INFO : Starting test v8_7 09:29:47 INFO - 2015-10-28 09:29:47,802 DEBUG : operating with platform_type : linux_ 09:29:47 INFO - 2015-10-28 09:29:47,802 INFO : Initialising browser for v8_7 test... 09:29:47 INFO - 2015-10-28 09:29:47,808 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjF3bUJ/profile http://localhost:45947/getInfo.html 09:29:51 INFO - 2015-10-28 09:29:51,735 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:29:51 INFO - 2015-10-28 09:29:51,736 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:29:51 INFO - 2015-10-28 09:29:51,736 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:29:51 INFO - 2015-10-28 09:29:51,736 DEBUG : BROWSER_OUTPUT: __metrics 09:29:51 INFO - 2015-10-28 09:29:51,885 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:53 INFO - 2015-10-28 09:29:53,027 INFO : Browser initialized. 09:29:53 INFO - 2015-10-28 09:29:53,028 INFO : Running cycle 1/1 for v8_7 test... 09:29:53 INFO - 2015-10-28 09:29:53,028 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjF3bUJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:30:04 INFO - 2015-10-28 09:30:04,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 148832256 09:30:04 INFO - 2015-10-28 09:30:04,948 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45947/tests/v8_7/run.html (next: http://localhost:45947/tests/v8_7/run.html) 09:30:26 INFO - 2015-10-28 09:30:26,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 451112960 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |0;Richards;170.15484090522375 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.90816136828406 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2032.520325203252 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |6;Boyer;11720.93023255814 09:30:26 INFO - 2015-10-28 09:30:26,632 DEBUG : BROWSER_OUTPUT: |7;RegExp;27081.08108108108 09:30:26 INFO - 2015-10-28 09:30:26,633 DEBUG : BROWSER_OUTPUT: |8;Splay;611.2469437652812 09:30:26 INFO - 2015-10-28 09:30:26,633 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 09:30:26 INFO - 2015-10-28 09:30:26,633 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:30:26 INFO - 2015-10-28 09:30:26,633 DEBUG : BROWSER_OUTPUT: __startTimestamp1446049826631__endTimestamp 09:30:26 INFO - 2015-10-28 09:30:26,633 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,634 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:30:26 INFO - 2015-10-28 09:30:26,634 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:30:26 INFO - 2015-10-28 09:30:26,634 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,634 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.15 Median:170.15 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,634 DEBUG : BROWSER_OUTPUT: Values: 170.2 09:30:26 INFO - 2015-10-28 09:30:26,634 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,634 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.91 Median:185.91 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: Values: 185.9 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: Values: 279.7 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: Values: 5025.1 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: Values: 2032.5 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: Values: 782.5 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11720.93 Median:11720.93 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,635 DEBUG : BROWSER_OUTPUT: Values: 11720.9 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27081.08 Median:27081.08 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: Values: 27081.1 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.25 Median:611.25 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: Values: 611.2 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: Values: 4822.1 09:30:26 INFO - 2015-10-28 09:30:26,636 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:30:26 INFO - 2015-10-28 09:30:26,637 DEBUG : BROWSER_OUTPUT: 09:30:27 INFO - 2015-10-28 09:30:27,498 INFO : Browser exited with error code: 0 09:30:27 INFO - 2015-10-28 09:30:27,512 INFO : Completed test v8_7 (00:00:39) 09:30:27 INFO - 2015-10-28 09:30:27,647 INFO : Completed test suite (00:20:19) 09:30:27 INFO - 2015-10-28 09:30:27,647 DEBUG : Working with test: dromaeo_css 09:30:27 INFO - 2015-10-28 09:30:27,647 DEBUG : Generating results file: dromaeo_css 09:30:27 INFO - 2015-10-28 09:30:27,648 DEBUG : Working with test: kraken 09:30:27 INFO - 2015-10-28 09:30:27,648 DEBUG : Generating results file: kraken 09:30:27 INFO - 2015-10-28 09:30:27,649 INFO : javascript benchmark 09:30:27 INFO - 2015-10-28 09:30:27,649 DEBUG : Working with test: v8_7 09:30:27 INFO - 2015-10-28 09:30:27,649 DEBUG : Generating results file: v8_7 09:30:27 INFO - 2015-10-28 09:30:27,649 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:27 INFO - 2015-10-28 09:30:27,724 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,144,35]] 09:30:27 INFO - 2015-10-28 09:30:27,724 DEBUG : process_Request line: dromaeo_css 6152.91 graph.html#tests=[[72,144,35]] 09:30:27 INFO - 2015-10-28 09:30:27,724 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:27 INFO - 2015-10-28 09:30:27,866 DEBUG : process_Request line: kraken 1490.80 graph.html#tests=[[232,144,35]] 09:30:27 INFO - 2015-10-28 09:30:27,866 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:27 INFO - 2015-10-28 09:30:27,985 DEBUG : process_Request line: v8_7 19830.77 graph.html#tests=[[230,144,35]] 09:30:27 INFO - 2015-10-28 09:30:27,986 INFO : javascript benchmark 09:30:28 INFO - 2015-10-28 09:30:27,989 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [310.8026403233946, 317.12947957855675, 317.2971867313899, 319.825694996227, 325.48248285226487, 12685.238885666866, 13095.803562946563, 15350.616234594141, 15610.609734756623, 15689.215539223036, 13191.868081319208, 13740.519081832137, 14909.701805963874, 15621.765673514907, 15625.218739063059, 3810.1998580298173, 4754.9762251188695, 4867.464578896319, 4872.0499502597, 4889.291052797343, 4843.297721830332, 4943.159662857305, 4949.4060712714345, 4950.480199579047, 4951.653384263103, 4780.952190478086, 4910.288008238803, 4922.187839006559, 4926.507349265081, 4927.1870141426625, 4862.951370486303, 4910.386201724785, 4910.631702622282, 4911.852644420655, 4913.017396520692, 4216.2199993001395, 4305.763183024964, 4325.870223893288, 4327.653787696977, 4329.610335069859, 19457.51356216106, 19577.412677619694, 19779.406617801487, 20275.898620506803, 20546.07542660584, 1666.4584010196734, 1715.2795825753215, 1754.561359660085, 1767.3902503636225, 1835.7246413038017, 12394.380280986004, 12568.120231583793, 12710.23738575679, 13020.609381718468, 13041.0, 1666.5500314915025, 1668.382698401587, 1735.6268402293567, 1790.54341143009, 1803.962721435167, 55534.0, 56019.43980560183, 56020.43979560193, 57246.42753572453, 57391.71304143452, 15029.774553381709, 15997.28012239452, 16072.919635401748, 16107.516774496784, 16133.919330403507, 19339.323123690883, 19692.212311507665, 21586.35240942774, 23572.528549428916, 23644.0, 7966.362690984707, 8070.556119413372, 8187.3040791533385, 8326.04250511187, 8328.0, 6891.620960847101, 6931.792046238621, 6933.826654333581, 6978.720851165896, 6983.685734141975, 7615.0, 7726.38188944883, 7755.961220193975, 7771.455998080193, 7798.610069496503, 3110.5023196288485, 3153.984230078835, 3189.2983543620367, 3207.3905957867933, 3217.51737239416, 387.7654019318328, 397.15406184826713, 403.0, 415.3582714705727, 419.1909614444152, 10594.31136976094, 10622.893771062345, 10768.658382320238, 10881.183911206692, 11188.104951603853, 425.27915183763224, 430.694207112947, 431.33358960406247, 440.0275391385011, 443.2110842699999, 5169.586433085344, 5957.9427615129725, 6038.758449662052, 6084.665343406066, 6094.573379863456, 484479.0, 487794.0, 488524.0, 495327.0, 509322.0, 53752.46247537553, 61718.69140654268, 69064.0, 70475.64762176259, 70678.64660676663, 474.99287510687367, 478.84437557793854, 479.0610403608965, 480.52908150013184, 480.5818937524376, 10183.13443357323, 10190.337628054152, 10230.795384092426, 10252.538635761259, 10359.015893490106, 32769.50845737364, 32881.177970550925, 33138.33723325568, 34450.31099377948, 34453.82773086119, 42691.78654106834, 44245.55754442414, 44546.0, 44838.327425088, 45457.54542454533, 5798.768049277982, 6007.189029480965, 6027.78902738402, 6069.939300606938, 6090.908636370546, 11213.71965700864, 11390.430478475877, 11427.314361138358, 11453.141014424118, 11574.6527604172, 10093.091621754078, 10114.848277275994, 10158.695239142837, 10240.436775977094, 10324.48377581133, 9743.025697430201, 9885.406875587487, 10011.449370284705, 10070.295079344376, 10299.227557933335, 10176.898231017594, 10205.081542661195, 10306.12397946153, 10389.53247103867, 10438.269321147447, 6097.494485886383, 6145.10895920098, 6147.754089836357, 6155.784547540815, 6168.722407491584, 9849.212063034796, 9851.507424628597, 10107.3430227035, 10116.59533618647, 10181.541830617789], "dojo.html": [2586.0389853617608, 2698.4468184022276, 2716.9320766980836, 2730.9044183453584, 2733.2346942855984, 4614.976925115369, 4743.573078422941, 4887.095887260854, 4999.1501444754385, 5022.096022715905, 4744.549267819561, 4807.2789081637775, 4882.218844984804, 4892.877678058041, 4894.094592500381, 4420.845270415536, 4428.557144285562, 4496.505384407721, 4556.863294101166, 4594.517575654559, 4266.210751011057, 4531.637469002472, 4551.613112885409, 4559.9740058486905, 4605.30920361945, 4388.517263101056, 4416.0, 4432.601065904084, 4488.438945131858, 4516.277395616686, 4493.5281795411665, 4509.278515437547, 4515.932261016087, 4523.36672865799, 4562.224421848294, 4466.419365482499, 4479.865604031885, 4492.3710680504755, 4499.707519011254, 4533.116042371739, 4601.332806743037, 4725.456572494173, 4726.692764970266, 4728.054389122155, 4861.368022157132, 5132.076226279269, 5170.715610641413, 5171.612129090333, 5175.223716442526, 5181.093308671006, 5195.792168313263, 5199.220116982445, 5199.688018718889, 5263.736813159365, 5265.578753699733, 4601.792919318638, 4657.04530571232, 4737.0, 4741.051789642085, 4782.713037217778, 5260.684358938476, 5328.8401347959625, 5335.0, 5339.385970613429, 5377.300950876361, 5106.4893510648635, 5116.411612664591, 5119.0, 5123.180291153472, 5124.436312005676, 4837.758112094381, 4945.629077819178, 4956.628252880976, 5043.420006699276, 5194.168932970707, 5105.387353517602, 5120.052790233819, 5121.8719532012, 5127.051495473349, 5147.948520514822, 5070.7464626768515, 5075.746212689424, 5094.592432605383, 5102.642815002914, 5133.512316329943, 4082.6121518456293, 4185.162967406531, 4187.623113919762, 4265.97867010663, 4349.891252718644, 3722.962770372316, 3723.8510459581853, 3738.0, 3753.0804952786198, 3758.774473531597, 4055.3511438169753, 4067.3085575452246, 4069.8168582413864, 4095.97952010244, 4110.630043296118, 4844.709317440965, 4946.752662366867, 4957.231629097496, 4961.50384961501, 5182.6372153949615, 3921.039345360405, 3944.0, 3946.881593552198, 4004.8798536043964, 4034.3545032794614, 4635.258358662665, 4647.465541462708, 4660.883477913079, 4667.299905014207, 4710.646701497401, 4914.729689867092, 4924.162892308316, 4928.654994150375, 4940.555350018516, 4951.702897826142, 4925.138100832269, 4980.701157930535, 5077.593792496517, 5083.110455670317, 5112.3865136183895, 4900.0, 4907.533784290486, 4909.263610458317, 4913.213885778258, 4955.975220124021, 5133.2300154975555, 5136.666116702552, 5141.126008578625, 5141.408737995029, 5146.433892271922, 4933.407991041098, 5040.899182016413, 5052.5705315048635, 5063.240513922941, 5173.3533308336455, 4999.700017998932, 5063.898722025612, 5086.313347698014, 5092.185250359925, 5123.410807757155, 5056.62075344358, 5060.1903695408555, 5067.721275329893, 5068.189089745623, 5070.6957582545165, 4587.0596527712405, 4713.528647135259, 4716.5990890774665, 4748.453927798348, 4874.7562621868055, 5001.049800537886, 5009.148444764472, 5012.47369026247, 5020.3724534433195, 5020.598352131748, 4897.877553061059, 4898.24077268024, 4900.387451568554, 4903.362562866804, 4949.7030178189425], "mootools.html": [1452.2158034661284, 1677.1195122560655, 1743.0413272700011, 1763.7971633262175, 1777.9288828446863, 5733.140028995647, 6750.122484077069, 6882.174139103302, 6892.724291028353, 6903.068085808414, 6996.335348141931, 7092.893606595905, 7103.325184107502, 7103.325184107502, 7105.396041336493, 2019.8182163605309, 2028.6449871272541, 2043.0193507116594, 2043.2439997200981, 2045.7033730109126, 2111.68324751287, 2112.42964399612, 2119.2476670781803, 2135.0819147766456, 2145.678148277763, 1999.5900840327697, 2017.193122750904, 2025.6758918573032, 2027.3005812994493, 2034.3185033013958, 2032.227753453693, 2040.2858999350258, 2047.0276618606117, 2047.0788145334584, 2049.5900819836093, 2022.3326302320347, 2023.5345870449733, 2066.3077868913783, 2069.1309649946907, 2072.274703853654, 5615.0454422748235, 5738.340090889517, 7039.648017599099, 7067.681954312017, 7074.292570742936, 3987.5414327352437, 4098.385242213662, 4099.077707515815, 4100.753954762724, 4110.23960567293, 2526.3557792762726, 2534.9239522814346, 2574.4979728952862, 2577.6262441946, 2583.302508322742, 752.6838727734365, 766.6626684258908, 767.5931756169239, 779.9610019499003, 784.4979213303491, 9503.477308748015, 9579.329446938717, 9580.185684216849, 9589.424634521882, 9595.28035397348, 3870.283997460479, 3895.9610403896163, 3984.362501999666, 3992.0818211811447, 3994.580569040267, 7677.539347639159, 7710.96144519285, 7720.0, 7723.691052357955, 7733.342665873463, 4111.157212771374, 4137.937930931039, 4150.937735933963, 4151.709380343407, 4154.210699966997, 3769.962300377016, 3780.3762379207124, 3781.4327850822046, 3787.0, 3791.75353602015, 3048.7713421493477, 3072.9078127656207, 3081.506958886612, 3107.300857307133, 3115.4236466253815, 931.6599441204047, 939.2532936315646, 946.8059047895165, 954.6801821389773, 954.708813811794, 1146.6731981385265, 1167.048855183023, 1171.6016554371383, 1174.0607513988775, 1194.4804010255566, 6476.514261430411, 6583.144191255106, 6589.53873228879, 6603.570767900071, 6689.4982876284475, 408.58324509001244, 412.37319274702287, 416.11990639796613, 416.3463362520813, 416.65417703306184, 5350.545203657655, 5362.383325917492, 5403.459654034644, 5404.054290499225, 5404.83785486436, 6867.2102708188195, 7009.088818453569, 8028.076771171273, 8120.796980075427, 8133.389995750343, 8033.0, 8036.316913062338, 8046.919530804617, 8054.838903221903, 8074.192580741878, 6216.564840461215, 6297.590656607306, 6358.872822543523, 6446.097546343516, 6448.871022579522, 6690.59856408617, 6750.898736519054, 6760.864782704417, 6765.8985115224295, 6767.763128290486, 7500.399968002437, 7598.962005189938, 7699.8075048122, 7703.922960770545, 7705.036870391201, 7229.783106506813, 7334.816629584303, 7342.926570734438, 7347.926520734724, 7847.332976697045, 6059.6364218147055, 6107.511399087974, 6114.082887566723, 6133.233345831771, 6139.600925939978, 6802.387785099365, 6843.520953533205, 6845.418139458202, 6850.760223392157, 6857.0, 6375.0, 6409.455196308179, 6448.935510645021, 6560.343965603402, 6580.934190658032, 6260.593061450991, 6284.465820405317, 6286.528510361833, 6366.554341196072, 6412.422881940461, 6393.328700486382, 6442.677866106769, 6446.580972236789, 6458.095866578588, 6461.515386346136, 5942.73257703413, 5944.8811023780145, 5972.940270597239, 5978.282606087298, 5986.0, 5993.400659933972, 6038.426349496791, 6101.84745381369, 6111.327753946974, 6116.14373987651], "ext.html": [549.9945000549994, 553.5129086403966, 558.2881825672267, 558.5057224356444, 565.2510423688614, 28810.711892881063, 29366.265843353925, 37589.872303830896, 38386.80806595963, 38394.61605383952, 40671.59328406715, 41207.0, 41214.793926030325, 41228.0, 41296.0, 7149.213586505481, 7280.0, 7696.769096927087, 7874.370050395954, 7876.842463150733, 10205.744856378577, 10414.583416663325, 10430.63492777753, 10432.061114499693, 10433.686989390331, 10052.74868128299, 10112.443815590139, 10134.391936483798, 10140.138088262469, 10148.543315550782, 7344.045274114357, 7552.69789208431, 10267.743306417324, 10466.21503387249, 10744.462776861204, 10176.694699159038, 10325.122364599018, 10337.22470814692, 10338.172946164288, 10346.12057975073, 37535.0, 37930.43104353437, 37961.0, 37966.240675186615, 37968.62031379678, 2713.118236573102, 2752.8898844046216, 2786.5541513357966, 2816.7605753510975, 3277.459219228824, 26956.821692637477, 27260.727392726018, 27913.720862791317, 28483.287917802012, 30036.348000859944, 2376.4652953085592, 2405.6992875890514, 2535.2774459279017, 2569.5117927593697, 2579.097315939425, 221120.0, 221782.0, 221888.9999999984, 222739.0, 223266.0, 51968.0, 52700.0, 54345.0, 55993.16010259849, 56408.15387769187, 58431.0, 58658.41341586615, 58749.706251468466, 58842.11736823951, 58918.0, 13226.140300880605, 13359.799603005962, 13442.462301508025, 13454.730905381837, 13469.259190744408, 9894.505274736235, 9929.900700993043, 9952.253580981456, 9957.701268961942, 9961.452120133317, 18709.158087886077, 18821.247150114115, 18833.434996950113, 18910.243590256512, 18911.959842208536, 8111.837763244702, 8281.917180828115, 8365.205305495969, 8394.79013024667, 8408.0, 761.2235519769914, 785.9842803143905, 821.2485575698289, 823.3536673711108, 937.8593211018265, 26603.46793064128, 26738.73261267401, 26956.865215673795, 26985.1904442867, 27090.5936410954, 887.3300658003295, 927.7263207353847, 950.5627411390699, 1064.6205730193012, 1066.0512144191675, 13962.371693273826, 14086.647833804032, 14124.929375353264, 14287.0, 14317.78523322151, 263527.0, 268804.0, 268847.0, 268854.0, 268878.0, 45747.31379029317, 46170.5382946173, 46397.30404043942, 46435.53564464312, 46454.07091858212, 1142.3431526872082, 1151.1078913841839, 1152.988470115288, 1155.3241353808116, 1155.6590805712335, 21788.0, 25337.0, 25479.61780573256, 26573.867130664225, 27275.86362068177, 37338.62661373351, 37709.622903770614, 37761.62238377691, 37767.62232377641, 37778.0, 224838.0, 225283.0, 226267.0, 226297.0, 226300.0, 23720.288391348287, 28383.29041773972, 28526.0, 29004.7099529002, 29030.41939161247, 33969.830150849084, 34363.48454773131, 34512.65487345094, 35053.123671908405, 35393.81455669002, 30111.0, 30408.0, 38496.422553662276, 39985.2002959945, 40725.0, 34327.65672343344, 34492.482612761334, 35032.64967350396, 35055.82472087623, 35178.296434071686, 34839.12902177466, 34890.302193956486, 35110.64889351074, 35787.46318805272, 36631.81684091563, 29342.41315173642, 30806.0, 30993.0, 31408.685913140576, 31463.84268078645, 24043.0, 24235.0, 24345.634815478137, 24563.140290090476, 24604.261872143863], "prototype.html": [288.8526851305834, 290.74414515226596, 292.3407715601319, 295.9778016648752, 297.5239616613418, 5184.11869982103, 5227.424983251844, 5231.633785635002, 5235.921461178081, 5319.069162896487, 5139.100657384962, 5191.480851914816, 5196.766145523451, 5208.453112423198, 5212.635115541913, 3995.98002009991, 4014.4379786829795, 4019.6181362770635, 4027.3958906164016, 4027.919441611166, 3810.4474851146565, 3860.9806950965344, 3946.881593552198, 4008.078142027321, 4010.4585880905997, 3942.6845852331744, 3943.605639436062, 3947.7631342119566, 3950.9012274693077, 3952.664023558001, 3775.62243775623, 3822.57951625321, 3951.9209615807667, 3954.0707933635717, 3954.920901581981, 3389.4576867701294, 3420.8973730788116, 3426.0920855973186, 3433.6909678128836, 3438.6561343865665, 4898.461169271413, 4920.384951881015, 4925.113479573675, 4927.679700819435, 4930.383702037246, 4411.669124815651, 4413.933790993137, 4416.094700586372, 4417.447819022622, 4417.602415782563, 5090.261912022773, 5237.633365664405, 5239.79040838366, 5240.0, 5248.343957005374, 3703.2223233121076, 3706.5366829146355, 3707.4624179494094, 3708.647678470541, 3716.9442458363146, 5563.554915606742, 5628.690422026828, 5633.943660563383, 5635.746391412396, 5636.070048442002, 3771.9245615087543, 3774.6225377462033, 3775.0562359410146, 3777.0557360659836, 3779.4141908004303, 3821.980890095532, 3827.75119617224, 3829.9850539607028, 3830.4637350770913, 3833.5399752029934, 4293.957060429419, 4414.3157810539415, 4415.977920110443, 4427.911441771146, 4435.911281774346, 5367.677939323653, 5382.273393091961, 5389.541888939406, 5390.164524498709, 5391.3799913009725, 1366.706158175997, 1379.3861731529373, 1380.1374141161773, 1380.5444203412849, 1381.4543255414055, 889.6886089868494, 907.4101833807946, 911.5260064766417, 912.0059135542291, 912.6258234123977, 4337.37108119321, 4338.58783415575, 4342.240107981091, 4342.261815491374, 4343.326784348431, 5506.284183056177, 5543.695096769717, 5545.112781954948, 5548.0845660466375, 5553.111502159635, 4328.783560822009, 4334.544872788312, 4337.175936572041, 4337.240982827992, 4337.37108119321, 2993.9101826945225, 3042.209025653302, 3067.217859445827, 3068.2329417645587, 3069.9386012280074, 5266.210068489757, 5281.39263984639, 5285.603579731459, 5285.735713214324, 5288.0, 5731.369549349568, 5733.369329373765, 5733.741981610838, 5734.426557344233, 5741.282339707536, 5275.947240527546, 5276.34045744282, 5280.86797830042, 5284.920726189111, 5287.180487024518, 5410.513053825174, 5513.834584962297, 5537.280153580009, 5548.944510555004, 5561.304836895388, 5416.729163541886, 5425.647332923348, 5425.6744595322825, 5426.620136590559, 5427.565794736491, 5255.973720131375, 5264.52619264268, 5267.525922666979, 5280.471952804843, 5280.551153151871, 3762.2663580602616, 3785.356489396864, 3787.715921305968, 3789.0, 3789.6589306962505, 5403.0544654686055, 5515.4760297771645, 5520.613557050968, 5523.6409633373705, 5527.778888844401, 5327.227552005015, 5329.333833270841, 5330.120530112488, 5333.653312534673, 5334.093204155225, 5305.495977882095, 5310.070737620978, 5310.654807437504, 5312.309399778004, 5328.920066198933, 5092.083424983539, 5147.0, 5186.092433824141, 5225.895482090261, 5243.318368612056, 5451.754671039892, 5451.781928722807, 5452.863678408072, 5462.91805622908, 5464.781408743765, 5082.364704411949, 5152.536271735562, 5231.764570594256, 5327.254184414108, 5337.279467271868], "yui.html": [658.1772784019975, 705.7635692043166, 727.6725473536907, 739.1278291615893, 780.9843803123935, 12039.879601203997, 12285.69285767854, 12332.81500777489, 12334.383280835968, 12376.81434778479, 11061.612843550478, 11153.0, 11156.832647510273, 11156.944215278912, 11164.0, 624.5565648389648, 641.1920979565734, 786.1862971824163, 803.505843905998, 818.2267756969666, 821.195228675898, 823.4194892600732, 828.1966492502263, 828.3083625172987, 829.1418381974657, 663.4161937494997, 858.6093327535956, 864.4683519635411, 865.0, 865.5672163918041, 673.8315421144714, 834.4284165346756, 854.0989256334565, 854.5641722721394, 854.9273311768507, 629.0187307799802, 629.295189387884, 629.559308484063, 629.804760524239, 630.1461519640912, 12182.0, 12366.258024518467, 12427.813582796265, 12433.3783310835, 12436.316002619942, 11401.885981140165, 11872.347020913847, 11901.345426001566, 11918.940405297919, 12072.698182545419, 9232.723018309462, 9492.95253523735, 9565.713028609152, 9619.230461563058, 9722.659706910295, 3240.951385729216, 3274.885379011747, 3308.3714094322004, 3327.317899830529, 3404.3701915145775, 40508.79745601253, 40723.796381017906, 40926.38610420876, 41062.38406423906, 41134.38298425526, 9474.478903660365, 9829.262805289633, 9886.555105020292, 9894.851577226347, 9906.455144966953, 17109.0, 17130.571735706708, 17151.056691881815, 17158.48524544266, 17163.828361716223, 6517.837054073591, 6653.068570400148, 6769.966150169316, 6770.966145169243, 6796.558223715443, 3590.1024743814046, 3613.5663720353728, 3619.9638003620153, 3636.854390866921, 3680.9631903681156, 2696.0968075694864, 2731.617573539706, 2737.9589306160424, 2739.4794988952035, 2762.4337010912714, 535.5340853457517, 541.7453796715538, 549.228334190455, 555.089652969131, 555.2032832884823, 430.9827606895752, 547.4361407750024, 609.3936533149545, 610.7618028968706, 613.0, 6792.21889482706, 6866.141732283465, 6965.094537710065, 6999.545029573062, 7033.8944915826305, 496.16487330960024, 571.2630706388795, 581.8109114537792, 599.2838557923327, 614.1432701381636, 3491.511188433621, 3507.824608769551, 3526.7002304803864, 3599.1002249437643, 3616.87340943071, 48510.0, 53480.465195348326, 53646.73176634092, 53801.1929821053, 53919.73040134774, 41617.1676566467, 41996.160076798296, 42189.57810421918, 42225.57774422278, 42464.36303455451, 40374.39438408426, 42550.0, 42580.78709606432, 42593.0, 44098.338524922154, 7425.7029718810645, 8013.4791238569305, 8100.918990810253, 8198.672053118047, 8215.958920205361, 32881.17797054997, 33242.16894577558, 34009.65990340065, 34059.14852128716, 34357.312853743286, 40579.18841623092, 43450.565494345916, 43709.78145109381, 43721.34417983669, 44085.0, 9934.056264654846, 10109.747256318651, 10266.230032747722, 10271.640492582725, 10467.214958877963, 10681.0, 10983.066439352744, 11017.44912754343, 11157.832632510357, 11222.10223182127, 10137.594496220363, 10246.692599222035, 10631.096356809758, 10922.453877306261, 10998.34009959405, 10745.355278683304, 10807.405592692163, 11251.156163287622, 11279.266847654877, 11378.203525753117, 9669.564869581027, 9811.411315321104, 9880.110790028932, 10059.849102263619, 10474.738131546772, 8870.15733505316, 8973.685920992733, 9340.392874463138, 9467.384619999679, 9967.0, 7446.8510629786015, 7789.376849852111, 8161.918380816353, 8327.167283271625, 8421.789455263422]}, "summary": {"suite": 6152.91277802813, "subtests": {"jquery.html": {"filtered": 7539.468706847075, "value": 7539.468706847075}, "dojo.html": {"filtered": 4688.329578468857, "value": 4688.329578468857}, "mootools.html": {"filtered": 3909.671264811033, "value": 3909.671264811033}, "ext.html": {"filtered": 17017.60639420579, "value": 17017.60639420579}, "prototype.html": {"filtered": 3998.6043255023856, "value": 3998.6043255023856}, "yui.html": {"filtered": 5769.408864022804, "value": 5769.408864022804}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1446048608, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151028080504", "branch": "Ash-Non-PGO", "revision": "363f841f4135909e8cdeab151d97502000f8c904"}}, {"talos_counters": {}, "results": {"audio-dft": [159.0, 158.0, 157.0, 159.0, 157.0, 158.0, 159.0, 158.0, 161.0, 161.0], "ai-astar": [114.0, 116.0, 107.0, 112.0, 115.0, 113.0, 102.0, 113.0, 106.0, 114.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0], "audio-beat-detection": [131.0, 127.0, 137.0, 147.0, 132.0, 141.0, 137.0, 129.0, 147.0, 128.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 72.0, 70.0, 68.0], "stanford-crypto-pbkdf2": [137.0, 139.0, 136.0, 138.0, 143.0, 138.0, 138.0, 137.0, 137.0, 147.0], "json-parse-financial": [70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 78.0, 66.0, 66.0], "stanford-crypto-sha256-iterative": [70.0, 72.0, 72.0, 71.0, 70.0, 71.0, 70.0, 69.0, 70.0, 69.0], "audio-fft": [70.0, 70.0, 71.0, 81.0, 71.0, 73.0, 70.0, 71.0, 78.0, 71.0], "imaging-darkroom": [148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "stanford-crypto-ccm": [119.0, 119.0, 132.0, 117.0, 133.0, 119.0, 124.0, 122.0, 125.0, 123.0], "audio-oscillator": [94.0, 94.0, 141.0, 95.0, 94.0, 94.0, 128.0, 94.0, 93.0, 135.0], "stanford-crypto-aes": [81.0, 84.0, 82.0, 81.0, 82.0, 81.0, 84.0, 83.0, 85.0, 85.0], "imaging-desaturate": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0]}, "summary": {"suite": 1490.8, "subtests": {"audio-fft": {"filtered": 72.6, "value": 72.6}, "stanford-crypto-pbkdf2": {"filtered": 139.0, "value": 139.0}, "audio-beat-detection": {"filtered": 135.6, "value": 135.6}, "stanford-crypto-ccm": {"filtered": 123.3, "value": 123.3}, "imaging-darkroom": {"filtered": 147.5, "value": 147.5}, "json-parse-financial": {"filtered": 69.3, "value": 69.3}, "audio-oscillator": {"filtered": 106.2, "value": 106.2}, "ai-astar": {"filtered": 111.2, "value": 111.2}, "audio-dft": {"filtered": 158.7, "value": 158.7}, "stanford-crypto-sha256-iterative": {"filtered": 70.4, "value": 70.4}, "json-stringify-tinderbox": {"filtered": 69.0, "value": 69.0}, "imaging-gaussian-blur": {"filtered": 109.8, "value": 109.8}, "stanford-crypto-aes": {"filtered": 82.8, "value": 82.8}, "imaging-desaturate": {"filtered": 95.4, "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1446048608, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151028080504", "branch": "Ash-Non-PGO", "revision": "363f841f4135909e8cdeab151d97502000f8c904"}}, {"talos_counters": {}, "results": {"DeltaBlue": [185.90816136828406], "Encrypt": [279.72027972027973], "NavierStokes": [4822.115384615385], "Decrypt": [5025.125628140703], "Splay": [611.2469437652812], "Richards": [170.15484090522375], "RegExp": [27081.08108108108], "Earley": [782.4726134585289], "Boyer": [11720.93023255814], "RayTrace": [2032.520325203252]}, "summary": {"suite": 19830.767580147116, "subtests": {"DeltaBlue": {"filtered": 355.64872200000013, "value": 355.64872200000013}, "Encrypt": {"filtered": 951.5970750000004, "value": 951.5970750000004}, "NavierStokes": {"filtered": 307.7487537387835, "value": 307.7487537387835}, "Decrypt": {"filtered": 52.970019, "value": 52.970019}, "Splay": {"filtered": 133.31927600000003, "value": 133.31927600000003}, "RegExp": {"filtered": 33.63916666666665, "value": 33.63916666666665}, "Richards": {"filtered": 207.46985400000003, "value": 207.46985400000003}, "Earley": {"filtered": 851.7397139999999, "value": 851.7397139999999}, "Boyer": {"filtered": 56.86093055555553, "value": 56.86093055555553}, "RayTrace": {"filtered": 364.0745880000001, "value": 364.0745880000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1446048608, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151028080504", "branch": "Ash-Non-PGO", "revision": "363f841f4135909e8cdeab151d97502000f8c904"}}] 09:30:28 INFO - RETURN: dromaeo_css: 6152.91 09:30:28 INFO - RETURN: kraken: 1490.80 09:30:28 INFO - RETURN: v8_7: 19830.77 09:30:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,144,35]]", "result": "19830.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,144,35]]", "result": "1490.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,144,35]]", "result": "6152.91"}}} 09:30:28 INFO - Return code: 0 09:30:28 INFO - # TBPL SUCCESS # 09:30:28 INFO - Running post-action listener: _resource_record_post_action 09:30:28 INFO - Running post-run listener: _resource_record_post_run 09:30:29 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 8007680; Write bytes: 447197184; Read time: 1728; Write time: 388072 09:30:29 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 6561792; Read time: 0; Write time: 884 09:30:29 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 5742592; Write bytes: 434683904; Read time: 1460; Write time: 386756 09:30:29 INFO - Running post-run listener: _upload_blobber_files 09:30:29 INFO - Blob upload gear active. 09:30:29 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:30:29 INFO - Copying logs to upload dir... 09:30:29 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.019882 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-10-28 09:30:29.212865) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-28 09:30:29.216211) ========= 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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009764 build_url: 'https://queue.taskcluster.net/v1/task/7Ueeav-mSBqSPHgE8Ztnxw/artifacts/public/build/firefox-44.0a1.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-28 09:30:29.270525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:30:29.271151) ========= 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=801756c90a5e5cfe63934219000001c7-1446044290.694267-452287541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 09:30:29.326175) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-28 09:30:29.326817) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-28 09:30:33.467756) =========