builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1449104555.57 results: success (0) buildid: 20151202163722 builduid: 728272d63cf7468a9e4644a866e75837 revision: 30f9c10a9e5b74e906c60be0c46d35eca049e115 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.569780) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.570230) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.570567) ========= 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=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006423 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.596241) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.596569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.635203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.635591) ========= 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=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.709053) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.709363) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.709727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.710028) ========= 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=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 17:02:35-- 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-12-02 17:02:35 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116512 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.839905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.840248) ========= 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=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022246 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.890204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:35.890583) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30f9c10a9e5b74e906c60be0c46d35eca049e115 --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 30f9c10a9e5b74e906c60be0c46d35eca049e115 --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=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 17:02:36,055 truncating revision to first 12 chars 2015-12-02 17:02:36,055 Setting DEBUG logging. 2015-12-02 17:02:36,055 attempt 1/10 2015-12-02 17:02:36,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30f9c10a9e5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 17:02:36,304 unpacking tar archive at: fx-team-30f9c10a9e5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:36.438904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:36.439215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:36.449778) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:36.450286) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 17:02:36.450772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-02 17:02:36.451209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:02:36 INFO - MultiFileLogger online at 20151202 17:02:36 in /builds/slave/test 17:02:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:02:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:02:36 INFO - {'append_to_log': False, 17:02:36 INFO - 'base_work_dir': '/builds/slave/test', 17:02:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:02:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:02:36 INFO - 'branch': 'Fx-Team-Non-PGO', 17:02:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:02:36 INFO - 'config_files': ('talos/linux_config.py',), 17:02:36 INFO - 'default_actions': ('clobber', 17:02:36 INFO - 'read-buildbot-config', 17:02:36 INFO - 'download-and-extract', 17:02:36 INFO - 'populate-webroot', 17:02:36 INFO - 'create-virtualenv', 17:02:36 INFO - 'install', 17:02:36 INFO - 'run-tests'), 17:02:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:02:36 INFO - 'download_minidump_stackwalk': True, 17:02:36 INFO - 'download_symbols': 'ondemand', 17:02:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:02:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:02:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:02:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:02:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:02:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:02:36 INFO - 'installer_path': 'installer.exe', 17:02:36 INFO - 'log_level': 'info', 17:02:36 INFO - 'log_name': 'talos', 17:02:36 INFO - 'log_to_console': True, 17:02:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:02:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:02:36 INFO - 'opt_config_files': (), 17:02:36 INFO - 'pip_index': False, 17:02:36 INFO - 'sps_profile': False, 17:02:36 INFO - 'sps_profile_interval': 0, 17:02:36 INFO - 'suite': 'dromaeojs-e10s', 17:02:36 INFO - 'system_bits': '64', 17:02:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:02:36 INFO - 'title': 'talos-linux64-ix-025', 17:02:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:02:36 INFO - 'use_talos_json': True, 17:02:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:02:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:02:36 INFO - 'work_dir': 'build'} 17:02:36 INFO - ##### 17:02:36 INFO - ##### Running clobber step. 17:02:36 INFO - ##### 17:02:36 INFO - Running pre-action listener: _resource_record_pre_action 17:02:36 INFO - Running main action method: clobber 17:02:36 INFO - rmtree: /builds/slave/test/build 17:02:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:02:37 INFO - Running post-action listener: _resource_record_post_action 17:02:37 INFO - ##### 17:02:37 INFO - ##### Running read-buildbot-config step. 17:02:37 INFO - ##### 17:02:37 INFO - Running pre-action listener: _resource_record_pre_action 17:02:37 INFO - Running main action method: read_buildbot_config 17:02:37 INFO - Using buildbot properties: 17:02:37 INFO - { 17:02:37 INFO - "properties": { 17:02:37 INFO - "buildnumber": 506, 17:02:37 INFO - "product": "firefox", 17:02:37 INFO - "script_repo_revision": "production", 17:02:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:02:37 INFO - "repository": "", 17:02:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:02:37 INFO - "buildid": "20151202163722", 17:02:37 INFO - "slavename": "talos-linux64-ix-025", 17:02:37 INFO - "pgo_build": "False", 17:02:37 INFO - "basedir": "/builds/slave/test", 17:02:37 INFO - "project": "", 17:02:37 INFO - "platform": "ubuntu64_hw", 17:02:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:02:37 INFO - "slavebuilddir": "test", 17:02:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:02:37 INFO - "branch": "fx-team", 17:02:37 INFO - "repo_path": "integration/fx-team", 17:02:37 INFO - "stage_platform": "linux64", 17:02:37 INFO - "builduid": "728272d63cf7468a9e4644a866e75837", 17:02:37 INFO - "revision": "30f9c10a9e5b74e906c60be0c46d35eca049e115" 17:02:37 INFO - }, 17:02:37 INFO - "sourcestamp": { 17:02:37 INFO - "repository": "", 17:02:37 INFO - "hasPatch": false, 17:02:37 INFO - "project": "", 17:02:37 INFO - "branch": "fx-team-linux64-talos", 17:02:37 INFO - "changes": [ 17:02:37 INFO - { 17:02:37 INFO - "category": null, 17:02:37 INFO - "files": [ 17:02:37 INFO - { 17:02:37 INFO - "url": null, 17:02:37 INFO - "name": "https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:02:37 INFO - } 17:02:37 INFO - ], 17:02:37 INFO - "repository": "", 17:02:37 INFO - "rev": "30f9c10a9e5b74e906c60be0c46d35eca049e115", 17:02:37 INFO - "who": "mozilla@noorenberghe.ca", 17:02:37 INFO - "when": 1449104530, 17:02:37 INFO - "number": 6736418, 17:02:37 INFO - "comments": "Bug 1216986 - Fix usage of nsIURI.host in password manager and prompt code to support IPv6. r=dolske,liuche,kanru", 17:02:37 INFO - "project": "", 17:02:37 INFO - "at": "Wed 02 Dec 2015 17:02:10", 17:02:37 INFO - "branch": "fx-team-linux64-talos", 17:02:37 INFO - "revlink": "", 17:02:37 INFO - "properties": [ 17:02:37 INFO - [ 17:02:37 INFO - "buildid", 17:02:37 INFO - "20151202163722", 17:02:37 INFO - "Change" 17:02:37 INFO - ], 17:02:37 INFO - [ 17:02:37 INFO - "builduid", 17:02:37 INFO - "728272d63cf7468a9e4644a866e75837", 17:02:37 INFO - "Change" 17:02:37 INFO - ], 17:02:37 INFO - [ 17:02:37 INFO - "pgo_build", 17:02:37 INFO - "False", 17:02:37 INFO - "Change" 17:02:37 INFO - ] 17:02:37 INFO - ], 17:02:37 INFO - "revision": "30f9c10a9e5b74e906c60be0c46d35eca049e115" 17:02:37 INFO - } 17:02:37 INFO - ], 17:02:37 INFO - "revision": "30f9c10a9e5b74e906c60be0c46d35eca049e115" 17:02:37 INFO - } 17:02:37 INFO - } 17:02:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:02:37 INFO - Running post-action listener: _resource_record_post_action 17:02:37 INFO - ##### 17:02:37 INFO - ##### Running download-and-extract step. 17:02:37 INFO - ##### 17:02:37 INFO - Running pre-action listener: _resource_record_pre_action 17:02:37 INFO - Running main action method: download_and_extract 17:02:37 INFO - mkdir: /builds/slave/test/build/tests 17:02: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')]} 17:02:37 INFO - https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/test_packages.json 17:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/test_packages.json 17:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:02:46 INFO - Downloaded 1302 bytes. 17:02:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:02:46 INFO - Using the following test package requirements: 17:02:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:02:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:46 INFO - u'jsshell-linux-x86_64.zip'], 17:02:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:02:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:02:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:02:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:02:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:02:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:02:46 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')]} 17:02:46 INFO - https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:50 INFO - Downloaded 21774978 bytes. 17:02:50 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 17:02:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:02:50 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 17:02:51 INFO - Return code: 0 17:02:51 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 17:02:51 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')]} 17:02:51 INFO - https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:02:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:02:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:02:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:53 INFO - Downloaded 21774978 bytes. 17:02:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:02:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:02:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:02:54 INFO - Return code: 0 17:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:54 INFO - https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:02:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:55 INFO - Downloaded 11132001 bytes. 17:02:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 17:02:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:02:55 INFO - Return code: 0 17:02:55 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')]} 17:02:55 INFO - https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:02:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:02:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:02:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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 17:02:58 INFO - Downloaded 57675942 bytes. 17:02:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:02:58 INFO - mkdir: /builds/slave/test/properties 17:02:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:58 INFO - Contents: 17:02:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:02:58 INFO - Running post-action listener: _resource_record_post_action 17:02:58 INFO - Running post-action listener: set_extra_try_arguments 17:02:58 INFO - ##### 17:02:58 INFO - ##### Running populate-webroot step. 17:02:58 INFO - ##### 17:02:58 INFO - Running pre-action listener: _resource_record_pre_action 17:02:58 INFO - Running main action method: populate_webroot 17:02:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:02:58 INFO - '../fennec_ids.txt'], 17:02:58 INFO - 'tests': ['tcheck2']}, 17:02:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:58 INFO - '--tppagecycles', 17:02:58 INFO - '7'], 17:02:58 INFO - 'tests': ['tsvgm']}}, 17:02:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:02:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:02:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:02:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'tests': ['damp', 'tps']}, 17:02:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['damp', 'tps']}, 17:02:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:02:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:58 INFO - 'other': {'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore']}, 17:02:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore']}, 17:02:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore']}, 17:02:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore']}, 17:02:58 INFO - 'other_l64': {'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore']}, 17:02:58 INFO - 'other_nol64': {'tests': ['a11yr', 17:02:58 INFO - 'ts_paint', 17:02:58 INFO - 'tpaint', 17:02:58 INFO - 'sessionrestore', 17:02:58 INFO - 'sessionrestore_no_auto_restore']}, 17:02:58 INFO - 'svgr': {'tests': ['tsvgx', 17:02:58 INFO - 'tsvgr_opacity', 17:02:58 INFO - 'tart', 17:02:58 INFO - 'tscrollx', 17:02:58 INFO - 'cart']}, 17:02:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['tsvgx', 17:02:58 INFO - 'tsvgr_opacity', 17:02:58 INFO - 'tart', 17:02:58 INFO - 'tscrollx', 17:02:58 INFO - 'cart']}, 17:02:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'tests': ['tp5o']}, 17:02:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--e10s'], 17:02:58 INFO - 'tests': ['tp5o']}, 17:02:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--xperf_path', 17:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:58 INFO - 'tests': ['tp5n']}, 17:02:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:58 INFO - 'talos_options': ['--e10s', 17:02:58 INFO - '--xperf_path', 17:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:58 INFO - 'tests': ['tp5n']}}, 17:02:58 INFO - 'talos.zip': {'path': '', 17:02:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:58 INFO - Running post-action listener: _resource_record_post_action 17:02:58 INFO - ##### 17:02:58 INFO - ##### Running create-virtualenv step. 17:02:58 INFO - ##### 17:02:58 INFO - Running pre-action listener: _resource_record_pre_action 17:02:58 INFO - Running main action method: create_virtualenv 17:02:58 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:58 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 17:02:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:58 INFO - Using real prefix '/usr' 17:02:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:59 INFO - Installing distribute.............................................................................................................................................................................................done. 17:03:01 INFO - Installing pip.................done. 17:03:01 INFO - Return code: 0 17:03:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:03:01 INFO - Using env: {'DISPLAY': ':0', 17:03:01 INFO - 'HOME': '/home/cltbld', 17:03:01 INFO - 'LANG': 'en_US.UTF-8', 17:03:01 INFO - 'LANGUAGE': 'en_US:en', 17:03:01 INFO - 'LOGNAME': 'cltbld', 17:03:01 INFO - 'MAIL': '/var/mail/cltbld', 17:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:01 INFO - 'MOZ_NO_REMOTE': '1', 17:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:01 INFO - 'NO_EM_RESTART': '1', 17:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:01 INFO - 'PWD': '/builds/slave/test', 17:03:01 INFO - 'SHELL': '/bin/bash', 17:03:01 INFO - 'SHLVL': '1', 17:03:01 INFO - 'TERM': 'linux', 17:03:01 INFO - 'TMOUT': '86400', 17:03:01 INFO - 'USER': 'cltbld', 17:03:01 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:01 INFO - '_': '/tools/buildbot/bin/python'} 17:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:01 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 17:03:01 INFO - Cleaning up... 17:03:01 INFO - Return code: 0 17:03:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:03:01 INFO - Using env: {'DISPLAY': ':0', 17:03:01 INFO - 'HOME': '/home/cltbld', 17:03:01 INFO - 'LANG': 'en_US.UTF-8', 17:03:01 INFO - 'LANGUAGE': 'en_US:en', 17:03:01 INFO - 'LOGNAME': 'cltbld', 17:03:01 INFO - 'MAIL': '/var/mail/cltbld', 17:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:01 INFO - 'MOZ_NO_REMOTE': '1', 17:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:01 INFO - 'NO_EM_RESTART': '1', 17:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:01 INFO - 'PWD': '/builds/slave/test', 17:03:01 INFO - 'SHELL': '/bin/bash', 17:03:01 INFO - 'SHLVL': '1', 17:03:01 INFO - 'TERM': 'linux', 17:03:01 INFO - 'TMOUT': '86400', 17:03:01 INFO - 'USER': 'cltbld', 17:03:01 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:01 INFO - '_': '/tools/buildbot/bin/python'} 17:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:01 INFO - Downloading/unpacking psutil>=0.7.1 17:03:01 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 17:03:01 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 17:03:01 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 17:03:01 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 17:03:01 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 17:03:01 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 17:03:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:03:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:03 INFO - Installing collected packages: psutil 17:03:03 INFO - Running setup.py install for psutil 17:03:03 INFO - building 'psutil._psutil_linux' extension 17:03:03 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 17:03:03 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 17:03:03 INFO - building 'psutil._psutil_posix' extension 17:03:03 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 17:03:03 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 17:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:03 INFO - Successfully installed psutil 17:03:03 INFO - Cleaning up... 17:03:03 INFO - Return code: 0 17:03:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:03:03 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')]} 17:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:03 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')]} 17:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:03 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 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:03 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 17:03:03 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 17:03:03 INFO - Using env: {'DISPLAY': ':0', 17:03:03 INFO - 'HOME': '/home/cltbld', 17:03:03 INFO - 'LANG': 'en_US.UTF-8', 17:03:03 INFO - 'LANGUAGE': 'en_US:en', 17:03:03 INFO - 'LOGNAME': 'cltbld', 17:03:03 INFO - 'MAIL': '/var/mail/cltbld', 17:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:03 INFO - 'MOZ_NO_REMOTE': '1', 17:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:03 INFO - 'NO_EM_RESTART': '1', 17:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:03 INFO - 'PWD': '/builds/slave/test', 17:03:03 INFO - 'SHELL': '/bin/bash', 17:03:03 INFO - 'SHLVL': '1', 17:03:03 INFO - 'TERM': 'linux', 17:03:03 INFO - 'TMOUT': '86400', 17:03:03 INFO - 'USER': 'cltbld', 17:03:03 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:03 INFO - '_': '/tools/buildbot/bin/python'} 17:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:03:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:03:05 INFO - Installing collected packages: mozsystemmonitor 17:03:05 INFO - Running setup.py install for mozsystemmonitor 17:03:06 INFO - Successfully installed mozsystemmonitor 17:03:06 INFO - Cleaning up... 17:03:06 INFO - Return code: 0 17:03:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:03:06 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')]} 17:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:06 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')]} 17:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:06 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 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:06 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 17:03:06 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 17:03:06 INFO - Using env: {'DISPLAY': ':0', 17:03:06 INFO - 'HOME': '/home/cltbld', 17:03:06 INFO - 'LANG': 'en_US.UTF-8', 17:03:06 INFO - 'LANGUAGE': 'en_US:en', 17:03:06 INFO - 'LOGNAME': 'cltbld', 17:03:06 INFO - 'MAIL': '/var/mail/cltbld', 17:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:06 INFO - 'MOZ_NO_REMOTE': '1', 17:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:06 INFO - 'NO_EM_RESTART': '1', 17:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:06 INFO - 'PWD': '/builds/slave/test', 17:03:06 INFO - 'SHELL': '/bin/bash', 17:03:06 INFO - 'SHLVL': '1', 17:03:06 INFO - 'TERM': 'linux', 17:03:06 INFO - 'TMOUT': '86400', 17:03:06 INFO - 'USER': 'cltbld', 17:03:06 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:06 INFO - '_': '/tools/buildbot/bin/python'} 17:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:06 INFO - Downloading/unpacking blobuploader==1.2.4 17:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:03:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:03:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:03:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:08 INFO - Downloading docopt-0.6.1.tar.gz 17:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:03:08 INFO - Installing collected packages: blobuploader, requests, docopt 17:03:08 INFO - Running setup.py install for blobuploader 17:03:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:03:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:03:08 INFO - Running setup.py install for requests 17:03:09 INFO - Running setup.py install for docopt 17:03:09 INFO - Successfully installed blobuploader requests docopt 17:03:09 INFO - Cleaning up... 17:03:09 INFO - Return code: 0 17:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03:09 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')]} 17:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:09 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')]} 17:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:09 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 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:09 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 17:03:09 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 17:03:09 INFO - Using env: {'DISPLAY': ':0', 17:03:09 INFO - 'HOME': '/home/cltbld', 17:03:09 INFO - 'LANG': 'en_US.UTF-8', 17:03:09 INFO - 'LANGUAGE': 'en_US:en', 17:03:09 INFO - 'LOGNAME': 'cltbld', 17:03:09 INFO - 'MAIL': '/var/mail/cltbld', 17:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:09 INFO - 'MOZ_NO_REMOTE': '1', 17:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:09 INFO - 'NO_EM_RESTART': '1', 17:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:09 INFO - 'PWD': '/builds/slave/test', 17:03:09 INFO - 'SHELL': '/bin/bash', 17:03:09 INFO - 'SHLVL': '1', 17:03:09 INFO - 'TERM': 'linux', 17:03:09 INFO - 'TMOUT': '86400', 17:03:09 INFO - 'USER': 'cltbld', 17:03:09 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:09 INFO - '_': '/tools/buildbot/bin/python'} 17:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:09 INFO - Running setup.py (path:/tmp/pip-nyOF23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:09 INFO - Running setup.py (path:/tmp/pip-qeGnmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:09 INFO - Running setup.py (path:/tmp/pip-lndoby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:09 INFO - Running setup.py (path:/tmp/pip-FWxWos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:09 INFO - Running setup.py (path:/tmp/pip-FgU7gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:09 INFO - Running setup.py (path:/tmp/pip-Hg7GDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:09 INFO - Running setup.py (path:/tmp/pip-GxRkvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:09 INFO - Running setup.py (path:/tmp/pip-3RojP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:10 INFO - Running setup.py (path:/tmp/pip-2uUtMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:10 INFO - Running setup.py (path:/tmp/pip-tytQfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:10 INFO - Running setup.py (path:/tmp/pip-m7EWZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:10 INFO - Running setup.py (path:/tmp/pip-huN6hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:10 INFO - Running setup.py (path:/tmp/pip-3ItTlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:10 INFO - Running setup.py (path:/tmp/pip-DAtqXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:10 INFO - Running setup.py (path:/tmp/pip-S_vJ1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:10 INFO - Running setup.py (path:/tmp/pip-Wz8hKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:10 INFO - Running setup.py (path:/tmp/pip-lMRcuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:03:10 INFO - Running setup.py install for manifestparser 17:03:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:03:10 INFO - Running setup.py install for mozcrash 17:03:10 INFO - Running setup.py install for mozdebug 17:03:10 INFO - Running setup.py install for mozdevice 17:03:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Running setup.py install for mozfile 17:03:11 INFO - Running setup.py install for mozhttpd 17:03:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Running setup.py install for mozinfo 17:03:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Running setup.py install for mozInstall 17:03:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Running setup.py install for mozleak 17:03:11 INFO - Running setup.py install for mozlog 17:03:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Running setup.py install for moznetwork 17:03:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:03:11 INFO - Running setup.py install for mozprocess 17:03:11 INFO - Running setup.py install for mozprofile 17:03:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:03:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:03:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:03:12 INFO - Running setup.py install for mozrunner 17:03:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:03:12 INFO - Running setup.py install for mozscreenshot 17:03:12 INFO - Running setup.py install for moztest 17:03:12 INFO - Running setup.py install for mozversion 17:03:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:03:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:03:12 INFO - Cleaning up... 17:03:12 INFO - Return code: 0 17:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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', '-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 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:12 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 17:03:12 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 17:03:12 INFO - Using env: {'DISPLAY': ':0', 17:03:12 INFO - 'HOME': '/home/cltbld', 17:03:12 INFO - 'LANG': 'en_US.UTF-8', 17:03:12 INFO - 'LANGUAGE': 'en_US:en', 17:03:12 INFO - 'LOGNAME': 'cltbld', 17:03:12 INFO - 'MAIL': '/var/mail/cltbld', 17:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:12 INFO - 'MOZ_NO_REMOTE': '1', 17:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:12 INFO - 'NO_EM_RESTART': '1', 17:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:12 INFO - 'PWD': '/builds/slave/test', 17:03:12 INFO - 'SHELL': '/bin/bash', 17:03:12 INFO - 'SHLVL': '1', 17:03:12 INFO - 'TERM': 'linux', 17:03:12 INFO - 'TMOUT': '86400', 17:03:12 INFO - 'USER': 'cltbld', 17:03:12 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:12 INFO - '_': '/tools/buildbot/bin/python'} 17:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:03:12 INFO - Running setup.py (path:/tmp/pip-TWspYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:03:12 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)) 17:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:03:12 INFO - Running setup.py (path:/tmp/pip-Nh82n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:03:12 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)) 17:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:03:12 INFO - Running setup.py (path:/tmp/pip-rNmtZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:03:12 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)) 17:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:03:12 INFO - Running setup.py (path:/tmp/pip-uX_ZFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:03:12 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)) 17:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:03:12 INFO - Running setup.py (path:/tmp/pip-jzKT8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:03:13 INFO - Running setup.py (path:/tmp/pip-NwZN7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:03:13 INFO - Running setup.py (path:/tmp/pip-_FdV4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:03:13 INFO - Running setup.py (path:/tmp/pip-dPJ8OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:03:13 INFO - Running setup.py (path:/tmp/pip-QRtCWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:03:13 INFO - Running setup.py (path:/tmp/pip-pBhLjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:03:13 INFO - Running setup.py (path:/tmp/pip-PLshz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:03:13 INFO - Running setup.py (path:/tmp/pip-Rwb0Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:03:13 INFO - Running setup.py (path:/tmp/pip-yH9HBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:03:13 INFO - Running setup.py (path:/tmp/pip-Tggwkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:13 INFO - Running setup.py (path:/tmp/pip-R3G22m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:03:13 INFO - Running setup.py (path:/tmp/pip-4X8RSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:03:13 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)) 17:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:03:13 INFO - Running setup.py (path:/tmp/pip-40OWbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:03:13 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)) 17:03:13 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)) 17:03:13 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)) 17:03:13 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)) 17:03:13 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)) 17:03:13 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)) 17:03:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:15 INFO - Downloading blessings-1.5.1.tar.gz 17:03:15 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 17:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:03:15 INFO - Installing collected packages: blessings 17:03:15 INFO - Running setup.py install for blessings 17:03:15 INFO - Successfully installed blessings 17:03:15 INFO - Cleaning up... 17:03:15 INFO - Return code: 0 17:03:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:16 INFO - Reading from file tmpfile_stdout 17:03:16 INFO - Current package versions: 17:03:16 INFO - argparse == 1.2.1 17:03:16 INFO - blessings == 1.5.1 17:03:16 INFO - blobuploader == 1.2.4 17:03:16 INFO - docopt == 0.6.1 17:03:16 INFO - manifestparser == 1.1 17:03:16 INFO - mozInstall == 1.12 17:03:16 INFO - mozcrash == 0.16 17:03:16 INFO - mozdebug == 0.1 17:03:16 INFO - mozdevice == 0.47 17:03:16 INFO - mozfile == 1.2 17:03:16 INFO - mozhttpd == 0.7 17:03:16 INFO - mozinfo == 0.9 17:03:16 INFO - mozleak == 0.1 17:03:16 INFO - mozlog == 3.1 17:03:16 INFO - moznetwork == 0.27 17:03:16 INFO - mozprocess == 0.22 17:03:16 INFO - mozprofile == 0.27 17:03:16 INFO - mozrunner == 6.11 17:03:16 INFO - mozscreenshot == 0.1 17:03:16 INFO - mozsystemmonitor == 0.0 17:03:16 INFO - moztest == 0.7 17:03:16 INFO - mozversion == 1.4 17:03:16 INFO - psutil == 3.1.1 17:03:16 INFO - requests == 1.2.3 17:03:16 INFO - wsgiref == 0.1.2 17:03:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:16 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 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:16 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 17:03:16 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 17:03:16 INFO - Using env: {'DISPLAY': ':0', 17:03:16 INFO - 'HOME': '/home/cltbld', 17:03:16 INFO - 'LANG': 'en_US.UTF-8', 17:03:16 INFO - 'LANGUAGE': 'en_US:en', 17:03:16 INFO - 'LOGNAME': 'cltbld', 17:03:16 INFO - 'MAIL': '/var/mail/cltbld', 17:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:16 INFO - 'MOZ_NO_REMOTE': '1', 17:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:16 INFO - 'NO_EM_RESTART': '1', 17:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:16 INFO - 'PWD': '/builds/slave/test', 17:03:16 INFO - 'SHELL': '/bin/bash', 17:03:16 INFO - 'SHLVL': '1', 17:03:16 INFO - 'TERM': 'linux', 17:03:16 INFO - 'TMOUT': '86400', 17:03:16 INFO - 'USER': 'cltbld', 17:03:16 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:16 INFO - '_': '/tools/buildbot/bin/python'} 17:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 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)) 17:03:16 INFO - Cleaning up... 17:03:16 INFO - Return code: 0 17:03:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:16 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:16 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', 'jsonschema'] in /builds/slave/test/build 17:03:16 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 jsonschema 17:03:16 INFO - Using env: {'DISPLAY': ':0', 17:03:16 INFO - 'HOME': '/home/cltbld', 17:03:16 INFO - 'LANG': 'en_US.UTF-8', 17:03:16 INFO - 'LANGUAGE': 'en_US:en', 17:03:16 INFO - 'LOGNAME': 'cltbld', 17:03:16 INFO - 'MAIL': '/var/mail/cltbld', 17:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:16 INFO - 'MOZ_NO_REMOTE': '1', 17:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:16 INFO - 'NO_EM_RESTART': '1', 17:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:16 INFO - 'PWD': '/builds/slave/test', 17:03:16 INFO - 'SHELL': '/bin/bash', 17:03:16 INFO - 'SHLVL': '1', 17:03:16 INFO - 'TERM': 'linux', 17:03:16 INFO - 'TMOUT': '86400', 17:03:16 INFO - 'USER': 'cltbld', 17:03:16 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:16 INFO - '_': '/tools/buildbot/bin/python'} 17:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:16 INFO - Downloading/unpacking jsonschema 17:03:16 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 17:03:16 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 17:03:16 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 17:03:16 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 17:03:16 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 17:03:16 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 17:03:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:03:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:03:18 INFO - Downloading/unpacking functools32 (from jsonschema) 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:03:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:03:18 INFO - warning: no files found matching '*.txt' 17:03:18 INFO - no previously-included directories found matching 'build' 17:03:18 INFO - no previously-included directories found matching 'dist' 17:03:18 INFO - no previously-included directories found matching '.git*' 17:03:18 INFO - Installing collected packages: jsonschema, functools32 17:03:18 INFO - Running setup.py install for functools32 17:03:18 INFO - warning: no files found matching '*.txt' 17:03:18 INFO - no previously-included directories found matching 'build' 17:03:18 INFO - no previously-included directories found matching 'dist' 17:03:18 INFO - no previously-included directories found matching '.git*' 17:03:18 INFO - Successfully installed jsonschema functools32 17:03:18 INFO - Cleaning up... 17:03:18 INFO - Return code: 0 17:03:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:18 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd10f14df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, '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': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', '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 17:03:18 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', 'flake8'] in /builds/slave/test/build 17:03:18 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 flake8 17:03:18 INFO - Using env: {'DISPLAY': ':0', 17:03:18 INFO - 'HOME': '/home/cltbld', 17:03:18 INFO - 'LANG': 'en_US.UTF-8', 17:03:18 INFO - 'LANGUAGE': 'en_US:en', 17:03:18 INFO - 'LOGNAME': 'cltbld', 17:03:18 INFO - 'MAIL': '/var/mail/cltbld', 17:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:18 INFO - 'MOZ_NO_REMOTE': '1', 17:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:18 INFO - 'NO_EM_RESTART': '1', 17:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:18 INFO - 'PWD': '/builds/slave/test', 17:03:18 INFO - 'SHELL': '/bin/bash', 17:03:18 INFO - 'SHLVL': '1', 17:03:18 INFO - 'TERM': 'linux', 17:03:18 INFO - 'TMOUT': '86400', 17:03:18 INFO - 'USER': 'cltbld', 17:03:18 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:18 INFO - '_': '/tools/buildbot/bin/python'} 17:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:18 INFO - Downloading/unpacking flake8 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:18 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 17:03:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:03:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:03:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:03:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:03:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:03:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:03:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:03:21 INFO - no previously-included directories found matching 'docs/_build' 17:03:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:03:21 INFO - Running setup.py install for pep8 17:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:03:21 INFO - no previously-included directories found matching 'docs/_build' 17:03:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:03:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:03:21 INFO - Cleaning up... 17:03:21 INFO - Return code: 0 17:03:21 INFO - Running post-action listener: _resource_record_post_action 17:03:21 INFO - Running post-action listener: _start_resource_monitoring 17:03:21 INFO - Starting resource monitoring. 17:03:21 INFO - ##### 17:03:21 INFO - ##### Running install step. 17:03:21 INFO - ##### 17:03:21 INFO - Running pre-action listener: _resource_record_pre_action 17:03:21 INFO - Running main action method: install 17:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:03:21 INFO - Reading from file tmpfile_stdout 17:03:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:03:21 INFO - Reading from file tmpfile_stdout 17:03:21 INFO - Output received: 17:03:21 INFO - Usage: mozinstall [options] installer 17:03:21 INFO - Options: 17:03:21 INFO - -h, --help show this help message and exit 17:03:21 INFO - -d DEST, --destination=DEST 17:03:21 INFO - Directory to install application into. [default: 17:03:21 INFO - "/builds/slave/test"] 17:03:21 INFO - --app=APP Application being installed. [default: firefox] 17:03:21 INFO - mkdir: /builds/slave/test/build/application 17:03:21 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'] 17:03:21 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 17:03:36 INFO - Reading from file tmpfile_stdout 17:03:36 INFO - Output received: 17:03:36 INFO - /builds/slave/test/build/application/firefox/firefox 17:03:36 INFO - Running post-action listener: _resource_record_post_action 17:03:36 INFO - ##### 17:03:36 INFO - ##### Running run-tests step. 17:03:36 INFO - ##### 17:03:36 INFO - Running pre-action listener: _resource_record_pre_action 17:03:36 INFO - Running main action method: run_tests 17:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:03:36 INFO - Python 2.7.3 17:03:36 INFO - Return code: 0 17:03:36 INFO - grabbing minidump binary from tooltool 17:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:36 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 0x11000b0>, '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 0x1100fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:03:36 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 17:03:36 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 17:03:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:03:36 INFO - Return code: 0 17:03:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:03:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:03:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:03:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:03:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:03:37 INFO - Return code: 0 17:03: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 17:03: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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 17:03:37 INFO - Using env: {'DISPLAY': ':0', 17:03:37 INFO - 'HOME': '/home/cltbld', 17:03:37 INFO - 'LANG': 'en_US.UTF-8', 17:03:37 INFO - 'LANGUAGE': 'en_US:en', 17:03:37 INFO - 'LOGNAME': 'cltbld', 17:03:37 INFO - 'MAIL': '/var/mail/cltbld', 17:03:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:03:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:37 INFO - 'MOZ_NO_REMOTE': '1', 17:03:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:37 INFO - 'NO_EM_RESTART': '1', 17:03:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:37 INFO - 'PWD': '/builds/slave/test', 17:03:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:03:37 INFO - 'SHELL': '/bin/bash', 17:03:37 INFO - 'SHLVL': '1', 17:03:37 INFO - 'TERM': 'linux', 17:03:37 INFO - 'TMOUT': '86400', 17:03:37 INFO - 'USER': 'cltbld', 17:03:37 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449104310.982004-2132606872', 17:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:37 INFO - '_': '/tools/buildbot/bin/python'} 17:03: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 17:03:37 INFO - mozversion INFO | application_buildid: 20151202163722 17:03:37 INFO - mozversion INFO | application_changeset: 30f9c10a9e5b74e906c60be0c46d35eca049e115 17:03:37 INFO - mozversion INFO | application_display_name: Nightly 17:03:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:03:37 INFO - mozversion INFO | application_name: Firefox 17:03:37 INFO - mozversion INFO | application_remotingname: firefox 17:03:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:03:37 INFO - mozversion INFO | application_vendor: Mozilla 17:03:37 INFO - mozversion INFO | application_version: 45.0a1 17:03:37 INFO - mozversion INFO | platform_buildid: 20151202163722 17:03:37 INFO - mozversion INFO | platform_changeset: 30f9c10a9e5b74e906c60be0c46d35eca049e115 17:03:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:03:37 INFO - mozversion INFO | platform_version: 45.0a1 17:03:37 INFO - 2015-12-02 17:03:37,441 DEBUG : using testdate: 1449104617 17:03:37 INFO - 2015-12-02 17:03:37,442 DEBUG : actual date: 1449104617 17:03:37 INFO - 2015-12-02 17:03:37,450 INFO : starting webserver on 'localhost:35603' 17:03:37 INFO - 2015-12-02 17:03:37,451 INFO : Starting test suite talos-linux64-ix-025.e 17:03:37 INFO - 2015-12-02 17:03:37,451 INFO : Starting test dromaeo_css 17:03:37 INFO - 2015-12-02 17:03:37,451 DEBUG : operating with platform_type : linux_ 17:03:37 INFO - 2015-12-02 17:03:37,452 INFO : Initialising browser for dromaeo_css test... 17:03:37 INFO - 2015-12-02 17:03:37,464 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpskSw/profile http://localhost:35603/getInfo.html 17:03:42 INFO - 2015-12-02 17:03:42,577 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:03:42 INFO - 2015-12-02 17:03:42,577 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:03:42 INFO - 2015-12-02 17:03:42,577 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:03:42 INFO - 2015-12-02 17:03:42,577 DEBUG : BROWSER_OUTPUT: __metrics 17:03:42 INFO - 2015-12-02 17:03:42,714 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:03:43 INFO - 2015-12-02 17:03:43,661 INFO : Browser initialized. 17:03:43 INFO - 2015-12-02 17:03:43,662 INFO : Running cycle 1/1 for dromaeo_css test... 17:03:43 INFO - 2015-12-02 17:03:43,662 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpskSw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:03:55 INFO - 2015-12-02 17:03:55,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 143757312 17:03:55 INFO - 2015-12-02 17:03:55,688 DEBUG : BROWSER_OUTPUT: 17:04:45 INFO - 2015-12-02 17:04:45,339 DEBUG : BROWSER_OUTPUT: 1449104685333 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] 17:06:57 INFO - 2015-12-02 17:06:57,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35603/tests/dromaeo/cssquery-ext.html) 17:06:58 INFO - 2015-12-02 17:06:58,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 147034112 17:06:58 INFO - 2015-12-02 17:06:58,156 DEBUG : BROWSER_OUTPUT: 17:10:00 INFO - 2015-12-02 17:10:00,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/dromaeo/cssquery-ext.html (next: http://localhost:35603/tests/dromaeo/cssquery-jquery.html) 17:10:00 INFO - 2015-12-02 17:10:00,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 144822272 17:10:00 INFO - 2015-12-02 17:10:00,646 DEBUG : BROWSER_OUTPUT: 17:13:02 INFO - 2015-12-02 17:13:02,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35603/tests/dromaeo/cssquery-mootools.html) 17:13:03 INFO - 2015-12-02 17:13:03,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 146432000 17:13:03 INFO - 2015-12-02 17:13:03,030 DEBUG : BROWSER_OUTPUT: 17:16:04 INFO - 2015-12-02 17:16:04,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35603/tests/dromaeo/cssquery-prototype.html) 17:16:05 INFO - 2015-12-02 17:16:05,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 144949248 17:16:05 INFO - 2015-12-02 17:16:05,407 DEBUG : BROWSER_OUTPUT: 17:19:08 INFO - 2015-12-02 17:19:08,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35603/tests/dromaeo/cssquery-yui.html) 17:19:08 INFO - 2015-12-02 17:19:08,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 144818176 17:19:08 INFO - 2015-12-02 17:19:08,604 DEBUG : BROWSER_OUTPUT: 17:22:10 INFO - 2015-12-02 17:22:10,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/dromaeo/cssquery-yui.html (next: http://localhost:35603/tests/dromaeo/cssquery-dojo.html) 17:22:11 INFO - 2015-12-02 17:22:11,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 147976192 17:22:11 INFO - 2015-12-02 17:22:11,229 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,231 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:22:11 INFO - 2015-12-02 17:22:11,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:22:11 INFO - 2015-12-02 17:22:11,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:22:11 INFO - 2015-12-02 17:22:11,231 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:22:11 INFO - 2015-12-02 17:22:11,233 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2668.2395517277578;2708.674959004917;2738.657667791526;2749.3126718320414;2762.337039110614;4579.862604121881;4749.762511874405;4773.904521909564;4778.139934811733;4853.1264372413;4668.229742092551;4708.293755936611;4720.008798152384;4800.039992001596;4812.975935120319;4266.616004559589;4353.976815448367;4410.404595379631;4419.668524860632;4470.798814053359;4068.6745060395247;4403.339499075132;4424.712393694415;4485.618722408599;4496.437945256843;4290.592393722607;4293.742375457483;4389.714668546534;4397.780110994469;4417.939694473335;4330.956690433119;4339.956600433987;4348.456442944632;4371.693981421302;4442.844500442501;4150.315197992328;4311.28863737483;4327.0480494291205;4346.4349634547625;4370.650347972155;4566.10960862632;4622.2835460503675;4623.976880115578;4640.466346370177;4676.649251306166;5073.416557095944;5077.949220507821;5097.46476619957;5113;5123.129068058439;4913.336699545587;4988.850334489971;5050.646454748169;5126.307948426989;5183.015227106837;4740.644451666139;4776.307435421844;4777.856664300077;4781.474037855833;4818.855434336975;5241;5255.185446255837;5256.316678831804;5260.710660913686;5266.4470230626;4774.259989701602;4880.731559764176;4890.388701412324;5027.4721154279005;5092.337996060489;5098.719570423662;5117.1045067113855;5137.791176208072;5146.974265128725;5154.14956532168;5063.518965698253;5077.339945807022;5081.085404627129;5085.872853178626;5093.439721630618;4779.593734532534;4915.213565829522;4916.70499770015;4947.975260123676;4997.400311962588;4188.434561334181;4236.9788151059665;4247.384129301296;4265.1043280910735;4297.05464797744;3601.4777857211084;3723.832427540767;3744.1014156602764;3766.2655782122224;3774.169682669808;4329.285667864767;4346.521882592912;4439.66702497314;4448.065906159743;4491.169133710274;4998.175301075355;5019.14674505335;5032.949670503248;5058.747062646853;5091.490850914879;4219.324908014764;4296.742195468282;4340.348947657813;4342.6308763754805;4416.138852923649;4354.194474022316;4446.177457170434;4451.421315228999;4461.286194208911;4502.077074199781;4870.975645121752;4900.117978763857;4902.166631672553;4915.21356582945;4965;4879.682820616648;4998.400191976986;5009.949900500948;5106.361704786902;5169.586433085419;4764.237721964469;4775.95224047769;4825.252085926687;4863.197572400514;4868.294097355934;4995.550400463976;5013.072581572275;5020.974895125501;5022;5068.543831055223;4828;5051.823186188466;5054.16606259963;5054.772535235997;5123.513266239701;4807.543283388072;4918.311436398979;4983.626228032985;5007.974960125176;5056.595472362129;4887.095887260868;4891.828785992473;4893.8042478301895;4896.241082632056;4930;4645.907081858411;4792.003674635072;4803.471618121934;4809.735464549483;4828.734419606815;4886.560209581155;4965.106280869334;4975.179095449211;4994.775235114356;5030.8239211627415;4807.543283388072;4853.733044682435;4866.270059491105;4882.731449770296;4914.975425122851 17:22:11 INFO - 2015-12-02 17:22:11,236 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.7803300646733;555.616624529075;558.5029323901725;567.9630823996439;571.3515160293068;27225.31936701581;36895.26209475809;36923;37064.258714825686;37296.813515932416;39196.412053819215;39553.802230988804;39807.80096099523;39864.80067599658;39893.20213595726;7647.082350117979;7747.418943579226;7766.805829854242;7783.610819459004;7791.026121734783;7699.230076992284;7815.609219539028;7836.68653253872;7885.60571971402;7921.485103468285;7885.487443316166;7959.522428654299;7966.760997170065;7975.122736498981;7978.202179782033;7873.133955264945;7958.6418611162635;7983.560904150269;7991.280784729344;7998.0402351717585;7771.417143714244;7880.369570434352;7933.127355990837;7949.443538952276;7953.721619743281;36214.275714485826;36578.8171059143;36653;36662.63337366619;36668.63331366706;2907;2987.357718090621;3186.4105140549073;3354.563906692139;3497.2655742293896;27341.316467088283;27390.452190956068;27480.312992175157;27769.305767355978;27900.581491277648;3181.077487528614;3210.2616398228306;3239.49787782894;3253.96746032539;3288.128645908836;209385;209552.9999999985;210218;210278;210282;50261.24608130881;50410.243846341604;50487.24269135966;50493.49506504962;50751.23873141906;46387.30419043717;47452.525474745504;59317.70341148267;60714;60819.69590152021;13773.655658608615;13888.097273677178;13927.651808704863;13962.790558141636;13985;9966.451845148586;9997.700068997941;10023.2482563808;10034.899651003543;10050.447225402528;17289.91355043242;17398.652026959644;17531.64936701259;17562.121893905252;17565.155658655658;7503.399728021745;7684.46208765381;7750.660454152732;7829.804254893559;7853.175416581176;846.9322454203649;860.3633311349681;862.9913700862911;908.504864848659;985.5417230987625;23939.16212932539;23958.281251562483;24022.51954960891;24025.639615405784;24196.637050444257;982.5234761140841;1034.7620047388991;1062.6865074802952;1083.344576531203;1124.8087825069758;11994.500687414073;12254.326012069421;12286.631401057983;12318.568850090203;12353.814692779615;271750.6412467925;275561;276657;276869;276992;43754.34368484475;44155.55844441515;44160.558394416286;44244.778776105915;44276.33585496156;1190.595197632809;1212.8726483719258;1221.432034104146;1229.8216758569956;1234.8456442944453;23383.41541461477;24645;25550;25770.613440798777;27995.720042799312;40038.19923601453;40331.79834100811;40676.3898541528;40741.38887916743;40896.18207635771;221816;224938;225290;225371;225374;28127.71872281251;30242.395152097273;30803.84598076995;30867;30901.227469313446;36187.81906090453;36728.63271367359;36819.26361472702;36948.815255923546;36990;31316.686833131378;31324;31508.842455787573;32096.839515802272;32209.355812883143;31161.532577011818;31724.841375793898;31772.523412148374;31807.204819879687;31862;32174.678253218106;32557.837210813796;32590.348193035534;33026.33947320992;33158.83420582882;26388.868055659597;27027;28306.85846570754;29401;31433;22746.772532274466;23145.768542314363;23485.840522196017;23819.761802382447;25378.746212537637 17:22:11 INFO - 2015-12-02 17:22:11,238 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.11900048370114;329.31831109603115;334.5032626549573;334.58177278401996;334.65697659898615;14649.70700585989;14975;15263.236838158104;15804;16490.58773530659;9971.10260076593;10010.04904534068;10010.349327293721;12610.054245931546;14568.417263309455;4451.287793952968;4525.0949810037955;4576.222042252808;4591.65562582806;4623.606993405565;4887.902241955158;4947.876303092416;4969.602431805465;4977;4982.651214414992;3306.470964645657;3474.391981403257;4912.410510738717;4916.0905232532095;5004.474530174334;5097;5131.358580177478;5144.202648589475;5157.071727089123;5157.329547158864;4896.951030489685;5027.84916452507;5059.494050594948;5076.568491678212;5101.540861322499;11386.943065284704;11426.428678566039;13976.860231397657;18862.811371886244;18955.81044189554;1807.6023274879506;1869.2242719271485;1870.2238570993022;1894.725264836591;1966.2233417800032;8836.823263534694;8943;9256.814863702755;11076.944615276952;12617.432215550321;1703.2590822991915;1712.3578658003248;1735.5314065202451;1766.655502177076;1786.88385254958;53839.46160538384;55607;56081.71959140219;56139.43860561424;56628.716856415864;9411.670591529264;9627.711168664951;9752.707418777449;9804.313698041211;9822.066903644143;12380.133390662568;12380.752384952251;12384.31886246247;12387.938060309642;12388.62834114978;6965.33829286217;7054.2240353561065;7065.823354416078;7166.068411106523;7268.491205615662;6675.732970681119;6707.1616047994;6848.657567121723;6910.550814197061;6976.127984002;4089.0799570097083;4123.402106694512;4130.112025914443;4144.171165766858;4167.020750123718;1740;1761.9647607048043;1768.1071059115066;1778.9555261118576;1815.9092045397676;359.16824196597145;364.9087728067983;864.2394692670409;869.5000374784524;1031.566741968375;9497.762555936019;9588.856167157499;9686.515674216262;9784.070513301225;9881.160101391462;385.5104017897255;390.49235993208714;391.79430798830845;402.971791974559;428.4301878501585;5146.665466744649;5307.787688492417;5340.465953404706;5394.730263486888;5455.536279416215;476051;488040;491981;493784;502436;70935.58128837394;71123.50510002645;71368.83133713143;71717;71909.86545741391;414.9564295748903;417.40936574746394;417.90597115648734;421.1240619511409;422.0819717115262;8876.112388761072;8993.460392376479;9076.909230907606;9131.315151363542;9145.314101442551;29698.703012969592;29923.70076299296;30373.392532149675;30663.54004689976;30836;42051.57948420599;43400.348994765736;43913.34129987989;44445;45259.54740452685;8532.70135545253;8605.569721514024;8638.26574741154;8679.435836670596;8852.24755895756;10062.798744024933;14036.78944815808;15781.28984195691;16103.75844362359;16283.592910176867;12684.365781711062;13074.477020919057;13237.933810330887;13715.245661488714;13900.304984750925;9757.414555126716;12326;12504;12949.935250323688;13104.410301536644;12458.252504849737;13181.538646147339;13261.403236854172;13424.463021479422;13493.730125397633;8463.66145354179;8494.957525212334;8625.525596092275;8655.6970506032;8685.174908383693;12731;12972.935135324264;13065.281409522568;13158.868411315765;13159.144655597356 17:22:11 INFO - 2015-12-02 17:22:11,239 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1338.9196648201103;1376.5732622886899;1393.2824595333398;1633.436464419775;1724.862011039117;6344.6510441925675;6482.935170648292;7118.822029449267;7291.598962057092;7317.634118294084;6979.965100174505;7191.280871912806;7256.8911466328045;7291.963540182305;7296.781096567098;2064.246550009247;2095.266656670161;2095.905684244213;2097.129691178159;2098.5697931923996;2020.959580808383;2039.3168288623328;2048.498117961102;2053.219776484934;2055.445029841942;2037.8981050947468;2062.618415593113;2069.6998935154393;2070.7618623858298;2071.140476702167;2093.706881036656;2102.484891201658;2103.316422162803;2104.757952835413;2105.0948092320295;2028.2495476673726;2040.2043203150783;2050.98974505128;2064.7935206479383;2069.9379018629465;7280.927190728131;7287.599182044985;7313.524620899624;7319.634018299063;7373.29953654402;4168.7081904266715;4233.174530966432;4235.512916014636;4263.275243208631;4267.551907049746;2703.5268827955224;2710.4579084183047;2738.4659991301705;2804.340979869729;2809.3819359740824;887.0552861202798;894.8344556257048;896.6996056321141;907.1246247371319;945.1588086602928;9477.526123693788;9481.383710058824;9591.760205994837;9600.471974041426;9706.223502119885;3853.5183102112237;3863.690904727615;3931.9606803932165;3948.861789837342;3952.0317522207242;8481.363897707697;8487.575621218914;8489.575521224038;8495.787605309917;8517.914820851713;4259.5527469615245;4260.126674031816;4278.55075217104;4289.785510724514;4305.182015417061;3361.2605226850055;3461.2558299965626;3792.3173828711097;3891.6886649068006;3901.044244160199;3447.5690538682666;3467.6185619581825;3472.722182225416;3485.2855164691177;3506.7545271830727;1085.5115198160859;1090.1878100814943;1099.9175061870392;1104.045001074065;1116.4975760907462;1199.91600587958;1200.3338147328143;1208.4139192491634;1221.0841868598552;1227.2145826670937;6839.213490448563;6869.416099631488;6895.827604309932;6905.343992320722;6905.620190889549;413.70213446318604;418.98676857698445;422.391755871544;426.0222788699941;426.1136835382459;5160.380754309507;5224.03355379256;5225.451327610622;5237.240600112962;5245.26566280721;8620.78448038804;8630.180132887366;8832.160944710242;8879.822403552022;8941.642334306685;8791.252743516745;8799.736007919773;8821.955890220508;8829.028806831244;8850.468971861708;6774.695138718868;6781.152355955505;6933.965330173317;6954.826129346807;6992.545484543489;6673.599584024974;6677.198736151693;6681.76613818514;6682.398584127452;6692.0965669635925;7741.45809793309;7785.727499537489;7859.803504912423;7867.13461519221;7957.124716281089;7933.651279282652;7976.800579985546;8010.719624813103;8017.358611311198;8106.39202059836;5582.218489411404;5671.206031155559;6127.387261273837;6477;6577.572457790228;6814.897776533257;6821.386075253251;6831.28271531482;6832.453403727789;6833.248342682202;6504.707288171949;6597.60414375139;6624.867502650017;6733.225679046972;6759.357861003196;6338.778142764981;6553.639549824806;6583.901241481286;6645.933540664531;6654.068430419648;6654.73381064752;6671;6689.397954184147;6740.258571557223;6754.763583274758;5935.584509084495;5985.162077309094;6000.69996500182;6008.489278411384;6009.06859436788;6287.2140982377205;6302.558820882494;6316.178896743394;6327.96836015817;6336.334684858023 17:22:11 INFO - 2015-12-02 17:22:11,242 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.36711071196925;303.2373580445181;303.712991223294;310.08061098841927;312.8341978751263;5539;5552.278203833501;5624.915626265604;5651.180578816079;5651.689157096358;5543.667379957205;5545.223668686387;5550.500454959053;5551.3893471718075;5569.331680198382;4107.589241075899;4270.167317373113;4275.187714334266;4278.914421711564;4285.121550082241;4183.372494125875;4240.321548552232;4253.51084625269;4255.9787201063955;4260.211860805745;4167.458230430055;4204.348326009474;4205.705600607958;4206.537280899099;4214.346776249671;4200.70595058346;4214.578542145791;4217.45173127493;4225.661947044229;4226.788660566959;3651.7991510466913;3656.1225305926387;3658.6890114340313;3662.61542538035;3670.284294562561;5168.250603662485;5237.083510385667;5264.894702105975;5290.894182116374;5304.469553044703;4825.2520859266515;4832.178529649968;4840.346553215341;4840.443349014838;4848.0788650156355;5784.479396854304;5799.710014499258;5801.24583804107;5810.1865738796605;5816.243888294537;3943.507061617298;3957.940630890539;3970.1861118470642;3974.046228905042;3974.5230572331216;5947.167396564484;6043.1841701370195;6072.605280656743;6115.5413343998935;6120.846978825521;4047.251258517125;4065.7153999220363;4082.5713300103657;4083.856520174356;4088.4889388826396;4131.8967025823995;4134.937975930364;4137.648299894482;4144.067584793458;4146.523149837807;4786.44955830077;4789.090072886141;4799.496052914394;4802.903941921212;4805.13507568634;5585.329760428694;5741.942580574224;5763;5808.854778630568;5810.622309549865;1452.6295794572316;1460.5983354577577;1461.7734251191082;1474.8893832962572;1475.7048590281986;973.7808992976524;975.9801007946712;977.2572844638127;992.503748125937;998.9051040151174;5106.540411362995;5114.744262786846;5115.360579927509;5125;5127.333446651986;5954.374790647006;6068.666223357669;6072.878542429126;6098.26820781509;6141.631502109888;5107.106256405114;5119.564836988823;5124.615653825904;5128.076946149654;5144.6913185209005;3247.691469310412;3286.8685252590108;3288.2108294009745;3305.4545999909747;3309.172706823294;5603.495685388335;5695.743691533891;5792.4497172768515;5795.82612521625;5798.362180160179;6214.161088253119;6256.812295631138;6296.0555916612875;6304.18045654062;6311.2426508819235;5811.389804070596;5819.447152520504;5820;5823.679697616587;5835.649861008353;6065.999110146953;6086.360932102066;6088.665123418255;6123.234595675541;6143.877122457615;5842.766289348378;5921.970390148022;5928.67392293428;5963.701814909324;5981.970090149522;5769.711514424346;5780.710964451845;5787.884242315215;5797.681127537857;5820.621659592113;4066.9593304067766;4084.04025054118;4089.5910408958866;4092.5907409260026;4097.6926730495925;5984.730687119003;6088.208532890696;6094.024956007195;6108.02271636536;6114.449699526886;5870.589058766016;5879.882402352015;5882.088276317178;5882.764689412375;5887.322957859729;5853.0635098384055;5862;5869.882602348014;5876.08920617305;5881.117832325185;5595.328560572757;5720.771169153188;5735.512481439125;5737.311522617312;5740.196372507936;5882.49998750111;5899.056151015817;5905.881882362242;5920.763169473173;5920.911186332295;5730.799422020209;5734.856628584319;5737.340205876378;5739.684317362585;5744.224529688438 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.60692601754;739.9060658336904;783.6708582395394;789.9565523896183;800.7517669522447;11450.370229637367;11662.358570278631;11669.474873630686;11698.415079246024;11708;11844.348560829172;12027.879721202786;12166.330851803148;12192.085593580472;12200;794.2057942057928;805.1505661527086;813.9308158806479;814.3322475570035;814.604916615444;798.8162722573811;799.7760627024413;802.9237222463856;802.9437939344248;806.733777853307;840.4201101240155;843.1442086282428;843.8143608406172;845.7674139611595;846.5936350551739;840.7015509494133;841.2512863551383;842.2335674536173;842.5871323051722;843.6330196364601;616.7193926763312;616.8365383173418;618.0420348459915;618.1376979114156;618.437222127866;10129.392236465836;10259.589616415335;10265.743356416075;10277.743056423575;10284.537195826206;9476.431414115175;9792.265580081452;9883.752906177331;9908.455034973074;9909.058639429242;9855.90144098564;9899.307048506607;10024.59901603935;10221.853410783744;10248.12890904274;3250.2849373137874;3262.559554460141;3284.2774589590254;3327.7504187185814;3340.448825943716;34072.31855362903;34546.30907381838;39308.213835723414;40482;41656.58343416588;9210.355275130676;9296.907030929739;9391;9485.573149208301;9668.274879384075;16048.358065677476;16106.114163720873;16115.435959741353;16134;16236.350545978265;6265.154204182468;6424.100625912376;6473.482121430275;6626.734930602722;6677.09859169006;3631.5668502103654;3639.217568222845;3735.084904198489;3739;3764.698824094066;2849.4870923233602;2898.565215217734;2916.6791652918164;2920.6495220573665;2922.0795449433363;481.05712802906;489.77470363632415;493.77779998999875;497.8083437876444;498.9700617962934;573.6558065160954;612.8130920069333;616.3251488539759;622.7260005597523;658.1674182159572;7377;7641.235876412315;7648.426368022309;7709.7301594443925;7957.960210199028;586.2876604925036;600.8557946092993;609.2414943395412;627.97802076928;641.1440726629908;3558.5729712434154;3692.590355129748;3826.9234615308096;3836.8873026821907;3932.3511620582285;50462.243066354036;50882;51242.74378628083;51362;51469.48530514647;43879.34180987288;44738.32892506615;44963.550364496594;45090.549094508635;45991.54008459939;38642.80678596589;39487.80256098701;41287.1742565147;43351.99999999937;43658.56341436545;7847.607619619111;7849.372050235853;7973.202679732212;8188.713395031145;8608.053114157563;30802.691973079982;31750.412479375478;31890.52164217492;32027.67972320247;32046.19884502906;38175.42736859005;38418.231635366574;39094.80452597719;39578.2084358317;39638.60361396349;9722.416655000723;10084.798304034024;10161.644342447978;10251.487425628839;10674.199435042248;10991.450427478754;11037;11197.496112674786;11204.775904482029;11441.256318339281;10317.17462602975;10855;10856.620018299638;11051.171162163031;11369.090472761995;10969.835452468378;11059.336439813636;11067.557297708001;11272.323660580063;11480.196386252883;10354.5340459678;10938.179636527133;11199.888001119885;11207.327560346404;11233.101351891666;8951.41815781972;9135.954320228357;9139.771505712144;9247.491387973727;9384.202342800938;9065.77335566616;9184.954075229582;9215.631374745204;9435.858462122937;9533.380330278787 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,337 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: __startTimestamp1449105731230__endTimestamp 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,243 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4676.60 Median:4812.98 stddev:487.83 (10.1%) stddev-sans-first:463.18 17:22:11 INFO - 2015-12-02 17:22:11,244 DEBUG : BROWSER_OUTPUT: Values: 2668.2 2708.7 2738.7 2749.3 2762.3 4579.9 4749.8 4773.9 4778.1 4853.1 4668.2 4708.3 4720.0 4800.0 4813.0 4266.6 4354.0 4410.4 4419.7 4470.8 4068.7 4403.3 4424.7 4485.6 4496.4 4290.6 4293.7 4389.7 4397.8 4417.9 4331.0 4340.0 4348.5 4371.7 4442.8 4150.3 4311.3 4327.0 4346.4 4370.7 4566.1 4622.3 4624.0 4640.5 4676.6 5073.4 5077.9 5097.5 5113.0 5123.1 4913.3 4988.9 5050.6 5126.3 5183.0 4740.6 4776.3 4777.9 4781.5 4818.9 5241.0 5255.2 5256.3 5260.7 5266.4 4774.3 4880.7 4890.4 5027.5 5092.3 5098.7 5117.1 5137.8 5147.0 5154.1 5063.5 5077.3 5081.1 5085.9 5093.4 4779.6 4915.2 4916.7 4948.0 4997.4 4188.4 4237.0 4247.4 4265.1 4297.1 3601.5 3723.8 3744.1 3766.3 3774.2 4329.3 4346.5 4439.7 4448.1 4491.2 4998.2 5019.1 5032.9 5058.7 5091.5 4219.3 4296.7 4340.3 4342.6 4416.1 4354.2 4446.2 4451.4 4461.3 4502.1 4871.0 4900.1 4902.2 4915.2 4965.0 4879.7 4998.4 5009.9 5106.4 5169.6 4764.2 4776.0 4825.3 4863.2 4868.3 4995.6 5013.1 5021.0 5022.0 5068.5 4828.0 5051.8 5054.2 5054.8 5123.5 4807.5 4918.3 4983.6 5008.0 5056.6 4887.1 4891.8 4893.8 4896.2 4930.0 4645.9 4792.0 4803.5 4809.7 4828.7 4886.6 4965.1 4975.2 4994.8 5030.8 4807.5 4853.7 4866.3 4882.7 4915.0 17:22:11 INFO - 2015-12-02 17:22:11,244 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,244 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39294.94 Median:17905.90 stddev:62100.79 (346.8%) stddev-sans-first:62206.81 17:22:11 INFO - 2015-12-02 17:22:11,244 DEBUG : BROWSER_OUTPUT: Values: 535.8 555.6 558.5 568.0 571.4 27225.3 36895.3 36923.0 37064.3 37296.8 39196.4 39553.8 39807.8 39864.8 39893.2 7647.1 7747.4 7766.8 7783.6 7791.0 7699.2 7815.6 7836.7 7885.6 7921.5 7885.5 7959.5 7966.8 7975.1 7978.2 7873.1 7958.6 7983.6 7991.3 7998.0 7771.4 7880.4 7933.1 7949.4 7953.7 36214.3 36578.8 36653.0 36662.6 36668.6 2907.0 2987.4 3186.4 3354.6 3497.3 27341.3 27390.5 27480.3 27769.3 27900.6 3181.1 3210.3 3239.5 3254.0 3288.1 209385.0 209553.0 210218.0 210278.0 210282.0 50261.2 50410.2 50487.2 50493.5 50751.2 46387.3 47452.5 59317.7 60714.0 60819.7 13773.7 13888.1 13927.7 13962.8 13985.0 9966.5 9997.7 10023.2 10034.9 10050.4 17289.9 17398.7 17531.6 17562.1 17565.2 7503.4 7684.5 7750.7 7829.8 7853.2 846.9 860.4 863.0 908.5 985.5 23939.2 23958.3 24022.5 24025.6 24196.6 982.5 1034.8 1062.7 1083.3 1124.8 11994.5 12254.3 12286.6 12318.6 12353.8 271750.6 275561.0 276657.0 276869.0 276992.0 43754.3 44155.6 44160.6 44244.8 44276.3 1190.6 1212.9 1221.4 1229.8 1234.8 23383.4 24645.0 25550.0 25770.6 27995.7 40038.2 40331.8 40676.4 40741.4 40896.2 221816.0 224938.0 225290.0 225371.0 225374.0 28127.7 30242.4 30803.8 30867.0 30901.2 36187.8 36728.6 36819.3 36948.8 36990.0 31316.7 31324.0 31508.8 32096.8 32209.4 31161.5 31724.8 31772.5 31807.2 31862.0 32174.7 32557.8 32590.3 33026.3 33158.8 26388.9 27027.0 28306.9 29401.0 31433.0 22746.8 23145.8 23485.8 23819.8 25378.7 17:22:11 INFO - 2015-12-02 17:22:11,244 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,244 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25620.66 Median:21914.39 stddev:80234.79 (366.1%) stddev-sans-first:80437.40 17:22:11 INFO - 2015-12-02 17:22:11,245 DEBUG : BROWSER_OUTPUT: Values: 328.1 329.3 334.5 334.6 334.7 14649.7 14975.0 15263.2 15804.0 16490.6 9971.1 10010.0 10010.3 12610.1 14568.4 4451.3 4525.1 4576.2 4591.7 4623.6 4887.9 4947.9 4969.6 4977.0 4982.7 3306.5 3474.4 4912.4 4916.1 5004.5 5097.0 5131.4 5144.2 5157.1 5157.3 4897.0 5027.8 5059.5 5076.6 5101.5 11386.9 11426.4 13976.9 18862.8 18955.8 1807.6 1869.2 1870.2 1894.7 1966.2 8836.8 8943.0 9256.8 11076.9 12617.4 1703.3 1712.4 1735.5 1766.7 1786.9 53839.5 55607.0 56081.7 56139.4 56628.7 9411.7 9627.7 9752.7 9804.3 9822.1 12380.1 12380.8 12384.3 12387.9 12388.6 6965.3 7054.2 7065.8 7166.1 7268.5 6675.7 6707.2 6848.7 6910.6 6976.1 4089.1 4123.4 4130.1 4144.2 4167.0 1740.0 1762.0 1768.1 1779.0 1815.9 359.2 364.9 864.2 869.5 1031.6 9497.8 9588.9 9686.5 9784.1 9881.2 385.5 390.5 391.8 403.0 428.4 5146.7 5307.8 5340.5 5394.7 5455.5 476051.0 488040.0 491981.0 493784.0 502436.0 70935.6 71123.5 71368.8 71717.0 71909.9 415.0 417.4 417.9 421.1 422.1 8876.1 8993.5 9076.9 9131.3 9145.3 29698.7 29923.7 30373.4 30663.5 30836.0 42051.6 43400.3 43913.3 44445.0 45259.5 8532.7 8605.6 8638.3 8679.4 8852.2 10062.8 14036.8 15781.3 16103.8 16283.6 12684.4 13074.5 13237.9 13715.2 13900.3 9757.4 12326.0 12504.0 12949.9 13104.4 12458.3 13181.5 13261.4 13424.5 13493.7 8463.7 8495.0 8625.5 8655.7 8685.2 12731.0 12972.9 13065.3 13158.9 13159.1 17:22:11 INFO - 2015-12-02 17:22:11,245 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,245 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5042.97 Median:6322.07 stddev:2656.13 (42.0%) stddev-sans-first:2648.99 17:22:11 INFO - 2015-12-02 17:22:11,245 DEBUG : BROWSER_OUTPUT: Values: 1338.9 1376.6 1393.3 1633.4 1724.9 6344.7 6482.9 7118.8 7291.6 7317.6 6980.0 7191.3 7256.9 7292.0 7296.8 2064.2 2095.3 2095.9 2097.1 2098.6 2021.0 2039.3 2048.5 2053.2 2055.4 2037.9 2062.6 2069.7 2070.8 2071.1 2093.7 2102.5 2103.3 2104.8 2105.1 2028.2 2040.2 2051.0 2064.8 2069.9 7280.9 7287.6 7313.5 7319.6 7373.3 4168.7 4233.2 4235.5 4263.3 4267.6 2703.5 2710.5 2738.5 2804.3 2809.4 887.1 894.8 896.7 907.1 945.2 9477.5 9481.4 9591.8 9600.5 9706.2 3853.5 3863.7 3932.0 3948.9 3952.0 8481.4 8487.6 8489.6 8495.8 8517.9 4259.6 4260.1 4278.6 4289.8 4305.2 3361.3 3461.3 3792.3 3891.7 3901.0 3447.6 3467.6 3472.7 3485.3 3506.8 1085.5 1090.2 1099.9 1104.0 1116.5 1199.9 1200.3 1208.4 1221.1 1227.2 6839.2 6869.4 6895.8 6905.3 6905.6 413.7 419.0 422.4 426.0 426.1 5160.4 5224.0 5225.5 5237.2 5245.3 8620.8 8630.2 8832.2 8879.8 8941.6 8791.3 8799.7 8822.0 8829.0 8850.5 6774.7 6781.2 6934.0 6954.8 6992.5 6673.6 6677.2 6681.8 6682.4 6692.1 7741.5 7785.7 7859.8 7867.1 7957.1 7933.7 7976.8 8010.7 8017.4 8106.4 5582.2 5671.2 6127.4 6477.0 6577.6 6814.9 6821.4 6831.3 6832.5 6833.2 6504.7 6597.6 6624.9 6733.2 6759.4 6338.8 6553.6 6583.9 6645.9 6654.1 6654.7 6671.0 6689.4 6740.3 6754.8 5935.6 5985.2 6000.7 6008.5 6009.1 6287.2 6302.6 6316.2 6328.0 6336.3 17:22:11 INFO - 2015-12-02 17:22:11,246 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,246 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4823.66 Median:5560.80 stddev:1443.80 (26.0%) stddev-sans-first:1407.25 17:22:11 INFO - 2015-12-02 17:22:11,247 DEBUG : BROWSER_OUTPUT: Values: 294.4 303.2 303.7 310.1 312.8 5539.0 5552.3 5624.9 5651.2 5651.7 5543.7 5545.2 5550.5 5551.4 5569.3 4107.6 4270.2 4275.2 4278.9 4285.1 4183.4 4240.3 4253.5 4256.0 4260.2 4167.5 4204.3 4205.7 4206.5 4214.3 4200.7 4214.6 4217.5 4225.7 4226.8 3651.8 3656.1 3658.7 3662.6 3670.3 5168.3 5237.1 5264.9 5290.9 5304.5 4825.3 4832.2 4840.3 4840.4 4848.1 5784.5 5799.7 5801.2 5810.2 5816.2 3943.5 3957.9 3970.2 3974.0 3974.5 5947.2 6043.2 6072.6 6115.5 6120.8 4047.3 4065.7 4082.6 4083.9 4088.5 4131.9 4134.9 4137.6 4144.1 4146.5 4786.4 4789.1 4799.5 4802.9 4805.1 5585.3 5741.9 5763.0 5808.9 5810.6 1452.6 1460.6 1461.8 1474.9 1475.7 973.8 976.0 977.3 992.5 998.9 5106.5 5114.7 5115.4 5125.0 5127.3 5954.4 6068.7 6072.9 6098.3 6141.6 5107.1 5119.6 5124.6 5128.1 5144.7 3247.7 3286.9 3288.2 3305.5 3309.2 5603.5 5695.7 5792.4 5795.8 5798.4 6214.2 6256.8 6296.1 6304.2 6311.2 5811.4 5819.4 5820.0 5823.7 5835.6 6066.0 6086.4 6088.7 6123.2 6143.9 5842.8 5922.0 5928.7 5963.7 5982.0 5769.7 5780.7 5787.9 5797.7 5820.6 4067.0 4084.0 4089.6 4092.6 4097.7 5984.7 6088.2 6094.0 6108.0 6114.4 5870.6 5879.9 5882.1 5882.8 5887.3 5853.1 5862.0 5869.9 5876.1 5881.1 5595.3 5720.8 5735.5 5737.3 5740.2 5882.5 5899.1 5905.9 5920.8 5920.9 5730.8 5734.9 5737.3 5739.7 5744.2 17:22:11 INFO - 2015-12-02 17:22:11,247 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,247 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12236.76 Median:45541.04 stddev:13823.40 (30.4%) stddev-sans-first:13834.95 17:22:11 INFO - 2015-12-02 17:22:11,247 DEBUG : BROWSER_OUTPUT: Values: 683.6 739.9 783.7 790.0 800.8 11450.4 11662.4 11669.5 11698.4 11708.0 11844.3 12027.9 12166.3 12192.1 12200.0 794.2 805.2 813.9 814.3 814.6 798.8 799.8 802.9 802.9 806.7 840.4 843.1 843.8 845.8 846.6 840.7 841.3 842.2 842.6 843.6 616.7 616.8 618.0 618.1 618.4 10129.4 10259.6 10265.7 10277.7 10284.5 9476.4 9792.3 9883.8 9908.5 9909.1 9855.9 9899.3 10024.6 10221.9 10248.1 3250.3 3262.6 3284.3 3327.8 3340.4 34072.3 34546.3 39308.2 40482.0 41656.6 9210.4 9296.9 9391.0 9485.6 9668.3 16048.4 16106.1 16115.4 16134.0 16236.4 6265.2 6424.1 6473.5 6626.7 6677.1 3631.6 3639.2 3735.1 3739.0 3764.7 2849.5 2898.6 2916.7 2920.6 2922.1 481.1 489.8 493.8 497.8 499.0 573.7 612.8 616.3 622.7 658.2 7377.0 7641.2 7648.4 7709.7 7958.0 586.3 600.9 609.2 628.0 641.1 3558.6 3692.6 3826.9 3836.9 3932.4 50462.2 50882.0 51242.7 51362.0 51469.5 43879.3 44738.3 44963.6 45090.5 45991.5 38642.8 39487.8 41287.2 43352.0 43658.6 7847.6 7849.4 7973.2 8188.7 8608.1 30802.7 31750.4 31890.5 32027.7 32046.2 38175.4 38418.2 39094.8 39578.2 39638.6 9722.4 10084.8 10161.6 10251.5 10674.2 10991.5 11037.0 11197.5 11204.8 11441.3 10317.2 10855.0 10856.6 11051.2 11369.1 10969.8 11059.3 11067.6 11272.3 11480.2 10354.5 10938.2 11199.9 11207.3 11233.1 8951.4 9136.0 9139.8 9247.5 9384.2 9065.8 9185.0 9215.6 9435.9 9533.4 17:22:11 INFO - 2015-12-02 17:22:11,247 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:22:11 INFO - 2015-12-02 17:22:11,247 DEBUG : BROWSER_OUTPUT: 17:22:11 INFO - 2015-12-02 17:22:11,929 INFO : Browser exited with error code: 0 17:22:11 INFO - 2015-12-02 17:22:11,946 INFO : Completed test dromaeo_css (00:18:34) 17:22:11 INFO - 2015-12-02 17:22:11,946 INFO : Starting test kraken 17:22:11 INFO - 2015-12-02 17:22:11,946 DEBUG : operating with platform_type : linux_ 17:22:11 INFO - 2015-12-02 17:22:11,946 INFO : Initialising browser for kraken test... 17:22:11 INFO - 2015-12-02 17:22:11,952 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqdfwS5/profile http://localhost:35603/getInfo.html 17:22:16 INFO - 2015-12-02 17:22:16,633 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:22:16 INFO - 2015-12-02 17:22:16,633 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:22:16 INFO - 2015-12-02 17:22:16,633 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:22:16 INFO - 2015-12-02 17:22:16,633 DEBUG : BROWSER_OUTPUT: __metrics 17:22:16 INFO - 2015-12-02 17:22:16,758 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:22:17 INFO - 2015-12-02 17:22:17,681 INFO : Browser initialized. 17:22:17 INFO - 2015-12-02 17:22:17,682 INFO : Running cycle 1/1 for kraken test... 17:22:17 INFO - 2015-12-02 17:22:17,682 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqdfwS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:22:29 INFO - 2015-12-02 17:22:29,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 143196160 17:22:29 INFO - 2015-12-02 17:22:29,802 DEBUG : BROWSER_OUTPUT: 17:22:32 INFO - 2015-12-02 17:22:32,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35603/tests/kraken/driver.html?testName=audio-beat-detection) 17:22:32 INFO - 2015-12-02 17:22:32,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 142880768 17:22:32 INFO - 2015-12-02 17:22:32,951 DEBUG : BROWSER_OUTPUT: 17:22:35 INFO - 2015-12-02 17:22:35,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35603/tests/kraken/driver.html?testName=audio-dft) 17:22:36 INFO - 2015-12-02 17:22:36,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 141479936 17:22:36 INFO - 2015-12-02 17:22:36,276 DEBUG : BROWSER_OUTPUT: 17:22:39 INFO - 2015-12-02 17:22:39,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35603/tests/kraken/driver.html?testName=audio-fft) 17:22:39 INFO - 2015-12-02 17:22:39,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 17:22:39 INFO - 2015-12-02 17:22:39,755 DEBUG : BROWSER_OUTPUT: 17:22:41 INFO - 2015-12-02 17:22:41,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35603/tests/kraken/driver.html?testName=audio-oscillator) 17:22:42 INFO - 2015-12-02 17:22:42,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 138252288 17:22:42 INFO - 2015-12-02 17:22:42,564 DEBUG : BROWSER_OUTPUT: 17:22:44 INFO - 2015-12-02 17:22:44,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:45 INFO - 2015-12-02 17:22:45,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 140464128 17:22:45 INFO - 2015-12-02 17:22:45,415 DEBUG : BROWSER_OUTPUT: 17:22:48 INFO - 2015-12-02 17:22:48,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35603/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:49 INFO - 2015-12-02 17:22:49,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 139649024 17:22:49 INFO - 2015-12-02 17:22:49,068 DEBUG : BROWSER_OUTPUT: 17:22:52 INFO - 2015-12-02 17:22:52,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35603/tests/kraken/driver.html?testName=imaging-desaturate) 17:22:53 INFO - 2015-12-02 17:22:53,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 140050432 17:22:53 INFO - 2015-12-02 17:22:53,095 DEBUG : BROWSER_OUTPUT: 17:22:55 INFO - 2015-12-02 17:22:55,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35603/tests/kraken/driver.html?testName=json-parse-financial) 17:22:56 INFO - 2015-12-02 17:22:56,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 140386304 17:22:56 INFO - 2015-12-02 17:22:56,574 DEBUG : BROWSER_OUTPUT: 17:22:58 INFO - 2015-12-02 17:22:58,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:58 INFO - 2015-12-02 17:22:58,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 140562432 17:22:58 INFO - 2015-12-02 17:22:58,894 DEBUG : BROWSER_OUTPUT: 17:23:00 INFO - 2015-12-02 17:23:00,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:23:01 INFO - 2015-12-02 17:23:01,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 141172736 17:23:01 INFO - 2015-12-02 17:23:01,406 DEBUG : BROWSER_OUTPUT: 17:23:03 INFO - 2015-12-02 17:23:03,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:23:04 INFO - 2015-12-02 17:23:04,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 141496320 17:23:04 INFO - 2015-12-02 17:23:04,141 DEBUG : BROWSER_OUTPUT: 17:23:06 INFO - 2015-12-02 17:23:06,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:23:07 INFO - 2015-12-02 17:23:07,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 141680640 17:23:07 INFO - 2015-12-02 17:23:07,328 DEBUG : BROWSER_OUTPUT: 17:23:09 INFO - 2015-12-02 17:23:09,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:23:10 INFO - 2015-12-02 17:23:10,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 142131200 17:23:10 INFO - 2015-12-02 17:23:10,531 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35603/tests/kraken/driver.html?testName=ai-astar) 17:23:12 INFO - 2015-12-02 17:23:12,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 141107200 17:23:12 INFO - 2015-12-02 17:23:12,550 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,550 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;112;111;113;123;110;110;110;109 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;151;173;135;158;163;132;168;142 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;167;162;163;163;164;171;162;164;163 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;73;73;72;146;72;78;79;73 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;131;95;95;94;137;94;95;133 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;111;110;112;109;110 17:23:12 INFO - 2015-12-02 17:23:12,551 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;148;147;149;148;148;147 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;99;95;96;96;95;96;96;96 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;74;76;73;72;73;72;75;72;70 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;68;69;69;68 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;85;86;86;86;85;84;84;83 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;125;119;121;125;135;135;126;131;124 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;146;148;148;149;146;148;149;147;140 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;71;69;70;69;70;69;68;68 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,800 17:23:12 INFO - 2015-12-02 17:23:12,552 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:23:12 INFO - 2015-12-02 17:23:12,553 DEBUG : BROWSER_OUTPUT: __startTimestamp1449105792546__endTimestamp 17:23:12 INFO - 2015-12-02 17:23:12,553 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,554 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:23:12 INFO - 2015-12-02 17:23:12,554 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:23:12 INFO - 2015-12-02 17:23:12,554 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,555 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.60 (4.1%) stddev-sans-first:4.88 17:23:12 INFO - 2015-12-02 17:23:12,555 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 112.0 111.0 113.0 123.0 110.0 110.0 110.0 109.0 17:23:12 INFO - 2015-12-02 17:23:12,555 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,555 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:155.50 stddev:15.45 (9.9%) stddev-sans-first:16.36 17:23:12 INFO - 2015-12-02 17:23:12,555 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 151.0 173.0 135.0 158.0 163.0 132.0 168.0 142.0 17:23:12 INFO - 2015-12-02 17:23:12,555 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,556 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.85 (1.7%) stddev-sans-first:2.92 17:23:12 INFO - 2015-12-02 17:23:12,556 DEBUG : BROWSER_OUTPUT: Values: 162.0 167.0 162.0 163.0 163.0 164.0 171.0 162.0 164.0 163.0 17:23:12 INFO - 2015-12-02 17:23:12,556 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,556 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:73.00 stddev:22.99 (31.5%) stddev-sans-first:24.20 17:23:12 INFO - 2015-12-02 17:23:12,556 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 73.0 73.0 72.0 146.0 72.0 78.0 79.0 73.0 17:23:12 INFO - 2015-12-02 17:23:12,556 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,557 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.50 stddev:18.94 (20.0%) stddev-sans-first:19.56 17:23:12 INFO - 2015-12-02 17:23:12,557 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 131.0 95.0 95.0 94.0 137.0 94.0 95.0 133.0 17:23:12 INFO - 2015-12-02 17:23:12,557 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,557 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 17:23:12 INFO - 2015-12-02 17:23:12,557 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 111.0 110.0 112.0 109.0 110.0 17:23:12 INFO - 2015-12-02 17:23:12,557 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,558 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:23:12 INFO - 2015-12-02 17:23:12,558 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 148.0 147.0 149.0 148.0 148.0 147.0 17:23:12 INFO - 2015-12-02 17:23:12,558 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,558 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.10 (1.1%) stddev-sans-first:1.17 17:23:12 INFO - 2015-12-02 17:23:12,559 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 99.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 17:23:12 INFO - 2015-12-02 17:23:12,559 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,559 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.90 Median:73.00 stddev:1.73 (2.4%) stddev-sans-first:1.80 17:23:12 INFO - 2015-12-02 17:23:12,560 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 76.0 73.0 72.0 73.0 72.0 75.0 72.0 70.0 17:23:12 INFO - 2015-12-02 17:23:12,560 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,560 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 17:23:12 INFO - 2015-12-02 17:23:12,560 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 68.0 17:23:12 INFO - 2015-12-02 17:23:12,560 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:1.58 (1.9%) stddev-sans-first:1.09 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 85.0 86.0 86.0 86.0 85.0 84.0 84.0 83.0 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:127.50 stddev:5.44 (4.3%) stddev-sans-first:5.72 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: Values: 129.0 125.0 119.0 121.0 125.0 135.0 135.0 126.0 131.0 124.0 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:148.00 stddev:4.55 (3.1%) stddev-sans-first:2.77 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: Values: 135.0 146.0 148.0 148.0 149.0 146.0 148.0 149.0 147.0 140.0 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.03 (1.5%) stddev-sans-first:1.05 17:23:12 INFO - 2015-12-02 17:23:12,562 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 71.0 69.0 70.0 69.0 70.0 69.0 68.0 68.0 17:23:12 INFO - 2015-12-02 17:23:12,563 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:23:12 INFO - 2015-12-02 17:23:12,563 DEBUG : BROWSER_OUTPUT: 17:23:13 INFO - 2015-12-02 17:23:13,453 INFO : Browser exited with error code: 0 17:23:13 INFO - 2015-12-02 17:23:13,502 INFO : Completed test kraken (00:01:01) 17:23:13 INFO - 2015-12-02 17:23:13,502 INFO : Starting test v8_7 17:23:13 INFO - 2015-12-02 17:23:13,502 DEBUG : operating with platform_type : linux_ 17:23:13 INFO - 2015-12-02 17:23:13,502 INFO : Initialising browser for v8_7 test... 17:23:13 INFO - 2015-12-02 17:23:13,508 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDq6nL/profile http://localhost:35603/getInfo.html 17:23:18 INFO - 2015-12-02 17:23:18,277 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:23:18 INFO - 2015-12-02 17:23:18,278 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:23:18 INFO - 2015-12-02 17:23:18,278 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:23:18 INFO - 2015-12-02 17:23:18,278 DEBUG : BROWSER_OUTPUT: __metrics 17:23:18 INFO - 2015-12-02 17:23:18,447 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:23:19 INFO - 2015-12-02 17:23:19,429 INFO : Browser initialized. 17:23:19 INFO - 2015-12-02 17:23:19,430 INFO : Running cycle 1/1 for v8_7 test... 17:23:19 INFO - 2015-12-02 17:23:19,430 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDq6nL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:23:31 INFO - 2015-12-02 17:23:31,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 143245312 17:23:31 INFO - 2015-12-02 17:23:31,462 DEBUG : BROWSER_OUTPUT: 17:23:52 INFO - 2015-12-02 17:23:52,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35603/tests/v8_7/run.html (next: http://localhost:35603/tests/v8_7/run.html) 17:23:53 INFO - 2015-12-02 17:23:53,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 17:23:53 INFO - 2015-12-02 17:23:53,133 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,133 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |0;Richards;164.58196181698486 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.36578171091446 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.2387025228722 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1061.5711252653928 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |5;Earley;693.4812760055479 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 17:23:53 INFO - 2015-12-02 17:23:53,134 DEBUG : BROWSER_OUTPUT: |7;RegExp;25692.30769230769 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: |8;Splay;604.9606775559589 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: __startTimestamp1449105833131__endTimestamp 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:23:53 INFO - 2015-12-02 17:23:53,135 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.58 Median:164.58 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: Values: 164.6 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.37 Median:184.37 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: Values: 184.4 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.24 Median:277.24 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: Values: 277.2 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,136 DEBUG : BROWSER_OUTPUT: Values: 5181.3 17:23:53 INFO - 2015-12-02 17:23:53,137 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,137 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,137 DEBUG : BROWSER_OUTPUT: Values: 1061.6 17:23:53 INFO - 2015-12-02 17:23:53,137 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,137 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:693.48 Median:693.48 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,137 DEBUG : BROWSER_OUTPUT: Values: 693.5 17:23:53 INFO - 2015-12-02 17:23:53,137 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: Values: 12512.5 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: Values: 25692.3 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.96 Median:604.96 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,138 DEBUG : BROWSER_OUTPUT: Values: 605.0 17:23:53 INFO - 2015-12-02 17:23:53,139 DEBUG : BROWSER_OUTPUT: 17:23:53 INFO - 2015-12-02 17:23:53,139 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:23:53 INFO - 2015-12-02 17:23:53,139 DEBUG : BROWSER_OUTPUT: Values: 4830.9 17:23:53 INFO - 2015-12-02 17:23:53,139 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:23:53 INFO - 2015-12-02 17:23:53,139 DEBUG : BROWSER_OUTPUT: 17:23:54 INFO - 2015-12-02 17:23:54,021 INFO : Browser exited with error code: 0 17:23:54 INFO - 2015-12-02 17:23:54,036 INFO : Completed test v8_7 (00:00:40) 17:23:54 INFO - 2015-12-02 17:23:54,147 INFO : Completed test suite (00:20:16) 17:23:54 INFO - 2015-12-02 17:23:54,147 DEBUG : Working with test: dromaeo_css 17:23:54 INFO - 2015-12-02 17:23:54,147 DEBUG : Generating results file: dromaeo_css 17:23:54 INFO - 2015-12-02 17:23:54,148 DEBUG : Working with test: kraken 17:23:54 INFO - 2015-12-02 17:23:54,148 DEBUG : Generating results file: kraken 17:23:54 INFO - 2015-12-02 17:23:54,148 INFO : javascript benchmark 17:23:54 INFO - 2015-12-02 17:23:54,149 DEBUG : Working with test: v8_7 17:23:54 INFO - 2015-12-02 17:23:54,149 DEBUG : Generating results file: v8_7 17:23:54 INFO - 2015-12-02 17:23:54,149 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:23:54 INFO - 2015-12-02 17:23:54,197 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 17:23:54 INFO - 2015-12-02 17:23:54,197 DEBUG : process_Request line: dromaeo_css 6207.50 graph.html#tests=[[72,132,43]] 17:23:54 INFO - 2015-12-02 17:23:54,197 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:23:54 INFO - 2015-12-02 17:23:54,227 DEBUG : process_Request line: kraken 1535.10 graph.html#tests=[[232,132,43]] 17:23:54 INFO - 2015-12-02 17:23:54,227 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:23:54 INFO - 2015-12-02 17:23:54,257 DEBUG : process_Request line: v8_7 21457.42 graph.html#tests=[[230,132,43]] 17:23:54 INFO - 2015-12-02 17:23:54,258 INFO : javascript benchmark 17:23:54 INFO - 2015-12-02 17:23:54,261 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2668.2395517277578, 2708.674959004917, 2738.657667791526, 2749.3126718320414, 2762.337039110614, 4579.862604121881, 4749.762511874405, 4773.904521909564, 4778.139934811733, 4853.1264372413, 4668.229742092551, 4708.293755936611, 4720.008798152384, 4800.039992001596, 4812.975935120319, 4266.616004559589, 4353.976815448367, 4410.404595379631, 4419.668524860632, 4470.798814053359, 4068.6745060395247, 4403.339499075132, 4424.712393694415, 4485.618722408599, 4496.437945256843, 4290.592393722607, 4293.742375457483, 4389.714668546534, 4397.780110994469, 4417.939694473335, 4330.956690433119, 4339.956600433987, 4348.456442944632, 4371.693981421302, 4442.844500442501, 4150.315197992328, 4311.28863737483, 4327.0480494291205, 4346.4349634547625, 4370.650347972155, 4566.10960862632, 4622.2835460503675, 4623.976880115578, 4640.466346370177, 4676.649251306166, 5073.416557095944, 5077.949220507821, 5097.46476619957, 5113.0, 5123.129068058439, 4913.336699545587, 4988.850334489971, 5050.646454748169, 5126.307948426989, 5183.015227106837, 4740.644451666139, 4776.307435421844, 4777.856664300077, 4781.474037855833, 4818.855434336975, 5241.0, 5255.185446255837, 5256.316678831804, 5260.710660913686, 5266.4470230626, 4774.259989701602, 4880.731559764176, 4890.388701412324, 5027.4721154279005, 5092.337996060489, 5098.719570423662, 5117.1045067113855, 5137.791176208072, 5146.974265128725, 5154.14956532168, 5063.518965698253, 5077.339945807022, 5081.085404627129, 5085.872853178626, 5093.439721630618, 4779.593734532534, 4915.213565829522, 4916.70499770015, 4947.975260123676, 4997.400311962588, 4188.434561334181, 4236.9788151059665, 4247.384129301296, 4265.1043280910735, 4297.05464797744, 3601.4777857211084, 3723.832427540767, 3744.1014156602764, 3766.2655782122224, 3774.169682669808, 4329.285667864767, 4346.521882592912, 4439.66702497314, 4448.065906159743, 4491.169133710274, 4998.175301075355, 5019.14674505335, 5032.949670503248, 5058.747062646853, 5091.490850914879, 4219.324908014764, 4296.742195468282, 4340.348947657813, 4342.6308763754805, 4416.138852923649, 4354.194474022316, 4446.177457170434, 4451.421315228999, 4461.286194208911, 4502.077074199781, 4870.975645121752, 4900.117978763857, 4902.166631672553, 4915.21356582945, 4965.0, 4879.682820616648, 4998.400191976986, 5009.949900500948, 5106.361704786902, 5169.586433085419, 4764.237721964469, 4775.95224047769, 4825.252085926687, 4863.197572400514, 4868.294097355934, 4995.550400463976, 5013.072581572275, 5020.974895125501, 5022.0, 5068.543831055223, 4828.0, 5051.823186188466, 5054.16606259963, 5054.772535235997, 5123.513266239701, 4807.543283388072, 4918.311436398979, 4983.626228032985, 5007.974960125176, 5056.595472362129, 4887.095887260868, 4891.828785992473, 4893.8042478301895, 4896.241082632056, 4930.0, 4645.907081858411, 4792.003674635072, 4803.471618121934, 4809.735464549483, 4828.734419606815, 4886.560209581155, 4965.106280869334, 4975.179095449211, 4994.775235114356, 5030.8239211627415, 4807.543283388072, 4853.733044682435, 4866.270059491105, 4882.731449770296, 4914.975425122851], "unit": "ms", "name": "dojo.html", "value": 4646.504748538677}, {"lowerIsBetter": false, "replicates": [535.7803300646733, 555.616624529075, 558.5029323901725, 567.9630823996439, 571.3515160293068, 27225.31936701581, 36895.26209475809, 36923.0, 37064.258714825686, 37296.813515932416, 39196.412053819215, 39553.802230988804, 39807.80096099523, 39864.80067599658, 39893.20213595726, 7647.082350117979, 7747.418943579226, 7766.805829854242, 7783.610819459004, 7791.026121734783, 7699.230076992284, 7815.609219539028, 7836.68653253872, 7885.60571971402, 7921.485103468285, 7885.487443316166, 7959.522428654299, 7966.760997170065, 7975.122736498981, 7978.202179782033, 7873.133955264945, 7958.6418611162635, 7983.560904150269, 7991.280784729344, 7998.0402351717585, 7771.417143714244, 7880.369570434352, 7933.127355990837, 7949.443538952276, 7953.721619743281, 36214.275714485826, 36578.8171059143, 36653.0, 36662.63337366619, 36668.63331366706, 2907.0, 2987.357718090621, 3186.4105140549073, 3354.563906692139, 3497.2655742293896, 27341.316467088283, 27390.452190956068, 27480.312992175157, 27769.305767355978, 27900.581491277648, 3181.077487528614, 3210.2616398228306, 3239.49787782894, 3253.96746032539, 3288.128645908836, 209385.0, 209552.9999999985, 210218.0, 210278.0, 210282.0, 50261.24608130881, 50410.243846341604, 50487.24269135966, 50493.49506504962, 50751.23873141906, 46387.30419043717, 47452.525474745504, 59317.70341148267, 60714.0, 60819.69590152021, 13773.655658608615, 13888.097273677178, 13927.651808704863, 13962.790558141636, 13985.0, 9966.451845148586, 9997.700068997941, 10023.2482563808, 10034.899651003543, 10050.447225402528, 17289.91355043242, 17398.652026959644, 17531.64936701259, 17562.121893905252, 17565.155658655658, 7503.399728021745, 7684.46208765381, 7750.660454152732, 7829.804254893559, 7853.175416581176, 846.9322454203649, 860.3633311349681, 862.9913700862911, 908.504864848659, 985.5417230987625, 23939.16212932539, 23958.281251562483, 24022.51954960891, 24025.639615405784, 24196.637050444257, 982.5234761140841, 1034.7620047388991, 1062.6865074802952, 1083.344576531203, 1124.8087825069758, 11994.500687414073, 12254.326012069421, 12286.631401057983, 12318.568850090203, 12353.814692779615, 271750.6412467925, 275561.0, 276657.0, 276869.0, 276992.0, 43754.34368484475, 44155.55844441515, 44160.558394416286, 44244.778776105915, 44276.33585496156, 1190.595197632809, 1212.8726483719258, 1221.432034104146, 1229.8216758569956, 1234.8456442944453, 23383.41541461477, 24645.0, 25550.0, 25770.613440798777, 27995.720042799312, 40038.19923601453, 40331.79834100811, 40676.3898541528, 40741.38887916743, 40896.18207635771, 221816.0, 224938.0, 225290.0, 225371.0, 225374.0, 28127.71872281251, 30242.395152097273, 30803.84598076995, 30867.0, 30901.227469313446, 36187.81906090453, 36728.63271367359, 36819.26361472702, 36948.815255923546, 36990.0, 31316.686833131378, 31324.0, 31508.842455787573, 32096.839515802272, 32209.355812883143, 31161.532577011818, 31724.841375793898, 31772.523412148374, 31807.204819879687, 31862.0, 32174.678253218106, 32557.837210813796, 32590.348193035534, 33026.33947320992, 33158.83420582882, 26388.868055659597, 27027.0, 28306.85846570754, 29401.0, 31433.0, 22746.772532274466, 23145.768542314363, 23485.840522196017, 23819.761802382447, 25378.746212537637], "unit": "ms", "name": "ext.html", "value": 16469.13716265827}, {"lowerIsBetter": false, "replicates": [328.11900048370114, 329.31831109603115, 334.5032626549573, 334.58177278401996, 334.65697659898615, 14649.70700585989, 14975.0, 15263.236838158104, 15804.0, 16490.58773530659, 9971.10260076593, 10010.04904534068, 10010.349327293721, 12610.054245931546, 14568.417263309455, 4451.287793952968, 4525.0949810037955, 4576.222042252808, 4591.65562582806, 4623.606993405565, 4887.902241955158, 4947.876303092416, 4969.602431805465, 4977.0, 4982.651214414992, 3306.470964645657, 3474.391981403257, 4912.410510738717, 4916.0905232532095, 5004.474530174334, 5097.0, 5131.358580177478, 5144.202648589475, 5157.071727089123, 5157.329547158864, 4896.951030489685, 5027.84916452507, 5059.494050594948, 5076.568491678212, 5101.540861322499, 11386.943065284704, 11426.428678566039, 13976.860231397657, 18862.811371886244, 18955.81044189554, 1807.6023274879506, 1869.2242719271485, 1870.2238570993022, 1894.725264836591, 1966.2233417800032, 8836.823263534694, 8943.0, 9256.814863702755, 11076.944615276952, 12617.432215550321, 1703.2590822991915, 1712.3578658003248, 1735.5314065202451, 1766.655502177076, 1786.88385254958, 53839.46160538384, 55607.0, 56081.71959140219, 56139.43860561424, 56628.716856415864, 9411.670591529264, 9627.711168664951, 9752.707418777449, 9804.313698041211, 9822.066903644143, 12380.133390662568, 12380.752384952251, 12384.31886246247, 12387.938060309642, 12388.62834114978, 6965.33829286217, 7054.2240353561065, 7065.823354416078, 7166.068411106523, 7268.491205615662, 6675.732970681119, 6707.1616047994, 6848.657567121723, 6910.550814197061, 6976.127984002, 4089.0799570097083, 4123.402106694512, 4130.112025914443, 4144.171165766858, 4167.020750123718, 1740.0, 1761.9647607048043, 1768.1071059115066, 1778.9555261118576, 1815.9092045397676, 359.16824196597145, 364.9087728067983, 864.2394692670409, 869.5000374784524, 1031.566741968375, 9497.762555936019, 9588.856167157499, 9686.515674216262, 9784.070513301225, 9881.160101391462, 385.5104017897255, 390.49235993208714, 391.79430798830845, 402.971791974559, 428.4301878501585, 5146.665466744649, 5307.787688492417, 5340.465953404706, 5394.730263486888, 5455.536279416215, 476051.0, 488040.0, 491981.0, 493784.0, 502436.0, 70935.58128837394, 71123.50510002645, 71368.83133713143, 71717.0, 71909.86545741391, 414.9564295748903, 417.40936574746394, 417.90597115648734, 421.1240619511409, 422.0819717115262, 8876.112388761072, 8993.460392376479, 9076.909230907606, 9131.315151363542, 9145.314101442551, 29698.703012969592, 29923.70076299296, 30373.392532149675, 30663.54004689976, 30836.0, 42051.57948420599, 43400.348994765736, 43913.34129987989, 44445.0, 45259.54740452685, 8532.70135545253, 8605.569721514024, 8638.26574741154, 8679.435836670596, 8852.24755895756, 10062.798744024933, 14036.78944815808, 15781.28984195691, 16103.75844362359, 16283.592910176867, 12684.365781711062, 13074.477020919057, 13237.933810330887, 13715.245661488714, 13900.304984750925, 9757.414555126716, 12326.0, 12504.0, 12949.935250323688, 13104.410301536644, 12458.252504849737, 13181.538646147339, 13261.403236854172, 13424.463021479422, 13493.730125397633, 8463.66145354179, 8494.957525212334, 8625.525596092275, 8655.6970506032, 8685.174908383693, 12731.0, 12972.935135324264, 13065.281409522568, 13158.868411315765, 13159.144655597356], "unit": "ms", "name": "jquery.html", "value": 7319.675000448352}, {"lowerIsBetter": false, "replicates": [1338.9196648201103, 1376.5732622886899, 1393.2824595333398, 1633.436464419775, 1724.862011039117, 6344.6510441925675, 6482.935170648292, 7118.822029449267, 7291.598962057092, 7317.634118294084, 6979.965100174505, 7191.280871912806, 7256.8911466328045, 7291.963540182305, 7296.781096567098, 2064.246550009247, 2095.266656670161, 2095.905684244213, 2097.129691178159, 2098.5697931923996, 2020.959580808383, 2039.3168288623328, 2048.498117961102, 2053.219776484934, 2055.445029841942, 2037.8981050947468, 2062.618415593113, 2069.6998935154393, 2070.7618623858298, 2071.140476702167, 2093.706881036656, 2102.484891201658, 2103.316422162803, 2104.757952835413, 2105.0948092320295, 2028.2495476673726, 2040.2043203150783, 2050.98974505128, 2064.7935206479383, 2069.9379018629465, 7280.927190728131, 7287.599182044985, 7313.524620899624, 7319.634018299063, 7373.29953654402, 4168.7081904266715, 4233.174530966432, 4235.512916014636, 4263.275243208631, 4267.551907049746, 2703.5268827955224, 2710.4579084183047, 2738.4659991301705, 2804.340979869729, 2809.3819359740824, 887.0552861202798, 894.8344556257048, 896.6996056321141, 907.1246247371319, 945.1588086602928, 9477.526123693788, 9481.383710058824, 9591.760205994837, 9600.471974041426, 9706.223502119885, 3853.5183102112237, 3863.690904727615, 3931.9606803932165, 3948.861789837342, 3952.0317522207242, 8481.363897707697, 8487.575621218914, 8489.575521224038, 8495.787605309917, 8517.914820851713, 4259.5527469615245, 4260.126674031816, 4278.55075217104, 4289.785510724514, 4305.182015417061, 3361.2605226850055, 3461.2558299965626, 3792.3173828711097, 3891.6886649068006, 3901.044244160199, 3447.5690538682666, 3467.6185619581825, 3472.722182225416, 3485.2855164691177, 3506.7545271830727, 1085.5115198160859, 1090.1878100814943, 1099.9175061870392, 1104.045001074065, 1116.4975760907462, 1199.91600587958, 1200.3338147328143, 1208.4139192491634, 1221.0841868598552, 1227.2145826670937, 6839.213490448563, 6869.416099631488, 6895.827604309932, 6905.343992320722, 6905.620190889549, 413.70213446318604, 418.98676857698445, 422.391755871544, 426.0222788699941, 426.1136835382459, 5160.380754309507, 5224.03355379256, 5225.451327610622, 5237.240600112962, 5245.26566280721, 8620.78448038804, 8630.180132887366, 8832.160944710242, 8879.822403552022, 8941.642334306685, 8791.252743516745, 8799.736007919773, 8821.955890220508, 8829.028806831244, 8850.468971861708, 6774.695138718868, 6781.152355955505, 6933.965330173317, 6954.826129346807, 6992.545484543489, 6673.599584024974, 6677.198736151693, 6681.76613818514, 6682.398584127452, 6692.0965669635925, 7741.45809793309, 7785.727499537489, 7859.803504912423, 7867.13461519221, 7957.124716281089, 7933.651279282652, 7976.800579985546, 8010.719624813103, 8017.358611311198, 8106.39202059836, 5582.218489411404, 5671.206031155559, 6127.387261273837, 6477.0, 6577.572457790228, 6814.897776533257, 6821.386075253251, 6831.28271531482, 6832.453403727789, 6833.248342682202, 6504.707288171949, 6597.60414375139, 6624.867502650017, 6733.225679046972, 6759.357861003196, 6338.778142764981, 6553.639549824806, 6583.901241481286, 6645.933540664531, 6654.068430419648, 6654.73381064752, 6671.0, 6689.397954184147, 6740.258571557223, 6754.763583274758, 5935.584509084495, 5985.162077309094, 6000.69996500182, 6008.489278411384, 6009.06859436788, 6287.2140982377205, 6302.558820882494, 6316.178896743394, 6327.96836015817, 6336.334684858023], "unit": "ms", "name": "mootools.html", "value": 4057.3847805035252}, {"lowerIsBetter": false, "replicates": [294.36711071196925, 303.2373580445181, 303.712991223294, 310.08061098841927, 312.8341978751263, 5539.0, 5552.278203833501, 5624.915626265604, 5651.180578816079, 5651.689157096358, 5543.667379957205, 5545.223668686387, 5550.500454959053, 5551.3893471718075, 5569.331680198382, 4107.589241075899, 4270.167317373113, 4275.187714334266, 4278.914421711564, 4285.121550082241, 4183.372494125875, 4240.321548552232, 4253.51084625269, 4255.9787201063955, 4260.211860805745, 4167.458230430055, 4204.348326009474, 4205.705600607958, 4206.537280899099, 4214.346776249671, 4200.70595058346, 4214.578542145791, 4217.45173127493, 4225.661947044229, 4226.788660566959, 3651.7991510466913, 3656.1225305926387, 3658.6890114340313, 3662.61542538035, 3670.284294562561, 5168.250603662485, 5237.083510385667, 5264.894702105975, 5290.894182116374, 5304.469553044703, 4825.2520859266515, 4832.178529649968, 4840.346553215341, 4840.443349014838, 4848.0788650156355, 5784.479396854304, 5799.710014499258, 5801.24583804107, 5810.1865738796605, 5816.243888294537, 3943.507061617298, 3957.940630890539, 3970.1861118470642, 3974.046228905042, 3974.5230572331216, 5947.167396564484, 6043.1841701370195, 6072.605280656743, 6115.5413343998935, 6120.846978825521, 4047.251258517125, 4065.7153999220363, 4082.5713300103657, 4083.856520174356, 4088.4889388826396, 4131.8967025823995, 4134.937975930364, 4137.648299894482, 4144.067584793458, 4146.523149837807, 4786.44955830077, 4789.090072886141, 4799.496052914394, 4802.903941921212, 4805.13507568634, 5585.329760428694, 5741.942580574224, 5763.0, 5808.854778630568, 5810.622309549865, 1452.6295794572316, 1460.5983354577577, 1461.7734251191082, 1474.8893832962572, 1475.7048590281986, 973.7808992976524, 975.9801007946712, 977.2572844638127, 992.503748125937, 998.9051040151174, 5106.540411362995, 5114.744262786846, 5115.360579927509, 5125.0, 5127.333446651986, 5954.374790647006, 6068.666223357669, 6072.878542429126, 6098.26820781509, 6141.631502109888, 5107.106256405114, 5119.564836988823, 5124.615653825904, 5128.076946149654, 5144.6913185209005, 3247.691469310412, 3286.8685252590108, 3288.2108294009745, 3305.4545999909747, 3309.172706823294, 5603.495685388335, 5695.743691533891, 5792.4497172768515, 5795.82612521625, 5798.362180160179, 6214.161088253119, 6256.812295631138, 6296.0555916612875, 6304.18045654062, 6311.2426508819235, 5811.389804070596, 5819.447152520504, 5820.0, 5823.679697616587, 5835.649861008353, 6065.999110146953, 6086.360932102066, 6088.665123418255, 6123.234595675541, 6143.877122457615, 5842.766289348378, 5921.970390148022, 5928.67392293428, 5963.701814909324, 5981.970090149522, 5769.711514424346, 5780.710964451845, 5787.884242315215, 5797.681127537857, 5820.621659592113, 4066.9593304067766, 4084.04025054118, 4089.5910408958866, 4092.5907409260026, 4097.6926730495925, 5984.730687119003, 6088.208532890696, 6094.024956007195, 6108.02271636536, 6114.449699526886, 5870.589058766016, 5879.882402352015, 5882.088276317178, 5882.764689412375, 5887.322957859729, 5853.0635098384055, 5862.0, 5869.882602348014, 5876.08920617305, 5881.117832325185, 5595.328560572757, 5720.771169153188, 5735.512481439125, 5737.311522617312, 5740.196372507936, 5882.49998750111, 5899.056151015817, 5905.881882362242, 5920.763169473173, 5920.911186332295, 5730.799422020209, 5734.856628584319, 5737.340205876378, 5739.684317362585, 5744.224529688438], "unit": "ms", "name": "prototype.html", "value": 4354.12583465268}, {"lowerIsBetter": false, "replicates": [683.60692601754, 739.9060658336904, 783.6708582395394, 789.9565523896183, 800.7517669522447, 11450.370229637367, 11662.358570278631, 11669.474873630686, 11698.415079246024, 11708.0, 11844.348560829172, 12027.879721202786, 12166.330851803148, 12192.085593580472, 12200.0, 794.2057942057928, 805.1505661527086, 813.9308158806479, 814.3322475570035, 814.604916615444, 798.8162722573811, 799.7760627024413, 802.9237222463856, 802.9437939344248, 806.733777853307, 840.4201101240155, 843.1442086282428, 843.8143608406172, 845.7674139611595, 846.5936350551739, 840.7015509494133, 841.2512863551383, 842.2335674536173, 842.5871323051722, 843.6330196364601, 616.7193926763312, 616.8365383173418, 618.0420348459915, 618.1376979114156, 618.437222127866, 10129.392236465836, 10259.589616415335, 10265.743356416075, 10277.743056423575, 10284.537195826206, 9476.431414115175, 9792.265580081452, 9883.752906177331, 9908.455034973074, 9909.058639429242, 9855.90144098564, 9899.307048506607, 10024.59901603935, 10221.853410783744, 10248.12890904274, 3250.2849373137874, 3262.559554460141, 3284.2774589590254, 3327.7504187185814, 3340.448825943716, 34072.31855362903, 34546.30907381838, 39308.213835723414, 40482.0, 41656.58343416588, 9210.355275130676, 9296.907030929739, 9391.0, 9485.573149208301, 9668.274879384075, 16048.358065677476, 16106.114163720873, 16115.435959741353, 16134.0, 16236.350545978265, 6265.154204182468, 6424.100625912376, 6473.482121430275, 6626.734930602722, 6677.09859169006, 3631.5668502103654, 3639.217568222845, 3735.084904198489, 3739.0, 3764.698824094066, 2849.4870923233602, 2898.565215217734, 2916.6791652918164, 2920.6495220573665, 2922.0795449433363, 481.05712802906, 489.77470363632415, 493.77779998999875, 497.8083437876444, 498.9700617962934, 573.6558065160954, 612.8130920069333, 616.3251488539759, 622.7260005597523, 658.1674182159572, 7377.0, 7641.235876412315, 7648.426368022309, 7709.7301594443925, 7957.960210199028, 586.2876604925036, 600.8557946092993, 609.2414943395412, 627.97802076928, 641.1440726629908, 3558.5729712434154, 3692.590355129748, 3826.9234615308096, 3836.8873026821907, 3932.3511620582285, 50462.243066354036, 50882.0, 51242.74378628083, 51362.0, 51469.48530514647, 43879.34180987288, 44738.32892506615, 44963.550364496594, 45090.549094508635, 45991.54008459939, 38642.80678596589, 39487.80256098701, 41287.1742565147, 43351.99999999937, 43658.56341436545, 7847.607619619111, 7849.372050235853, 7973.202679732212, 8188.713395031145, 8608.053114157563, 30802.691973079982, 31750.412479375478, 31890.52164217492, 32027.67972320247, 32046.19884502906, 38175.42736859005, 38418.231635366574, 39094.80452597719, 39578.2084358317, 39638.60361396349, 9722.416655000723, 10084.798304034024, 10161.644342447978, 10251.487425628839, 10674.199435042248, 10991.450427478754, 11037.0, 11197.496112674786, 11204.775904482029, 11441.256318339281, 10317.17462602975, 10855.0, 10856.620018299638, 11051.171162163031, 11369.090472761995, 10969.835452468378, 11059.336439813636, 11067.557297708001, 11272.323660580063, 11480.196386252883, 10354.5340459678, 10938.179636527133, 11199.888001119885, 11207.327560346404, 11233.101351891666, 8951.41815781972, 9135.954320228357, 9139.771505712144, 9247.491387973727, 9384.202342800938, 9065.77335566616, 9184.954075229582, 9215.631374745204, 9435.858462122937, 9533.380330278787], "unit": "ms", "name": "yui.html", "value": 5781.27573043555}], "name": "dromaeo_css", "value": 6207.501901554289}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 111.0, 113.0, 123.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 151.0, 173.0, 135.0, 158.0, 163.0, 132.0, 168.0, 142.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 167.0, 162.0, 163.0, 163.0, 164.0, 171.0, 162.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 73.0, 73.0, 72.0, 146.0, 72.0, 78.0, 79.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 95.0, 95.0, 94.0, 137.0, 94.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 112.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 99.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 76.0, 73.0, 72.0, 73.0, 72.0, 75.0, 72.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 85.0, 86.0, 86.0, 86.0, 85.0, 84.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [129.0, 125.0, 119.0, 121.0, 125.0, 135.0, 135.0, 126.0, 131.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [135.0, 146.0, 148.0, 148.0, 149.0, 146.0, 148.0, 149.0, 147.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 71.0, 69.0, 70.0, 69.0, 70.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1535.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.58196181698486], "unit": "score", "name": "Richards", "value": 214.4949520000001}, {"lowerIsBetter": false, "replicates": [184.36578171091446], "unit": "score", "name": "DeltaBlue", "value": 358.6240319999999}, {"lowerIsBetter": false, "replicates": [277.2387025228722], "unit": "score", "name": "Encrypt", "value": 960.114867}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [693.4812760055479], "unit": "score", "name": "Earley", "value": 961.039646}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [604.9606775559589], "unit": "score", "name": "Splay", "value": 134.70462300000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21457.415786600868}]} 17:23:54 INFO - RETURN: dromaeo_css: 6207.50 17:23:54 INFO - RETURN: kraken: 1535.10 17:23:54 INFO - RETURN: v8_7: 21457.42 17:23:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21457.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1535.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6207.50"}}} 17:23:54 INFO - Return code: 0 17:23:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:23:54 INFO - # TBPL SUCCESS # 17:23:54 INFO - Running post-action listener: _resource_record_post_action 17:23:54 INFO - Running post-run listener: _resource_record_post_run 17:23:55 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505237504; Read time: 24; Write time: 373108 17:23:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 230514688; Read time: 0; Write time: 223788 17:23:55 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274419712; Read time: 24; Write time: 149296 17:23:55 INFO - Running post-run listener: _upload_blobber_files 17:23:55 INFO - Blob upload gear active. 17:23:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:23:55 INFO - Copying logs to upload dir... 17:23:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.946376 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-02 17:23:55.404357) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 17:23:55.407863) ========= 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=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010119 build_url: 'https://queue.taskcluster.net/v1/task/Nig1wvwzRNi58v2zTlR6Hg/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-12-02 17:23:55.460123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:23:55.460522) ========= 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=3cd289541638898829117e0a000001bd-1449104310.982004-2132606872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 17:23:55.510883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 17:23:55.511259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 17:23:55.511614) ========= ========= Total master_lag: 0.24 =========