builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1448387034.88 results: success (0) buildid: 20151124083121 builduid: 57ec50228a394e12a2ddb244727a7fda revision: d516d82f29a2636c5834c7f3c932025b8e85a8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.883393) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.883843) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.884141) ========= 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-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.915073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.915438) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.928718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.929162) ========= 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-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.978045) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.978355) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.978703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:54.978973) ========= 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-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 09:43:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-24 09:43:55 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.155486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.155796) ========= 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-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014339 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.207715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.208283) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d516d82f29a2636c5834c7f3c932025b8e85a8ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d516d82f29a2636c5834c7f3c932025b8e85a8ad --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-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 09:43:56,077 truncating revision to first 12 chars 2015-11-24 09:43:56,078 Setting DEBUG logging. 2015-11-24 09:43:56,078 attempt 1/10 2015-11-24 09:43:56,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d516d82f29a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 09:43:56,355 unpacking tar archive at: fx-team-d516d82f29a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.823897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.824458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.835029) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.835368) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:43:55.835777) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-24 09:43:55.836078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:43:56 INFO - MultiFileLogger online at 20151124 09:43:56 in /builds/slave/test 09:43:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:43:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:56 INFO - {'append_to_log': False, 09:43:56 INFO - 'base_work_dir': '/builds/slave/test', 09:43:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:43:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:56 INFO - 'branch': 'Fx-Team-Non-PGO', 09:43:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:56 INFO - 'config_files': ('talos/linux_config.py',), 09:43:56 INFO - 'default_actions': ('clobber', 09:43:56 INFO - 'read-buildbot-config', 09:43:56 INFO - 'download-and-extract', 09:43:56 INFO - 'populate-webroot', 09:43:56 INFO - 'create-virtualenv', 09:43:56 INFO - 'install', 09:43:56 INFO - 'run-tests'), 09:43:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:56 INFO - 'download_minidump_stackwalk': True, 09:43:56 INFO - 'download_symbols': 'ondemand', 09:43:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:56 INFO - 'installer_path': 'installer.exe', 09:43:56 INFO - 'log_level': 'info', 09:43:56 INFO - 'log_name': 'talos', 09:43:56 INFO - 'log_to_console': True, 09:43:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:43:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:43:56 INFO - 'opt_config_files': (), 09:43:56 INFO - 'pip_index': False, 09:43:56 INFO - 'sps_profile': False, 09:43:56 INFO - 'sps_profile_interval': 0, 09:43:56 INFO - 'suite': 'dromaeojs', 09:43:56 INFO - 'system_bits': '64', 09:43:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:56 INFO - 'title': 'talos-linux64-ix-006', 09:43:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:56 INFO - 'use_talos_json': True, 09:43:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:56 INFO - 'work_dir': 'build'} 09:43:56 INFO - ##### 09:43:56 INFO - ##### Running clobber step. 09:43:56 INFO - ##### 09:43:56 INFO - Running pre-action listener: _resource_record_pre_action 09:43:56 INFO - Running main action method: clobber 09:43:56 INFO - rmtree: /builds/slave/test/build 09:43:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:57 INFO - Running post-action listener: _resource_record_post_action 09:43:57 INFO - ##### 09:43:57 INFO - ##### Running read-buildbot-config step. 09:43:57 INFO - ##### 09:43:57 INFO - Running pre-action listener: _resource_record_pre_action 09:43:57 INFO - Running main action method: read_buildbot_config 09:43:57 INFO - Using buildbot properties: 09:43:57 INFO - { 09:43:57 INFO - "properties": { 09:43:57 INFO - "buildnumber": 1130, 09:43:57 INFO - "product": "firefox", 09:43:57 INFO - "script_repo_revision": "production", 09:43:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:43:57 INFO - "repository": "", 09:43:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:43:57 INFO - "buildid": "20151124083121", 09:43:57 INFO - "slavename": "talos-linux64-ix-006", 09:43:57 INFO - "pgo_build": "False", 09:43:57 INFO - "basedir": "/builds/slave/test", 09:43:57 INFO - "project": "", 09:43:57 INFO - "platform": "ubuntu64_hw", 09:43:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:43:57 INFO - "slavebuilddir": "test", 09:43:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:43:57 INFO - "branch": "fx-team", 09:43:57 INFO - "repo_path": "integration/fx-team", 09:43:57 INFO - "stage_platform": "linux64", 09:43:57 INFO - "builduid": "57ec50228a394e12a2ddb244727a7fda", 09:43:57 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:43:57 INFO - }, 09:43:57 INFO - "sourcestamp": { 09:43:57 INFO - "repository": "", 09:43:57 INFO - "hasPatch": false, 09:43:57 INFO - "project": "", 09:43:57 INFO - "branch": "fx-team-linux64-talos", 09:43:57 INFO - "changes": [ 09:43:57 INFO - { 09:43:57 INFO - "category": null, 09:43:57 INFO - "files": [ 09:43:57 INFO - { 09:43:57 INFO - "url": null, 09:43:57 INFO - "name": "https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:43:57 INFO - } 09:43:57 INFO - ], 09:43:57 INFO - "repository": "", 09:43:57 INFO - "rev": "d516d82f29a2636c5834c7f3c932025b8e85a8ad", 09:43:57 INFO - "who": "jwein@mozilla.com", 09:43:57 INFO - "when": 1448385257, 09:43:57 INFO - "number": 6700840, 09:43:57 INFO - "comments": "Bug 1213421 - Add a test that verifies the text of a notification is present. r=MattN", 09:43:57 INFO - "project": "", 09:43:57 INFO - "at": "Tue 24 Nov 2015 09:14:17", 09:43:57 INFO - "branch": "fx-team-linux64-talos", 09:43:57 INFO - "revlink": "", 09:43:57 INFO - "properties": [ 09:43:57 INFO - [ 09:43:57 INFO - "buildid", 09:43:57 INFO - "20151124083121", 09:43:57 INFO - "Change" 09:43:57 INFO - ], 09:43:57 INFO - [ 09:43:57 INFO - "builduid", 09:43:57 INFO - "57ec50228a394e12a2ddb244727a7fda", 09:43:57 INFO - "Change" 09:43:57 INFO - ], 09:43:57 INFO - [ 09:43:57 INFO - "pgo_build", 09:43:57 INFO - "False", 09:43:57 INFO - "Change" 09:43:57 INFO - ] 09:43:57 INFO - ], 09:43:57 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:43:57 INFO - } 09:43:57 INFO - ], 09:43:57 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:43:57 INFO - } 09:43:57 INFO - } 09:43:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:43:57 INFO - Running post-action listener: _resource_record_post_action 09:43:57 INFO - ##### 09:43:57 INFO - ##### Running download-and-extract step. 09:43:57 INFO - ##### 09:43:57 INFO - Running pre-action listener: _resource_record_pre_action 09:43:57 INFO - Running main action method: download_and_extract 09:43:57 INFO - mkdir: /builds/slave/test/build/tests 09:43:57 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:43:57 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json 09:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json 09:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:43:57 INFO - Downloaded 1302 bytes. 09:43:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:43:57 INFO - Using the following test package requirements: 09:43:57 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:43:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:57 INFO - u'jsshell-linux-x86_64.zip'], 09:43:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:43:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:43:57 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:43:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:43:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:43:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:43:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:43:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:43:57 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:43:57 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:43:59 INFO - Downloaded 21341306 bytes. 09:43:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:43:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:44:00 INFO - Return code: 0 09:44:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:44:00 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:44:00 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:44:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:44:01 INFO - Downloaded 21341306 bytes. 09:44:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:44:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:44:02 INFO - Return code: 0 09:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:02 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:44:04 INFO - Downloaded 11130997 bytes. 09:44:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:44:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:44:04 INFO - Return code: 0 09:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:04 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:44:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:44:05 INFO - Downloaded 56072224 bytes. 09:44:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:05 INFO - mkdir: /builds/slave/test/properties 09:44:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:44:05 INFO - Writing to file /builds/slave/test/properties/build_url 09:44:05 INFO - Contents: 09:44:05 INFO - build_url:https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:05 INFO - Running post-action listener: _resource_record_post_action 09:44:05 INFO - Running post-action listener: set_extra_try_arguments 09:44:05 INFO - ##### 09:44:05 INFO - ##### Running populate-webroot step. 09:44:05 INFO - ##### 09:44:05 INFO - Running pre-action listener: _resource_record_pre_action 09:44:05 INFO - Running main action method: populate_webroot 09:44:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:44:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:44:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:44:05 INFO - '../fennec_ids.txt'], 09:44:05 INFO - 'tests': ['tcheck2']}, 09:44:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:44:05 INFO - '--tppagecycles', 09:44:05 INFO - '7'], 09:44:05 INFO - 'tests': ['tsvgm']}}, 09:44:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:44:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:44:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:44:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:44:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'tests': ['damp', 'tps']}, 09:44:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['damp', 'tps']}, 09:44:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:44:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:44:05 INFO - 'other': {'tests': ['a11yr', 09:44:05 INFO - 'ts_paint', 09:44:05 INFO - 'tpaint', 09:44:05 INFO - 'sessionrestore', 09:44:05 INFO - 'sessionrestore_no_auto_restore']}, 09:44:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['a11yr', 09:44:05 INFO - 'ts_paint', 09:44:05 INFO - 'tpaint', 09:44:05 INFO - 'sessionrestore', 09:44:05 INFO - 'sessionrestore_no_auto_restore']}, 09:44:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['a11yr', 09:44:05 INFO - 'ts_paint', 09:44:05 INFO - 'tpaint', 09:44:05 INFO - 'sessionrestore', 09:44:05 INFO - 'sessionrestore_no_auto_restore']}, 09:44:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['a11yr', 09:44:05 INFO - 'ts_paint', 09:44:05 INFO - 'tpaint', 09:44:05 INFO - 'sessionrestore', 09:44:05 INFO - 'sessionrestore_no_auto_restore']}, 09:44:05 INFO - 'other_l64': {'tests': ['a11yr', 09:44:05 INFO - 'ts_paint', 09:44:05 INFO - 'tpaint', 09:44:05 INFO - 'sessionrestore', 09:44:05 INFO - 'sessionrestore_no_auto_restore']}, 09:44:05 INFO - 'other_nol64': {'tests': ['a11yr', 09:44:05 INFO - 'ts_paint', 09:44:05 INFO - 'tpaint', 09:44:05 INFO - 'sessionrestore', 09:44:05 INFO - 'sessionrestore_no_auto_restore']}, 09:44:05 INFO - 'svgr': {'tests': ['tsvgx', 09:44:05 INFO - 'tsvgr_opacity', 09:44:05 INFO - 'tart', 09:44:05 INFO - 'tscrollx', 09:44:05 INFO - 'cart']}, 09:44:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['tsvgx', 09:44:05 INFO - 'tsvgr_opacity', 09:44:05 INFO - 'tart', 09:44:05 INFO - 'tscrollx', 09:44:05 INFO - 'cart']}, 09:44:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'tests': ['tp5o']}, 09:44:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'talos_options': ['--e10s'], 09:44:05 INFO - 'tests': ['tp5o']}, 09:44:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'talos_options': ['--xperf_path', 09:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:05 INFO - 'tests': ['tp5n']}, 09:44:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:05 INFO - 'talos_options': ['--e10s', 09:44:05 INFO - '--xperf_path', 09:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:05 INFO - 'tests': ['tp5n']}}, 09:44:05 INFO - 'talos.zip': {'path': '', 09:44:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:44:05 INFO - Running post-action listener: _resource_record_post_action 09:44:05 INFO - ##### 09:44:05 INFO - ##### Running create-virtualenv step. 09:44:05 INFO - ##### 09:44:05 INFO - Running pre-action listener: _resource_record_pre_action 09:44:05 INFO - Running main action method: create_virtualenv 09:44:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:44:05 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:44:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:44:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:44:05 INFO - Using real prefix '/usr' 09:44:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:44:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:44:08 INFO - Installing pip.................done. 09:44:08 INFO - Return code: 0 09:44:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:44:08 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:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:08 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:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:08 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 0x7f40b245bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, '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-1448387035.100889-1927429162', '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:44:08 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:44:08 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:44:08 INFO - Using env: {'DISPLAY': ':0', 09:44:08 INFO - 'HOME': '/home/cltbld', 09:44:08 INFO - 'LANG': 'en_US.UTF-8', 09:44:08 INFO - 'LANGUAGE': 'en_US:en', 09:44:08 INFO - 'LOGNAME': 'cltbld', 09:44:08 INFO - 'MAIL': '/var/mail/cltbld', 09:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:08 INFO - 'MOZ_NO_REMOTE': '1', 09:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:08 INFO - 'NO_EM_RESTART': '1', 09:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:08 INFO - 'PWD': '/builds/slave/test', 09:44:08 INFO - 'SHELL': '/bin/bash', 09:44:08 INFO - 'SHLVL': '1', 09:44:08 INFO - 'TERM': 'linux', 09:44:08 INFO - 'TMOUT': '86400', 09:44:08 INFO - 'USER': 'cltbld', 09:44:08 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:08 INFO - '_': '/tools/buildbot/bin/python'} 09:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:08 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:44:08 INFO - Cleaning up... 09:44:08 INFO - Return code: 0 09:44:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:44:08 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:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:08 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:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:08 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 0x7f40b245bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, '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-1448387035.100889-1927429162', '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:44:08 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:44:08 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:44:08 INFO - Using env: {'DISPLAY': ':0', 09:44:08 INFO - 'HOME': '/home/cltbld', 09:44:08 INFO - 'LANG': 'en_US.UTF-8', 09:44:08 INFO - 'LANGUAGE': 'en_US:en', 09:44:08 INFO - 'LOGNAME': 'cltbld', 09:44:08 INFO - 'MAIL': '/var/mail/cltbld', 09:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:08 INFO - 'MOZ_NO_REMOTE': '1', 09:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:08 INFO - 'NO_EM_RESTART': '1', 09:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:08 INFO - 'PWD': '/builds/slave/test', 09:44:08 INFO - 'SHELL': '/bin/bash', 09:44:08 INFO - 'SHLVL': '1', 09:44:08 INFO - 'TERM': 'linux', 09:44:08 INFO - 'TMOUT': '86400', 09:44:08 INFO - 'USER': 'cltbld', 09:44:08 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:08 INFO - '_': '/tools/buildbot/bin/python'} 09:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:08 INFO - Downloading/unpacking psutil>=0.7.1 09:44:08 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:44:08 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:44:08 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:44:08 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:44:08 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:44:08 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:44:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:10 INFO - Installing collected packages: psutil 09:44:10 INFO - Running setup.py install for psutil 09:44:10 INFO - building 'psutil._psutil_linux' extension 09:44:10 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:44:10 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:44:10 INFO - building 'psutil._psutil_posix' extension 09:44:10 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:44:10 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:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:10 INFO - Successfully installed psutil 09:44:10 INFO - Cleaning up... 09:44:10 INFO - Return code: 0 09:44:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f40b245bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, '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-1448387035.100889-1927429162', '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:44:10 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:44:10 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:44:10 INFO - Using env: {'DISPLAY': ':0', 09:44:10 INFO - 'HOME': '/home/cltbld', 09:44:10 INFO - 'LANG': 'en_US.UTF-8', 09:44:10 INFO - 'LANGUAGE': 'en_US:en', 09:44:10 INFO - 'LOGNAME': 'cltbld', 09:44:10 INFO - 'MAIL': '/var/mail/cltbld', 09:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:10 INFO - 'MOZ_NO_REMOTE': '1', 09:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:10 INFO - 'NO_EM_RESTART': '1', 09:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:10 INFO - 'PWD': '/builds/slave/test', 09:44:10 INFO - 'SHELL': '/bin/bash', 09:44:10 INFO - 'SHLVL': '1', 09:44:10 INFO - 'TERM': 'linux', 09:44:10 INFO - 'TMOUT': '86400', 09:44:10 INFO - 'USER': 'cltbld', 09:44:10 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:10 INFO - '_': '/tools/buildbot/bin/python'} 09:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:44:12 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:44:12 INFO - Installing collected packages: mozsystemmonitor 09:44:12 INFO - Running setup.py install for mozsystemmonitor 09:44:12 INFO - Successfully installed mozsystemmonitor 09:44:12 INFO - Cleaning up... 09:44:12 INFO - Return code: 0 09:44:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:44:12 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:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:12 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:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:12 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 0x7f40b245bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, '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-1448387035.100889-1927429162', '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:44:12 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:44:12 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:44:12 INFO - Using env: {'DISPLAY': ':0', 09:44:12 INFO - 'HOME': '/home/cltbld', 09:44:12 INFO - 'LANG': 'en_US.UTF-8', 09:44:12 INFO - 'LANGUAGE': 'en_US:en', 09:44:12 INFO - 'LOGNAME': 'cltbld', 09:44:12 INFO - 'MAIL': '/var/mail/cltbld', 09:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:12 INFO - 'MOZ_NO_REMOTE': '1', 09:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:12 INFO - 'NO_EM_RESTART': '1', 09:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:12 INFO - 'PWD': '/builds/slave/test', 09:44:12 INFO - 'SHELL': '/bin/bash', 09:44:12 INFO - 'SHLVL': '1', 09:44:12 INFO - 'TERM': 'linux', 09:44:12 INFO - 'TMOUT': '86400', 09:44:12 INFO - 'USER': 'cltbld', 09:44:12 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:12 INFO - '_': '/tools/buildbot/bin/python'} 09:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:44:13 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:44:13 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:44:13 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:44:13 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:44:13 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:44:13 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:44:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:44:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:44:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:44:14 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:44:14 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:44:14 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:44:14 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:44:14 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:44:14 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:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:44:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:15 INFO - Downloading docopt-0.6.1.tar.gz 09:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:44:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:44:15 INFO - Running setup.py install for blobuploader 09:44:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:44:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:44:15 INFO - Running setup.py install for requests 09:44:16 INFO - Running setup.py install for docopt 09:44:16 INFO - Successfully installed blobuploader requests docopt 09:44:16 INFO - Cleaning up... 09:44:16 INFO - Return code: 0 09:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:16 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:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:16 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:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:16 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 0x7f40b245bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, '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-1448387035.100889-1927429162', '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:44:16 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:44:16 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:44:16 INFO - Using env: {'DISPLAY': ':0', 09:44:16 INFO - 'HOME': '/home/cltbld', 09:44:16 INFO - 'LANG': 'en_US.UTF-8', 09:44:16 INFO - 'LANGUAGE': 'en_US:en', 09:44:16 INFO - 'LOGNAME': 'cltbld', 09:44:16 INFO - 'MAIL': '/var/mail/cltbld', 09:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:16 INFO - 'MOZ_NO_REMOTE': '1', 09:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:16 INFO - 'NO_EM_RESTART': '1', 09:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:16 INFO - 'PWD': '/builds/slave/test', 09:44:16 INFO - 'SHELL': '/bin/bash', 09:44:16 INFO - 'SHLVL': '1', 09:44:16 INFO - 'TERM': 'linux', 09:44:16 INFO - 'TMOUT': '86400', 09:44:16 INFO - 'USER': 'cltbld', 09:44:16 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:16 INFO - '_': '/tools/buildbot/bin/python'} 09:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:16 INFO - Running setup.py (path:/tmp/pip-6puyCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:16 INFO - Running setup.py (path:/tmp/pip-khS8xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:16 INFO - Running setup.py (path:/tmp/pip-2UyD6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:16 INFO - Running setup.py (path:/tmp/pip-irZ0_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:16 INFO - Running setup.py (path:/tmp/pip-TWcPnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:16 INFO - Running setup.py (path:/tmp/pip-ja6JKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:16 INFO - Running setup.py (path:/tmp/pip-dKt0g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:16 INFO - Running setup.py (path:/tmp/pip-bSI94h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:16 INFO - Running setup.py (path:/tmp/pip-Hx5HuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:17 INFO - Running setup.py (path:/tmp/pip-HfDDCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:17 INFO - Running setup.py (path:/tmp/pip-662gio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:17 INFO - Running setup.py (path:/tmp/pip-ROw7Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:17 INFO - Running setup.py (path:/tmp/pip-bAMErB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:17 INFO - Running setup.py (path:/tmp/pip-0b9cmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:17 INFO - Running setup.py (path:/tmp/pip-fX9eI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:17 INFO - Running setup.py (path:/tmp/pip-_t8h6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:17 INFO - Running setup.py (path:/tmp/pip-130vKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:44:17 INFO - Running setup.py install for manifestparser 09:44:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:44:17 INFO - Running setup.py install for mozcrash 09:44:17 INFO - Running setup.py install for mozdebug 09:44:17 INFO - Running setup.py install for mozdevice 09:44:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozfile 09:44:18 INFO - Running setup.py install for mozhttpd 09:44:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozinfo 09:44:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozInstall 09:44:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozleak 09:44:18 INFO - Running setup.py install for mozlog 09:44:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for moznetwork 09:44:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozprocess 09:44:18 INFO - Running setup.py install for mozprofile 09:44:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozrunner 09:44:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Running setup.py install for mozscreenshot 09:44:19 INFO - Running setup.py install for moztest 09:44:19 INFO - Running setup.py install for mozversion 09:44:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:44:19 INFO - Cleaning up... 09:44:19 INFO - Return code: 0 09:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:19 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:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:19 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:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:19 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 0x7f40b245bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, '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-1448387035.100889-1927429162', '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:44:19 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:44:19 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:44:19 INFO - Using env: {'DISPLAY': ':0', 09:44:19 INFO - 'HOME': '/home/cltbld', 09:44:19 INFO - 'LANG': 'en_US.UTF-8', 09:44:19 INFO - 'LANGUAGE': 'en_US:en', 09:44:19 INFO - 'LOGNAME': 'cltbld', 09:44:19 INFO - 'MAIL': '/var/mail/cltbld', 09:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:19 INFO - 'MOZ_NO_REMOTE': '1', 09:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:19 INFO - 'NO_EM_RESTART': '1', 09:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:19 INFO - 'PWD': '/builds/slave/test', 09:44:19 INFO - 'SHELL': '/bin/bash', 09:44:19 INFO - 'SHLVL': '1', 09:44:19 INFO - 'TERM': 'linux', 09:44:19 INFO - 'TMOUT': '86400', 09:44:19 INFO - 'USER': 'cltbld', 09:44:19 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:19 INFO - '_': '/tools/buildbot/bin/python'} 09:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:19 INFO - Running setup.py (path:/tmp/pip-nUye6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:19 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:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:19 INFO - Running setup.py (path:/tmp/pip-JwjaDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:19 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:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:19 INFO - Running setup.py (path:/tmp/pip-vNsMeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:19 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:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:19 INFO - Running setup.py (path:/tmp/pip-qz8uYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:19 INFO - Running setup.py (path:/tmp/pip-nru8oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:19 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:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:19 INFO - Running setup.py (path:/tmp/pip-VgMwnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:20 INFO - Running setup.py (path:/tmp/pip-UQJMS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:20 INFO - Running setup.py (path:/tmp/pip-gX_n02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:20 INFO - Running setup.py (path:/tmp/pip-tuvXsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:20 INFO - Running setup.py (path:/tmp/pip-A2EpPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:20 INFO - Running setup.py (path:/tmp/pip-6yI7Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:20 INFO - Running setup.py (path:/tmp/pip-9xRF6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:20 INFO - Running setup.py (path:/tmp/pip-4aXeBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:20 INFO - Running setup.py (path:/tmp/pip-U_lgmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:20 INFO - Running setup.py (path:/tmp/pip-TS1X__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:20 INFO - Running setup.py (path:/tmp/pip-karzyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:20 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:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:20 INFO - Running setup.py (path:/tmp/pip-QVwXTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:20 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:44:20 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:44:20 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:44:20 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:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44:20 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:44:20 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:44:20 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:44:20 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:44:20 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:44:20 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:44:22 INFO - Downloading blessings-1.5.1.tar.gz 09:44:22 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:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:44:22 INFO - Installing collected packages: blessings 09:44:22 INFO - Running setup.py install for blessings 09:44:22 INFO - Successfully installed blessings 09:44:22 INFO - Cleaning up... 09:44:22 INFO - Return code: 0 09:44:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:22 INFO - Reading from file tmpfile_stdout 09:44:22 INFO - Current package versions: 09:44:22 INFO - argparse == 1.2.1 09:44:22 INFO - blessings == 1.5.1 09:44:22 INFO - blobuploader == 1.2.4 09:44:22 INFO - docopt == 0.6.1 09:44:22 INFO - manifestparser == 1.1 09:44:22 INFO - mozInstall == 1.12 09:44:22 INFO - mozcrash == 0.16 09:44:22 INFO - mozdebug == 0.1 09:44:22 INFO - mozdevice == 0.47 09:44:22 INFO - mozfile == 1.2 09:44:22 INFO - mozhttpd == 0.7 09:44:22 INFO - mozinfo == 0.9 09:44:22 INFO - mozleak == 0.1 09:44:22 INFO - mozlog == 3.1 09:44:22 INFO - moznetwork == 0.27 09:44:22 INFO - mozprocess == 0.22 09:44:22 INFO - mozprofile == 0.27 09:44:22 INFO - mozrunner == 6.11 09:44:22 INFO - mozscreenshot == 0.1 09:44:22 INFO - mozsystemmonitor == 0.0 09:44:22 INFO - moztest == 0.7 09:44:22 INFO - mozversion == 1.4 09:44:22 INFO - psutil == 3.1.1 09:44:22 INFO - requests == 1.2.3 09:44:22 INFO - wsgiref == 0.1.2 09:44:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44: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:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:22 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 0x7f40b245bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe1f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, '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-1448387035.100889-1927429162', '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:44:22 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:44:23 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:44:23 INFO - Using env: {'DISPLAY': ':0', 09:44:23 INFO - 'HOME': '/home/cltbld', 09:44:23 INFO - 'LANG': 'en_US.UTF-8', 09:44:23 INFO - 'LANGUAGE': 'en_US:en', 09:44:23 INFO - 'LOGNAME': 'cltbld', 09:44:23 INFO - 'MAIL': '/var/mail/cltbld', 09:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:23 INFO - 'MOZ_NO_REMOTE': '1', 09:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:23 INFO - 'NO_EM_RESTART': '1', 09:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:23 INFO - 'PWD': '/builds/slave/test', 09:44:23 INFO - 'SHELL': '/bin/bash', 09:44:23 INFO - 'SHLVL': '1', 09:44:23 INFO - 'TERM': 'linux', 09:44:23 INFO - 'TMOUT': '86400', 09:44:23 INFO - 'USER': 'cltbld', 09:44:23 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:23 INFO - '_': '/tools/buildbot/bin/python'} 09:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 INFO - Cleaning up... 09:44:23 INFO - Return code: 0 09:44:23 INFO - Running post-action listener: _resource_record_post_action 09:44:23 INFO - Running post-action listener: _start_resource_monitoring 09:44:23 INFO - Starting resource monitoring. 09:44:23 INFO - ##### 09:44:23 INFO - ##### Running install step. 09:44:23 INFO - ##### 09:44:23 INFO - Running pre-action listener: _resource_record_pre_action 09:44:23 INFO - Running main action method: install 09:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:23 INFO - Reading from file tmpfile_stdout 09:44:23 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:23 INFO - Reading from file tmpfile_stdout 09:44:23 INFO - Output received: 09:44:23 INFO - Usage: mozinstall [options] installer 09:44:23 INFO - Options: 09:44:23 INFO - -h, --help show this help message and exit 09:44:23 INFO - -d DEST, --destination=DEST 09:44:23 INFO - Directory to install application into. [default: 09:44:23 INFO - "/builds/slave/test"] 09:44:23 INFO - --app=APP Application being installed. [default: firefox] 09:44:23 INFO - mkdir: /builds/slave/test/build/application 09:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:44:37 INFO - Reading from file tmpfile_stdout 09:44:37 INFO - Output received: 09:44:37 INFO - /builds/slave/test/build/application/firefox/firefox 09:44:37 INFO - Running post-action listener: _resource_record_post_action 09:44:37 INFO - ##### 09:44:37 INFO - ##### Running run-tests step. 09:44:37 INFO - ##### 09:44:37 INFO - Running pre-action listener: _resource_record_pre_action 09:44:37 INFO - Running main action method: run_tests 09:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:44:37 INFO - Python 2.7.3 09:44:37 INFO - Return code: 0 09:44:37 INFO - grabbing minidump binary from tooltool 09:44:37 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:44:37 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 0xe65b70>, '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 0xeb6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb7250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:44:37 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:44:37 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:44:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:44:37 INFO - Return code: 0 09:44:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:44:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:44:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:44:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:44:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] in /builds/slave/test/build 09:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost 09:44:37 INFO - Using env: {'DISPLAY': ':0', 09:44:37 INFO - 'HOME': '/home/cltbld', 09:44:37 INFO - 'LANG': 'en_US.UTF-8', 09:44:37 INFO - 'LANGUAGE': 'en_US:en', 09:44:37 INFO - 'LOGNAME': 'cltbld', 09:44:37 INFO - 'MAIL': '/var/mail/cltbld', 09:44:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:44:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:37 INFO - 'MOZ_NO_REMOTE': '1', 09:44:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:37 INFO - 'NO_EM_RESTART': '1', 09:44:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:37 INFO - 'PWD': '/builds/slave/test', 09:44:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:44:37 INFO - 'SHELL': '/bin/bash', 09:44:37 INFO - 'SHLVL': '1', 09:44:37 INFO - 'TERM': 'linux', 09:44:37 INFO - 'TMOUT': '86400', 09:44:37 INFO - 'USER': 'cltbld', 09:44:37 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1448387035.100889-1927429162', 09:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:37 INFO - '_': '/tools/buildbot/bin/python'} 09:44:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] with output_timeout 3600 09:44:37 INFO - mozversion INFO | application_buildid: 20151124083121 09:44:37 INFO - mozversion INFO | application_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 09:44:37 INFO - mozversion INFO | application_display_name: Nightly 09:44:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:44:37 INFO - mozversion INFO | application_name: Firefox 09:44:37 INFO - mozversion INFO | application_remotingname: firefox 09:44:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:44:37 INFO - mozversion INFO | application_vendor: Mozilla 09:44:37 INFO - mozversion INFO | application_version: 45.0a1 09:44:37 INFO - mozversion INFO | platform_buildid: 20151124083121 09:44:37 INFO - mozversion INFO | platform_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 09:44:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:44:37 INFO - mozversion INFO | platform_version: 45.0a1 09:44:37 INFO - 2015-11-24 09:44:37,922 DEBUG : using testdate: 1448387077 09:44:37 INFO - 2015-11-24 09:44:37,922 DEBUG : actual date: 1448387077 09:44:37 INFO - 2015-11-24 09:44:37,976 INFO : starting webserver on 'localhost:46430' 09:44:37 INFO - 2015-11-24 09:44:37,977 INFO : Starting test suite talos-linux64-ix-006 09:44:37 INFO - 2015-11-24 09:44:37,977 INFO : Starting test dromaeo_css 09:44:37 INFO - 2015-11-24 09:44:37,977 DEBUG : operating with platform_type : linux_ 09:44:37 INFO - 2015-11-24 09:44:37,978 INFO : Initialising browser for dromaeo_css test... 09:44:37 INFO - 2015-11-24 09:44:37,989 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc2Q3CQ/profile http://localhost:46430/getInfo.html 09:44:43 INFO - 2015-11-24 09:44:43,602 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:44:43 INFO - 2015-11-24 09:44:43,603 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:44:43 INFO - 2015-11-24 09:44:43,603 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:44:43 INFO - 2015-11-24 09:44:43,603 DEBUG : BROWSER_OUTPUT: __metrics 09:44:43 INFO - 2015-11-24 09:44:43,692 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:44:44 INFO - 2015-11-24 09:44:44,910 INFO : Browser initialized. 09:44:44 INFO - 2015-11-24 09:44:44,911 INFO : Running cycle 1/1 for dromaeo_css test... 09:44:44 INFO - 2015-11-24 09:44:44,911 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc2Q3CQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:44:56 INFO - 2015-11-24 09:44:56,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 140161024 09:44:56 INFO - 2015-11-24 09:44:56,893 DEBUG : BROWSER_OUTPUT: 09:45:48 INFO - 2015-11-24 09:45:48,107 DEBUG : BROWSER_OUTPUT: 1448387148101 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:47:59 INFO - 2015-11-24 09:47:59,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46430/tests/dromaeo/cssquery-ext.html) 09:48:01 INFO - 2015-11-24 09:48:01,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 304107520 09:48:01 INFO - 2015-11-24 09:48:01,336 DEBUG : BROWSER_OUTPUT: 09:51:04 INFO - 2015-11-24 09:51:04,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/dromaeo/cssquery-ext.html (next: http://localhost:46430/tests/dromaeo/cssquery-jquery.html) 09:51:04 INFO - 2015-11-24 09:51:04,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 224174080 09:51:04 INFO - 2015-11-24 09:51:04,687 DEBUG : BROWSER_OUTPUT: 09:54:06 INFO - 2015-11-24 09:54:06,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46430/tests/dromaeo/cssquery-mootools.html) 09:54:07 INFO - 2015-11-24 09:54:07,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 215908352 09:54:07 INFO - 2015-11-24 09:54:07,346 DEBUG : BROWSER_OUTPUT: 09:57:09 INFO - 2015-11-24 09:57:09,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46430/tests/dromaeo/cssquery-prototype.html) 09:57:09 INFO - 2015-11-24 09:57:09,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 201232384 09:57:09 INFO - 2015-11-24 09:57:09,864 DEBUG : BROWSER_OUTPUT: 10:00:12 INFO - 2015-11-24 10:00:12,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46430/tests/dromaeo/cssquery-yui.html) 10:00:13 INFO - 2015-11-24 10:00:13,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 207360000 10:00:13 INFO - 2015-11-24 10:00:13,138 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/dromaeo/cssquery-yui.html (next: http://localhost:46430/tests/dromaeo/cssquery-dojo.html) 10:03:15 INFO - 2015-11-24 10:03:15,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 251412480 10:03:15 INFO - 2015-11-24 10:03:15,828 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,830 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:15 INFO - 2015-11-24 10:03:15,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:15 INFO - 2015-11-24 10:03:15,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:15 INFO - 2015-11-24 10:03:15,830 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:15 INFO - 2015-11-24 10:03:15,831 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2593.1701855406272;2690.3543149644092;2700.1899430170943;2706.0934586913395;2716.9456610867787;4529.2753159494405;4651.093036857814;4659.487456379799;4680.321353403754;4689.9296510552285;4568.840090596821;4570.794314255858;4655.231886738692;4663.7668116594205;4686.648501362394;4283.464566929134;4321.913561728771;4326.913461730764;4403.845865394712;4439.800208990587;4349.282368409209;4408.4709834819705;4432.11357728454;4434.445694288214;4458.375827384169;4121.29937910556;4174.603412675791;4217.641500472463;4247.469066366704;4281.293586558214;4247.638950689196;4248.851290204859;4259.190753756808;4295.463067116611;4303.419038429804;4125.773082480462;4271.9786401067795;4288.871333859989;4297.290946993742;4345.239583072949;4502.0545685406105;4515.909681806378;4518.593326600621;4602.424696912886;4630.143423466669;4976.651634385595;5023.799048038074;5025.798968041274;5025.974870125662;5067.037262920034;4830.3479030331155;5035.471275516092;5044.066847633199;5045.066662667418;5055.595552355802;4611.400517932714;4613.0543238636;4614.9077018459775;4696.7651617419;4708.246680531099;5120.257562653469;5127;5134.48655134491;5136.794528218829;5142.04872098663;4921.532454416824;4922.778474968635;4926.236433352764;4928.0390323886495;4969.006198760262;4806.014766972762;4856.757162141878;4908.288298196741;4910.263460480956;4919.0407870464915;4880.072786170616;4902.068606964665;4902.3872015998;4909.7790599423115;4911.267843148942;4887.266651416745;4895.534924182268;4898.730569818694;4905.386826646669;4928.950710492921;3929;4058.330375488011;4059.04612416082;4119.8352065917625;4160.063985603215;3517.2262102337445;3578.624244454347;3583.354996100727;3608.0619039050034;3611.8735844245325;4251.4685664291965;4304.289792184317;4307.310830267143;4340.739555626673;4343.761093139908;4817.759112044384;4918.671958571165;4920.138975679241;4971.6022718183185;4987.127252730757;4273.87178384649;4323.3947247385395;4340.045190058182;4352.586504282088;4375.628071613948;4459.7547134907245;4461.486929003141;4461.7992190351515;4485.663575231805;4509.706869053567;4548.56788605082;4659.883502912454;4779.330893674888;4793.065352256276;4796.712197268175;4857.0528746894015;4913.213885778258;4929.186684197068;4972.154733695353;4980.178270585313;4733.952660473351;4781.282807578891;4782.6173906088125;4786.497417771223;4819.614430845594;4681;4791.832285869978;4958.727270000185;4971.627127965345;5014.899702006012;4880.902381952412;4923.483034281349;4943.802247910187;4950.059488697136;4950.628702847373;4854.83008094715;4881.90236195267;4883.072216278895;4883.6093112551625;4883.926741098958;4716.056788642217;4786.186348320724;4789.832355867528;4826.396700412449;4827.179379505422;4732.100900828831;4774.809007639656;4784.569388755029;4801.639877009168;4840.806367745392;4580.862574122782;4890.9021819562695;4902.7058376497525;4904.2643603459765;4952.380952380952;4618.584327410549;4664.416947881515;4688.390509233778;4699.412573428322;4726.1492931272705 10:03:15 INFO - 2015-11-24 10:03:15,835 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.940681228471;569.1235497334105;571.8170185540629;572.6420986883198;579.4408395897958;28128.578071328946;28787.136385908405;37086.25827483449;38063.809680951555;38140.427893581546;40591.18817623646;41131.38302925451;41206.17587648253;41282;41296.17407651845;7071.7878463646175;7730.304272615477;7893.368530517573;7895.565743884084;7896.565688887109;7147.642617869085;9765.658201962933;10023.849642255373;10027.34822236556;10034.69895903124;9919.652812151577;10047.145992590638;10049.748756281078;10053.145482633949;10064.647737329195;7196.928030719678;7383.2247614000835;9822.361546499455;9949.303548751626;9984.650537231162;9817.263705222136;9961.203103751755;9982.301238913278;9986;10011.349262297927;37085.258294834224;37392.25215495675;37609.81195094007;37624;37635;2609.123973192302;2709.6612923384578;2718.4698983698186;2728.5497892847657;2824.6892841787385;28355.291117722016;28523.286917827012;28910.85544572264;29228.41543169146;29438.70561294381;3313.6686331366673;3330.884153808477;3354.8490317935507;3395.6604339565847;3405.7275417966503;217633;218133;219785;220104.9999999984;220430;43206.56793432088;54230.45769542254;54529;54642;54680;47108;61678;63084.36915630785;63085.36914630887;63179.68410158012;14305.57083287503;14585.343659535347;14597.562073137822;14604.196769177584;14617.561473155822;10413.219008574388;10441.112505436971;10462.895371046192;10466.947665261625;10475.84286235707;17965.7305140423;18111.909440452713;18212.089395530435;18231.627148977215;18267.63464730698;6933.042874344867;7209.170945341353;7256.310650488195;7276.708931642781;7359.337659610554;717.865097041037;831.094107422912;859.1966511311819;893.3835653399134;1018.23123541727;23119.306420807403;23541.529169416517;23606.527869442514;23607.881960590086;23737.525249494913;935.9438433694;977.2914636888199;984.3208186351395;1002.734275417015;1010.8584798128268;12355.622120501266;12523.499060037679;12537.122401431812;12953.287569183785;12969.35153242353;258934;261192;263128;263531;263573;44636.10727785491;44746;44809.32786008212;44856.775716121214;44915.32627010597;1068.7221322456062;1082.9350238985687;1091.4324551233315;1201.4413297816557;1315.8355205599491;23426.18008369699;25511;26583.202503924913;26764.330891727863;26809.865950670122;36269.45595816012;36915.44626830546;37177.814110930354;37216.44175337318;37229.255414891006;165923;237020;241754.74735757956;242119;242353;25901.611475828253;26519.204423867315;26551.734482654927;26552.468950621267;26624.20127396181;38101.809490952364;38118.23763524659;38612.80693596514;39093.80453097716;39252.214955701296;29568.408631827675;30616.693833062276;31780.205494862814;34584.30831383308;35435.291294173454;32711.345773084882;32829.17927051843;32924.59954688229;33085.83457082699;33185.50221746627;32631.673683262863;33011;33223.501647474826;33329.83335083309;33528.994130176136;28521.28696782514;29236.853815730785;29688;30169;30207.09378718642;21764.30280941833;23576.29271121869;23577.52844943126;23804.404889877893;23810 10:03:15 INFO - 2015-11-24 10:03:15,835 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.71381968416995;334.8911603728788;335.617396168368;337.7703161849943;337.9712724418424;12314.81527777084;12688.111832171751;15020.549383518499;15403.84596154038;15439.614009649751;9878;9983.800323993533;10187.54156062977;10253.538590763415;10263.281570290083;4482.282834746433;4621.5378462153685;4625.213713668684;4629.7222166669935;4633.096546173498;3357.9496307555405;3455.0671318743925;5059.494050594948;5187.27378167055;5219.71291578963;5128.128218202895;5156.716380599066;5176.327077479922;5189.065968125736;5205.37535495741;5201.0898092833795;5618.550515958734;5663.915041274384;5668.064769313059;5668.546516278729;5016.44819069902;5016.573591244712;5029.547340739315;5032.094223039851;5039.521245481674;18222.544436389064;18277.360292389836;18867.433976980712;18871.62256754871;19039.238430462763;1740.9651806963916;1778.4397914656843;1800.7028840241344;1818.7180986946912;1844.769403824522;10932.344059356465;12220.572279970158;12491;12726.490940362375;12791.680207994781;1597.0736972556006;1676.7484877268507;1691.2220378625848;1709.6495218480181;1720.4408567215705;54749.45250547483;56280.99999999959;57708.71145644287;57834;58600.706996465175;9376.156145946898;9798.608055677692;9818.558164882455;9860;9895.257855660855;12531.812022819666;12534.874651253553;12598.937005314914;12615.243085414904;12662.936685316514;6707.3628005339415;7007;7163.31948464895;7216.134063912364;7292.854142917218;6853.588784672936;6929.896051559231;6975.372216500539;7030.9296907030275;7031.92968070323;4185.686073544496;4263.488381394252;4267.829286828554;4285.935710964338;4297.183535128315;1617.3449752850115;1639.45897853708;1656.3209084275388;1714.6742118997352;1766.222861940742;397.72556935714266;403.6851256020309;766.8274638206359;808.3048578222724;810.7892744730814;9347.485888276211;9826.508674566243;13533.45866165362;14871.776923346159;15853.841461585236;859.9097094804955;871.2072014466931;884.5090974509209;924.7087167542203;931.2782593489964;6382.936170638327;8751.781205469913;9001.18989290967;9122.954385228031;9141.725748227564;320440;323004;439611;443174;446195;54838.177427338625;55878.72060639671;56061.439385606434;68370.29074273183;69802;1040.4485622620023;1068.7435015596202;1089.553283153903;1090.0897750378365;1093.928894621863;9256.72229833106;9385.15533601979;9396.624135034795;9429.15137637616;13506.932465338003;28712;29271.41457170802;29693;29896.402071958873;30455.847720761256;43127.784361078;43261.7836910826;43266.35100473432;44035;46101.79625800317;14171.291435427982;14266.572002839932;14277.785833212718;14408.495702650356;14725.631859203606;12848.807267890803;17333.393331233347;17577;18136.546586335448;18180.636387272443;13639.522616708367;13901.652458688613;13987;13989.342025015214;14414.567562973127;13276.867231327564;13665.453381865012;13810.516631917835;14136.363863625957;14210.502632407815;9003.684871029482;9169.449833010041;9570.186534144676;9571;14064.367103480572;12954.222746635232;13057.934710326388;13163.736725265633;13292.534761283308;13546.390412431661;13055.673608159872;13315.600531983668;13317.800232996318;14527.346269418113;14541.345639446039 10:03:15 INFO - 2015-11-24 10:03:15,837 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1097.4074000039977;1127.441916251455;1138.806402911505;1306.353355089231;1461.6345913521627;5841.649501029936;6526.445252153567;6632.60204387737;6642.900356494656;6648.734050637969;6680.565763225387;6786.389224969752;6830.419414349773;6847.075644787952;6855.383015528601;2011.3664195778356;2018.818306352428;2031.4007367826528;2032.2582257475988;2032.5121970726993;2029.2998915374171;2041.7345745053121;2048.2216757632154;2048.385484354695;2068.0280268273964;1903.1530968718857;1917.5397904502888;1924.9615007699838;1926.0754837677923;1927.44104209779;2030.878147311166;2038.755349358079;2039.296442727264;2040.6938959156098;2041.7345745053049;1987.9801201987939;1991.7211590377358;1991.8605697601174;1993.8504612154147;2011.5071807407278;5649.887002259973;5836.5622578306375;6646.767363142267;6692.799216023527;6733.192016957947;3806.8286927088348;3902.804859757001;3905.668018218455;3909.4526766252748;3911.6675082618012;2696.514627367073;2701.1491380215366;2741.232454912628;2746.491898998692;2748.628935093757;895.552223888056;900.5407242306405;904.8371293167228;905.4522014181457;907.3240435875249;8746.737597872074;8795.648174073029;8805.339599529996;8806.075362086953;8825.470471771714;3757;3773.415120656303;3777.981110094432;3825.081980324702;3834.1948190880225;7788;7788.4548081634875;7792.961035194788;7817.140114587391;7826.373890088779;4079.1229885574744;4082.2651922653613;4082.4488694026522;4088.4276201331836;4091.0386059276047;3724.255148970217;3724.962750372516;3727.7576957497677;3728.254349130185;3737.009692431508;3156.4002839460886;3170.445172094874;3195.0414875537713;3205.3108581655056;3208.262099717078;1022.897710228986;1037.9896201038043;1046.0951277145214;1047.314009323894;1048.8951104889602;1112.844201811747;1119.7872404243167;1138.174823253135;1145.7593905279984;1150.327058670687;6384.616922984543;6388.329225431356;6434.227892652912;6448.613083215022;6451.709673064724;418.49780263683704;420.2372693561177;420.50590556097075;422.20203814790074;456.26769035697225;4708.764561771898;4950.2079667253065;5009.423916249678;5019.7239151847;5020.648554601216;6932.168139823153;7722.691092356243;7882.605869706492;7911.604419778988;7993.640286187136;7804.414668899855;7820.296173344426;7868.567228802356;7868.606569671493;7877.724279650185;6155.169052177898;6325.841853953596;6416.486681065504;6423.678816059271;6429.517786166056;5969.343372229138;6005.429484198994;6012.1582978382185;6012.428819262163;6013.9097913532205;6930.410915072275;7232.891506627299;7243.348098671145;7245.38414234796;7258.129024517092;7299.087614048244;7425.665845037094;7440.888386674313;7541.773746787605;7542.962285188759;5833.883322333614;5848.736806843787;5899.233099697012;5903.970480147572;5910.113482977587;6465.612063276219;6605.075289459575;6625.536212465081;6626.072349871119;6631.734730610721;6139.4781443577795;6189.876202476015;6237.251529816451;6291.465225455888;6305.621662700252;6012.729427175875;6065.484433823174;6083.057126145454;6099.75600975956;6184.81445556634;5944.375840536682;6184.443400093834;6184.876302474016;6196.81409557714;6223.284322302993;5679.602427830012;5709.229254050816;5713.428657134254;5714.314282286152;5721.542276617777;5683.147527870852;5801.680907549957;5811.535077193899;5816.651000939957;5837.09525023622 10:03:15 INFO - 2015-11-24 10:03:15,838 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.6351042259711;310.07133634763886;311.91422358851315;315.14281155257703;320.2362365757668;5301.814436494718;5310.654807437519;5341.278927344817;5376.704281264529;5399.892002159954;5069.822556210534;5149;5213.530782229599;5219.42586315505;5294.993951149279;4153.792310384476;4164.063085805685;4183.226103170923;4199.706020578561;4205.369194620816;4169.833206671729;4198.286291330481;4200.411942328076;4201.831926722927;4201.873943781691;3948.7433316834313;3987.3221552336026;4040.9089545822612;4062.943634654996;4082.326416141333;4056.9451942495016;4069.877903662895;4071.9592804071876;4074.246264441088;4077.4495443115097;3563.9109022274392;3565.7860528368383;3572.3034008368377;3572.7141828653907;3574.7140228781896;5118.744062796845;5141.383034035902;5148.2535032420465;5152.871178220537;5153.56194723449;4623.214053610861;4681.953180468186;4687.789049492781;4761.857144285642;4765.09463201994;5607.971960140214;5611.551075913917;5614.63504872182;5615.550755939515;5619.129034999541;3946.309395855714;3947.98026009871;3949;3952.3281042222893;3952.6837852971694;5856.267966504187;5926.348101708809;5928.377520360344;5936.940630593682;5942.910856337158;3977.7414468059483;4059.7767122807936;4064.4716186895516;4073.796310184538;4075.409065685459;4130.215259100762;4135.731177473514;4136.524299705572;4138.627523522898;4144.33690609501;4706.764661766898;4707.176244157327;4710.576048155683;4717.9292310615365;4722.645801564897;5615.382307946123;5620.437956204347;5621.915671264935;5622.044252477089;5629.071203251499;1429.0425414971994;1433.125793266107;1465.1209274435253;1466.596685911383;1471.8528147185195;968.7820240445984;984.8719666443317;988.0712130597216;989.0702739424918;990.4008075114596;4970.602351811846;4978.228374601942;4981.850544483671;4986.850394488171;4988.575971042429;5851.063829787214;5852.297724273115;5859;5865.853353666193;5866.530677545786;4797.088553174885;4869.63477739171;4939.654224204343;4955.0337684151245;4961.355023846877;3146.528020796899;3174.0477856643374;3184.617845858512;3188.1710755203812;3191.457452233126;5565.332160140728;5568.053430916754;5574.60977731563;5574.665520068809;5581.609287349927;5902.852428689317;6036.305824830113;6046.758129674852;6047.183630209954;6048.939510604838;5512.614117011771;5524.972375138179;5557;5559.499645031967;5567.777288908398;5832.591718579828;5860.706964651665;5866.2960444746905;5884.382139875252;5886.293644762656;5719.113537401709;5726.8568285791525;5728.914066289092;5733.455321744427;5734.369219385948;5402.540784033244;5543.944560554504;5553.611247212656;5564.332280126248;5572.554195664256;4092.0997380576227;4092.856750013735;4096.16028714107;4097.1396006838895;4098.672106231554;5871.530277577869;5871.706414679335;5876.970615146897;5878.94121058801;5880.794172204123;5482.451754824486;5650.943490565206;5657.981563318642;5661.320641523043;5664.0654292043;5658.377578466448;5661.320641523043;5663.122216056518;5663.716814159358;5669.943300567106;5543.279373681396;5552.7778888843995;5553.611247212656;5558.360788509373;5561.610687251854;5689.231953686365;5711.914321285101;5713.685747283939;5716.628419152742;5717.371089180104;5417.43116972728;5557.972210138923;5570.888582228414;5578.051731205624;5578.470045345685 10:03:15 INFO - 2015-11-24 10:03:15,842 DEBUG : BROWSER_OUTPUT: |5;yui.html;703.7360989628887;736.4844608773858;752.2853289375095;752.3529764402616;781.2460975158971;10305.38167709938;10778.029977302042;10793;10798.946005269963;10806.891931080687;11158.776824463506;11258.324500529974;11260.21178517504;11293.435328233576;11304.717382065452;593.8307582339035;601.8585632376388;733.2996987876566;739.4897520710706;760.9315161635452;755.2636179724752;757.1519897714568;762.8207371267748;763.2710761223046;763.2748888555866;792.2117493094379;798.4769975665948;799.9000124984377;800.5156880087551;801.0387534958045;628.8742251549686;636.1221514310246;783.0407750505642;796.024869534821;797.4577287444536;588.7350692188533;592.6681058607151;593.2288025566789;593.4629160609655;593.5815250248608;9935.254855885838;10018.3488073275;10084.69745907624;10089.697309080739;10120.544575494047;11422.771544569063;12038.759224815454;12184.268943863397;12325.753484930341;12483.93758031204;9150.313726470542;9184.632614695403;9229.769255768593;9267.25861931044;9388.718338449857;3186.3467989062187;3287.4575695010294;3298.8515516801563;3307.6692330766973;3316.3201543683485;40340.59659403398;40495.392569111485;40534.39198412026;40573.39139912904;40634.390484142765;8935.508547029845;8944.97132829733;9016.819663606822;9031.096890310917;9177.128172823572;16722.58193545171;16733.581660458585;16737.16314184286;16741.1629418531;16748.581285467717;6157.314804192034;6424.486041116699;6438.195225596801;6466.612003279818;6551.21385433751;3252.3983063133396;3329.8335083246225;3426.777259478126;3430.7598468107494;3470.8958731238104;2654.1639383594106;2689.623452716621;2690.192942117357;2752.1330780804383;2812.451571943492;491.8622785620032;497.82327273818;503.72295237619164;504.14798989707276;507.5305342558119;455.50122615735717;456.80129143822546;494.7699319816303;519.5295426550678;555.5583311267552;7010.228874823765;7322.1579518355;7323.194448610649;7729.8454030919065;7866.685332586747;396.6786902608896;442.710024933669;527.8466550586979;531.8404478656388;576.4005434348231;3299.5545601343993;3300.075978725961;3358.3619112368574;3418.4017796885446;3449.275652113034;48265.58672066383;48538.5146148541;50571;51204.207852724976;51720.22419663708;39402;39446.605533944865;39477.40783888244;39879.20241595152;40009.39985900214;39490.60509394927;39917.40123898144;42035;42266;42394.1521169581;7321.78034658961;7366.337029667356;7766.262205090507;7790.3304058536305;7822.4524283299625;31818.36363272768;32079.839600801846;32167.356652866343;32332.83833580817;32701.509477358333;36994.630053700195;37170;37353.81323093367;38743.2251354977;39510.80244598759;9093.22707569864;9181.495017774087;9421.306816762886;9497.477638729937;9583.568739406604;9892.950535247277;10052.447115408722;10058.29591928558;10088.638033865627;10094.091531762177;9930;9989.950050249703;10075.244356673133;10273.84589231177;10292.125169360388;10295.794084118126;10392.22058345612;10402.427866467417;10408.583656653953;10414;9656;10091.192704583762;10161.745956351151;10233.9488302558;10255.230857685852;8443.66225350979;8557.358198135289;8792.956035219782;8806.119388061143;8973.237274831712;8232.876506852523;8356;8645.697400590949;8899.555022248733;9008.189262966365 10:03:15 INFO - 2015-11-24 10:03:15,842 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:15 INFO - 2015-11-24 10:03:15,842 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:03:15 INFO - 2015-11-24 10:03:15,842 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1448 10:03:15 INFO - 2015-11-24 10:03:15,842 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: __startTimestamp1448388195828__endTimestamp 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4586.47 Median:4708.25 stddev:475.27 (10.1%) stddev-sans-first:450.27 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: Values: 2593.2 2690.4 2700.2 2706.1 2716.9 4529.3 4651.1 4659.5 4680.3 4689.9 4568.8 4570.8 4655.2 4663.8 4686.6 4283.5 4321.9 4326.9 4403.8 4439.8 4349.3 4408.5 4432.1 4434.4 4458.4 4121.3 4174.6 4217.6 4247.5 4281.3 4247.6 4248.9 4259.2 4295.5 4303.4 4125.8 4272.0 4288.9 4297.3 4345.2 4502.1 4515.9 4518.6 4602.4 4630.1 4976.7 5023.8 5025.8 5026.0 5067.0 4830.3 5035.5 5044.1 5045.1 5055.6 4611.4 4613.1 4614.9 4696.8 4708.2 5120.3 5127.0 5134.5 5136.8 5142.0 4921.5 4922.8 4926.2 4928.0 4969.0 4806.0 4856.8 4908.3 4910.3 4919.0 4880.1 4902.1 4902.4 4909.8 4911.3 4887.3 4895.5 4898.7 4905.4 4929.0 3929.0 4058.3 4059.0 4119.8 4160.1 3517.2 3578.6 3583.4 3608.1 3611.9 4251.5 4304.3 4307.3 4340.7 4343.8 4817.8 4918.7 4920.1 4971.6 4987.1 4273.9 4323.4 4340.0 4352.6 4375.6 4459.8 4461.5 4461.8 4485.7 4509.7 4548.6 4659.9 4779.3 4793.1 4796.7 4857.1 4913.2 4929.2 4972.2 4980.2 4734.0 4781.3 4782.6 4786.5 4819.6 4681.0 4791.8 4958.7 4971.6 5014.9 4880.9 4923.5 4943.8 4950.1 4950.6 4854.8 4881.9 4883.1 4883.6 4883.9 4716.1 4786.2 4789.8 4826.4 4827.2 4732.1 4774.8 4784.6 4801.6 4840.8 4580.9 4890.9 4902.7 4904.3 4952.4 4618.6 4664.4 4688.4 4699.4 4726.1 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,843 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39629.17 Median:32205.94 stddev:61707.23 (191.6%) stddev-sans-first:61810.62 10:03:15 INFO - 2015-11-24 10:03:15,844 DEBUG : BROWSER_OUTPUT: Values: 564.9 569.1 571.8 572.6 579.4 28128.6 28787.1 37086.3 38063.8 38140.4 40591.2 41131.4 41206.2 41282.0 41296.2 7071.8 7730.3 7893.4 7895.6 7896.6 7147.6 9765.7 10023.8 10027.3 10034.7 9919.7 10047.1 10049.7 10053.1 10064.6 7196.9 7383.2 9822.4 9949.3 9984.7 9817.3 9961.2 9982.3 9986.0 10011.3 37085.3 37392.3 37609.8 37624.0 37635.0 2609.1 2709.7 2718.5 2728.5 2824.7 28355.3 28523.3 28910.9 29228.4 29438.7 3313.7 3330.9 3354.8 3395.7 3405.7 217633.0 218133.0 219785.0 220105.0 220430.0 43206.6 54230.5 54529.0 54642.0 54680.0 47108.0 61678.0 63084.4 63085.4 63179.7 14305.6 14585.3 14597.6 14604.2 14617.6 10413.2 10441.1 10462.9 10466.9 10475.8 17965.7 18111.9 18212.1 18231.6 18267.6 6933.0 7209.2 7256.3 7276.7 7359.3 717.9 831.1 859.2 893.4 1018.2 23119.3 23541.5 23606.5 23607.9 23737.5 935.9 977.3 984.3 1002.7 1010.9 12355.6 12523.5 12537.1 12953.3 12969.4 258934.0 261192.0 263128.0 263531.0 263573.0 44636.1 44746.0 44809.3 44856.8 44915.3 1068.7 1082.9 1091.4 1201.4 1315.8 23426.2 25511.0 26583.2 26764.3 26809.9 36269.5 36915.4 37177.8 37216.4 37229.3 165923.0 237020.0 241754.7 242119.0 242353.0 25901.6 26519.2 26551.7 26552.5 26624.2 38101.8 38118.2 38612.8 39093.8 39252.2 29568.4 30616.7 31780.2 34584.3 35435.3 32711.3 32829.2 32924.6 33085.8 33185.5 32631.7 33011.0 33223.5 33329.8 33529.0 28521.3 29236.9 29688.0 30169.0 30207.1 21764.3 23576.3 23577.5 23804.4 23810.0 10:03:15 INFO - 2015-11-24 10:03:15,844 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,845 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23399.66 Median:1896.52 stddev:65220.11 (3438.9%) stddev-sans-first:65380.08 10:03:15 INFO - 2015-11-24 10:03:15,845 DEBUG : BROWSER_OUTPUT: Values: 334.7 334.9 335.6 337.8 338.0 12314.8 12688.1 15020.5 15403.8 15439.6 9878.0 9983.8 10187.5 10253.5 10263.3 4482.3 4621.5 4625.2 4629.7 4633.1 3357.9 3455.1 5059.5 5187.3 5219.7 5128.1 5156.7 5176.3 5189.1 5205.4 5201.1 5618.6 5663.9 5668.1 5668.5 5016.4 5016.6 5029.5 5032.1 5039.5 18222.5 18277.4 18867.4 18871.6 19039.2 1741.0 1778.4 1800.7 1818.7 1844.8 10932.3 12220.6 12491.0 12726.5 12791.7 1597.1 1676.7 1691.2 1709.6 1720.4 54749.5 56281.0 57708.7 57834.0 58600.7 9376.2 9798.6 9818.6 9860.0 9895.3 12531.8 12534.9 12598.9 12615.2 12662.9 6707.4 7007.0 7163.3 7216.1 7292.9 6853.6 6929.9 6975.4 7030.9 7031.9 4185.7 4263.5 4267.8 4285.9 4297.2 1617.3 1639.5 1656.3 1714.7 1766.2 397.7 403.7 766.8 808.3 810.8 9347.5 9826.5 13533.5 14871.8 15853.8 859.9 871.2 884.5 924.7 931.3 6382.9 8751.8 9001.2 9123.0 9141.7 320440.0 323004.0 439611.0 443174.0 446195.0 54838.2 55878.7 56061.4 68370.3 69802.0 1040.4 1068.7 1089.6 1090.1 1093.9 9256.7 9385.2 9396.6 9429.2 13506.9 28712.0 29271.4 29693.0 29896.4 30455.8 43127.8 43261.8 43266.4 44035.0 46101.8 14171.3 14266.6 14277.8 14408.5 14725.6 12848.8 17333.4 17577.0 18136.5 18180.6 13639.5 13901.7 13987.0 13989.3 14414.6 13276.9 13665.5 13810.5 14136.4 14210.5 9003.7 9169.4 9570.2 9571.0 14064.4 12954.2 13057.9 13163.7 13292.5 13546.4 13055.7 13315.6 13317.8 14527.3 14541.3 10:03:15 INFO - 2015-11-24 10:03:15,846 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,846 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4684.83 Median:5835.22 stddev:2403.29 (41.2%) stddev-sans-first:2394.90 10:03:15 INFO - 2015-11-24 10:03:15,846 DEBUG : BROWSER_OUTPUT: Values: 1097.4 1127.4 1138.8 1306.4 1461.6 5841.6 6526.4 6632.6 6642.9 6648.7 6680.6 6786.4 6830.4 6847.1 6855.4 2011.4 2018.8 2031.4 2032.3 2032.5 2029.3 2041.7 2048.2 2048.4 2068.0 1903.2 1917.5 1925.0 1926.1 1927.4 2030.9 2038.8 2039.3 2040.7 2041.7 1988.0 1991.7 1991.9 1993.9 2011.5 5649.9 5836.6 6646.8 6692.8 6733.2 3806.8 3902.8 3905.7 3909.5 3911.7 2696.5 2701.1 2741.2 2746.5 2748.6 895.6 900.5 904.8 905.5 907.3 8746.7 8795.6 8805.3 8806.1 8825.5 3757.0 3773.4 3778.0 3825.1 3834.2 7788.0 7788.5 7793.0 7817.1 7826.4 4079.1 4082.3 4082.4 4088.4 4091.0 3724.3 3725.0 3727.8 3728.3 3737.0 3156.4 3170.4 3195.0 3205.3 3208.3 1022.9 1038.0 1046.1 1047.3 1048.9 1112.8 1119.8 1138.2 1145.8 1150.3 6384.6 6388.3 6434.2 6448.6 6451.7 418.5 420.2 420.5 422.2 456.3 4708.8 4950.2 5009.4 5019.7 5020.6 6932.2 7722.7 7882.6 7911.6 7993.6 7804.4 7820.3 7868.6 7868.6 7877.7 6155.2 6325.8 6416.5 6423.7 6429.5 5969.3 6005.4 6012.2 6012.4 6013.9 6930.4 7232.9 7243.3 7245.4 7258.1 7299.1 7425.7 7440.9 7541.8 7543.0 5833.9 5848.7 5899.2 5904.0 5910.1 6465.6 6605.1 6625.5 6626.1 6631.7 6139.5 6189.9 6237.3 6291.5 6305.6 6012.7 6065.5 6083.1 6099.8 6184.8 5944.4 6184.4 6184.9 6196.8 6223.3 5679.6 5709.2 5713.4 5714.3 5721.5 5683.1 5801.7 5811.5 5816.7 5837.1 10:03:15 INFO - 2015-11-24 10:03:15,846 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,846 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4678.22 Median:5306.23 stddev:1374.89 (25.9%) stddev-sans-first:1339.03 10:03:15 INFO - 2015-11-24 10:03:15,847 DEBUG : BROWSER_OUTPUT: Values: 306.6 310.1 311.9 315.1 320.2 5301.8 5310.7 5341.3 5376.7 5399.9 5069.8 5149.0 5213.5 5219.4 5295.0 4153.8 4164.1 4183.2 4199.7 4205.4 4169.8 4198.3 4200.4 4201.8 4201.9 3948.7 3987.3 4040.9 4062.9 4082.3 4056.9 4069.9 4072.0 4074.2 4077.4 3563.9 3565.8 3572.3 3572.7 3574.7 5118.7 5141.4 5148.3 5152.9 5153.6 4623.2 4682.0 4687.8 4761.9 4765.1 5608.0 5611.6 5614.6 5615.6 5619.1 3946.3 3948.0 3949.0 3952.3 3952.7 5856.3 5926.3 5928.4 5936.9 5942.9 3977.7 4059.8 4064.5 4073.8 4075.4 4130.2 4135.7 4136.5 4138.6 4144.3 4706.8 4707.2 4710.6 4717.9 4722.6 5615.4 5620.4 5621.9 5622.0 5629.1 1429.0 1433.1 1465.1 1466.6 1471.9 968.8 984.9 988.1 989.1 990.4 4970.6 4978.2 4981.9 4986.9 4988.6 5851.1 5852.3 5859.0 5865.9 5866.5 4797.1 4869.6 4939.7 4955.0 4961.4 3146.5 3174.0 3184.6 3188.2 3191.5 5565.3 5568.1 5574.6 5574.7 5581.6 5902.9 6036.3 6046.8 6047.2 6048.9 5512.6 5525.0 5557.0 5559.5 5567.8 5832.6 5860.7 5866.3 5884.4 5886.3 5719.1 5726.9 5728.9 5733.5 5734.4 5402.5 5543.9 5553.6 5564.3 5572.6 4092.1 4092.9 4096.2 4097.1 4098.7 5871.5 5871.7 5877.0 5878.9 5880.8 5482.5 5650.9 5658.0 5661.3 5664.1 5658.4 5661.3 5663.1 5663.7 5669.9 5543.3 5552.8 5553.6 5558.4 5561.6 5689.2 5711.9 5713.7 5716.6 5717.4 5417.4 5558.0 5570.9 5578.1 5578.5 10:03:15 INFO - 2015-11-24 10:03:15,848 DEBUG : BROWSER_OUTPUT: 10:03:15 INFO - 2015-11-24 10:03:15,848 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11889.97 Median:24515.19 stddev:13575.45 (55.4%) stddev-sans-first:13587.54 10:03:15 INFO - 2015-11-24 10:03:15,848 DEBUG : BROWSER_OUTPUT: Values: 703.7 736.5 752.3 752.4 781.2 10305.4 10778.0 10793.0 10798.9 10806.9 11158.8 11258.3 11260.2 11293.4 11304.7 593.8 601.9 733.3 739.5 760.9 755.3 757.2 762.8 763.3 763.3 792.2 798.5 799.9 800.5 801.0 628.9 636.1 783.0 796.0 797.5 588.7 592.7 593.2 593.5 593.6 9935.3 10018.3 10084.7 10089.7 10120.5 11422.8 12038.8 12184.3 12325.8 12483.9 9150.3 9184.6 9229.8 9267.3 9388.7 3186.3 3287.5 3298.9 3307.7 3316.3 40340.6 40495.4 40534.4 40573.4 40634.4 8935.5 8945.0 9016.8 9031.1 9177.1 16722.6 16733.6 16737.2 16741.2 16748.6 6157.3 6424.5 6438.2 6466.6 6551.2 3252.4 3329.8 3426.8 3430.8 3470.9 2654.2 2689.6 2690.2 2752.1 2812.5 491.9 497.8 503.7 504.1 507.5 455.5 456.8 494.8 519.5 555.6 7010.2 7322.2 7323.2 7729.8 7866.7 396.7 442.7 527.8 531.8 576.4 3299.6 3300.1 3358.4 3418.4 3449.3 48265.6 48538.5 50571.0 51204.2 51720.2 39402.0 39446.6 39477.4 39879.2 40009.4 39490.6 39917.4 42035.0 42266.0 42394.2 7321.8 7366.3 7766.3 7790.3 7822.5 31818.4 32079.8 32167.4 32332.8 32701.5 36994.6 37170.0 37353.8 38743.2 39510.8 9093.2 9181.5 9421.3 9497.5 9583.6 9893.0 10052.4 10058.3 10088.6 10094.1 9930.0 9990.0 10075.2 10273.8 10292.1 10295.8 10392.2 10402.4 10408.6 10414.0 9656.0 10091.2 10161.7 10233.9 10255.2 8443.7 8557.4 8793.0 8806.1 8973.2 8232.9 8356.0 8645.7 8899.6 9008.2 10:03:15 INFO - 2015-11-24 10:03:15,848 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:15 INFO - 2015-11-24 10:03:15,848 DEBUG : BROWSER_OUTPUT: 10:03:16 INFO - 2015-11-24 10:03:16,615 INFO : Browser exited with error code: 0 10:03:16 INFO - 2015-11-24 10:03:16,638 INFO : Completed test dromaeo_css (00:18:38) 10:03:16 INFO - 2015-11-24 10:03:16,638 INFO : Starting test kraken 10:03:16 INFO - 2015-11-24 10:03:16,638 DEBUG : operating with platform_type : linux_ 10:03:16 INFO - 2015-11-24 10:03:16,638 INFO : Initialising browser for kraken test... 10:03:16 INFO - 2015-11-24 10:03:16,645 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp48_UKL/profile http://localhost:46430/getInfo.html 10:03:20 INFO - 2015-11-24 10:03:20,687 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:03:20 INFO - 2015-11-24 10:03:20,687 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:03:20 INFO - 2015-11-24 10:03:20,687 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:03:20 INFO - 2015-11-24 10:03:20,687 DEBUG : BROWSER_OUTPUT: __metrics 10:03:20 INFO - 2015-11-24 10:03:20,768 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:03:22 INFO - 2015-11-24 10:03:22,064 INFO : Browser initialized. 10:03:22 INFO - 2015-11-24 10:03:22,065 INFO : Running cycle 1/1 for kraken test... 10:03:22 INFO - 2015-11-24 10:03:22,065 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp48_UKL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:03:33 INFO - 2015-11-24 10:03:33,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 140140544 10:03:33 INFO - 2015-11-24 10:03:33,991 DEBUG : BROWSER_OUTPUT: 10:03:36 INFO - 2015-11-24 10:03:36,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46430/tests/kraken/driver.html?testName=audio-beat-detection) 10:03:37 INFO - 2015-11-24 10:03:37,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 179449856 10:03:37 INFO - 2015-11-24 10:03:37,208 DEBUG : BROWSER_OUTPUT: 10:03:39 INFO - 2015-11-24 10:03:39,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46430/tests/kraken/driver.html?testName=audio-dft) 10:03:40 INFO - 2015-11-24 10:03:40,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 167706624 10:03:40 INFO - 2015-11-24 10:03:40,564 DEBUG : BROWSER_OUTPUT: 10:03:43 INFO - 2015-11-24 10:03:43,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46430/tests/kraken/driver.html?testName=audio-fft) 10:03:44 INFO - 2015-11-24 10:03:44,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 151904256 10:03:44 INFO - 2015-11-24 10:03:44,156 DEBUG : BROWSER_OUTPUT: 10:03:46 INFO - 2015-11-24 10:03:46,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46430/tests/kraken/driver.html?testName=audio-oscillator) 10:03:46 INFO - 2015-11-24 10:03:46,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 155205632 10:03:46 INFO - 2015-11-24 10:03:46,779 DEBUG : BROWSER_OUTPUT: 10:03:49 INFO - 2015-11-24 10:03:49,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:03:49 INFO - 2015-11-24 10:03:49,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 155197440 10:03:49 INFO - 2015-11-24 10:03:49,605 DEBUG : BROWSER_OUTPUT: 10:03:52 INFO - 2015-11-24 10:03:52,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46430/tests/kraken/driver.html?testName=imaging-darkroom) 10:03:53 INFO - 2015-11-24 10:03:53,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 157495296 10:03:53 INFO - 2015-11-24 10:03:53,158 DEBUG : BROWSER_OUTPUT: 10:03:56 INFO - 2015-11-24 10:03:56,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46430/tests/kraken/driver.html?testName=imaging-desaturate) 10:03:57 INFO - 2015-11-24 10:03:57,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 158314496 10:03:57 INFO - 2015-11-24 10:03:57,111 DEBUG : BROWSER_OUTPUT: 10:03:59 INFO - 2015-11-24 10:03:59,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46430/tests/kraken/driver.html?testName=json-parse-financial) 10:04:00 INFO - 2015-11-24 10:04:00,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 157511680 10:04:00 INFO - 2015-11-24 10:04:00,543 DEBUG : BROWSER_OUTPUT: 10:04:02 INFO - 2015-11-24 10:04:02,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:04:02 INFO - 2015-11-24 10:04:02,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 169054208 10:04:02 INFO - 2015-11-24 10:04:02,916 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:04:05 INFO - 2015-11-24 10:04:05,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 169127936 10:04:05 INFO - 2015-11-24 10:04:05,416 DEBUG : BROWSER_OUTPUT: 10:04:07 INFO - 2015-11-24 10:04:07,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:08 INFO - 2015-11-24 10:04:08,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 177463296 10:04:08 INFO - 2015-11-24 10:04:08,134 DEBUG : BROWSER_OUTPUT: 10:04:10 INFO - 2015-11-24 10:04:10,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:04:11 INFO - 2015-11-24 10:04:11,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 182755328 10:04:11 INFO - 2015-11-24 10:04:11,267 DEBUG : BROWSER_OUTPUT: 10:04:13 INFO - 2015-11-24 10:04:13,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:04:14 INFO - 2015-11-24 10:04:14,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 180801536 10:04:14 INFO - 2015-11-24 10:04:14,435 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46430/tests/kraken/driver.html?testName=ai-astar) 10:04:16 INFO - 2015-11-24 10:04:16,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 241344512 10:04:16 INFO - 2015-11-24 10:04:16,457 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,457 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:16 INFO - 2015-11-24 10:04:16,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:16 INFO - 2015-11-24 10:04:16,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:16 INFO - 2015-11-24 10:04:16,457 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:16 INFO - 2015-11-24 10:04:16,458 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;109;113;113;115;103;112;113;109 10:04:16 INFO - 2015-11-24 10:04:16,458 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;134;161;178;131;157;164;138;184;141 10:04:16 INFO - 2015-11-24 10:04:16,458 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;160;160;162;160;162;160 10:04:16 INFO - 2015-11-24 10:04:16,458 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;82;91;73;72;72;114;91;71 10:04:16 INFO - 2015-11-24 10:04:16,458 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;136;94;94;94;133;95;95;128 10:04:16 INFO - 2015-11-24 10:04:16,458 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;117;110;109;109;110;109;110 10:04:16 INFO - 2015-11-24 10:04:16,458 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;147;146;146;147;146;146 10:04:16 INFO - 2015-11-24 10:04:16,459 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;95;96;95;96;95 10:04:16 INFO - 2015-11-24 10:04:16,459 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;72;71;71;72;72;71;73;69 10:04:16 INFO - 2015-11-24 10:04:16,459 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;70;69;69;69;69 10:04:16 INFO - 2015-11-24 10:04:16,459 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;80;83;86;84;82;93;83;84;83 10:04:16 INFO - 2015-11-24 10:04:16,459 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;128;126;124;137;122;131;130;129;121 10:04:16 INFO - 2015-11-24 10:04:16,459 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;135;137;147;147;137;145;147;151;138 10:04:16 INFO - 2015-11-24 10:04:16,459 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;71;69;70;70;72;69;68;69 10:04:16 INFO - 2015-11-24 10:04:16,460 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:16 INFO - 2015-11-24 10:04:16,460 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:16 INFO - 2015-11-24 10:04:16,460 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 10:04:16 INFO - 2015-11-24 10:04:16,460 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:16 INFO - 2015-11-24 10:04:16,460 DEBUG : BROWSER_OUTPUT: __startTimestamp1448388256455__endTimestamp 10:04:16 INFO - 2015-11-24 10:04:16,460 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:3.70 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 109.0 113.0 113.0 115.0 103.0 112.0 113.0 109.0 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:154.20 Median:159.00 stddev:18.22 (11.5%) stddev-sans-first:19.32 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: Values: 154.0 134.0 161.0 178.0 131.0 157.0 164.0 138.0 184.0 141.0 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 160.0 160.0 162.0 160.0 162.0 160.0 10:04:16 INFO - 2015-11-24 10:04:16,468 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:72.50 stddev:14.06 (19.4%) stddev-sans-first:14.53 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 82.0 91.0 73.0 72.0 72.0 114.0 91.0 71.0 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:94.00 stddev:18.48 (19.7%) stddev-sans-first:19.11 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 136.0 94.0 94.0 94.0 133.0 95.0 95.0 128.0 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:2.41 (2.2%) stddev-sans-first:2.55 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 117.0 110.0 109.0 109.0 110.0 109.0 110.0 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,469 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:72.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 72.0 71.0 71.0 72.0 72.0 71.0 73.0 69.0 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 70.0 69.0 69.0 69.0 69.0 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.50 stddev:3.53 (4.2%) stddev-sans-first:3.67 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: Values: 82.0 80.0 83.0 86.0 84.0 82.0 93.0 83.0 84.0 83.0 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.50 stddev:5.13 (4.0%) stddev-sans-first:4.98 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: Values: 121.0 128.0 126.0 124.0 137.0 122.0 131.0 130.0 129.0 121.0 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:147.00 stddev:5.70 (3.9%) stddev-sans-first:5.87 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: Values: 147.0 135.0 137.0 147.0 147.0 137.0 145.0 147.0 151.0 138.0 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 10:04:16 INFO - 2015-11-24 10:04:16,470 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 69.0 70.0 70.0 72.0 69.0 68.0 69.0 10:04:16 INFO - 2015-11-24 10:04:16,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:16 INFO - 2015-11-24 10:04:16,471 DEBUG : BROWSER_OUTPUT: 10:04:17 INFO - 2015-11-24 10:04:17,375 INFO : Browser exited with error code: 0 10:04:17 INFO - 2015-11-24 10:04:17,430 INFO : Completed test kraken (00:01:00) 10:04:17 INFO - 2015-11-24 10:04:17,431 INFO : Starting test v8_7 10:04:17 INFO - 2015-11-24 10:04:17,431 DEBUG : operating with platform_type : linux_ 10:04:17 INFO - 2015-11-24 10:04:17,431 INFO : Initialising browser for v8_7 test... 10:04:17 INFO - 2015-11-24 10:04:17,437 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB95sxz/profile http://localhost:46430/getInfo.html 10:04:21 INFO - 2015-11-24 10:04:21,384 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:04:21 INFO - 2015-11-24 10:04:21,384 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:04:21 INFO - 2015-11-24 10:04:21,384 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:04:21 INFO - 2015-11-24 10:04:21,384 DEBUG : BROWSER_OUTPUT: __metrics 10:04:21 INFO - 2015-11-24 10:04:21,509 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:22 INFO - 2015-11-24 10:04:22,705 INFO : Browser initialized. 10:04:22 INFO - 2015-11-24 10:04:22,706 INFO : Running cycle 1/1 for v8_7 test... 10:04:22 INFO - 2015-11-24 10:04:22,706 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB95sxz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:04:34 INFO - 2015-11-24 10:04:34,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 140451840 10:04:34 INFO - 2015-11-24 10:04:34,601 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46430/tests/v8_7/run.html (next: http://localhost:46430/tests/v8_7/run.html) 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 441696256 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: |0;Richards;190.04180919802357 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.7063169560399 10:04:56 INFO - 2015-11-24 10:04:56,272 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: |6;Boyer;11788.235294117647 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: |8;Splay;611.6504854368932 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:56 INFO - 2015-11-24 10:04:56,273 DEBUG : BROWSER_OUTPUT: __startTimestamp1448388296266__endTimestamp 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.04 Median:190.04 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: Values: 190.0 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.71 Median:184.71 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: Values: 184.7 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: Values: 279.8 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,274 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: Values: 4995.0 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: Values: 1976.3 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: Values: 784.3 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11788.24 Median:11788.24 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: Values: 11788.2 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: Values: 26921.1 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.65 Median:611.65 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,275 DEBUG : BROWSER_OUTPUT: Values: 611.7 10:04:56 INFO - 2015-11-24 10:04:56,276 DEBUG : BROWSER_OUTPUT: 10:04:56 INFO - 2015-11-24 10:04:56,276 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:04:56 INFO - 2015-11-24 10:04:56,276 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:04:56 INFO - 2015-11-24 10:04:56,276 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:56 INFO - 2015-11-24 10:04:56,276 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-24 10:04:57,191 INFO : Browser exited with error code: 0 10:04:57 INFO - 2015-11-24 10:04:57,208 INFO : Completed test v8_7 (00:00:39) 10:04:57 INFO - 2015-11-24 10:04:57,268 INFO : Completed test suite (00:20:19) 10:04:57 INFO - 2015-11-24 10:04:57,269 DEBUG : Working with test: dromaeo_css 10:04:57 INFO - 2015-11-24 10:04:57,269 DEBUG : Generating results file: dromaeo_css 10:04:57 INFO - 2015-11-24 10:04:57,270 DEBUG : Working with test: kraken 10:04:57 INFO - 2015-11-24 10:04:57,270 DEBUG : Generating results file: kraken 10:04:57 INFO - 2015-11-24 10:04:57,270 INFO : javascript benchmark 10:04:57 INFO - 2015-11-24 10:04:57,270 DEBUG : Working with test: v8_7 10:04:57 INFO - 2015-11-24 10:04:57,270 DEBUG : Generating results file: v8_7 10:04:57 INFO - 2015-11-24 10:04:57,271 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:57 INFO - 2015-11-24 10:04:57,321 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:04:57 INFO - 2015-11-24 10:04:57,322 DEBUG : process_Request line: dromaeo_css 6158.41 graph.html#tests=[[72,132,35]] 10:04:57 INFO - 2015-11-24 10:04:57,322 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:57 INFO - 2015-11-24 10:04:57,352 DEBUG : process_Request line: kraken 1528.70 graph.html#tests=[[232,132,35]] 10:04:57 INFO - 2015-11-24 10:04:57,352 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:04:57 INFO - 2015-11-24 10:04:57,387 DEBUG : process_Request line: v8_7 19682.64 graph.html#tests=[[230,132,35]] 10:04:57 INFO - 2015-11-24 10:04:57,388 INFO : javascript benchmark 10:04:57 INFO - 2015-11-24 10:04:57,392 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2593.1701855406272, 2690.3543149644092, 2700.1899430170943, 2706.0934586913395, 2716.9456610867787, 4529.2753159494405, 4651.093036857814, 4659.487456379799, 4680.321353403754, 4689.9296510552285, 4568.840090596821, 4570.794314255858, 4655.231886738692, 4663.7668116594205, 4686.648501362394, 4283.464566929134, 4321.913561728771, 4326.913461730764, 4403.845865394712, 4439.800208990587, 4349.282368409209, 4408.4709834819705, 4432.11357728454, 4434.445694288214, 4458.375827384169, 4121.29937910556, 4174.603412675791, 4217.641500472463, 4247.469066366704, 4281.293586558214, 4247.638950689196, 4248.851290204859, 4259.190753756808, 4295.463067116611, 4303.419038429804, 4125.773082480462, 4271.9786401067795, 4288.871333859989, 4297.290946993742, 4345.239583072949, 4502.0545685406105, 4515.909681806378, 4518.593326600621, 4602.424696912886, 4630.143423466669, 4976.651634385595, 5023.799048038074, 5025.798968041274, 5025.974870125662, 5067.037262920034, 4830.3479030331155, 5035.471275516092, 5044.066847633199, 5045.066662667418, 5055.595552355802, 4611.400517932714, 4613.0543238636, 4614.9077018459775, 4696.7651617419, 4708.246680531099, 5120.257562653469, 5127.0, 5134.48655134491, 5136.794528218829, 5142.04872098663, 4921.532454416824, 4922.778474968635, 4926.236433352764, 4928.0390323886495, 4969.006198760262, 4806.014766972762, 4856.757162141878, 4908.288298196741, 4910.263460480956, 4919.0407870464915, 4880.072786170616, 4902.068606964665, 4902.3872015998, 4909.7790599423115, 4911.267843148942, 4887.266651416745, 4895.534924182268, 4898.730569818694, 4905.386826646669, 4928.950710492921, 3929.0, 4058.330375488011, 4059.04612416082, 4119.8352065917625, 4160.063985603215, 3517.2262102337445, 3578.624244454347, 3583.354996100727, 3608.0619039050034, 3611.8735844245325, 4251.4685664291965, 4304.289792184317, 4307.310830267143, 4340.739555626673, 4343.761093139908, 4817.759112044384, 4918.671958571165, 4920.138975679241, 4971.6022718183185, 4987.127252730757, 4273.87178384649, 4323.3947247385395, 4340.045190058182, 4352.586504282088, 4375.628071613948, 4459.7547134907245, 4461.486929003141, 4461.7992190351515, 4485.663575231805, 4509.706869053567, 4548.56788605082, 4659.883502912454, 4779.330893674888, 4793.065352256276, 4796.712197268175, 4857.0528746894015, 4913.213885778258, 4929.186684197068, 4972.154733695353, 4980.178270585313, 4733.952660473351, 4781.282807578891, 4782.6173906088125, 4786.497417771223, 4819.614430845594, 4681.0, 4791.832285869978, 4958.727270000185, 4971.627127965345, 5014.899702006012, 4880.902381952412, 4923.483034281349, 4943.802247910187, 4950.059488697136, 4950.628702847373, 4854.83008094715, 4881.90236195267, 4883.072216278895, 4883.6093112551625, 4883.926741098958, 4716.056788642217, 4786.186348320724, 4789.832355867528, 4826.396700412449, 4827.179379505422, 4732.100900828831, 4774.809007639656, 4784.569388755029, 4801.639877009168, 4840.806367745392, 4580.862574122782, 4890.9021819562695, 4902.7058376497525, 4904.2643603459765, 4952.380952380952, 4618.584327410549, 4664.416947881515, 4688.390509233778, 4699.412573428322, 4726.1492931272705], "unit": "ms", "name": "dojo.html", "value": 4557.098188486251}, {"lowerIsBetter": false, "replicates": [564.940681228471, 569.1235497334105, 571.8170185540629, 572.6420986883198, 579.4408395897958, 28128.578071328946, 28787.136385908405, 37086.25827483449, 38063.809680951555, 38140.427893581546, 40591.18817623646, 41131.38302925451, 41206.17587648253, 41282.0, 41296.17407651845, 7071.7878463646175, 7730.304272615477, 7893.368530517573, 7895.565743884084, 7896.565688887109, 7147.642617869085, 9765.658201962933, 10023.849642255373, 10027.34822236556, 10034.69895903124, 9919.652812151577, 10047.145992590638, 10049.748756281078, 10053.145482633949, 10064.647737329195, 7196.928030719678, 7383.2247614000835, 9822.361546499455, 9949.303548751626, 9984.650537231162, 9817.263705222136, 9961.203103751755, 9982.301238913278, 9986.0, 10011.349262297927, 37085.258294834224, 37392.25215495675, 37609.81195094007, 37624.0, 37635.0, 2609.123973192302, 2709.6612923384578, 2718.4698983698186, 2728.5497892847657, 2824.6892841787385, 28355.291117722016, 28523.286917827012, 28910.85544572264, 29228.41543169146, 29438.70561294381, 3313.6686331366673, 3330.884153808477, 3354.8490317935507, 3395.6604339565847, 3405.7275417966503, 217633.0, 218133.0, 219785.0, 220104.9999999984, 220430.0, 43206.56793432088, 54230.45769542254, 54529.0, 54642.0, 54680.0, 47108.0, 61678.0, 63084.36915630785, 63085.36914630887, 63179.68410158012, 14305.57083287503, 14585.343659535347, 14597.562073137822, 14604.196769177584, 14617.561473155822, 10413.219008574388, 10441.112505436971, 10462.895371046192, 10466.947665261625, 10475.84286235707, 17965.7305140423, 18111.909440452713, 18212.089395530435, 18231.627148977215, 18267.63464730698, 6933.042874344867, 7209.170945341353, 7256.310650488195, 7276.708931642781, 7359.337659610554, 717.865097041037, 831.094107422912, 859.1966511311819, 893.3835653399134, 1018.23123541727, 23119.306420807403, 23541.529169416517, 23606.527869442514, 23607.881960590086, 23737.525249494913, 935.9438433694, 977.2914636888199, 984.3208186351395, 1002.734275417015, 1010.8584798128268, 12355.622120501266, 12523.499060037679, 12537.122401431812, 12953.287569183785, 12969.35153242353, 258934.0, 261192.0, 263128.0, 263531.0, 263573.0, 44636.10727785491, 44746.0, 44809.32786008212, 44856.775716121214, 44915.32627010597, 1068.7221322456062, 1082.9350238985687, 1091.4324551233315, 1201.4413297816557, 1315.8355205599491, 23426.18008369699, 25511.0, 26583.202503924913, 26764.330891727863, 26809.865950670122, 36269.45595816012, 36915.44626830546, 37177.814110930354, 37216.44175337318, 37229.255414891006, 165923.0, 237020.0, 241754.74735757956, 242119.0, 242353.0, 25901.611475828253, 26519.204423867315, 26551.734482654927, 26552.468950621267, 26624.20127396181, 38101.809490952364, 38118.23763524659, 38612.80693596514, 39093.80453097716, 39252.214955701296, 29568.408631827675, 30616.693833062276, 31780.205494862814, 34584.30831383308, 35435.291294173454, 32711.345773084882, 32829.17927051843, 32924.59954688229, 33085.83457082699, 33185.50221746627, 32631.673683262863, 33011.0, 33223.501647474826, 33329.83335083309, 33528.994130176136, 28521.28696782514, 29236.853815730785, 29688.0, 30169.0, 30207.09378718642, 21764.30280941833, 23576.29271121869, 23577.52844943126, 23804.404889877893, 23810.0], "unit": "ms", "name": "ext.html", "value": 16791.354558348958}, {"lowerIsBetter": false, "replicates": [334.71381968416995, 334.8911603728788, 335.617396168368, 337.7703161849943, 337.9712724418424, 12314.81527777084, 12688.111832171751, 15020.549383518499, 15403.84596154038, 15439.614009649751, 9878.0, 9983.800323993533, 10187.54156062977, 10253.538590763415, 10263.281570290083, 4482.282834746433, 4621.5378462153685, 4625.213713668684, 4629.7222166669935, 4633.096546173498, 3357.9496307555405, 3455.0671318743925, 5059.494050594948, 5187.27378167055, 5219.71291578963, 5128.128218202895, 5156.716380599066, 5176.327077479922, 5189.065968125736, 5205.37535495741, 5201.0898092833795, 5618.550515958734, 5663.915041274384, 5668.064769313059, 5668.546516278729, 5016.44819069902, 5016.573591244712, 5029.547340739315, 5032.094223039851, 5039.521245481674, 18222.544436389064, 18277.360292389836, 18867.433976980712, 18871.62256754871, 19039.238430462763, 1740.9651806963916, 1778.4397914656843, 1800.7028840241344, 1818.7180986946912, 1844.769403824522, 10932.344059356465, 12220.572279970158, 12491.0, 12726.490940362375, 12791.680207994781, 1597.0736972556006, 1676.7484877268507, 1691.2220378625848, 1709.6495218480181, 1720.4408567215705, 54749.45250547483, 56280.99999999959, 57708.71145644287, 57834.0, 58600.706996465175, 9376.156145946898, 9798.608055677692, 9818.558164882455, 9860.0, 9895.257855660855, 12531.812022819666, 12534.874651253553, 12598.937005314914, 12615.243085414904, 12662.936685316514, 6707.3628005339415, 7007.0, 7163.31948464895, 7216.134063912364, 7292.854142917218, 6853.588784672936, 6929.896051559231, 6975.372216500539, 7030.9296907030275, 7031.92968070323, 4185.686073544496, 4263.488381394252, 4267.829286828554, 4285.935710964338, 4297.183535128315, 1617.3449752850115, 1639.45897853708, 1656.3209084275388, 1714.6742118997352, 1766.222861940742, 397.72556935714266, 403.6851256020309, 766.8274638206359, 808.3048578222724, 810.7892744730814, 9347.485888276211, 9826.508674566243, 13533.45866165362, 14871.776923346159, 15853.841461585236, 859.9097094804955, 871.2072014466931, 884.5090974509209, 924.7087167542203, 931.2782593489964, 6382.936170638327, 8751.781205469913, 9001.18989290967, 9122.954385228031, 9141.725748227564, 320440.0, 323004.0, 439611.0, 443174.0, 446195.0, 54838.177427338625, 55878.72060639671, 56061.439385606434, 68370.29074273183, 69802.0, 1040.4485622620023, 1068.7435015596202, 1089.553283153903, 1090.0897750378365, 1093.928894621863, 9256.72229833106, 9385.15533601979, 9396.624135034795, 9429.15137637616, 13506.932465338003, 28712.0, 29271.41457170802, 29693.0, 29896.402071958873, 30455.847720761256, 43127.784361078, 43261.7836910826, 43266.35100473432, 44035.0, 46101.79625800317, 14171.291435427982, 14266.572002839932, 14277.785833212718, 14408.495702650356, 14725.631859203606, 12848.807267890803, 17333.393331233347, 17577.0, 18136.546586335448, 18180.636387272443, 13639.522616708367, 13901.652458688613, 13987.0, 13989.342025015214, 14414.567562973127, 13276.867231327564, 13665.453381865012, 13810.516631917835, 14136.363863625957, 14210.502632407815, 9003.684871029482, 9169.449833010041, 9570.186534144676, 9571.0, 14064.367103480572, 12954.222746635232, 13057.934710326388, 13163.736725265633, 13292.534761283308, 13546.390412431661, 13055.673608159872, 13315.600531983668, 13317.800232996318, 14527.346269418113, 14541.345639446039], "unit": "ms", "name": "jquery.html", "value": 8072.291201121591}, {"lowerIsBetter": false, "replicates": [1097.4074000039977, 1127.441916251455, 1138.806402911505, 1306.353355089231, 1461.6345913521627, 5841.649501029936, 6526.445252153567, 6632.60204387737, 6642.900356494656, 6648.734050637969, 6680.565763225387, 6786.389224969752, 6830.419414349773, 6847.075644787952, 6855.383015528601, 2011.3664195778356, 2018.818306352428, 2031.4007367826528, 2032.2582257475988, 2032.5121970726993, 2029.2998915374171, 2041.7345745053121, 2048.2216757632154, 2048.385484354695, 2068.0280268273964, 1903.1530968718857, 1917.5397904502888, 1924.9615007699838, 1926.0754837677923, 1927.44104209779, 2030.878147311166, 2038.755349358079, 2039.296442727264, 2040.6938959156098, 2041.7345745053049, 1987.9801201987939, 1991.7211590377358, 1991.8605697601174, 1993.8504612154147, 2011.5071807407278, 5649.887002259973, 5836.5622578306375, 6646.767363142267, 6692.799216023527, 6733.192016957947, 3806.8286927088348, 3902.804859757001, 3905.668018218455, 3909.4526766252748, 3911.6675082618012, 2696.514627367073, 2701.1491380215366, 2741.232454912628, 2746.491898998692, 2748.628935093757, 895.552223888056, 900.5407242306405, 904.8371293167228, 905.4522014181457, 907.3240435875249, 8746.737597872074, 8795.648174073029, 8805.339599529996, 8806.075362086953, 8825.470471771714, 3757.0, 3773.415120656303, 3777.981110094432, 3825.081980324702, 3834.1948190880225, 7788.0, 7788.4548081634875, 7792.961035194788, 7817.140114587391, 7826.373890088779, 4079.1229885574744, 4082.2651922653613, 4082.4488694026522, 4088.4276201331836, 4091.0386059276047, 3724.255148970217, 3724.962750372516, 3727.7576957497677, 3728.254349130185, 3737.009692431508, 3156.4002839460886, 3170.445172094874, 3195.0414875537713, 3205.3108581655056, 3208.262099717078, 1022.897710228986, 1037.9896201038043, 1046.0951277145214, 1047.314009323894, 1048.8951104889602, 1112.844201811747, 1119.7872404243167, 1138.174823253135, 1145.7593905279984, 1150.327058670687, 6384.616922984543, 6388.329225431356, 6434.227892652912, 6448.613083215022, 6451.709673064724, 418.49780263683704, 420.2372693561177, 420.50590556097075, 422.20203814790074, 456.26769035697225, 4708.764561771898, 4950.2079667253065, 5009.423916249678, 5019.7239151847, 5020.648554601216, 6932.168139823153, 7722.691092356243, 7882.605869706492, 7911.604419778988, 7993.640286187136, 7804.414668899855, 7820.296173344426, 7868.567228802356, 7868.606569671493, 7877.724279650185, 6155.169052177898, 6325.841853953596, 6416.486681065504, 6423.678816059271, 6429.517786166056, 5969.343372229138, 6005.429484198994, 6012.1582978382185, 6012.428819262163, 6013.9097913532205, 6930.410915072275, 7232.891506627299, 7243.348098671145, 7245.38414234796, 7258.129024517092, 7299.087614048244, 7425.665845037094, 7440.888386674313, 7541.773746787605, 7542.962285188759, 5833.883322333614, 5848.736806843787, 5899.233099697012, 5903.970480147572, 5910.113482977587, 6465.612063276219, 6605.075289459575, 6625.536212465081, 6626.072349871119, 6631.734730610721, 6139.4781443577795, 6189.876202476015, 6237.251529816451, 6291.465225455888, 6305.621662700252, 6012.729427175875, 6065.484433823174, 6083.057126145454, 6099.75600975956, 6184.81445556634, 5944.375840536682, 6184.443400093834, 6184.876302474016, 6196.81409557714, 6223.284322302993, 5679.602427830012, 5709.229254050816, 5713.428657134254, 5714.314282286152, 5721.542276617777, 5683.147527870852, 5801.680907549957, 5811.535077193899, 5816.651000939957, 5837.09525023622], "unit": "ms", "name": "mootools.html", "value": 3805.632440174238}, {"lowerIsBetter": false, "replicates": [306.6351042259711, 310.07133634763886, 311.91422358851315, 315.14281155257703, 320.2362365757668, 5301.814436494718, 5310.654807437519, 5341.278927344817, 5376.704281264529, 5399.892002159954, 5069.822556210534, 5149.0, 5213.530782229599, 5219.42586315505, 5294.993951149279, 4153.792310384476, 4164.063085805685, 4183.226103170923, 4199.706020578561, 4205.369194620816, 4169.833206671729, 4198.286291330481, 4200.411942328076, 4201.831926722927, 4201.873943781691, 3948.7433316834313, 3987.3221552336026, 4040.9089545822612, 4062.943634654996, 4082.326416141333, 4056.9451942495016, 4069.877903662895, 4071.9592804071876, 4074.246264441088, 4077.4495443115097, 3563.9109022274392, 3565.7860528368383, 3572.3034008368377, 3572.7141828653907, 3574.7140228781896, 5118.744062796845, 5141.383034035902, 5148.2535032420465, 5152.871178220537, 5153.56194723449, 4623.214053610861, 4681.953180468186, 4687.789049492781, 4761.857144285642, 4765.09463201994, 5607.971960140214, 5611.551075913917, 5614.63504872182, 5615.550755939515, 5619.129034999541, 3946.309395855714, 3947.98026009871, 3949.0, 3952.3281042222893, 3952.6837852971694, 5856.267966504187, 5926.348101708809, 5928.377520360344, 5936.940630593682, 5942.910856337158, 3977.7414468059483, 4059.7767122807936, 4064.4716186895516, 4073.796310184538, 4075.409065685459, 4130.215259100762, 4135.731177473514, 4136.524299705572, 4138.627523522898, 4144.33690609501, 4706.764661766898, 4707.176244157327, 4710.576048155683, 4717.9292310615365, 4722.645801564897, 5615.382307946123, 5620.437956204347, 5621.915671264935, 5622.044252477089, 5629.071203251499, 1429.0425414971994, 1433.125793266107, 1465.1209274435253, 1466.596685911383, 1471.8528147185195, 968.7820240445984, 984.8719666443317, 988.0712130597216, 989.0702739424918, 990.4008075114596, 4970.602351811846, 4978.228374601942, 4981.850544483671, 4986.850394488171, 4988.575971042429, 5851.063829787214, 5852.297724273115, 5859.0, 5865.853353666193, 5866.530677545786, 4797.088553174885, 4869.63477739171, 4939.654224204343, 4955.0337684151245, 4961.355023846877, 3146.528020796899, 3174.0477856643374, 3184.617845858512, 3188.1710755203812, 3191.457452233126, 5565.332160140728, 5568.053430916754, 5574.60977731563, 5574.665520068809, 5581.609287349927, 5902.852428689317, 6036.305824830113, 6046.758129674852, 6047.183630209954, 6048.939510604838, 5512.614117011771, 5524.972375138179, 5557.0, 5559.499645031967, 5567.777288908398, 5832.591718579828, 5860.706964651665, 5866.2960444746905, 5884.382139875252, 5886.293644762656, 5719.113537401709, 5726.8568285791525, 5728.914066289092, 5733.455321744427, 5734.369219385948, 5402.540784033244, 5543.944560554504, 5553.611247212656, 5564.332280126248, 5572.554195664256, 4092.0997380576227, 4092.856750013735, 4096.16028714107, 4097.1396006838895, 4098.672106231554, 5871.530277577869, 5871.706414679335, 5876.970615146897, 5878.94121058801, 5880.794172204123, 5482.451754824486, 5650.943490565206, 5657.981563318642, 5661.320641523043, 5664.0654292043, 5658.377578466448, 5661.320641523043, 5663.122216056518, 5663.716814159358, 5669.943300567106, 5543.279373681396, 5552.7778888843995, 5553.611247212656, 5558.360788509373, 5561.610687251854, 5689.231953686365, 5711.914321285101, 5713.685747283939, 5716.628419152742, 5717.371089180104, 5417.43116972728, 5557.972210138923, 5570.888582228414, 5578.051731205624, 5578.470045345685], "unit": "ms", "name": "prototype.html", "value": 4238.687642289237}, {"lowerIsBetter": false, "replicates": [703.7360989628887, 736.4844608773858, 752.2853289375095, 752.3529764402616, 781.2460975158971, 10305.38167709938, 10778.029977302042, 10793.0, 10798.946005269963, 10806.891931080687, 11158.776824463506, 11258.324500529974, 11260.21178517504, 11293.435328233576, 11304.717382065452, 593.8307582339035, 601.8585632376388, 733.2996987876566, 739.4897520710706, 760.9315161635452, 755.2636179724752, 757.1519897714568, 762.8207371267748, 763.2710761223046, 763.2748888555866, 792.2117493094379, 798.4769975665948, 799.9000124984377, 800.5156880087551, 801.0387534958045, 628.8742251549686, 636.1221514310246, 783.0407750505642, 796.024869534821, 797.4577287444536, 588.7350692188533, 592.6681058607151, 593.2288025566789, 593.4629160609655, 593.5815250248608, 9935.254855885838, 10018.3488073275, 10084.69745907624, 10089.697309080739, 10120.544575494047, 11422.771544569063, 12038.759224815454, 12184.268943863397, 12325.753484930341, 12483.93758031204, 9150.313726470542, 9184.632614695403, 9229.769255768593, 9267.25861931044, 9388.718338449857, 3186.3467989062187, 3287.4575695010294, 3298.8515516801563, 3307.6692330766973, 3316.3201543683485, 40340.59659403398, 40495.392569111485, 40534.39198412026, 40573.39139912904, 40634.390484142765, 8935.508547029845, 8944.97132829733, 9016.819663606822, 9031.096890310917, 9177.128172823572, 16722.58193545171, 16733.581660458585, 16737.16314184286, 16741.1629418531, 16748.581285467717, 6157.314804192034, 6424.486041116699, 6438.195225596801, 6466.612003279818, 6551.21385433751, 3252.3983063133396, 3329.8335083246225, 3426.777259478126, 3430.7598468107494, 3470.8958731238104, 2654.1639383594106, 2689.623452716621, 2690.192942117357, 2752.1330780804383, 2812.451571943492, 491.8622785620032, 497.82327273818, 503.72295237619164, 504.14798989707276, 507.5305342558119, 455.50122615735717, 456.80129143822546, 494.7699319816303, 519.5295426550678, 555.5583311267552, 7010.228874823765, 7322.1579518355, 7323.194448610649, 7729.8454030919065, 7866.685332586747, 396.6786902608896, 442.710024933669, 527.8466550586979, 531.8404478656388, 576.4005434348231, 3299.5545601343993, 3300.075978725961, 3358.3619112368574, 3418.4017796885446, 3449.275652113034, 48265.58672066383, 48538.5146148541, 50571.0, 51204.207852724976, 51720.22419663708, 39402.0, 39446.605533944865, 39477.40783888244, 39879.20241595152, 40009.39985900214, 39490.60509394927, 39917.40123898144, 42035.0, 42266.0, 42394.1521169581, 7321.78034658961, 7366.337029667356, 7766.262205090507, 7790.3304058536305, 7822.4524283299625, 31818.36363272768, 32079.839600801846, 32167.356652866343, 32332.83833580817, 32701.509477358333, 36994.630053700195, 37170.0, 37353.81323093367, 38743.2251354977, 39510.80244598759, 9093.22707569864, 9181.495017774087, 9421.306816762886, 9497.477638729937, 9583.568739406604, 9892.950535247277, 10052.447115408722, 10058.29591928558, 10088.638033865627, 10094.091531762177, 9930.0, 9989.950050249703, 10075.244356673133, 10273.84589231177, 10292.125169360388, 10295.794084118126, 10392.22058345612, 10402.427866467417, 10408.583656653953, 10414.0, 9656.0, 10091.192704583762, 10161.745956351151, 10233.9488302558, 10255.230857685852, 8443.66225350979, 8557.358198135289, 8792.956035219782, 8806.119388061143, 8973.237274831712, 8232.876506852523, 8356.0, 8645.697400590949, 8899.555022248733, 9008.189262966365], "unit": "ms", "name": "yui.html", "value": 5474.388994794068}], "name": "dromaeo_css", "value": 6158.412342611202}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 109.0, 113.0, 113.0, 115.0, 103.0, 112.0, 113.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 161.0, 178.0, 131.0, 157.0, 164.0, 138.0, 184.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 154.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 82.0, 91.0, 73.0, 72.0, 72.0, 114.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 94.0, 94.0, 94.0, 133.0, 95.0, 95.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 117.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 72.0, 71.0, 71.0, 72.0, 72.0, 71.0, 73.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 83.0, 86.0, 84.0, 82.0, 93.0, 83.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [121.0, 128.0, 126.0, 124.0, 137.0, 122.0, 131.0, 130.0, 129.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [147.0, 135.0, 137.0, 147.0, 147.0, 137.0, 145.0, 147.0, 151.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 69.0, 70.0, 70.0, 72.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1528.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.04180919802357], "unit": "score", "name": "Richards", "value": 185.75912399999996}, {"lowerIsBetter": false, "replicates": [184.7063169560399], "unit": "score", "name": "DeltaBlue", "value": 357.962852}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [11788.235294117647], "unit": "score", "name": "Boyer", "value": 56.536282435129706}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [611.6504854368932], "unit": "score", "name": "Splay", "value": 133.23131746031743}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19682.640738926646}]} 10:04:57 INFO - RETURN: dromaeo_css: 6158.41 10:04:57 INFO - RETURN: kraken: 1528.70 10:04:57 INFO - RETURN: v8_7: 19682.64 10:04:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19682.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6158.41"}}} 10:04:57 INFO - Return code: 0 10:04:57 INFO - # TBPL SUCCESS # 10:04:57 INFO - Running post-action listener: _resource_record_post_action 10:04:57 INFO - Running post-run listener: _resource_record_post_run 10:04:58 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 503857152; Read time: 0; Write time: 542744 10:04:58 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 125571072; Read time: 0; Write time: 115756 10:04:58 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 343732224; Read time: 0; Write time: 412616 10:04:58 INFO - Running post-run listener: _upload_blobber_files 10:04:58 INFO - Blob upload gear active. 10:04:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:04:58 INFO - Copying logs to upload dir... 10:04:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.909405 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-24 10:04:57.760895) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:04:57.764527) ========= 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-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009852 build_url: 'https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:04:57.815594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:04:57.815936) ========= 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-1448387035.100889-1927429162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:04:57.865992) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:04:57.866322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:04:57.866604) ========= ========= Total master_lag: 0.24 =========