builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1450299816.49 results: success (0) buildid: 20151216103901 builduid: 5765a8e45700472987b73e45c85677f7 revision: 65ae1a6420dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.487109) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.487652) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.487946) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006415 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.511618) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.511918) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.525345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.525711) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.575724) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.576107) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.576542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.576809) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 13:03:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-16 13:03:36 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.206610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.795982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.796287) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022058 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.848809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:36.849153) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 65ae1a6420dc --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 65ae1a6420dc --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 13:03:36,890 Setting DEBUG logging. 2015-12-16 13:03:36,890 attempt 1/10 2015-12-16 13:03:36,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/65ae1a6420dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 13:03:37,282 unpacking tar archive at: mozilla-beta-65ae1a6420dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658618 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:37.521263) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:37.521568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:37.529912) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:37.530198) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 13:03:37.530644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-16 13:03:37.530930) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:03:37 INFO - MultiFileLogger online at 20151216 13:03:37 in /builds/slave/test-pgo 13:03:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:03:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:03:37 INFO - {'append_to_log': False, 13:03:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:03:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:03:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:03:37 INFO - 'branch': 'Mozilla-Beta', 13:03:37 INFO - 'buildbot_json_path': 'buildprops.json', 13:03:37 INFO - 'config_files': ('talos/linux_config.py',), 13:03:37 INFO - 'default_actions': ('clobber', 13:03:37 INFO - 'read-buildbot-config', 13:03:37 INFO - 'download-and-extract', 13:03:37 INFO - 'populate-webroot', 13:03:37 INFO - 'create-virtualenv', 13:03:37 INFO - 'install', 13:03:37 INFO - 'run-tests'), 13:03:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:03:37 INFO - 'download_minidump_stackwalk': True, 13:03:37 INFO - 'download_symbols': 'ondemand', 13:03:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:03:37 INFO - 'tooltool.py': '/tools/tooltool.py', 13:03:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:03:37 INFO - '/tools/misc-python/virtualenv.py')}, 13:03:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:03:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:03:37 INFO - 'installer_path': 'installer.exe', 13:03:37 INFO - 'log_level': 'info', 13:03:37 INFO - 'log_name': 'talos', 13:03:37 INFO - 'log_to_console': True, 13:03:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:03:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:03:37 INFO - 'opt_config_files': (), 13:03:37 INFO - 'pip_index': False, 13:03:37 INFO - 'sps_profile': False, 13:03:37 INFO - 'sps_profile_interval': 0, 13:03:37 INFO - 'suite': 'dromaeojs', 13:03:37 INFO - 'system_bits': '64', 13:03:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:03:37 INFO - 'title': 'talos-linux64-ix-022', 13:03:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:03:37 INFO - 'use_talos_json': True, 13:03:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:03:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:03:37 INFO - 'work_dir': 'build'} 13:03:37 INFO - ##### 13:03:37 INFO - ##### Running clobber step. 13:03:37 INFO - ##### 13:03:37 INFO - Running pre-action listener: _resource_record_pre_action 13:03:37 INFO - Running main action method: clobber 13:03:37 INFO - rmtree: /builds/slave/test-pgo/build 13:03:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:03:38 INFO - Running post-action listener: _resource_record_post_action 13:03:38 INFO - ##### 13:03:38 INFO - ##### Running read-buildbot-config step. 13:03:38 INFO - ##### 13:03:38 INFO - Running pre-action listener: _resource_record_pre_action 13:03:38 INFO - Running main action method: read_buildbot_config 13:03:38 INFO - Using buildbot properties: 13:03:38 INFO - { 13:03:38 INFO - "properties": { 13:03:38 INFO - "buildnumber": 35, 13:03:38 INFO - "product": "firefox", 13:03:38 INFO - "script_repo_revision": "production", 13:03:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:03:38 INFO - "repository": "", 13:03:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:03:38 INFO - "buildid": "20151216103901", 13:03:38 INFO - "slavename": "talos-linux64-ix-022", 13:03:38 INFO - "pgo_build": "True", 13:03:38 INFO - "basedir": "/builds/slave/test-pgo", 13:03:38 INFO - "project": "", 13:03:38 INFO - "platform": "ubuntu64_hw", 13:03:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:03:38 INFO - "slavebuilddir": "test", 13:03:38 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:03:38 INFO - "branch": "mozilla-beta", 13:03:38 INFO - "repo_path": "releases/mozilla-beta", 13:03:38 INFO - "stage_platform": "linux64-pgo", 13:03:38 INFO - "builduid": "5765a8e45700472987b73e45c85677f7", 13:03:38 INFO - "revision": "65ae1a6420dc" 13:03:38 INFO - }, 13:03:38 INFO - "sourcestamp": { 13:03:38 INFO - "repository": "", 13:03:38 INFO - "hasPatch": false, 13:03:38 INFO - "project": "", 13:03:38 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:03:38 INFO - "changes": [ 13:03:38 INFO - { 13:03:38 INFO - "category": null, 13:03:38 INFO - "files": [ 13:03:38 INFO - { 13:03:38 INFO - "url": null, 13:03:38 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2" 13:03:38 INFO - } 13:03:38 INFO - ], 13:03:38 INFO - "repository": "", 13:03:38 INFO - "rev": "65ae1a6420dc", 13:03:38 INFO - "who": "sendchange", 13:03:38 INFO - "when": 1450299802, 13:03:38 INFO - "number": 7368155, 13:03:38 INFO - "comments": "Bug 1227024. Switch from GTK3 to GTK2. r=karlt a=ritu CLOSED TREE", 13:03:38 INFO - "project": "", 13:03:38 INFO - "at": "Wed 16 Dec 2015 13:03:22", 13:03:38 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:03:38 INFO - "revlink": "", 13:03:38 INFO - "properties": [ 13:03:38 INFO - [ 13:03:38 INFO - "buildid", 13:03:38 INFO - "20151216103901", 13:03:38 INFO - "Change" 13:03:38 INFO - ], 13:03:38 INFO - [ 13:03:38 INFO - "builduid", 13:03:38 INFO - "5765a8e45700472987b73e45c85677f7", 13:03:38 INFO - "Change" 13:03:38 INFO - ], 13:03:38 INFO - [ 13:03:38 INFO - "pgo_build", 13:03:38 INFO - "True", 13:03:38 INFO - "Change" 13:03:38 INFO - ] 13:03:38 INFO - ], 13:03:38 INFO - "revision": "65ae1a6420dc" 13:03:38 INFO - } 13:03:38 INFO - ], 13:03:38 INFO - "revision": "65ae1a6420dc" 13:03:38 INFO - } 13:03:38 INFO - } 13:03:38 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2. 13:03:38 INFO - Running post-action listener: _resource_record_post_action 13:03:38 INFO - ##### 13:03:38 INFO - ##### Running download-and-extract step. 13:03:38 INFO - ##### 13:03:38 INFO - Running pre-action listener: _resource_record_pre_action 13:03:38 INFO - Running main action method: download_and_extract 13:03:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:03:38 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')]} 13:03:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/test_packages.json 13:03:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:03:38 INFO - Downloaded 1270 bytes. 13:03:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:03:38 INFO - Using the following test package requirements: 13:03:38 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:03:38 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:03:38 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:03:38 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:03:38 INFO - u'jsshell-linux-x86_64.zip'], 13:03:38 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:03:38 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:03:38 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:03:38 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:03:38 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 13:03:38 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:03:38 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 13:03:38 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:03:38 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:03:38 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 13:03:38 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 13:03:38 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:03:38 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:03:38 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')]} 13:03:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:03:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:03:40 INFO - Downloaded 22572609 bytes. 13:03:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:03:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:03:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:03:42 INFO - Return code: 0 13:03:42 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:42 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:03:42 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:03:42 INFO - Downloaded 22572609 bytes. 13:03:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:03:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 13:03:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:03:43 INFO - Return code: 0 13:03:43 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')]} 13:03:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:03:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:03:49 INFO - Downloaded 11131970 bytes. 13:03:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:03:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 13:03:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:03:49 INFO - Return code: 0 13:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:03:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:03:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:04:01 INFO - Downloaded 56614253 bytes. 13:04:01 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:04:01 INFO - mkdir: /builds/slave/test-pgo/properties 13:04:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:04:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:04:01 INFO - Contents: 13:04:01 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2 13:04:01 INFO - Running post-action listener: _resource_record_post_action 13:04:01 INFO - Running post-action listener: set_extra_try_arguments 13:04:01 INFO - ##### 13:04:01 INFO - ##### Running populate-webroot step. 13:04:01 INFO - ##### 13:04:01 INFO - Running pre-action listener: _resource_record_pre_action 13:04:01 INFO - Running main action method: populate_webroot 13:04:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:04:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:04:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:04:01 INFO - '../fennec_ids.txt'], 13:04:01 INFO - 'tests': ['tcheck2']}, 13:04:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:04:01 INFO - '--tppagecycles', 13:04:01 INFO - '7'], 13:04:01 INFO - 'tests': ['tsvgm']}}, 13:04:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:04:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:04:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:04:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:04:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'tests': ['damp', 'tps']}, 13:04:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['damp', 'tps']}, 13:04:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:04:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:04:01 INFO - 'other': {'tests': ['a11yr', 13:04:01 INFO - 'ts_paint', 13:04:01 INFO - 'tpaint', 13:04:01 INFO - 'sessionrestore', 13:04:01 INFO - 'sessionrestore_no_auto_restore']}, 13:04:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['a11yr', 13:04:01 INFO - 'ts_paint', 13:04:01 INFO - 'tpaint', 13:04:01 INFO - 'sessionrestore', 13:04:01 INFO - 'sessionrestore_no_auto_restore']}, 13:04:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['a11yr', 13:04:01 INFO - 'ts_paint', 13:04:01 INFO - 'tpaint', 13:04:01 INFO - 'sessionrestore', 13:04:01 INFO - 'sessionrestore_no_auto_restore']}, 13:04:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['a11yr', 13:04:01 INFO - 'ts_paint', 13:04:01 INFO - 'tpaint', 13:04:01 INFO - 'sessionrestore', 13:04:01 INFO - 'sessionrestore_no_auto_restore']}, 13:04:01 INFO - 'other_l64': {'tests': ['a11yr', 13:04:01 INFO - 'ts_paint', 13:04:01 INFO - 'tpaint', 13:04:01 INFO - 'sessionrestore', 13:04:01 INFO - 'sessionrestore_no_auto_restore']}, 13:04:01 INFO - 'other_nol64': {'tests': ['a11yr', 13:04:01 INFO - 'ts_paint', 13:04:01 INFO - 'tpaint', 13:04:01 INFO - 'sessionrestore', 13:04:01 INFO - 'sessionrestore_no_auto_restore']}, 13:04:01 INFO - 'svgr': {'tests': ['tsvgx', 13:04:01 INFO - 'tsvgr_opacity', 13:04:01 INFO - 'tart', 13:04:01 INFO - 'tscrollx', 13:04:01 INFO - 'cart']}, 13:04:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['tsvgx', 13:04:01 INFO - 'tsvgr_opacity', 13:04:01 INFO - 'tart', 13:04:01 INFO - 'tscrollx', 13:04:01 INFO - 'cart']}, 13:04:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'tests': ['tp5o']}, 13:04:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'talos_options': ['--e10s'], 13:04:01 INFO - 'tests': ['tp5o']}, 13:04:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'talos_options': ['--xperf_path', 13:04:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:01 INFO - 'tests': ['tp5n']}, 13:04:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:01 INFO - 'talos_options': ['--e10s', 13:04:01 INFO - '--xperf_path', 13:04:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:01 INFO - 'tests': ['tp5n']}}, 13:04:01 INFO - 'talos.zip': {'path': '', 13:04:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:04:01 INFO - Running post-action listener: _resource_record_post_action 13:04:01 INFO - ##### 13:04:01 INFO - ##### Running create-virtualenv step. 13:04:01 INFO - ##### 13:04:01 INFO - Running pre-action listener: _resource_record_pre_action 13:04:01 INFO - Running main action method: create_virtualenv 13:04:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:04:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 13:04:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:04:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:04:01 INFO - Using real prefix '/usr' 13:04:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:04:01 INFO - Installing distribute.............................................................................................................................................................................................done. 13:04:03 INFO - Installing pip.................done. 13:04:03 INFO - Return code: 0 13:04:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:04: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')]} 13:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 13:04:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 13:04:03 INFO - Using env: {'DISPLAY': ':0', 13:04:03 INFO - 'HOME': '/home/cltbld', 13:04:03 INFO - 'LANG': 'en_US.UTF-8', 13:04:03 INFO - 'LANGUAGE': 'en_US:en', 13:04:03 INFO - 'LOGNAME': 'cltbld', 13:04:03 INFO - 'MAIL': '/var/mail/cltbld', 13:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:03 INFO - 'MOZ_NO_REMOTE': '1', 13:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:03 INFO - 'NO_EM_RESTART': '1', 13:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:03 INFO - 'SHELL': '/bin/bash', 13:04:03 INFO - 'SHLVL': '1', 13:04:03 INFO - 'TERM': 'linux', 13:04:03 INFO - 'TMOUT': '86400', 13:04:03 INFO - 'USER': 'cltbld', 13:04:03 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:03 INFO - '_': '/tools/buildbot/bin/python'} 13:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:04 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 13:04:04 INFO - Cleaning up... 13:04:04 INFO - Return code: 0 13:04:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 13:04:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 13:04:04 INFO - Using env: {'DISPLAY': ':0', 13:04:04 INFO - 'HOME': '/home/cltbld', 13:04:04 INFO - 'LANG': 'en_US.UTF-8', 13:04:04 INFO - 'LANGUAGE': 'en_US:en', 13:04:04 INFO - 'LOGNAME': 'cltbld', 13:04:04 INFO - 'MAIL': '/var/mail/cltbld', 13:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:04 INFO - 'MOZ_NO_REMOTE': '1', 13:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:04 INFO - 'NO_EM_RESTART': '1', 13:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:04 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:04 INFO - 'SHELL': '/bin/bash', 13:04:04 INFO - 'SHLVL': '1', 13:04:04 INFO - 'TERM': 'linux', 13:04:04 INFO - 'TMOUT': '86400', 13:04:04 INFO - 'USER': 'cltbld', 13:04:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:04 INFO - '_': '/tools/buildbot/bin/python'} 13:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:04 INFO - Downloading/unpacking psutil>=0.7.1 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:04:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:04:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:04:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:06 INFO - Installing collected packages: psutil 13:04:06 INFO - Running setup.py install for psutil 13:04:06 INFO - building 'psutil._psutil_linux' extension 13:04:06 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 13:04:06 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 13:04:06 INFO - building 'psutil._psutil_posix' extension 13:04:06 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 13:04:06 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 13:04:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:06 INFO - Successfully installed psutil 13:04:06 INFO - Cleaning up... 13:04:06 INFO - Return code: 0 13:04:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:04: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')]} 13:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 13:04:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 13:04:06 INFO - Using env: {'DISPLAY': ':0', 13:04:06 INFO - 'HOME': '/home/cltbld', 13:04:06 INFO - 'LANG': 'en_US.UTF-8', 13:04:06 INFO - 'LANGUAGE': 'en_US:en', 13:04:06 INFO - 'LOGNAME': 'cltbld', 13:04:06 INFO - 'MAIL': '/var/mail/cltbld', 13:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:06 INFO - 'MOZ_NO_REMOTE': '1', 13:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:06 INFO - 'NO_EM_RESTART': '1', 13:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:06 INFO - 'SHELL': '/bin/bash', 13:04:06 INFO - 'SHLVL': '1', 13:04:06 INFO - 'TERM': 'linux', 13:04:06 INFO - 'TMOUT': '86400', 13:04:06 INFO - 'USER': 'cltbld', 13:04:06 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:06 INFO - '_': '/tools/buildbot/bin/python'} 13:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:04:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:04:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:04:08 INFO - Installing collected packages: mozsystemmonitor 13:04:08 INFO - Running setup.py install for mozsystemmonitor 13:04:08 INFO - Successfully installed mozsystemmonitor 13:04:08 INFO - Cleaning up... 13:04:08 INFO - Return code: 0 13:04:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 13:04:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 13:04:08 INFO - Using env: {'DISPLAY': ':0', 13:04:08 INFO - 'HOME': '/home/cltbld', 13:04:08 INFO - 'LANG': 'en_US.UTF-8', 13:04:08 INFO - 'LANGUAGE': 'en_US:en', 13:04:08 INFO - 'LOGNAME': 'cltbld', 13:04:08 INFO - 'MAIL': '/var/mail/cltbld', 13:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:08 INFO - 'MOZ_NO_REMOTE': '1', 13:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:08 INFO - 'NO_EM_RESTART': '1', 13:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:08 INFO - 'SHELL': '/bin/bash', 13:04:08 INFO - 'SHLVL': '1', 13:04:08 INFO - 'TERM': 'linux', 13:04:08 INFO - 'TMOUT': '86400', 13:04:08 INFO - 'USER': 'cltbld', 13:04:08 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:08 INFO - '_': '/tools/buildbot/bin/python'} 13:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:08 INFO - Downloading/unpacking blobuploader==1.2.4 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:04:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:04:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:04:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:04:10 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 13:04:10 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 13:04:10 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 13:04:10 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 13:04:10 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 13:04:10 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 13:04:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:04:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:04:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:11 INFO - Downloading docopt-0.6.1.tar.gz 13:04:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:04:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:04:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:04:11 INFO - Running setup.py install for blobuploader 13:04:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:04:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:04:11 INFO - Running setup.py install for requests 13:04:11 INFO - Running setup.py install for docopt 13:04:11 INFO - Successfully installed blobuploader requests docopt 13:04:11 INFO - Cleaning up... 13:04:11 INFO - Return code: 0 13:04:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:04:11 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')]} 13:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:11 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')]} 13:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 13:04:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 13:04:11 INFO - Using env: {'DISPLAY': ':0', 13:04:11 INFO - 'HOME': '/home/cltbld', 13:04:11 INFO - 'LANG': 'en_US.UTF-8', 13:04:11 INFO - 'LANGUAGE': 'en_US:en', 13:04:11 INFO - 'LOGNAME': 'cltbld', 13:04:11 INFO - 'MAIL': '/var/mail/cltbld', 13:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:11 INFO - 'MOZ_NO_REMOTE': '1', 13:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:11 INFO - 'NO_EM_RESTART': '1', 13:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:11 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:11 INFO - 'SHELL': '/bin/bash', 13:04:11 INFO - 'SHLVL': '1', 13:04:11 INFO - 'TERM': 'linux', 13:04:11 INFO - 'TMOUT': '86400', 13:04:11 INFO - 'USER': 'cltbld', 13:04:11 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:11 INFO - '_': '/tools/buildbot/bin/python'} 13:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:04:12 INFO - Running setup.py (path:/tmp/pip-KnQaE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:04:12 INFO - Running setup.py (path:/tmp/pip-O_DmOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:04:12 INFO - Running setup.py (path:/tmp/pip-foG_0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:04:12 INFO - Running setup.py (path:/tmp/pip-_MUi3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:04:12 INFO - Running setup.py (path:/tmp/pip-DvJyEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:04:12 INFO - Running setup.py (path:/tmp/pip-rn6IaY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:04:12 INFO - Running setup.py (path:/tmp/pip-EIgrv2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:04:12 INFO - Running setup.py (path:/tmp/pip-nSTjcv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:04:12 INFO - Running setup.py (path:/tmp/pip-r41FWq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:04:12 INFO - Running setup.py (path:/tmp/pip-dPZ_IF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:04:12 INFO - Running setup.py (path:/tmp/pip-6Bvbzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:04:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:04:12 INFO - Running setup.py (path:/tmp/pip-cCtYpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:04:13 INFO - Running setup.py (path:/tmp/pip-nCuG67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:04:13 INFO - Running setup.py (path:/tmp/pip-0VLBkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:04:13 INFO - Running setup.py (path:/tmp/pip-0xLGa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:04:13 INFO - Running setup.py (path:/tmp/pip-mTOOLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:04:13 INFO - Running setup.py (path:/tmp/pip-IFB3As-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:04:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:04:13 INFO - Running setup.py install for manifestparser 13:04:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:04:13 INFO - Running setup.py install for mozcrash 13:04:13 INFO - Running setup.py install for mozdebug 13:04:13 INFO - Running setup.py install for mozdevice 13:04:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:04:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:04:13 INFO - Running setup.py install for mozfile 13:04:13 INFO - Running setup.py install for mozhttpd 13:04:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:04:13 INFO - Running setup.py install for mozinfo 13:04:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Running setup.py install for mozInstall 13:04:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Running setup.py install for mozleak 13:04:14 INFO - Running setup.py install for mozlog 13:04:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Running setup.py install for moznetwork 13:04:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Running setup.py install for mozprocess 13:04:14 INFO - Running setup.py install for mozprofile 13:04:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Running setup.py install for mozrunner 13:04:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:04:14 INFO - Running setup.py install for mozscreenshot 13:04:14 INFO - Running setup.py install for moztest 13:04:15 INFO - Running setup.py install for mozversion 13:04:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:04:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:04:15 INFO - Cleaning up... 13:04:15 INFO - Return code: 0 13:04:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:04:15 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')]} 13:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:15 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')]} 13:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 13:04:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 13:04:15 INFO - Using env: {'DISPLAY': ':0', 13:04:15 INFO - 'HOME': '/home/cltbld', 13:04:15 INFO - 'LANG': 'en_US.UTF-8', 13:04:15 INFO - 'LANGUAGE': 'en_US:en', 13:04:15 INFO - 'LOGNAME': 'cltbld', 13:04:15 INFO - 'MAIL': '/var/mail/cltbld', 13:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:15 INFO - 'MOZ_NO_REMOTE': '1', 13:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:15 INFO - 'NO_EM_RESTART': '1', 13:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:15 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:15 INFO - 'SHELL': '/bin/bash', 13:04:15 INFO - 'SHLVL': '1', 13:04:15 INFO - 'TERM': 'linux', 13:04:15 INFO - 'TMOUT': '86400', 13:04:15 INFO - 'USER': 'cltbld', 13:04:15 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:15 INFO - '_': '/tools/buildbot/bin/python'} 13:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:04:15 INFO - Running setup.py (path:/tmp/pip-2VbgEB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:04:15 INFO - Running setup.py (path:/tmp/pip-lQTW_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:04:15 INFO - Running setup.py (path:/tmp/pip-L5ScOK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:04:15 INFO - Running setup.py (path:/tmp/pip-ubDWka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:04:15 INFO - Running setup.py (path:/tmp/pip-a0L59y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:04:15 INFO - Running setup.py (path:/tmp/pip-1iUKeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:04:15 INFO - Running setup.py (path:/tmp/pip-PcSe4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:04:15 INFO - Running setup.py (path:/tmp/pip-F6PDcs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:04:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:04:15 INFO - Running setup.py (path:/tmp/pip-qmMo4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:04:16 INFO - Running setup.py (path:/tmp/pip-GlJW0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:04:16 INFO - Running setup.py (path:/tmp/pip-cnWxDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:04:16 INFO - Running setup.py (path:/tmp/pip-A8U0eA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:04:16 INFO - Running setup.py (path:/tmp/pip-LP8ENh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:04:16 INFO - Running setup.py (path:/tmp/pip-_kNVPh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:04:16 INFO - Running setup.py (path:/tmp/pip-ki6Jha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:04:16 INFO - Running setup.py (path:/tmp/pip-p8YqCI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:04:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:04:16 INFO - Running setup.py (path:/tmp/pip-EHd6ST-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:04:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:18 INFO - Downloading blessings-1.5.1.tar.gz 13:04:18 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:04:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:04:18 INFO - Installing collected packages: blessings 13:04:18 INFO - Running setup.py install for blessings 13:04:18 INFO - Successfully installed blessings 13:04:18 INFO - Cleaning up... 13:04:18 INFO - Return code: 0 13:04:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:04:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:04:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:04:18 INFO - Reading from file tmpfile_stdout 13:04:18 INFO - Current package versions: 13:04:18 INFO - argparse == 1.2.1 13:04:18 INFO - blessings == 1.5.1 13:04:18 INFO - blobuploader == 1.2.4 13:04:18 INFO - docopt == 0.6.1 13:04:18 INFO - manifestparser == 1.1 13:04:18 INFO - mozInstall == 1.12 13:04:18 INFO - mozcrash == 0.16 13:04:18 INFO - mozdebug == 0.1 13:04:18 INFO - mozdevice == 0.46 13:04:18 INFO - mozfile == 1.2 13:04:18 INFO - mozhttpd == 0.7 13:04:18 INFO - mozinfo == 0.8 13:04:18 INFO - mozleak == 0.1 13:04:18 INFO - mozlog == 3.0 13:04:18 INFO - moznetwork == 0.27 13:04:18 INFO - mozprocess == 0.22 13:04:18 INFO - mozprofile == 0.27 13:04:18 INFO - mozrunner == 6.11 13:04:18 INFO - mozscreenshot == 0.1 13:04:18 INFO - mozsystemmonitor == 0.0 13:04:18 INFO - moztest == 0.7 13:04:18 INFO - mozversion == 1.4 13:04:18 INFO - psutil == 3.1.1 13:04:18 INFO - requests == 1.2.3 13:04:18 INFO - wsgiref == 0.1.2 13:04:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:04: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')]} 13:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 13:04:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 13:04:18 INFO - Using env: {'DISPLAY': ':0', 13:04:18 INFO - 'HOME': '/home/cltbld', 13:04:18 INFO - 'LANG': 'en_US.UTF-8', 13:04:18 INFO - 'LANGUAGE': 'en_US:en', 13:04:18 INFO - 'LOGNAME': 'cltbld', 13:04:18 INFO - 'MAIL': '/var/mail/cltbld', 13:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:18 INFO - 'MOZ_NO_REMOTE': '1', 13:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:18 INFO - 'NO_EM_RESTART': '1', 13:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:18 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:18 INFO - 'SHELL': '/bin/bash', 13:04:18 INFO - 'SHLVL': '1', 13:04:18 INFO - 'TERM': 'linux', 13:04:18 INFO - 'TMOUT': '86400', 13:04:18 INFO - 'USER': 'cltbld', 13:04:18 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:18 INFO - '_': '/tools/buildbot/bin/python'} 13:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:04:18 INFO - Cleaning up... 13:04:18 INFO - Return code: 0 13:04:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:04: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')]} 13:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04: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')]} 13:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 13:04:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 13:04:18 INFO - Using env: {'DISPLAY': ':0', 13:04:18 INFO - 'HOME': '/home/cltbld', 13:04:18 INFO - 'LANG': 'en_US.UTF-8', 13:04:18 INFO - 'LANGUAGE': 'en_US:en', 13:04:18 INFO - 'LOGNAME': 'cltbld', 13:04:18 INFO - 'MAIL': '/var/mail/cltbld', 13:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:18 INFO - 'MOZ_NO_REMOTE': '1', 13:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:18 INFO - 'NO_EM_RESTART': '1', 13:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:18 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:18 INFO - 'SHELL': '/bin/bash', 13:04:18 INFO - 'SHLVL': '1', 13:04:18 INFO - 'TERM': 'linux', 13:04:18 INFO - 'TMOUT': '86400', 13:04:18 INFO - 'USER': 'cltbld', 13:04:18 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:18 INFO - '_': '/tools/buildbot/bin/python'} 13:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:19 INFO - Downloading/unpacking jsonschema 13:04:19 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 13:04:19 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 13:04:19 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 13:04:19 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 13:04:19 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 13:04:19 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 13:04:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:04:20 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 13:04:20 INFO - Downloading/unpacking functools32 (from jsonschema) 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:21 INFO - Downloading functools32-3.2.3-2.tar.gz 13:04:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:04:21 INFO - warning: no files found matching '*.txt' 13:04:21 INFO - no previously-included directories found matching 'build' 13:04:21 INFO - no previously-included directories found matching 'dist' 13:04:21 INFO - no previously-included directories found matching '.git*' 13:04:21 INFO - Installing collected packages: jsonschema, functools32 13:04:21 INFO - Running setup.py install for functools32 13:04:21 INFO - warning: no files found matching '*.txt' 13:04:21 INFO - no previously-included directories found matching 'build' 13:04:21 INFO - no previously-included directories found matching 'dist' 13:04:21 INFO - no previously-included directories found matching '.git*' 13:04:21 INFO - Successfully installed jsonschema functools32 13:04:21 INFO - Cleaning up... 13:04:21 INFO - Return code: 0 13:04:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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 0x7f6f731fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 13:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/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-pgo/build 13:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/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 13:04:21 INFO - Using env: {'DISPLAY': ':0', 13:04:21 INFO - 'HOME': '/home/cltbld', 13:04:21 INFO - 'LANG': 'en_US.UTF-8', 13:04:21 INFO - 'LANGUAGE': 'en_US:en', 13:04:21 INFO - 'LOGNAME': 'cltbld', 13:04:21 INFO - 'MAIL': '/var/mail/cltbld', 13:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:21 INFO - 'MOZ_NO_REMOTE': '1', 13:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:21 INFO - 'NO_EM_RESTART': '1', 13:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:21 INFO - 'SHELL': '/bin/bash', 13:04:21 INFO - 'SHLVL': '1', 13:04:21 INFO - 'TERM': 'linux', 13:04:21 INFO - 'TMOUT': '86400', 13:04:21 INFO - 'USER': 'cltbld', 13:04:21 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:21 INFO - '_': '/tools/buildbot/bin/python'} 13:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:21 INFO - Downloading/unpacking flake8 13:04:21 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 13:04:21 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 13:04:21 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 13:04:21 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 13:04:21 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 13:04:21 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 13:04:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:04:23 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 13:04:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:04:23 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 13:04:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 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 13:04:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:04:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:04:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:04:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:04:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:04:23 INFO - no previously-included directories found matching 'docs/_build' 13:04:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:04:23 INFO - Running setup.py install for pep8 13:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:04:24 INFO - no previously-included directories found matching 'docs/_build' 13:04:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:04:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:04:24 INFO - Cleaning up... 13:04:24 INFO - Return code: 0 13:04:24 INFO - Running post-action listener: _resource_record_post_action 13:04:24 INFO - Running post-action listener: _start_resource_monitoring 13:04:24 INFO - Starting resource monitoring. 13:04:24 INFO - ##### 13:04:24 INFO - ##### Running install step. 13:04:24 INFO - ##### 13:04:24 INFO - Running pre-action listener: _resource_record_pre_action 13:04:24 INFO - Running main action method: install 13:04:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:04:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:04:24 INFO - Reading from file tmpfile_stdout 13:04:24 INFO - Detecting whether we're running mozinstall >=1.0... 13:04:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:04:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:04:24 INFO - Reading from file tmpfile_stdout 13:04:24 INFO - Output received: 13:04:24 INFO - Usage: mozinstall [options] installer 13:04:24 INFO - Options: 13:04:24 INFO - -h, --help show this help message and exit 13:04:24 INFO - -d DEST, --destination=DEST 13:04:24 INFO - Directory to install application into. [default: 13:04:24 INFO - "/builds/slave/test-pgo"] 13:04:24 INFO - --app=APP Application being installed. [default: firefox] 13:04:24 INFO - mkdir: /builds/slave/test-pgo/build/application 13:04:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:04:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:04:38 INFO - Reading from file tmpfile_stdout 13:04:38 INFO - Output received: 13:04:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:04:38 INFO - Running post-action listener: _resource_record_post_action 13:04:38 INFO - ##### 13:04:38 INFO - ##### Running run-tests step. 13:04:38 INFO - ##### 13:04:38 INFO - Running pre-action listener: _resource_record_pre_action 13:04:38 INFO - Running main action method: run_tests 13:04:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:04:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:04:38 INFO - Python 2.7.3 13:04:38 INFO - Return code: 0 13:04:38 INFO - grabbing minidump binary from tooltool 13:04:38 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')]} 13:04:38 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-pgo/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 0x1f41350>, '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 0x1f42250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f426e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:04:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:04:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:04:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:04:38 INFO - Return code: 0 13:04:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:04:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:04:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:04:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:04:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:04:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:04:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:04:39 INFO - Return code: 0 13:04:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:04:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 13:04:39 INFO - Using env: {'DISPLAY': ':0', 13:04:39 INFO - 'HOME': '/home/cltbld', 13:04:39 INFO - 'LANG': 'en_US.UTF-8', 13:04:39 INFO - 'LANGUAGE': 'en_US:en', 13:04:39 INFO - 'LOGNAME': 'cltbld', 13:04:39 INFO - 'MAIL': '/var/mail/cltbld', 13:04:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:04:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:39 INFO - 'MOZ_NO_REMOTE': '1', 13:04:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:39 INFO - 'NO_EM_RESTART': '1', 13:04:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:04:39 INFO - 'SHELL': '/bin/bash', 13:04:39 INFO - 'SHLVL': '1', 13:04:39 INFO - 'TERM': 'linux', 13:04:39 INFO - 'TMOUT': '86400', 13:04:39 INFO - 'USER': 'cltbld', 13:04:39 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136', 13:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:39 INFO - '_': '/tools/buildbot/bin/python'} 13:04:39 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 13:04:40 INFO - mozversion INFO | application_buildid: 20151216103901 13:04:40 INFO - mozversion INFO | application_changeset: 65ae1a6420dc2952dbee4267f00603e95556f966 13:04:40 INFO - mozversion INFO | application_display_name: Nightly 13:04:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:04:40 INFO - mozversion INFO | application_name: Firefox 13:04:40 INFO - mozversion INFO | application_remotingname: firefox 13:04:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:04:40 INFO - mozversion INFO | application_vendor: Mozilla 13:04:40 INFO - mozversion INFO | application_version: 44.0 13:04:40 INFO - mozversion INFO | platform_buildid: 20151216103901 13:04:40 INFO - mozversion INFO | platform_changeset: 65ae1a6420dc2952dbee4267f00603e95556f966 13:04:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:04:40 INFO - mozversion INFO | platform_version: 44.0 13:04:40 INFO - 2015-12-16 13:04:40,011 DEBUG : using testdate: 1450299880 13:04:40 INFO - 2015-12-16 13:04:40,011 DEBUG : actual date: 1450299880 13:04:40 INFO - 2015-12-16 13:04:40,022 INFO : starting webserver on 'localhost:43932' 13:04:40 INFO - 2015-12-16 13:04:40,023 INFO : Starting test suite talos-linux64-ix-022 13:04:40 INFO - 2015-12-16 13:04:40,023 INFO : Starting test dromaeo_css 13:04:40 INFO - 2015-12-16 13:04:40,023 DEBUG : operating with platform_type : linux_ 13:04:40 INFO - 2015-12-16 13:04:40,024 INFO : Initialising browser for dromaeo_css test... 13:04:40 INFO - 2015-12-16 13:04:40,038 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg0lV7R/profile http://localhost:43932/getInfo.html 13:04:43 INFO - 2015-12-16 13:04:43,958 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:04:43 INFO - 2015-12-16 13:04:43,959 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:04:43 INFO - 2015-12-16 13:04:43,959 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:04:43 INFO - 2015-12-16 13:04:43,959 DEBUG : BROWSER_OUTPUT: __metrics 13:04:44 INFO - 2015-12-16 13:04:44,156 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:04:45 INFO - 2015-12-16 13:04:45,533 INFO : Browser initialized. 13:04:45 INFO - 2015-12-16 13:04:45,534 INFO : Running cycle 1/1 for dromaeo_css test... 13:04:45 INFO - 2015-12-16 13:04:45,534 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg0lV7R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:04:57 INFO - 2015-12-16 13:04:57,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 129298432 13:04:57 INFO - 2015-12-16 13:04:57,082 DEBUG : BROWSER_OUTPUT: 13:05:48 INFO - 2015-12-16 13:05:48,019 DEBUG : BROWSER_OUTPUT: 1450299948016 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] 13:07:56 INFO - 2015-12-16 13:07:56,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43932/tests/dromaeo/cssquery-ext.html) 13:07:57 INFO - 2015-12-16 13:07:57,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 227377152 13:07:57 INFO - 2015-12-16 13:07:57,273 DEBUG : BROWSER_OUTPUT: 13:10:59 INFO - 2015-12-16 13:10:59,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-ext.html (next: http://localhost:43932/tests/dromaeo/cssquery-jquery.html) 13:10:59 INFO - 2015-12-16 13:10:59,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 207294464 13:10:59 INFO - 2015-12-16 13:10:59,849 DEBUG : BROWSER_OUTPUT: 13:14:01 INFO - 2015-12-16 13:14:01,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43932/tests/dromaeo/cssquery-mootools.html) 13:14:02 INFO - 2015-12-16 13:14:02,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 208637952 13:14:02 INFO - 2015-12-16 13:14:02,140 DEBUG : BROWSER_OUTPUT: 13:17:03 INFO - 2015-12-16 13:17:03,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43932/tests/dromaeo/cssquery-prototype.html) 13:17:04 INFO - 2015-12-16 13:17:04,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 193269760 13:17:04 INFO - 2015-12-16 13:17:04,403 DEBUG : BROWSER_OUTPUT: 13:20:06 INFO - 2015-12-16 13:20:06,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43932/tests/dromaeo/cssquery-yui.html) 13:20:07 INFO - 2015-12-16 13:20:07,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 195067904 13:20:07 INFO - 2015-12-16 13:20:07,230 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-yui.html (next: http://localhost:43932/tests/dromaeo/cssquery-dojo.html) 13:23:09 INFO - 2015-12-16 13:23:09,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 233750528 13:23:09 INFO - 2015-12-16 13:23:09,526 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,526 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:23:09 INFO - 2015-12-16 13:23:09,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:23:09 INFO - 2015-12-16 13:23:09,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:23:09 INFO - 2015-12-16 13:23:09,526 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:23:09 INFO - 2015-12-16 13:23:09,527 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3299.5215693724413;3365.1755319946615;3400.353932752777;3400.8129552874598;3433.279011407605;5471.37079235888;5513.917291240629;5561.4716601922755;5571.5542756579525;5588.357338906027;5560.666360018402;5593.972030139854;5601.579881508883;5625.437456254373;5636.041872881609;5059.898802023967;5064.670796398241;5098.847034588968;5135.255387968742;5156.381234251895;4977.303177555127;4978.477259887714;4979.701217926918;4986.675866068712;5033.899322013576;5001.499850015006;5069.645124841262;5085.745712714368;5108.335916330871;5148.099082660538;5115.846524604268;5143.742812859379;5148.459411761749;5162.716050617196;5184.559312458446;4921.01579684061;4934.4572097069295;5001.824936127218;5064.366954130734;5070.949290507085;5360.061989151883;5473.261109750172;5483.616146869721;5496.120620700669;5503.174523821419;6046.062860256668;6047.485963693048;6053.576249662526;6057.3336932937345;6058.363871793443;5762.164486149527;5858.150568167634;5883.294004719461;6028.4272994065495;6062.363451837582;5501.092319767194;5518.33779946401;5518.696471694056;5521.751521181516;5568.331800183963;5926.703664816828;5930.822075337746;5932.317783454958;5980.401959804072;5999.670018149044;5608.887822243532;5701.4298570142655;5813.854653633693;5907.1434641976675;5938.524918006636;5910.940890591039;5919.1713160157615;5932.940670593325;5932.970335148297;5946.494547963472;5638.548916086703;5878.823635290948;5881.206037185011;5889.882202355929;5895.115732640138;5776.537876969833;5960.254968128984;6060.363661815534;6070.605410648293;6089.604175728564;4594.081183763261;4605.631549476034;4610.9308360374625;4613.284940834176;4634.281686338623;3995.9200815983518;4081.0817566047995;4136.296829538986;4144.316187828975;4170.374443833449;5480.177973303957;5482.945170548243;5540.722963851791;5581.581381396411;5607.214989901417;5876.9118463223085;5879.412058794172;5896.439838215449;5898.498627616701;5900.055991041413;5435.809746658848;5436.809711660073;5541.058020136506;5578.41426650204;5589.692566908778;5234.973825130926;5243.9213411798855;5246.4753524647995;5254.054270231395;5256.842294731164;6178.320384757673;6178.382161783876;6183.690815459209;6184.474319682788;6186.319504854552;5642.012647786703;5739.7417116229035;5876.265466816648;6014.849628759141;6043.8186854394435;6233.906491402723;6248;6253.624782513064;6255.78104766331;6255.812325630239;5993.190919225849;5998.940010599838;6005.909911351246;6019.608725432833;6036.939630603638;5755.913661295168;5856.209411729362;5902.2622172228475;5996.130561068708;5997.430244126801;5687.857803554944;5897.764089436375;5913.319968203712;5918.940810592011;5922;5513.338399392099;5872.765089396376;5921.911171332519;5923.674197918984;5925.1704761332585;5506.339239291311;5631.6902570359025;5655.066913959151;5661.716914154194;5672.886542269214;5834.299884013776;5860.94139058621;5868.2077919480325;5869.589128760946;5872.941270587239;5505.146702261156;5624.634398764068;5733;5735.569832262514;5737.627054241461 13:23:09 INFO - 2015-12-16 13:23:09,527 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.2429069337782;623.5011990407675;632.901900205468;633.3065293503613;640.57081755224;35066.824665876666;44114;44593.55406445934;44629;44645.107097858105;47390;47585.286220706716;47875.76062119693;47914.520854791444;47996.280055799194;8234.217749313806;8354.958225208866;9245.075492450751;9401.62393504259;9417.670381536647;10988.835167472495;11255.774884502305;11262.831057534102;11268.380239086848;11269.718257043558;10879.238453308271;10929.071028962548;10975.670729878117;10976.067034302094;11009.724756881062;10933.781324373547;10966.451677416097;11030.117590592734;11046.558137674483;11058.060064894493;10734.409607471585;10844.783104337868;10866.782664346747;10867.184961127869;10868.728281792939;44964.77517612391;45320.86697832547;45338.09323813505;45406.77296613496;45468;3589.892303230907;3687.3915803892323;3703.259348130358;4121.773302468363;4287.056847493546;33046.6695333046;33437.331253374796;33541.49687754686;33665.831670841486;34282.31435371304;3866.555346135174;3903.8048097595006;3933.1347103637154;3952.0910190656023;4012.4583181270445;326995.3650231757;327900;329142;329438;491773.5411322956;55107.72446137824;71539;72846;72953;72998.27001730021;67014;67986.66006669935;68072.31927680758;68086.65956670186;68142;18388.724169137473;18495.72256416128;18579.349722759638;18630.81369186318;18649.7202541962;14168.079074860101;14428.206448645426;14460.85539144616;14469;14472;20416.183352666023;20480.795192048186;20626.690599641017;20645.17419303211;20703.171873124906;7874.173211812792;8042.195780422028;8069.435139540294;8098.635561399751;8121.837563248702;987.2644879564626;1008.6873069348526;1025.3437799808128;1071.8338657508098;1090.39536780946;29775.957841475443;29795;30737.538936915964;30832;31123.84438077795;1096.188820273008;1105.4583254205381;1154.5324143721807;1163.5835187203581;1231.5443285984243;14086;15005.24973751308;16045.759313610306;16287.91856040736;16547.172641367884;288902;289153;289295;290627;292479;53563.73218133884;53818.46181538134;54189.45810541844;54225.45774542283;54233.72883135638;1380.3926272440094;1475.2992328643809;1478.1057460236616;1487.4793822162374;1493.081754720839;27956.161315160578;28053.859730701217;28525.572116418687;28694.71305287004;28767;47952;48254;48416;48449;48453.75773121112;285980;286647;287482;288313;289087;33298.833505832314;35571.64428355787;35585.82207088948;35814;36443.08892277714;43518.56481435145;44036.779816100716;44189.116217676106;44786.3282050763;44886.3267050988;36542;36600;36636.45045324269;37138.814305928296;37530.06174845651;39153.0334863444;39727.404088938114;40223.396649050876;40616.79691601523;40671.38992915049;39404.80297598494;40212.798936005136;40242.39636405398;40319;40344.596554034084;34753.478697819046;35222.29555408826;35863.82068089643;36729.44905826361;36757.816210918776;27627.723722762516;27714.584281235395;27868.442631147667;27905.581416278364;27953.72046279511 13:23:09 INFO - 2015-12-16 13:23:09,527 DEBUG : BROWSER_OUTPUT: |2;jquery.html;374.5093926955688;377.65178313421063;378.0906918860142;383.7467271600744;384.11653197645427;12886.613401597968;15648.530544083667;17743.822561774396;19865.60268794625;19871.503212419677;19183.23267069319;19332.3233686821;19481.805181948177;19509.414717558495;19658.606827863434;5750.281214848144;5859.7656093756195;5868.325142608591;5881.294244690643;5892.204552385438;4451.310046942729;4576.633869290449;5798.014337562603;6405.29541750407;6598.967005164967;6376.107344971708;6498.675066246692;6523.4455071319;6553.672316384185;6556.672166391685;6462.644554549498;6493.285738568754;6500.707468163944;6506.284308726013;6508.414242718178;4481.327800829901;4586.495485496593;5749.223854779593;5763.711814409263;5774.88450230993;14800.333984970703;14878.851211487854;14973.176475293854;15089.622759430993;15150.469733559272;2128.3508529898377;2189.4745261137373;2215.4682876109778;2218.6006518826603;2231.5313784105356;10952.233343665946;11113.222074454792;11264.54941802335;11271.718207044889;11383.146264030149;1666.2585149608428;1828.6159906419668;1839.3746126317117;1862.1806405181676;1926.5183704073982;70078.64960675215;70589;71179.99999999948;71400;72369;7291.744788932362;7399.4450416219;7453.105627324756;7454.664540095709;7500.212477689873;9073.54632268384;9077.636894524278;9085.364024518352;9100.180983711365;9115.316351273681;6286.654234017082;6306.085617585424;6331.525135614847;6332.366763323631;6372.904406433907;6614.933850661528;6616.702248398834;6626.7017984190825;6628.23775265841;6636.83407914806;3537;3585.8744943926836;3590.6409359063887;3612.6567976042234;3614.1326081740194;1177.605502156787;1210.9515619375302;1211.896988755948;1220.0056953582803;1277.2783377391745;517.4851023231834;526.2579762534807;532.9760160792773;536.5171345788822;558.954754608884;11467.885321146849;12775.936120319338;12795;13169.73660526784;13401.262930538718;550.9173623956439;553.9030669632798;563.5829486180197;575.1918554431031;591.1900696046443;6534.961198357582;7256.7460138894885;7337.26627337262;7368.1526624438875;7391.8152046199275;626889;627254;632010;666973;672730;83992.16007839965;84380;87598;88589.55705221432;91877;578.0491092153468;585.6105689716376;585.7920438244362;586.1471558881732;588.1413136820205;12301.384930753247;12406.25562466255;12468.875311247135;12534;12558.686032849251;39448.2110357797;39597;39958.2008359837;40033;40979.59020409758;53668.73165634147;53708.19437708359;54756.452435475134;55156;55204;6693.330666933462;6695.296993815774;6832.0435139081565;6834;6844.041834143124;12959.546415875398;13082.215067096005;13089.934550327187;13093;13394.397252123483;11409.942950285196;11677.649670509898;11768.293902365886;11841;12020.03839692805;9911.851322230317;11209.88790112121;11237.775244495228;11536.192466527598;11904.464299106734;10366.688999330032;10430.322029068086;11092.722681933015;11855.466504007169;12162;7239.167495738057;7279.708811647475;7381.630918453949;7392.593407362647;7402.1857595665515;12061.51753929833;12248.938755306523;12297.50809967627;12402.25586464815;12478.064145188966 13:23:09 INFO - 2015-12-16 13:23:09,527 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1589.1577463944107;1589.2451085734278;1845.114345114345;1848.8983105929185;1888.773347198336;7921.207879212076;8364.121767214447;8369.539675317863;8375.958120209398;8379.455335403194;7307.342339189472;7461.365783908361;7877.80305492363;8171.18288171184;8201.425900186974;2339.847909885856;2355.6348765941307;2357.4695693469002;2376.5246950609862;2377.6909001829827;2111.9366419007456;2337.9298621041394;2347.1432926981615;2377.8573285602833;2383.594788885885;2108.7469503659504;2316.177756896303;2357.068957761683;2357.316378250305;2357.634566642173;2311.9422014449606;2314.0975019742314;2316.5945959457113;2375.4892698069825;2380.595298799191;2365.680633114525;2369.7393286738443;2401.231605886117;2404.026369320428;2409.325388891113;8113.472624279403;8137.064237612632;8149.185081491863;8155.184481551797;8169.142240064826;4900.289458028602;4991.800327986876;4994.850154495371;5007.298978143026;5008.424031236418;3194.5687332210086;3219.6297425795865;3224.4034853552166;3245.1562593725566;3251.4309995750887;1098.8406681031286;2017.616652835971;2109.261758384553;2112.852100352976;2121.363590922717;10871.565137394495;10974.506147223394;10982.890171098346;10994.28537145083;11016.614418495394;4118.546959834416;4160.375943608483;4204.432401625802;4222.746635201897;4223.915521689611;9031.36780425364;9034.2320902724;9054.909450905538;9058.365914386062;9066.637334506679;4797.880052998633;4803.303520989437;4804.471508134172;4805.783739731721;4811.374521312207;4446.777661116996;4461.553844615512;4471.597556219956;4472.351509031172;4479.641628669699;3605.7836529808296;3632.8728494503093;3636.563612366533;3642;3669.9266014680093;962.5235508423235;994.0755097759153;1056.8414737789394;1061.0344586426315;1065.1532032034552;1000.5547531348626;1087.7498175419698;1155.9711007224887;1185.508014174108;1188.2514016169757;7930.603469826486;7959.44283900133;7966.044074710956;7976.6410511525955;8005.879911801328;1228.121892846601;1237.7648246833073;1242.7374106813716;1259.5339724302066;1274.8342715447118;6176.567640265228;6324.2410910691015;6359.332270111664;6363.363663633692;6384.968075159594;9655.758606034906;9746.122848943629;9784.070513301225;9796.069373409515;9808.313418060667;9533.570989305497;9594.232461403071;9672.903270967201;9800;9817.607295708092;7482.775516734507;7554.244575542401;7571.129320128146;7573.962130189424;7589.051368578927;7340.11918569775;7484.850302994018;7485.47601667878;7540.245975402416;7554.2823431773895;8686.131386861263;8686.435381700168;8764.255038321815;9016.09839016093;9037.819243615222;8639.87040194385;8815.118488151134;8834.955825220834;9047;9053.864192036994;7443.962780186064;7448.366888814511;7494.662740176596;7538.09542854861;7540.773776786705;8068.59657017135;8081.676732930617;8132.024157101186;8138.348932085537;8145.8370832584205;6324.968375158095;7606.391488680782;7640.541567505968;7784.299413052852;7814.648340824563;7158.463115266271;7203.171635262012;7210.855782884208;7267.818304542428;7420.183779784327;7419.4806363554035;7447.776566703008;7453.180150183584;7459;7461.179270280373;6761;6827.385535301847;6869.107016087876;6876.312368763083;6889.379955804002;7031.578105313698;7048.718051277891;7078.221395646578;7085.57486550788;7097.82255443618 13:23:09 INFO - 2015-12-16 13:23:09,527 DEBUG : BROWSER_OUTPUT: |4;prototype.html;354.8917580138058;357.91052236940766;362.93104310181053;364.09159147925914;365.1947455859828;5990.820275391745;5992.3108842483125;5995.550333724972;6001.339852616215;6020.247469066367;5755.366909639936;5804.651720896749;5844.970775146129;5916.5266778657715;5932.911006334908;4644.5819876211135;4685.929711054337;4687.8359257426;4689.695169813968;4689.9062018759605;4662.300654901758;4670.696404733699;4675.11172877154;4682.90634187316;4686.062787442508;4488.483824360192;4538.296564032564;4578.725276483405;4647.581717645411;4659.370984917026;4629.65277604181;4644.8374306899095;4648.744319062467;4661.487236403993;4671.182543054969;4116.670666346715;4124.628783409507;4129.772862492562;4130.112025914443;4132.607402296777;5631.2960879890015;5631.408702086263;5647;5667.914981275284;5678.914816277759;5308.575313974873;5378.919316210221;5386.299781028441;5389.191621256804;5390.299261096072;6330.17707698001;6332.081848131995;6334.208223972004;6338.87322253557;6345.17512723343;4511.526289739563;4513.1425029244665;4514.525974772634;4515.909681806378;4517.503074661785;6430.967845160744;6482.7082781274485;6543.378379053982;6564.638944858031;6572.11276477679;4650.162970665313;4651.2557990721325;4655.2784318430695;4656.278276867091;4671.252599584118;4709.481956984729;4710.52894710533;4712.31671407644;4715;4716.056788642285;5410.594205434608;5412.215228791882;5412.756425960842;5414.133738601805;5417.512423881791;6327.430531252117;6446.967765161145;6448.677566121769;6454.4513716333695;6454.580452270588;1668.2826384654716;1684.1242553871919;1684.713598688226;1685.2500637216567;1686.4940517844598;1126.3242054767074;1136.3182090745652;1139.2367114033618;1151.234429104636;1158.391844281742;6182.845428864314;6185.195924529782;6187.597806142587;6188.9690551546955;6190.3190649028575;6563.704633291513;6576.243731970789;6576.5067619928695;6579.901301480481;6585.736570537125;5981.461668449861;6049.304330002106;6052.334243233241;6179.721912513947;6182.412670796267;3607.494950706903;3619.819009049537;3625.166211771307;3625.2024554597947;3635.781853088823;6750.35871592198;6787.6266805325195;6809.7276108956075;6812.284710105467;6814.386705196457;6695.765648202387;6819.283975182534;6845.212800528003;6849.760258390932;6850.828729281709;6816.659167041727;6823.727050918007;6824.18109826824;6828.146481689789;6828.146481689789;6544.44372228366;6642.568233064835;6643.435307998681;6646.036324732983;6646.8005959821285;6544.8363790905605;6570.5400621956005;6579.4736421087155;6579.703913323816;6581.3418658135715;6743.494237932076;6751.594904305757;6752.122224110834;6753.257141714505;6802.8639427212165;4663.836765713184;4663.906721865475;4665.370175026328;4668.78990445424;4670.276107203389;6577.50668699859;6625.17185351831;6667.666616669244;6667.966660166668;6674.566153200027;6480.611163330027;6487.286398496068;6490.513211509061;6494.6752662367635;6498.057781621733;6468.676566171766;6476.935230647633;6478.967605161944;6482.611043337415;6484.1894763154605;6216.502679785516;6307.779227727007;6314.273858506147;6316.494680425647;6317.6841157941;6413;6415;6433.195850518685;6439.098526206241;6439.645819479973;6111.908321375094;6191.690415479298;6222.533310001859;6230.283517395557;6232.906506402498 13:23:09 INFO - 2015-12-16 13:23:09,527 DEBUG : BROWSER_OUTPUT: |5;yui.html;829.6391069884598;911.8085202107558;934.0892629686057;974.8934958821735;976.0678551982853;13728.725425491484;13931.512397066104;13950.790738138936;13970.23163725996;14013.159210447368;13473.797893031588;13476.25880576568;13992.720145597108;13997.370118344674;14014.509492167776;793.7261644732558;798.253632853284;934.8270569944565;935.9578818953163;957.6935380678186;945.2060269373725;945.7635591102224;952.7808604021079;953.5708930981051;954.312894715807;994.8308787506105;1000.4747507558553;1000.8098461292332;1001.5192707500404;1001.9799604007916;992.1318846009741;992.1665800727387;992.3698451483287;992.4938281476427;992.8808542974817;730.1639622632109;732.4653003307616;735.3418690272176;736.3556887723242;739.3272122368619;14179.14925104497;14256.643583910381;14273.714525709427;14275.428982840675;14288.428462861473;13079.41142648583;13627.250501222428;13963;14009.229492378017;14018.859811401857;11251.324920504714;11271.60549380776;11317.603883864107;11319;11480.598179063776;3837.0982819037504;3868.2650296443585;3902.1088310098235;3919.274934137165;3920.176762879799;51231.23153152705;51540;54001;54080.45919540833;54138.18792718073;10427.026757686013;10479.28229832105;10650.201234907257;10704.678859634068;10770.461476926122;18932.526686832665;18985.90507047456;19009;19141.13864876084;19157.13792879296;8190.467619604707;8233.217844304781;8376.12050734664;8459.534725590029;8497.660093596187;4300.0109974705365;4384.802683879169;4388.71473354231;4518.344839998182;4525.954740452619;3230.870765169414;3265.967340326614;3269.1336795749144;3273.083536609753;3278.9836050819595;495.60351718625674;516.4577193946342;521.1505246448265;523.4425337016065;524.1534921102392;620.9037599172135;744.4379493482494;764.8393837294119;773.3542492019114;798.9760307190794;9323.627054917728;9510.572024258925;9852.852207216898;10300.433476158732;10519.789604208027;533.9893202136013;600.4655856287907;702.9261927497539;770.8997830282027;789.6328207383594;4259.957400425956;4402.801873915681;4526.569975852289;4549.09018196362;4559.703619264737;60185;61061.38938610557;61082.38917610767;69539.30460695429;70355.64822175856;52996.735016324674;53228.201576976375;54326.456735432934;58356.7082164595;58493;50917;51176;51834.48165518372;51970.22044669333;52415;9395.122144512983;9838.311318207656;9843.064908833649;9848.567598431175;9928.11365840488;39090.80454597822;40064.799676001436;40842.1831563373;40866;41421.585784141775;50235;52303.215451769014;52867;52999;53443.198352023974;8999.145081217273;9059.954700226457;9207.953960230156;9210.907890921006;9254.12085851843;12147.088968327234;12412.069094817743;12745.362731863555;13828.86171138316;13923.443062277396;13405.798913016117;13649.38577763983;13703.794443083561;14149.292535373395;14306.284685765462;13415.731685366432;13511.594652160451;13653.726925461237;13665.385057672627;13985.090969086978;13349.132306400053;13357.465701371837;13475.258860762751;13612.523561675294;13800.171989680652;11074.446277686244;11226.326420414802;11342.94328528385;11427;11575.536978521102;10348.534315955649;10530.473476326306;10649.627263045757;10955.56177752881;10978.12175026012 13:23:09 INFO - 2015-12-16 13:23:09,527 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,746 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: __startTimestamp1450300989521__endTimestamp 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:23:09 INFO - 2015-12-16 13:23:09,528 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,529 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5523.84 Median:5642.01 stddev:601.77 (10.7%) stddev-sans-first:577.76 13:23:09 INFO - 2015-12-16 13:23:09,530 DEBUG : BROWSER_OUTPUT: Values: 3299.5 3365.2 3400.4 3400.8 3433.3 5471.4 5513.9 5561.5 5571.6 5588.4 5560.7 5594.0 5601.6 5625.4 5636.0 5059.9 5064.7 5098.8 5135.3 5156.4 4977.3 4978.5 4979.7 4986.7 5033.9 5001.5 5069.6 5085.7 5108.3 5148.1 5115.8 5143.7 5148.5 5162.7 5184.6 4921.0 4934.5 5001.8 5064.4 5070.9 5360.1 5473.3 5483.6 5496.1 5503.2 6046.1 6047.5 6053.6 6057.3 6058.4 5762.2 5858.2 5883.3 6028.4 6062.4 5501.1 5518.3 5518.7 5521.8 5568.3 5926.7 5930.8 5932.3 5980.4 5999.7 5608.9 5701.4 5813.9 5907.1 5938.5 5910.9 5919.2 5932.9 5933.0 5946.5 5638.5 5878.8 5881.2 5889.9 5895.1 5776.5 5960.3 6060.4 6070.6 6089.6 4594.1 4605.6 4610.9 4613.3 4634.3 3995.9 4081.1 4136.3 4144.3 4170.4 5480.2 5482.9 5540.7 5581.6 5607.2 5876.9 5879.4 5896.4 5898.5 5900.1 5435.8 5436.8 5541.1 5578.4 5589.7 5235.0 5243.9 5246.5 5254.1 5256.8 6178.3 6178.4 6183.7 6184.5 6186.3 5642.0 5739.7 5876.3 6014.8 6043.8 6233.9 6248.0 6253.6 6255.8 6255.8 5993.2 5998.9 6005.9 6019.6 6036.9 5755.9 5856.2 5902.3 5996.1 5997.4 5687.9 5897.8 5913.3 5918.9 5922.0 5513.3 5872.8 5921.9 5923.7 5925.2 5506.3 5631.7 5655.1 5661.7 5672.9 5834.3 5860.9 5868.2 5869.6 5872.9 5505.1 5624.6 5733.0 5735.6 5737.6 13:23:09 INFO - 2015-12-16 13:23:09,530 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,530 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50237.97 Median:35144.56 stddev:82897.76 (235.9%) stddev-sans-first:83046.43 13:23:09 INFO - 2015-12-16 13:23:09,532 DEBUG : BROWSER_OUTPUT: Values: 569.2 623.5 632.9 633.3 640.6 35066.8 44114.0 44593.6 44629.0 44645.1 47390.0 47585.3 47875.8 47914.5 47996.3 8234.2 8355.0 9245.1 9401.6 9417.7 10988.8 11255.8 11262.8 11268.4 11269.7 10879.2 10929.1 10975.7 10976.1 11009.7 10933.8 10966.5 11030.1 11046.6 11058.1 10734.4 10844.8 10866.8 10867.2 10868.7 44964.8 45320.9 45338.1 45406.8 45468.0 3589.9 3687.4 3703.3 4121.8 4287.1 33046.7 33437.3 33541.5 33665.8 34282.3 3866.6 3903.8 3933.1 3952.1 4012.5 326995.4 327900.0 329142.0 329438.0 491773.5 55107.7 71539.0 72846.0 72953.0 72998.3 67014.0 67986.7 68072.3 68086.7 68142.0 18388.7 18495.7 18579.3 18630.8 18649.7 14168.1 14428.2 14460.9 14469.0 14472.0 20416.2 20480.8 20626.7 20645.2 20703.2 7874.2 8042.2 8069.4 8098.6 8121.8 987.3 1008.7 1025.3 1071.8 1090.4 29776.0 29795.0 30737.5 30832.0 31123.8 1096.2 1105.5 1154.5 1163.6 1231.5 14086.0 15005.2 16045.8 16287.9 16547.2 288902.0 289153.0 289295.0 290627.0 292479.0 53563.7 53818.5 54189.5 54225.5 54233.7 1380.4 1475.3 1478.1 1487.5 1493.1 27956.2 28053.9 28525.6 28694.7 28767.0 47952.0 48254.0 48416.0 48449.0 48453.8 285980.0 286647.0 287482.0 288313.0 289087.0 33298.8 35571.6 35585.8 35814.0 36443.1 43518.6 44036.8 44189.1 44786.3 44886.3 36542.0 36600.0 36636.5 37138.8 37530.1 39153.0 39727.4 40223.4 40616.8 40671.4 39404.8 40212.8 40242.4 40319.0 40344.6 34753.5 35222.3 35863.8 36729.4 36757.8 27627.7 27714.6 27868.4 27905.6 27953.7 13:23:09 INFO - 2015-12-16 13:23:09,532 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,532 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31580.92 Median:534.75 stddev:105788.70 (19783.0%) stddev-sans-first:106059.51 13:23:09 INFO - 2015-12-16 13:23:09,532 DEBUG : BROWSER_OUTPUT: Values: 374.5 377.7 378.1 383.7 384.1 12886.6 15648.5 17743.8 19865.6 19871.5 19183.2 19332.3 19481.8 19509.4 19658.6 5750.3 5859.8 5868.3 5881.3 5892.2 4451.3 4576.6 5798.0 6405.3 6599.0 6376.1 6498.7 6523.4 6553.7 6556.7 6462.6 6493.3 6500.7 6506.3 6508.4 4481.3 4586.5 5749.2 5763.7 5774.9 14800.3 14878.9 14973.2 15089.6 15150.5 2128.4 2189.5 2215.5 2218.6 2231.5 10952.2 11113.2 11264.5 11271.7 11383.1 1666.3 1828.6 1839.4 1862.2 1926.5 70078.6 70589.0 71180.0 71400.0 72369.0 7291.7 7399.4 7453.1 7454.7 7500.2 9073.5 9077.6 9085.4 9100.2 9115.3 6286.7 6306.1 6331.5 6332.4 6372.9 6614.9 6616.7 6626.7 6628.2 6636.8 3537.0 3585.9 3590.6 3612.7 3614.1 1177.6 1211.0 1211.9 1220.0 1277.3 517.5 526.3 533.0 536.5 559.0 11467.9 12775.9 12795.0 13169.7 13401.3 550.9 553.9 563.6 575.2 591.2 6535.0 7256.7 7337.3 7368.2 7391.8 626889.0 627254.0 632010.0 666973.0 672730.0 83992.2 84380.0 87598.0 88589.6 91877.0 578.0 585.6 585.8 586.1 588.1 12301.4 12406.3 12468.9 12534.0 12558.7 39448.2 39597.0 39958.2 40033.0 40979.6 53668.7 53708.2 54756.5 55156.0 55204.0 6693.3 6695.3 6832.0 6834.0 6844.0 12959.5 13082.2 13089.9 13093.0 13394.4 11409.9 11677.6 11768.3 11841.0 12020.0 9911.9 11209.9 11237.8 11536.2 11904.5 10366.7 10430.3 11092.7 11855.5 12162.0 7239.2 7279.7 7381.6 7392.6 7402.2 12061.5 12248.9 12297.5 12402.3 12478.1 13:23:09 INFO - 2015-12-16 13:23:09,533 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,533 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5734.25 Median:6848.25 stddev:2926.06 (42.7%) stddev-sans-first:2917.68 13:23:09 INFO - 2015-12-16 13:23:09,534 DEBUG : BROWSER_OUTPUT: Values: 1589.2 1589.2 1845.1 1848.9 1888.8 7921.2 8364.1 8369.5 8376.0 8379.5 7307.3 7461.4 7877.8 8171.2 8201.4 2339.8 2355.6 2357.5 2376.5 2377.7 2111.9 2337.9 2347.1 2377.9 2383.6 2108.7 2316.2 2357.1 2357.3 2357.6 2311.9 2314.1 2316.6 2375.5 2380.6 2365.7 2369.7 2401.2 2404.0 2409.3 8113.5 8137.1 8149.2 8155.2 8169.1 4900.3 4991.8 4994.9 5007.3 5008.4 3194.6 3219.6 3224.4 3245.2 3251.4 1098.8 2017.6 2109.3 2112.9 2121.4 10871.6 10974.5 10982.9 10994.3 11016.6 4118.5 4160.4 4204.4 4222.7 4223.9 9031.4 9034.2 9054.9 9058.4 9066.6 4797.9 4803.3 4804.5 4805.8 4811.4 4446.8 4461.6 4471.6 4472.4 4479.6 3605.8 3632.9 3636.6 3642.0 3669.9 962.5 994.1 1056.8 1061.0 1065.2 1000.6 1087.7 1156.0 1185.5 1188.3 7930.6 7959.4 7966.0 7976.6 8005.9 1228.1 1237.8 1242.7 1259.5 1274.8 6176.6 6324.2 6359.3 6363.4 6385.0 9655.8 9746.1 9784.1 9796.1 9808.3 9533.6 9594.2 9672.9 9800.0 9817.6 7482.8 7554.2 7571.1 7574.0 7589.1 7340.1 7484.9 7485.5 7540.2 7554.3 8686.1 8686.4 8764.3 9016.1 9037.8 8639.9 8815.1 8835.0 9047.0 9053.9 7444.0 7448.4 7494.7 7538.1 7540.8 8068.6 8081.7 8132.0 8138.3 8145.8 6325.0 7606.4 7640.5 7784.3 7814.6 7158.5 7203.2 7210.9 7267.8 7420.2 7419.5 7447.8 7453.2 7459.0 7461.2 6761.0 6827.4 6869.1 6876.3 6889.4 7031.6 7048.7 7078.2 7085.6 7097.8 13:23:09 INFO - 2015-12-16 13:23:09,534 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,534 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5372.58 Median:6034.78 stddev:1586.60 (26.3%) stddev-sans-first:1545.70 13:23:09 INFO - 2015-12-16 13:23:09,535 DEBUG : BROWSER_OUTPUT: Values: 354.9 357.9 362.9 364.1 365.2 5990.8 5992.3 5995.6 6001.3 6020.2 5755.4 5804.7 5845.0 5916.5 5932.9 4644.6 4685.9 4687.8 4689.7 4689.9 4662.3 4670.7 4675.1 4682.9 4686.1 4488.5 4538.3 4578.7 4647.6 4659.4 4629.7 4644.8 4648.7 4661.5 4671.2 4116.7 4124.6 4129.8 4130.1 4132.6 5631.3 5631.4 5647.0 5667.9 5678.9 5308.6 5378.9 5386.3 5389.2 5390.3 6330.2 6332.1 6334.2 6338.9 6345.2 4511.5 4513.1 4514.5 4515.9 4517.5 6431.0 6482.7 6543.4 6564.6 6572.1 4650.2 4651.3 4655.3 4656.3 4671.3 4709.5 4710.5 4712.3 4715.0 4716.1 5410.6 5412.2 5412.8 5414.1 5417.5 6327.4 6447.0 6448.7 6454.5 6454.6 1668.3 1684.1 1684.7 1685.3 1686.5 1126.3 1136.3 1139.2 1151.2 1158.4 6182.8 6185.2 6187.6 6189.0 6190.3 6563.7 6576.2 6576.5 6579.9 6585.7 5981.5 6049.3 6052.3 6179.7 6182.4 3607.5 3619.8 3625.2 3625.2 3635.8 6750.4 6787.6 6809.7 6812.3 6814.4 6695.8 6819.3 6845.2 6849.8 6850.8 6816.7 6823.7 6824.2 6828.1 6828.1 6544.4 6642.6 6643.4 6646.0 6646.8 6544.8 6570.5 6579.5 6579.7 6581.3 6743.5 6751.6 6752.1 6753.3 6802.9 4663.8 4663.9 4665.4 4668.8 4670.3 6577.5 6625.2 6667.7 6668.0 6674.6 6480.6 6487.3 6490.5 6494.7 6498.1 6468.7 6476.9 6479.0 6482.6 6484.2 6216.5 6307.8 6314.3 6316.5 6317.7 6413.0 6415.0 6433.2 6439.1 6439.6 6111.9 6191.7 6222.5 6230.3 6232.9 13:23:09 INFO - 2015-12-16 13:23:09,535 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-12-16 13:23:09,535 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15299.06 Median:4460.57 stddev:17895.02 (401.2%) stddev-sans-first:17912.23 13:23:09 INFO - 2015-12-16 13:23:09,535 DEBUG : BROWSER_OUTPUT: Values: 829.6 911.8 934.1 974.9 976.1 13728.7 13931.5 13950.8 13970.2 14013.2 13473.8 13476.3 13992.7 13997.4 14014.5 793.7 798.3 934.8 936.0 957.7 945.2 945.8 952.8 953.6 954.3 994.8 1000.5 1000.8 1001.5 1002.0 992.1 992.2 992.4 992.5 992.9 730.2 732.5 735.3 736.4 739.3 14179.1 14256.6 14273.7 14275.4 14288.4 13079.4 13627.3 13963.0 14009.2 14018.9 11251.3 11271.6 11317.6 11319.0 11480.6 3837.1 3868.3 3902.1 3919.3 3920.2 51231.2 51540.0 54001.0 54080.5 54138.2 10427.0 10479.3 10650.2 10704.7 10770.5 18932.5 18985.9 19009.0 19141.1 19157.1 8190.5 8233.2 8376.1 8459.5 8497.7 4300.0 4384.8 4388.7 4518.3 4526.0 3230.9 3266.0 3269.1 3273.1 3279.0 495.6 516.5 521.2 523.4 524.2 620.9 744.4 764.8 773.4 799.0 9323.6 9510.6 9852.9 10300.4 10519.8 534.0 600.5 702.9 770.9 789.6 4260.0 4402.8 4526.6 4549.1 4559.7 60185.0 61061.4 61082.4 69539.3 70355.6 52996.7 53228.2 54326.5 58356.7 58493.0 50917.0 51176.0 51834.5 51970.2 52415.0 9395.1 9838.3 9843.1 9848.6 9928.1 39090.8 40064.8 40842.2 40866.0 41421.6 50235.0 52303.2 52867.0 52999.0 53443.2 8999.1 9060.0 9208.0 9210.9 9254.1 12147.1 12412.1 12745.4 13828.9 13923.4 13405.8 13649.4 13703.8 14149.3 14306.3 13415.7 13511.6 13653.7 13665.4 13985.1 13349.1 13357.5 13475.3 13612.5 13800.2 11074.4 11226.3 11342.9 11427.0 11575.5 10348.5 10530.5 10649.6 10955.6 10978.1 13:23:09 INFO - 2015-12-16 13:23:09,535 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:23:09 INFO - 2015-12-16 13:23:09,535 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-12-16 13:23:10,109 INFO : Browser exited with error code: 0 13:23:10 INFO - 2015-12-16 13:23:10,128 INFO : Completed test dromaeo_css (00:18:30) 13:23:10 INFO - 2015-12-16 13:23:10,128 INFO : Starting test kraken 13:23:10 INFO - 2015-12-16 13:23:10,128 DEBUG : operating with platform_type : linux_ 13:23:10 INFO - 2015-12-16 13:23:10,128 INFO : Initialising browser for kraken test... 13:23:10 INFO - 2015-12-16 13:23:10,134 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMErTY3/profile http://localhost:43932/getInfo.html 13:23:13 INFO - 2015-12-16 13:23:13,704 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:23:13 INFO - 2015-12-16 13:23:13,704 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:23:13 INFO - 2015-12-16 13:23:13,704 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:23:13 INFO - 2015-12-16 13:23:13,704 DEBUG : BROWSER_OUTPUT: __metrics 13:23:13 INFO - 2015-12-16 13:23:13,881 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:23:15 INFO - 2015-12-16 13:23:15,077 INFO : Browser initialized. 13:23:15 INFO - 2015-12-16 13:23:15,078 INFO : Running cycle 1/1 for kraken test... 13:23:15 INFO - 2015-12-16 13:23:15,078 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMErTY3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:23:26 INFO - 2015-12-16 13:23:26,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 128622592 13:23:26 INFO - 2015-12-16 13:23:26,671 DEBUG : BROWSER_OUTPUT: 13:23:29 INFO - 2015-12-16 13:23:29,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-beat-detection) 13:23:29 INFO - 2015-12-16 13:23:29,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 164995072 13:23:29 INFO - 2015-12-16 13:23:29,681 DEBUG : BROWSER_OUTPUT: 13:23:32 INFO - 2015-12-16 13:23:32,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-dft) 13:23:32 INFO - 2015-12-16 13:23:32,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 161468416 13:23:32 INFO - 2015-12-16 13:23:32,822 DEBUG : BROWSER_OUTPUT: 13:23:35 INFO - 2015-12-16 13:23:35,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-fft) 13:23:36 INFO - 2015-12-16 13:23:36,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 157208576 13:23:36 INFO - 2015-12-16 13:23:36,164 DEBUG : BROWSER_OUTPUT: 13:23:38 INFO - 2015-12-16 13:23:38,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-oscillator) 13:23:38 INFO - 2015-12-16 13:23:38,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 155508736 13:23:38 INFO - 2015-12-16 13:23:38,715 DEBUG : BROWSER_OUTPUT: 13:23:40 INFO - 2015-12-16 13:23:40,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:23:41 INFO - 2015-12-16 13:23:41,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 155459584 13:23:41 INFO - 2015-12-16 13:23:41,403 DEBUG : BROWSER_OUTPUT: 13:23:44 INFO - 2015-12-16 13:23:44,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43932/tests/kraken/driver.html?testName=imaging-darkroom) 13:23:44 INFO - 2015-12-16 13:23:44,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 156393472 13:23:44 INFO - 2015-12-16 13:23:44,830 DEBUG : BROWSER_OUTPUT: 13:23:48 INFO - 2015-12-16 13:23:48,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43932/tests/kraken/driver.html?testName=imaging-desaturate) 13:23:48 INFO - 2015-12-16 13:23:48,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 156901376 13:23:48 INFO - 2015-12-16 13:23:48,744 DEBUG : BROWSER_OUTPUT: 13:23:51 INFO - 2015-12-16 13:23:51,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43932/tests/kraken/driver.html?testName=json-parse-financial) 13:23:52 INFO - 2015-12-16 13:23:52,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 156536832 13:23:52 INFO - 2015-12-16 13:23:52,085 DEBUG : BROWSER_OUTPUT: 13:23:53 INFO - 2015-12-16 13:23:53,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:23:54 INFO - 2015-12-16 13:23:54,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 161026048 13:23:54 INFO - 2015-12-16 13:23:54,160 DEBUG : BROWSER_OUTPUT: 13:23:55 INFO - 2015-12-16 13:23:55,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:23:56 INFO - 2015-12-16 13:23:56,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 160399360 13:23:56 INFO - 2015-12-16 13:23:56,461 DEBUG : BROWSER_OUTPUT: 13:23:58 INFO - 2015-12-16 13:23:58,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:23:58 INFO - 2015-12-16 13:23:58,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 164175872 13:23:58 INFO - 2015-12-16 13:23:58,967 DEBUG : BROWSER_OUTPUT: 13:24:01 INFO - 2015-12-16 13:24:01,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:24:01 INFO - 2015-12-16 13:24:01,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 168497152 13:24:01 INFO - 2015-12-16 13:24:01,852 DEBUG : BROWSER_OUTPUT: 13:24:04 INFO - 2015-12-16 13:24:04,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:24:04 INFO - 2015-12-16 13:24:04,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 167153664 13:24:04 INFO - 2015-12-16 13:24:04,819 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43932/tests/kraken/driver.html?testName=ai-astar) 13:24:06 INFO - 2015-12-16 13:24:06,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 226545664 13:24:06 INFO - 2015-12-16 13:24:06,687 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,687 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:24:06 INFO - 2015-12-16 13:24:06,688 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:24:06 INFO - 2015-12-16 13:24:06,688 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:24:06 INFO - 2015-12-16 13:24:06,688 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:24:06 INFO - 2015-12-16 13:24:06,688 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;103;109;109;109;100;110;107;108 13:24:06 INFO - 2015-12-16 13:24:06,688 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;128;151;163;123;145;142;128;172;129 13:24:06 INFO - 2015-12-16 13:24:06,688 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;160;160;161;159;160;172;160;162 13:24:06 INFO - 2015-12-16 13:24:06,688 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;71;147;71;70;73;71;153;73 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;144;89;89;89;132;89;89;131 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;110;109;109;110 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;146;146;145;145;146;145 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;96 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;55;58;57;54;55;56;62;54;53 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;62;63;62;63;62;63;63;62;62 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;76;78;77;78;79;78;90;80;78 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;112;105;112;112;119;107;115;116;114 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;128;137;135;136;137;128;146;133;134;140 13:24:06 INFO - 2015-12-16 13:24:06,689 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;60;61;62;62;63;60;62;62;63;60 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,885 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: __startTimestamp1450301046681__endTimestamp 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:3.23 (3.0%) stddev-sans-first:3.37 13:24:06 INFO - 2015-12-16 13:24:06,690 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 103.0 109.0 109.0 109.0 100.0 110.0 107.0 108.0 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:148.00 stddev:16.82 (11.4%) stddev-sans-first:17.15 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: Values: 157.0 128.0 151.0 163.0 123.0 145.0 142.0 128.0 172.0 129.0 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:160.00 stddev:3.86 (2.4%) stddev-sans-first:4.07 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 160.0 160.0 161.0 159.0 160.0 172.0 160.0 162.0 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.00 Median:71.00 stddev:33.25 (46.8%) stddev-sans-first:34.76 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 147.0 71.0 70.0 73.0 71.0 153.0 73.0 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,691 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.00 Median:89.00 stddev:22.80 (25.6%) stddev-sans-first:23.61 13:24:06 INFO - 2015-12-16 13:24:06,692 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 144.0 89.0 89.0 89.0 132.0 89.0 89.0 131.0 13:24:06 INFO - 2015-12-16 13:24:06,692 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,692 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:24:06 INFO - 2015-12-16 13:24:06,692 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 13:24:06 INFO - 2015-12-16 13:24:06,692 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,692 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:24:06 INFO - 2015-12-16 13:24:06,693 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 13:24:06 INFO - 2015-12-16 13:24:06,693 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:2.66 (4.8%) stddev-sans-first:2.74 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: Values: 54.0 55.0 58.0 57.0 54.0 55.0 56.0 62.0 54.0 53.0 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 63.0 62.0 63.0 62.0 63.0 63.0 62.0 62.0 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:78.50 stddev:3.95 (5.0%) stddev-sans-first:4.15 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: Values: 81.0 76.0 78.0 77.0 78.0 79.0 78.0 90.0 80.0 78.0 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.10 Median:114.50 stddev:4.58 (4.0%) stddev-sans-first:4.33 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: Values: 119.0 112.0 105.0 112.0 112.0 119.0 107.0 115.0 116.0 114.0 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,694 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:136.50 stddev:5.34 (3.9%) stddev-sans-first:4.94 13:24:06 INFO - 2015-12-16 13:24:06,695 DEBUG : BROWSER_OUTPUT: Values: 128.0 137.0 135.0 136.0 137.0 128.0 146.0 133.0 134.0 140.0 13:24:06 INFO - 2015-12-16 13:24:06,695 DEBUG : BROWSER_OUTPUT: 13:24:06 INFO - 2015-12-16 13:24:06,695 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:1.18 (1.9%) stddev-sans-first:1.12 13:24:06 INFO - 2015-12-16 13:24:06,695 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 62.0 62.0 63.0 60.0 62.0 62.0 63.0 60.0 13:24:06 INFO - 2015-12-16 13:24:06,695 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:24:06 INFO - 2015-12-16 13:24:06,695 DEBUG : BROWSER_OUTPUT: 13:24:07 INFO - 2015-12-16 13:24:07,337 INFO : Browser exited with error code: 0 13:24:07 INFO - 2015-12-16 13:24:07,388 INFO : Completed test kraken (00:00:57) 13:24:07 INFO - 2015-12-16 13:24:07,388 INFO : Starting test v8_7 13:24:07 INFO - 2015-12-16 13:24:07,388 DEBUG : operating with platform_type : linux_ 13:24:07 INFO - 2015-12-16 13:24:07,389 INFO : Initialising browser for v8_7 test... 13:24:07 INFO - 2015-12-16 13:24:07,395 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsJSyg1/profile http://localhost:43932/getInfo.html 13:24:10 INFO - 2015-12-16 13:24:10,970 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:24:10 INFO - 2015-12-16 13:24:10,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:24:10 INFO - 2015-12-16 13:24:10,970 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:24:10 INFO - 2015-12-16 13:24:10,970 DEBUG : BROWSER_OUTPUT: __metrics 13:24:11 INFO - 2015-12-16 13:24:11,152 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:24:12 INFO - 2015-12-16 13:24:12,441 INFO : Browser initialized. 13:24:12 INFO - 2015-12-16 13:24:12,442 INFO : Running cycle 1/1 for v8_7 test... 13:24:12 INFO - 2015-12-16 13:24:12,442 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsJSyg1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:24:23 INFO - 2015-12-16 13:24:23,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 128602112 13:24:23 INFO - 2015-12-16 13:24:23,998 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43932/tests/v8_7/run.html (next: http://localhost:43932/tests/v8_7/run.html) 13:24:45 INFO - 2015-12-16 13:24:45,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 427622400 13:24:45 INFO - 2015-12-16 13:24:45,639 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,640 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:24:45 INFO - 2015-12-16 13:24:45,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:24:45 INFO - 2015-12-16 13:24:45,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:24:45 INFO - 2015-12-16 13:24:45,641 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:24:45 INFO - 2015-12-16 13:24:45,641 DEBUG : BROWSER_OUTPUT: |0;Richards;163.45210853220007 13:24:45 INFO - 2015-12-16 13:24:45,641 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;169.80811682798438 13:24:45 INFO - 2015-12-16 13:24:45,641 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4857462269424 13:24:45 INFO - 2015-12-16 13:24:45,642 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 13:24:45 INFO - 2015-12-16 13:24:45,642 DEBUG : BROWSER_OUTPUT: |4;RayTrace;931.9664492078285 13:24:45 INFO - 2015-12-16 13:24:45,642 DEBUG : BROWSER_OUTPUT: |5;Earley;556.4830272676684 13:24:45 INFO - 2015-12-16 13:24:45,643 DEBUG : BROWSER_OUTPUT: |6;Boyer;10489.583333333334 13:24:45 INFO - 2015-12-16 13:24:45,643 DEBUG : BROWSER_OUTPUT: |7;RegExp;23744.18604651163 13:24:45 INFO - 2015-12-16 13:24:45,643 DEBUG : BROWSER_OUTPUT: |8;Splay;531.6122233930453 13:24:45 INFO - 2015-12-16 13:24:45,643 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4873.78640776699 13:24:45 INFO - 2015-12-16 13:24:45,644 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:24:45 INFO - 2015-12-16 13:24:45,644 DEBUG : BROWSER_OUTPUT: __startTimestamp1450301085638__endTimestamp 13:24:45 INFO - 2015-12-16 13:24:45,644 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,645 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:24:45 INFO - 2015-12-16 13:24:45,645 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:24:45 INFO - 2015-12-16 13:24:45,645 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,645 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.45 Median:163.45 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,646 DEBUG : BROWSER_OUTPUT: Values: 163.5 13:24:45 INFO - 2015-12-16 13:24:45,646 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,646 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:169.81 Median:169.81 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,647 DEBUG : BROWSER_OUTPUT: Values: 169.8 13:24:45 INFO - 2015-12-16 13:24:45,647 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,647 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,648 DEBUG : BROWSER_OUTPUT: Values: 279.5 13:24:45 INFO - 2015-12-16 13:24:45,648 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,648 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,648 DEBUG : BROWSER_OUTPUT: Values: 5040.2 13:24:45 INFO - 2015-12-16 13:24:45,649 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,649 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:931.97 Median:931.97 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,649 DEBUG : BROWSER_OUTPUT: Values: 932.0 13:24:45 INFO - 2015-12-16 13:24:45,649 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,649 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:556.48 Median:556.48 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,650 DEBUG : BROWSER_OUTPUT: Values: 556.5 13:24:45 INFO - 2015-12-16 13:24:45,650 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,650 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10489.58 Median:10489.58 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,650 DEBUG : BROWSER_OUTPUT: Values: 10489.6 13:24:45 INFO - 2015-12-16 13:24:45,650 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,650 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23744.19 Median:23744.19 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,651 DEBUG : BROWSER_OUTPUT: Values: 23744.2 13:24:45 INFO - 2015-12-16 13:24:45,651 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,651 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:531.61 Median:531.61 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,651 DEBUG : BROWSER_OUTPUT: Values: 531.6 13:24:45 INFO - 2015-12-16 13:24:45,651 DEBUG : BROWSER_OUTPUT: 13:24:45 INFO - 2015-12-16 13:24:45,651 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 13:24:45 INFO - 2015-12-16 13:24:45,651 DEBUG : BROWSER_OUTPUT: Values: 4873.8 13:24:45 INFO - 2015-12-16 13:24:45,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:24:45 INFO - 2015-12-16 13:24:45,652 DEBUG : BROWSER_OUTPUT: 13:24:46 INFO - 2015-12-16 13:24:46,353 INFO : Browser exited with error code: 0 13:24:46 INFO - 2015-12-16 13:24:46,365 INFO : Completed test v8_7 (00:00:38) 13:24:46 INFO - 2015-12-16 13:24:46,677 INFO : Completed test suite (00:20:06) 13:24:46 INFO - 2015-12-16 13:24:46,678 DEBUG : Working with test: dromaeo_css 13:24:46 INFO - 2015-12-16 13:24:46,678 DEBUG : Generating results file: dromaeo_css 13:24:46 INFO - 2015-12-16 13:24:46,679 DEBUG : Working with test: kraken 13:24:46 INFO - 2015-12-16 13:24:46,680 DEBUG : Generating results file: kraken 13:24:46 INFO - 2015-12-16 13:24:46,680 INFO : javascript benchmark 13:24:46 INFO - 2015-12-16 13:24:46,680 DEBUG : Working with test: v8_7 13:24:46 INFO - 2015-12-16 13:24:46,680 DEBUG : Generating results file: v8_7 13:24:46 INFO - 2015-12-16 13:24:46,681 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:24:46 INFO - 2015-12-16 13:24:46,811 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 13:24:46 INFO - 2015-12-16 13:24:46,811 DEBUG : process_Request line: dromaeo_css 7212.97 graph.html#tests=[[72,53,35]] 13:24:46 INFO - 2015-12-16 13:24:46,811 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:24:46 INFO - 2015-12-16 13:24:46,839 DEBUG : process_Request line: kraken 1460.30 graph.html#tests=[[232,53,35]] 13:24:46 INFO - 2015-12-16 13:24:46,839 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:24:46 INFO - 2015-12-16 13:24:46,872 DEBUG : process_Request line: v8_7 23317.23 graph.html#tests=[[230,53,35]] 13:24:46 INFO - 2015-12-16 13:24:46,874 INFO : javascript benchmark 13:24:46 INFO - 2015-12-16 13:24:46,877 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3299.5215693724413, 3365.1755319946615, 3400.353932752777, 3400.8129552874598, 3433.279011407605, 5471.37079235888, 5513.917291240629, 5561.4716601922755, 5571.5542756579525, 5588.357338906027, 5560.666360018402, 5593.972030139854, 5601.579881508883, 5625.437456254373, 5636.041872881609, 5059.898802023967, 5064.670796398241, 5098.847034588968, 5135.255387968742, 5156.381234251895, 4977.303177555127, 4978.477259887714, 4979.701217926918, 4986.675866068712, 5033.899322013576, 5001.499850015006, 5069.645124841262, 5085.745712714368, 5108.335916330871, 5148.099082660538, 5115.846524604268, 5143.742812859379, 5148.459411761749, 5162.716050617196, 5184.559312458446, 4921.01579684061, 4934.4572097069295, 5001.824936127218, 5064.366954130734, 5070.949290507085, 5360.061989151883, 5473.261109750172, 5483.616146869721, 5496.120620700669, 5503.174523821419, 6046.062860256668, 6047.485963693048, 6053.576249662526, 6057.3336932937345, 6058.363871793443, 5762.164486149527, 5858.150568167634, 5883.294004719461, 6028.4272994065495, 6062.363451837582, 5501.092319767194, 5518.33779946401, 5518.696471694056, 5521.751521181516, 5568.331800183963, 5926.703664816828, 5930.822075337746, 5932.317783454958, 5980.401959804072, 5999.670018149044, 5608.887822243532, 5701.4298570142655, 5813.854653633693, 5907.1434641976675, 5938.524918006636, 5910.940890591039, 5919.1713160157615, 5932.940670593325, 5932.970335148297, 5946.494547963472, 5638.548916086703, 5878.823635290948, 5881.206037185011, 5889.882202355929, 5895.115732640138, 5776.537876969833, 5960.254968128984, 6060.363661815534, 6070.605410648293, 6089.604175728564, 4594.081183763261, 4605.631549476034, 4610.9308360374625, 4613.284940834176, 4634.281686338623, 3995.9200815983518, 4081.0817566047995, 4136.296829538986, 4144.316187828975, 4170.374443833449, 5480.177973303957, 5482.945170548243, 5540.722963851791, 5581.581381396411, 5607.214989901417, 5876.9118463223085, 5879.412058794172, 5896.439838215449, 5898.498627616701, 5900.055991041413, 5435.809746658848, 5436.809711660073, 5541.058020136506, 5578.41426650204, 5589.692566908778, 5234.973825130926, 5243.9213411798855, 5246.4753524647995, 5254.054270231395, 5256.842294731164, 6178.320384757673, 6178.382161783876, 6183.690815459209, 6184.474319682788, 6186.319504854552, 5642.012647786703, 5739.7417116229035, 5876.265466816648, 6014.849628759141, 6043.8186854394435, 6233.906491402723, 6248.0, 6253.624782513064, 6255.78104766331, 6255.812325630239, 5993.190919225849, 5998.940010599838, 6005.909911351246, 6019.608725432833, 6036.939630603638, 5755.913661295168, 5856.209411729362, 5902.2622172228475, 5996.130561068708, 5997.430244126801, 5687.857803554944, 5897.764089436375, 5913.319968203712, 5918.940810592011, 5922.0, 5513.338399392099, 5872.765089396376, 5921.911171332519, 5923.674197918984, 5925.1704761332585, 5506.339239291311, 5631.6902570359025, 5655.066913959151, 5661.716914154194, 5672.886542269214, 5834.299884013776, 5860.94139058621, 5868.2077919480325, 5869.589128760946, 5872.941270587239, 5505.146702261156, 5624.634398764068, 5733.0, 5735.569832262514, 5737.627054241461], "unit": "ms", "name": "dojo.html", "value": 5486.008176829131}, {"lowerIsBetter": false, "replicates": [569.2429069337782, 623.5011990407675, 632.901900205468, 633.3065293503613, 640.57081755224, 35066.824665876666, 44114.0, 44593.55406445934, 44629.0, 44645.107097858105, 47390.0, 47585.286220706716, 47875.76062119693, 47914.520854791444, 47996.280055799194, 8234.217749313806, 8354.958225208866, 9245.075492450751, 9401.62393504259, 9417.670381536647, 10988.835167472495, 11255.774884502305, 11262.831057534102, 11268.380239086848, 11269.718257043558, 10879.238453308271, 10929.071028962548, 10975.670729878117, 10976.067034302094, 11009.724756881062, 10933.781324373547, 10966.451677416097, 11030.117590592734, 11046.558137674483, 11058.060064894493, 10734.409607471585, 10844.783104337868, 10866.782664346747, 10867.184961127869, 10868.728281792939, 44964.77517612391, 45320.86697832547, 45338.09323813505, 45406.77296613496, 45468.0, 3589.892303230907, 3687.3915803892323, 3703.259348130358, 4121.773302468363, 4287.056847493546, 33046.6695333046, 33437.331253374796, 33541.49687754686, 33665.831670841486, 34282.31435371304, 3866.555346135174, 3903.8048097595006, 3933.1347103637154, 3952.0910190656023, 4012.4583181270445, 326995.3650231757, 327900.0, 329142.0, 329438.0, 491773.5411322956, 55107.72446137824, 71539.0, 72846.0, 72953.0, 72998.27001730021, 67014.0, 67986.66006669935, 68072.31927680758, 68086.65956670186, 68142.0, 18388.724169137473, 18495.72256416128, 18579.349722759638, 18630.81369186318, 18649.7202541962, 14168.079074860101, 14428.206448645426, 14460.85539144616, 14469.0, 14472.0, 20416.183352666023, 20480.795192048186, 20626.690599641017, 20645.17419303211, 20703.171873124906, 7874.173211812792, 8042.195780422028, 8069.435139540294, 8098.635561399751, 8121.837563248702, 987.2644879564626, 1008.6873069348526, 1025.3437799808128, 1071.8338657508098, 1090.39536780946, 29775.957841475443, 29795.0, 30737.538936915964, 30832.0, 31123.84438077795, 1096.188820273008, 1105.4583254205381, 1154.5324143721807, 1163.5835187203581, 1231.5443285984243, 14086.0, 15005.24973751308, 16045.759313610306, 16287.91856040736, 16547.172641367884, 288902.0, 289153.0, 289295.0, 290627.0, 292479.0, 53563.73218133884, 53818.46181538134, 54189.45810541844, 54225.45774542283, 54233.72883135638, 1380.3926272440094, 1475.2992328643809, 1478.1057460236616, 1487.4793822162374, 1493.081754720839, 27956.161315160578, 28053.859730701217, 28525.572116418687, 28694.71305287004, 28767.0, 47952.0, 48254.0, 48416.0, 48449.0, 48453.75773121112, 285980.0, 286647.0, 287482.0, 288313.0, 289087.0, 33298.833505832314, 35571.64428355787, 35585.82207088948, 35814.0, 36443.08892277714, 43518.56481435145, 44036.779816100716, 44189.116217676106, 44786.3282050763, 44886.3267050988, 36542.0, 36600.0, 36636.45045324269, 37138.814305928296, 37530.06174845651, 39153.0334863444, 39727.404088938114, 40223.396649050876, 40616.79691601523, 40671.38992915049, 39404.80297598494, 40212.798936005136, 40242.39636405398, 40319.0, 40344.596554034084, 34753.478697819046, 35222.29555408826, 35863.82068089643, 36729.44905826361, 36757.816210918776, 27627.723722762516, 27714.584281235395, 27868.442631147667, 27905.581416278364, 27953.72046279511], "unit": "ms", "name": "ext.html", "value": 20384.150676129066}, {"lowerIsBetter": false, "replicates": [374.5093926955688, 377.65178313421063, 378.0906918860142, 383.7467271600744, 384.11653197645427, 12886.613401597968, 15648.530544083667, 17743.822561774396, 19865.60268794625, 19871.503212419677, 19183.23267069319, 19332.3233686821, 19481.805181948177, 19509.414717558495, 19658.606827863434, 5750.281214848144, 5859.7656093756195, 5868.325142608591, 5881.294244690643, 5892.204552385438, 4451.310046942729, 4576.633869290449, 5798.014337562603, 6405.29541750407, 6598.967005164967, 6376.107344971708, 6498.675066246692, 6523.4455071319, 6553.672316384185, 6556.672166391685, 6462.644554549498, 6493.285738568754, 6500.707468163944, 6506.284308726013, 6508.414242718178, 4481.327800829901, 4586.495485496593, 5749.223854779593, 5763.711814409263, 5774.88450230993, 14800.333984970703, 14878.851211487854, 14973.176475293854, 15089.622759430993, 15150.469733559272, 2128.3508529898377, 2189.4745261137373, 2215.4682876109778, 2218.6006518826603, 2231.5313784105356, 10952.233343665946, 11113.222074454792, 11264.54941802335, 11271.718207044889, 11383.146264030149, 1666.2585149608428, 1828.6159906419668, 1839.3746126317117, 1862.1806405181676, 1926.5183704073982, 70078.64960675215, 70589.0, 71179.99999999948, 71400.0, 72369.0, 7291.744788932362, 7399.4450416219, 7453.105627324756, 7454.664540095709, 7500.212477689873, 9073.54632268384, 9077.636894524278, 9085.364024518352, 9100.180983711365, 9115.316351273681, 6286.654234017082, 6306.085617585424, 6331.525135614847, 6332.366763323631, 6372.904406433907, 6614.933850661528, 6616.702248398834, 6626.7017984190825, 6628.23775265841, 6636.83407914806, 3537.0, 3585.8744943926836, 3590.6409359063887, 3612.6567976042234, 3614.1326081740194, 1177.605502156787, 1210.9515619375302, 1211.896988755948, 1220.0056953582803, 1277.2783377391745, 517.4851023231834, 526.2579762534807, 532.9760160792773, 536.5171345788822, 558.954754608884, 11467.885321146849, 12775.936120319338, 12795.0, 13169.73660526784, 13401.262930538718, 550.9173623956439, 553.9030669632798, 563.5829486180197, 575.1918554431031, 591.1900696046443, 6534.961198357582, 7256.7460138894885, 7337.26627337262, 7368.1526624438875, 7391.8152046199275, 626889.0, 627254.0, 632010.0, 666973.0, 672730.0, 83992.16007839965, 84380.0, 87598.0, 88589.55705221432, 91877.0, 578.0491092153468, 585.6105689716376, 585.7920438244362, 586.1471558881732, 588.1413136820205, 12301.384930753247, 12406.25562466255, 12468.875311247135, 12534.0, 12558.686032849251, 39448.2110357797, 39597.0, 39958.2008359837, 40033.0, 40979.59020409758, 53668.73165634147, 53708.19437708359, 54756.452435475134, 55156.0, 55204.0, 6693.330666933462, 6695.296993815774, 6832.0435139081565, 6834.0, 6844.041834143124, 12959.546415875398, 13082.215067096005, 13089.934550327187, 13093.0, 13394.397252123483, 11409.942950285196, 11677.649670509898, 11768.293902365886, 11841.0, 12020.03839692805, 9911.851322230317, 11209.88790112121, 11237.775244495228, 11536.192466527598, 11904.464299106734, 10366.688999330032, 10430.322029068086, 11092.722681933015, 11855.466504007169, 12162.0, 7239.167495738057, 7279.708811647475, 7381.630918453949, 7392.593407362647, 7402.1857595665515, 12061.51753929833, 12248.938755306523, 12297.50809967627, 12402.25586464815, 12478.064145188966], "unit": "ms", "name": "jquery.html", "value": 7843.907940805446}, {"lowerIsBetter": false, "replicates": [1589.1577463944107, 1589.2451085734278, 1845.114345114345, 1848.8983105929185, 1888.773347198336, 7921.207879212076, 8364.121767214447, 8369.539675317863, 8375.958120209398, 8379.455335403194, 7307.342339189472, 7461.365783908361, 7877.80305492363, 8171.18288171184, 8201.425900186974, 2339.847909885856, 2355.6348765941307, 2357.4695693469002, 2376.5246950609862, 2377.6909001829827, 2111.9366419007456, 2337.9298621041394, 2347.1432926981615, 2377.8573285602833, 2383.594788885885, 2108.7469503659504, 2316.177756896303, 2357.068957761683, 2357.316378250305, 2357.634566642173, 2311.9422014449606, 2314.0975019742314, 2316.5945959457113, 2375.4892698069825, 2380.595298799191, 2365.680633114525, 2369.7393286738443, 2401.231605886117, 2404.026369320428, 2409.325388891113, 8113.472624279403, 8137.064237612632, 8149.185081491863, 8155.184481551797, 8169.142240064826, 4900.289458028602, 4991.800327986876, 4994.850154495371, 5007.298978143026, 5008.424031236418, 3194.5687332210086, 3219.6297425795865, 3224.4034853552166, 3245.1562593725566, 3251.4309995750887, 1098.8406681031286, 2017.616652835971, 2109.261758384553, 2112.852100352976, 2121.363590922717, 10871.565137394495, 10974.506147223394, 10982.890171098346, 10994.28537145083, 11016.614418495394, 4118.546959834416, 4160.375943608483, 4204.432401625802, 4222.746635201897, 4223.915521689611, 9031.36780425364, 9034.2320902724, 9054.909450905538, 9058.365914386062, 9066.637334506679, 4797.880052998633, 4803.303520989437, 4804.471508134172, 4805.783739731721, 4811.374521312207, 4446.777661116996, 4461.553844615512, 4471.597556219956, 4472.351509031172, 4479.641628669699, 3605.7836529808296, 3632.8728494503093, 3636.563612366533, 3642.0, 3669.9266014680093, 962.5235508423235, 994.0755097759153, 1056.8414737789394, 1061.0344586426315, 1065.1532032034552, 1000.5547531348626, 1087.7498175419698, 1155.9711007224887, 1185.508014174108, 1188.2514016169757, 7930.603469826486, 7959.44283900133, 7966.044074710956, 7976.6410511525955, 8005.879911801328, 1228.121892846601, 1237.7648246833073, 1242.7374106813716, 1259.5339724302066, 1274.8342715447118, 6176.567640265228, 6324.2410910691015, 6359.332270111664, 6363.363663633692, 6384.968075159594, 9655.758606034906, 9746.122848943629, 9784.070513301225, 9796.069373409515, 9808.313418060667, 9533.570989305497, 9594.232461403071, 9672.903270967201, 9800.0, 9817.607295708092, 7482.775516734507, 7554.244575542401, 7571.129320128146, 7573.962130189424, 7589.051368578927, 7340.11918569775, 7484.850302994018, 7485.47601667878, 7540.245975402416, 7554.2823431773895, 8686.131386861263, 8686.435381700168, 8764.255038321815, 9016.09839016093, 9037.819243615222, 8639.87040194385, 8815.118488151134, 8834.955825220834, 9047.0, 9053.864192036994, 7443.962780186064, 7448.366888814511, 7494.662740176596, 7538.09542854861, 7540.773776786705, 8068.59657017135, 8081.676732930617, 8132.024157101186, 8138.348932085537, 8145.8370832584205, 6324.968375158095, 7606.391488680782, 7640.541567505968, 7784.299413052852, 7814.648340824563, 7158.463115266271, 7203.171635262012, 7210.855782884208, 7267.818304542428, 7420.183779784327, 7419.4806363554035, 7447.776566703008, 7453.180150183584, 7459.0, 7461.179270280373, 6761.0, 6827.385535301847, 6869.107016087876, 6876.312368763083, 6889.379955804002, 7031.578105313698, 7048.718051277891, 7078.221395646578, 7085.57486550788, 7097.82255443618], "unit": "ms", "name": "mootools.html", "value": 4750.255164266749}, {"lowerIsBetter": false, "replicates": [354.8917580138058, 357.91052236940766, 362.93104310181053, 364.09159147925914, 365.1947455859828, 5990.820275391745, 5992.3108842483125, 5995.550333724972, 6001.339852616215, 6020.247469066367, 5755.366909639936, 5804.651720896749, 5844.970775146129, 5916.5266778657715, 5932.911006334908, 4644.5819876211135, 4685.929711054337, 4687.8359257426, 4689.695169813968, 4689.9062018759605, 4662.300654901758, 4670.696404733699, 4675.11172877154, 4682.90634187316, 4686.062787442508, 4488.483824360192, 4538.296564032564, 4578.725276483405, 4647.581717645411, 4659.370984917026, 4629.65277604181, 4644.8374306899095, 4648.744319062467, 4661.487236403993, 4671.182543054969, 4116.670666346715, 4124.628783409507, 4129.772862492562, 4130.112025914443, 4132.607402296777, 5631.2960879890015, 5631.408702086263, 5647.0, 5667.914981275284, 5678.914816277759, 5308.575313974873, 5378.919316210221, 5386.299781028441, 5389.191621256804, 5390.299261096072, 6330.17707698001, 6332.081848131995, 6334.208223972004, 6338.87322253557, 6345.17512723343, 4511.526289739563, 4513.1425029244665, 4514.525974772634, 4515.909681806378, 4517.503074661785, 6430.967845160744, 6482.7082781274485, 6543.378379053982, 6564.638944858031, 6572.11276477679, 4650.162970665313, 4651.2557990721325, 4655.2784318430695, 4656.278276867091, 4671.252599584118, 4709.481956984729, 4710.52894710533, 4712.31671407644, 4715.0, 4716.056788642285, 5410.594205434608, 5412.215228791882, 5412.756425960842, 5414.133738601805, 5417.512423881791, 6327.430531252117, 6446.967765161145, 6448.677566121769, 6454.4513716333695, 6454.580452270588, 1668.2826384654716, 1684.1242553871919, 1684.713598688226, 1685.2500637216567, 1686.4940517844598, 1126.3242054767074, 1136.3182090745652, 1139.2367114033618, 1151.234429104636, 1158.391844281742, 6182.845428864314, 6185.195924529782, 6187.597806142587, 6188.9690551546955, 6190.3190649028575, 6563.704633291513, 6576.243731970789, 6576.5067619928695, 6579.901301480481, 6585.736570537125, 5981.461668449861, 6049.304330002106, 6052.334243233241, 6179.721912513947, 6182.412670796267, 3607.494950706903, 3619.819009049537, 3625.166211771307, 3625.2024554597947, 3635.781853088823, 6750.35871592198, 6787.6266805325195, 6809.7276108956075, 6812.284710105467, 6814.386705196457, 6695.765648202387, 6819.283975182534, 6845.212800528003, 6849.760258390932, 6850.828729281709, 6816.659167041727, 6823.727050918007, 6824.18109826824, 6828.146481689789, 6828.146481689789, 6544.44372228366, 6642.568233064835, 6643.435307998681, 6646.036324732983, 6646.8005959821285, 6544.8363790905605, 6570.5400621956005, 6579.4736421087155, 6579.703913323816, 6581.3418658135715, 6743.494237932076, 6751.594904305757, 6752.122224110834, 6753.257141714505, 6802.8639427212165, 4663.836765713184, 4663.906721865475, 4665.370175026328, 4668.78990445424, 4670.276107203389, 6577.50668699859, 6625.17185351831, 6667.666616669244, 6667.966660166668, 6674.566153200027, 6480.611163330027, 6487.286398496068, 6490.513211509061, 6494.6752662367635, 6498.057781621733, 6468.676566171766, 6476.935230647633, 6478.967605161944, 6482.611043337415, 6484.1894763154605, 6216.502679785516, 6307.779227727007, 6314.273858506147, 6316.494680425647, 6317.6841157941, 6413.0, 6415.0, 6433.195850518685, 6439.098526206241, 6439.645819479973, 6111.908321375094, 6191.690415479298, 6222.533310001859, 6230.283517395557, 6232.906506402498], "unit": "ms", "name": "prototype.html", "value": 4867.554914508178}, {"lowerIsBetter": false, "replicates": [829.6391069884598, 911.8085202107558, 934.0892629686057, 974.8934958821735, 976.0678551982853, 13728.725425491484, 13931.512397066104, 13950.790738138936, 13970.23163725996, 14013.159210447368, 13473.797893031588, 13476.25880576568, 13992.720145597108, 13997.370118344674, 14014.509492167776, 793.7261644732558, 798.253632853284, 934.8270569944565, 935.9578818953163, 957.6935380678186, 945.2060269373725, 945.7635591102224, 952.7808604021079, 953.5708930981051, 954.312894715807, 994.8308787506105, 1000.4747507558553, 1000.8098461292332, 1001.5192707500404, 1001.9799604007916, 992.1318846009741, 992.1665800727387, 992.3698451483287, 992.4938281476427, 992.8808542974817, 730.1639622632109, 732.4653003307616, 735.3418690272176, 736.3556887723242, 739.3272122368619, 14179.14925104497, 14256.643583910381, 14273.714525709427, 14275.428982840675, 14288.428462861473, 13079.41142648583, 13627.250501222428, 13963.0, 14009.229492378017, 14018.859811401857, 11251.324920504714, 11271.60549380776, 11317.603883864107, 11319.0, 11480.598179063776, 3837.0982819037504, 3868.2650296443585, 3902.1088310098235, 3919.274934137165, 3920.176762879799, 51231.23153152705, 51540.0, 54001.0, 54080.45919540833, 54138.18792718073, 10427.026757686013, 10479.28229832105, 10650.201234907257, 10704.678859634068, 10770.461476926122, 18932.526686832665, 18985.90507047456, 19009.0, 19141.13864876084, 19157.13792879296, 8190.467619604707, 8233.217844304781, 8376.12050734664, 8459.534725590029, 8497.660093596187, 4300.0109974705365, 4384.802683879169, 4388.71473354231, 4518.344839998182, 4525.954740452619, 3230.870765169414, 3265.967340326614, 3269.1336795749144, 3273.083536609753, 3278.9836050819595, 495.60351718625674, 516.4577193946342, 521.1505246448265, 523.4425337016065, 524.1534921102392, 620.9037599172135, 744.4379493482494, 764.8393837294119, 773.3542492019114, 798.9760307190794, 9323.627054917728, 9510.572024258925, 9852.852207216898, 10300.433476158732, 10519.789604208027, 533.9893202136013, 600.4655856287907, 702.9261927497539, 770.8997830282027, 789.6328207383594, 4259.957400425956, 4402.801873915681, 4526.569975852289, 4549.09018196362, 4559.703619264737, 60185.0, 61061.38938610557, 61082.38917610767, 69539.30460695429, 70355.64822175856, 52996.735016324674, 53228.201576976375, 54326.456735432934, 58356.7082164595, 58493.0, 50917.0, 51176.0, 51834.48165518372, 51970.22044669333, 52415.0, 9395.122144512983, 9838.311318207656, 9843.064908833649, 9848.567598431175, 9928.11365840488, 39090.80454597822, 40064.799676001436, 40842.1831563373, 40866.0, 41421.585784141775, 50235.0, 52303.215451769014, 52867.0, 52999.0, 53443.198352023974, 8999.145081217273, 9059.954700226457, 9207.953960230156, 9210.907890921006, 9254.12085851843, 12147.088968327234, 12412.069094817743, 12745.362731863555, 13828.86171138316, 13923.443062277396, 13405.798913016117, 13649.38577763983, 13703.794443083561, 14149.292535373395, 14306.284685765462, 13415.731685366432, 13511.594652160451, 13653.726925461237, 13665.385057672627, 13985.090969086978, 13349.132306400053, 13357.465701371837, 13475.258860762751, 13612.523561675294, 13800.171989680652, 11074.446277686244, 11226.326420414802, 11342.94328528385, 11427.0, 11575.536978521102, 10348.534315955649, 10530.473476326306, 10649.627263045757, 10955.56177752881, 10978.12175026012], "unit": "ms", "name": "yui.html", "value": 6942.837472128354}], "name": "dromaeo_css", "value": 7212.968250382977}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 103.0, 109.0, 109.0, 109.0, 100.0, 110.0, 107.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [157.0, 128.0, 151.0, 163.0, 123.0, 145.0, 142.0, 128.0, 172.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 160.0, 161.0, 159.0, 160.0, 172.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 147.0, 71.0, 70.0, 73.0, 71.0, 153.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 144.0, 89.0, 89.0, 89.0, 132.0, 89.0, 89.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 103.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 58.0, 57.0, 54.0, 55.0, 56.0, 62.0, 54.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.5}, {"lowerIsBetter": true, "replicates": [81.0, 76.0, 78.0, 77.0, 78.0, 79.0, 78.0, 90.0, 80.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [119.0, 112.0, 105.0, 112.0, 112.0, 119.0, 107.0, 115.0, 116.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.1}, {"lowerIsBetter": true, "replicates": [128.0, 137.0, 135.0, 136.0, 137.0, 128.0, 146.0, 133.0, 134.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.4}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 62.0, 62.0, 63.0, 60.0, 62.0, 62.0, 63.0, 60.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 61.5}], "name": "kraken", "value": 1460.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.45210853220007], "unit": "score", "name": "Richards", "value": 215.97763600000008}, {"lowerIsBetter": false, "replicates": [169.80811682798438], "unit": "score", "name": "DeltaBlue", "value": 389.3689020000002}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [931.9664492078285], "unit": "score", "name": "RayTrace", "value": 794.0081969999997}, {"lowerIsBetter": false, "replicates": [556.4830272676684], "unit": "score", "name": "Earley", "value": 1197.6340109999996}, {"lowerIsBetter": false, "replicates": [10489.583333333334], "unit": "score", "name": "Boyer", "value": 63.5356981132075}, {"lowerIsBetter": false, "replicates": [23744.18604651163], "unit": "score", "name": "RegExp", "value": 38.36665523996084}, {"lowerIsBetter": false, "replicates": [531.6122233930453], "unit": "score", "name": "Splay", "value": 153.2903052527255}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 23317.233571841592}]} 13:24:46 INFO - RETURN: dromaeo_css: 7212.97 13:24:46 INFO - RETURN: kraken: 1460.30 13:24:46 INFO - RETURN: v8_7: 23317.23 13:24:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23317.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1460.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7212.97"}}} 13:24:46 INFO - Return code: 0 13:24:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:24:47 INFO - # TBPL SUCCESS # 13:24:47 INFO - Running post-action listener: _resource_record_post_action 13:24:47 INFO - Running post-run listener: _resource_record_post_run 13:24:48 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 3801088; Write bytes: 315314176; Read time: 468; Write time: 168816 13:24:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 57352192; Read time: 0; Write time: 47396 13:24:48 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 3801088; Write bytes: 257511424; Read time: 468; Write time: 121368 13:24:48 INFO - Running post-run listener: _upload_blobber_files 13:24:48 INFO - Blob upload gear active. 13:24:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:24:48 INFO - Copying logs to upload dir... 13:24:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.599889 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-16 13:24:48.153634) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:24:48.157872) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009898 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1450291141/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 13:24:48.211888) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:24:48.212253) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450299371.247777-710201136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 13:24:48.262808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 13:24:48.263159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 13:24:48.263544) ========= ========= Total master_lag: 0.23 =========