builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1447686105.02 results: success (0) buildid: 20151116053004 builduid: a89dfbd42820401486033060449daa15 revision: d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.017984) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.018494) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.018796) ========= 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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006699 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.040339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.040649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.114739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.115013) ========= 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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.164908) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.165209) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.165568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.165858) ========= 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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 07:01:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2015-11-16 07:01:46 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173204 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.352312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.352674) ========= 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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014293 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:45.404113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 07:01:45.404650) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4 --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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 07:01:46,384 truncating revision to first 12 chars 2015-11-16 07:01:46,385 Setting DEBUG logging. 2015-11-16 07:01:46,385 attempt 1/10 2015-11-16 07:01:46,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d1cae7deae1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 07:01:47,214 unpacking tar archive at: fx-team-d1cae7deae1a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.141712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 07:01:46.561759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:46.562334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:46.573360) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:46.573784) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 07:01:46.574263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-16 07:01:46.574557) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:01:47 INFO - MultiFileLogger online at 20151116 07:01:47 in /builds/slave/test-pgo 07:01:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:01:47 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:01:47 INFO - {'append_to_log': False, 07:01:47 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:01:47 INFO - 'blob_upload_branch': 'Fx-Team', 07:01:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:01:47 INFO - 'branch': 'Fx-Team', 07:01:47 INFO - 'buildbot_json_path': 'buildprops.json', 07:01:47 INFO - 'config_files': ('talos/linux_config.py',), 07:01:47 INFO - 'default_actions': ('clobber', 07:01:47 INFO - 'read-buildbot-config', 07:01:47 INFO - 'download-and-extract', 07:01:47 INFO - 'populate-webroot', 07:01:47 INFO - 'create-virtualenv', 07:01:47 INFO - 'install', 07:01:47 INFO - 'run-tests'), 07:01:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:01:47 INFO - 'download_minidump_stackwalk': True, 07:01:47 INFO - 'download_symbols': 'ondemand', 07:01:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:01:47 INFO - 'tooltool.py': '/tools/tooltool.py', 07:01:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:01:47 INFO - '/tools/misc-python/virtualenv.py')}, 07:01:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:01:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:01:47 INFO - 'installer_path': 'installer.exe', 07:01:47 INFO - 'log_level': 'info', 07:01:47 INFO - 'log_name': 'talos', 07:01:47 INFO - 'log_to_console': True, 07:01:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:01:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:01:47 INFO - 'opt_config_files': (), 07:01:47 INFO - 'pip_index': False, 07:01:47 INFO - 'sps_profile': False, 07:01:47 INFO - 'sps_profile_interval': 0, 07:01:47 INFO - 'suite': 'dromaeojs-e10s', 07:01:47 INFO - 'system_bits': '64', 07:01:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:01:47 INFO - 'title': 'talos-linux64-ix-042', 07:01:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:01:47 INFO - 'use_talos_json': True, 07:01:47 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:01:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:01:47 INFO - 'work_dir': 'build'} 07:01:47 INFO - ##### 07:01:47 INFO - ##### Running clobber step. 07:01:47 INFO - ##### 07:01:47 INFO - Running pre-action listener: _resource_record_pre_action 07:01:47 INFO - Running main action method: clobber 07:01:47 INFO - rmtree: /builds/slave/test-pgo/build 07:01:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:01:48 INFO - Running post-action listener: _resource_record_post_action 07:01:48 INFO - ##### 07:01:48 INFO - ##### Running read-buildbot-config step. 07:01:48 INFO - ##### 07:01:48 INFO - Running pre-action listener: _resource_record_pre_action 07:01:48 INFO - Running main action method: read_buildbot_config 07:01:48 INFO - Using buildbot properties: 07:01:48 INFO - { 07:01:48 INFO - "properties": { 07:01:48 INFO - "buildnumber": 335, 07:01:48 INFO - "product": "firefox", 07:01:48 INFO - "script_repo_revision": "production", 07:01:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:01:48 INFO - "repository": "", 07:01:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:01:48 INFO - "buildid": "20151116053004", 07:01:48 INFO - "slavename": "talos-linux64-ix-042", 07:01:48 INFO - "pgo_build": "True", 07:01:48 INFO - "basedir": "/builds/slave/test-pgo", 07:01:48 INFO - "project": "", 07:01:48 INFO - "platform": "ubuntu64_hw", 07:01:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:01:48 INFO - "slavebuilddir": "test", 07:01:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:01:48 INFO - "branch": "fx-team", 07:01:48 INFO - "repo_path": "integration/fx-team", 07:01:48 INFO - "stage_platform": "linux64-pgo", 07:01:48 INFO - "builduid": "a89dfbd42820401486033060449daa15", 07:01:48 INFO - "revision": "d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4" 07:01:48 INFO - }, 07:01:48 INFO - "sourcestamp": { 07:01:48 INFO - "repository": "", 07:01:48 INFO - "hasPatch": false, 07:01:48 INFO - "project": "", 07:01:48 INFO - "branch": "fx-team-linux64-pgo-talos", 07:01:48 INFO - "changes": [ 07:01:48 INFO - { 07:01:48 INFO - "category": null, 07:01:48 INFO - "files": [ 07:01:48 INFO - { 07:01:48 INFO - "url": null, 07:01:48 INFO - "name": "https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:01:48 INFO - } 07:01:48 INFO - ], 07:01:48 INFO - "repository": "", 07:01:48 INFO - "rev": "d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4", 07:01:48 INFO - "who": "sendchange", 07:01:48 INFO - "when": 1447686072, 07:01:48 INFO - "number": 6666025, 07:01:48 INFO - "comments": "", 07:01:48 INFO - "project": "", 07:01:48 INFO - "at": "Mon 16 Nov 2015 07:01:12", 07:01:48 INFO - "branch": "fx-team-linux64-pgo-talos", 07:01:48 INFO - "revlink": "", 07:01:48 INFO - "properties": [ 07:01:48 INFO - [ 07:01:48 INFO - "buildid", 07:01:48 INFO - "20151116053004", 07:01:48 INFO - "Change" 07:01:48 INFO - ], 07:01:48 INFO - [ 07:01:48 INFO - "builduid", 07:01:48 INFO - "a89dfbd42820401486033060449daa15", 07:01:48 INFO - "Change" 07:01:48 INFO - ], 07:01:48 INFO - [ 07:01:48 INFO - "pgo_build", 07:01:48 INFO - "True", 07:01:48 INFO - "Change" 07:01:48 INFO - ] 07:01:48 INFO - ], 07:01:48 INFO - "revision": "d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4" 07:01:48 INFO - } 07:01:48 INFO - ], 07:01:48 INFO - "revision": "d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4" 07:01:48 INFO - } 07:01:48 INFO - } 07:01:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:01:48 INFO - Running post-action listener: _resource_record_post_action 07:01:48 INFO - ##### 07:01:48 INFO - ##### Running download-and-extract step. 07:01:48 INFO - ##### 07:01:48 INFO - Running pre-action listener: _resource_record_pre_action 07:01:48 INFO - Running main action method: download_and_extract 07:01:48 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:48 INFO - https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/test_packages.json 07:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/test_packages.json 07:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:01:49 INFO - Downloaded 1302 bytes. 07:01:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:01:49 INFO - Using the following test package requirements: 07:01:49 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:01:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:49 INFO - u'jsshell-linux-x86_64.zip'], 07:01:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:01:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:01:49 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:01:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:01:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:49 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:01:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:01: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')]} 07:01:49 INFO - https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:01:50 INFO - Downloaded 22461708 bytes. 07:01:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:01:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:01:51 INFO - Return code: 0 07:01:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:51 INFO - https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:01:52 INFO - Downloaded 22461708 bytes. 07:01:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:01:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:01:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:01:54 INFO - Return code: 0 07:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:54 INFO - https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:01:55 INFO - Downloaded 11131693 bytes. 07:01:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:01:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:01:55 INFO - Return code: 0 07:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:55 INFO - https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:01:59 INFO - Downloaded 57134599 bytes. 07:01:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:01:59 INFO - mkdir: /builds/slave/test-pgo/properties 07:01:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:01:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:01:59 INFO - Contents: 07:01:59 INFO - build_url:https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:01:59 INFO - Running post-action listener: _resource_record_post_action 07:01:59 INFO - Running post-action listener: set_extra_try_arguments 07:01:59 INFO - ##### 07:01:59 INFO - ##### Running populate-webroot step. 07:01:59 INFO - ##### 07:01:59 INFO - Running pre-action listener: _resource_record_pre_action 07:01:59 INFO - Running main action method: populate_webroot 07:01:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:01:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:01:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:01:59 INFO - '../fennec_ids.txt'], 07:01:59 INFO - 'tests': ['tcheck2']}, 07:01:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:01:59 INFO - '--tppagecycles', 07:01:59 INFO - '7'], 07:01:59 INFO - 'tests': ['tsvgm']}}, 07:01:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:01:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:01:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:01:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:01:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'tests': ['damp', 'tps']}, 07:01:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['damp', 'tps']}, 07:01:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:01:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:01:59 INFO - 'other': {'tests': ['a11yr', 07:01:59 INFO - 'ts_paint', 07:01:59 INFO - 'tpaint', 07:01:59 INFO - 'sessionrestore', 07:01:59 INFO - 'sessionrestore_no_auto_restore']}, 07:01:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['a11yr', 07:01:59 INFO - 'ts_paint', 07:01:59 INFO - 'tpaint', 07:01:59 INFO - 'sessionrestore', 07:01:59 INFO - 'sessionrestore_no_auto_restore']}, 07:01:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['a11yr', 07:01:59 INFO - 'ts_paint', 07:01:59 INFO - 'tpaint', 07:01:59 INFO - 'sessionrestore', 07:01:59 INFO - 'sessionrestore_no_auto_restore']}, 07:01:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['a11yr', 07:01:59 INFO - 'ts_paint', 07:01:59 INFO - 'tpaint', 07:01:59 INFO - 'sessionrestore', 07:01:59 INFO - 'sessionrestore_no_auto_restore']}, 07:01:59 INFO - 'other_l64': {'tests': ['a11yr', 07:01:59 INFO - 'ts_paint', 07:01:59 INFO - 'tpaint', 07:01:59 INFO - 'sessionrestore', 07:01:59 INFO - 'sessionrestore_no_auto_restore']}, 07:01:59 INFO - 'other_nol64': {'tests': ['a11yr', 07:01:59 INFO - 'ts_paint', 07:01:59 INFO - 'tpaint', 07:01:59 INFO - 'sessionrestore', 07:01:59 INFO - 'sessionrestore_no_auto_restore']}, 07:01:59 INFO - 'svgr': {'tests': ['tsvgx', 07:01:59 INFO - 'tsvgr_opacity', 07:01:59 INFO - 'tart', 07:01:59 INFO - 'tscrollx', 07:01:59 INFO - 'cart']}, 07:01:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['tsvgx', 07:01:59 INFO - 'tsvgr_opacity', 07:01:59 INFO - 'tart', 07:01:59 INFO - 'tscrollx', 07:01:59 INFO - 'cart']}, 07:01:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'tests': ['tp5o']}, 07:01:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'talos_options': ['--e10s'], 07:01:59 INFO - 'tests': ['tp5o']}, 07:01:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'talos_options': ['--xperf_path', 07:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:59 INFO - 'tests': ['tp5n']}, 07:01:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:59 INFO - 'talos_options': ['--e10s', 07:01:59 INFO - '--xperf_path', 07:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:59 INFO - 'tests': ['tp5n']}}, 07:01:59 INFO - 'talos.zip': {'path': '', 07:01:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:01:59 INFO - Running post-action listener: _resource_record_post_action 07:01:59 INFO - ##### 07:01:59 INFO - ##### Running create-virtualenv step. 07:01:59 INFO - ##### 07:01:59 INFO - Running pre-action listener: _resource_record_pre_action 07:01:59 INFO - Running main action method: create_virtualenv 07:01:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:01:59 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 07:01:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:01:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:01:59 INFO - Using real prefix '/usr' 07:01:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:02:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:02 INFO - Installing pip.................done. 07:02:02 INFO - Return code: 0 07:02:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:02 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 0x7f6ac6016c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, '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': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', '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 07:02:02 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 07:02:02 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 07:02:02 INFO - Using env: {'DISPLAY': ':0', 07:02:02 INFO - 'HOME': '/home/cltbld', 07:02:02 INFO - 'LANG': 'en_US.UTF-8', 07:02:02 INFO - 'LANGUAGE': 'en_US:en', 07:02:02 INFO - 'LOGNAME': 'cltbld', 07:02:02 INFO - 'MAIL': '/var/mail/cltbld', 07:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:02 INFO - 'MOZ_NO_REMOTE': '1', 07:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:02 INFO - 'NO_EM_RESTART': '1', 07:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:02 INFO - 'SHELL': '/bin/bash', 07:02:02 INFO - 'SHLVL': '1', 07:02:02 INFO - 'TERM': 'linux', 07:02:02 INFO - 'TMOUT': '86400', 07:02:02 INFO - 'USER': 'cltbld', 07:02:02 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:02 INFO - '_': '/tools/buildbot/bin/python'} 07:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:02:02 INFO - Cleaning up... 07:02:02 INFO - Return code: 0 07:02:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:02 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 0x7f6ac6016c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, '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': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', '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 07:02:02 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 07:02:02 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 07:02:02 INFO - Using env: {'DISPLAY': ':0', 07:02:02 INFO - 'HOME': '/home/cltbld', 07:02:02 INFO - 'LANG': 'en_US.UTF-8', 07:02:02 INFO - 'LANGUAGE': 'en_US:en', 07:02:02 INFO - 'LOGNAME': 'cltbld', 07:02:02 INFO - 'MAIL': '/var/mail/cltbld', 07:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:02 INFO - 'MOZ_NO_REMOTE': '1', 07:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:02 INFO - 'NO_EM_RESTART': '1', 07:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:02 INFO - 'SHELL': '/bin/bash', 07:02:02 INFO - 'SHLVL': '1', 07:02:02 INFO - 'TERM': 'linux', 07:02:02 INFO - 'TMOUT': '86400', 07:02:02 INFO - 'USER': 'cltbld', 07:02:02 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:02 INFO - '_': '/tools/buildbot/bin/python'} 07:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:02 INFO - Downloading/unpacking psutil>=0.7.1 07:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:02:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:02:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:04 INFO - Installing collected packages: psutil 07:02:04 INFO - Running setup.py install for psutil 07:02:04 INFO - building 'psutil._psutil_linux' extension 07:02:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:02:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:02:04 INFO - building 'psutil._psutil_posix' extension 07:02:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:02:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:04 INFO - Successfully installed psutil 07:02:04 INFO - Cleaning up... 07:02:05 INFO - Return code: 0 07:02:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:05 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 0x7f6ac6016c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, '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': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', '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 07:02:05 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 07:02:05 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 07:02:05 INFO - Using env: {'DISPLAY': ':0', 07:02:05 INFO - 'HOME': '/home/cltbld', 07:02:05 INFO - 'LANG': 'en_US.UTF-8', 07:02:05 INFO - 'LANGUAGE': 'en_US:en', 07:02:05 INFO - 'LOGNAME': 'cltbld', 07:02:05 INFO - 'MAIL': '/var/mail/cltbld', 07:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:05 INFO - 'MOZ_NO_REMOTE': '1', 07:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:05 INFO - 'NO_EM_RESTART': '1', 07:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:05 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:05 INFO - 'SHELL': '/bin/bash', 07:02:05 INFO - 'SHLVL': '1', 07:02:05 INFO - 'TERM': 'linux', 07:02:05 INFO - 'TMOUT': '86400', 07:02:05 INFO - 'USER': 'cltbld', 07:02:05 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:05 INFO - '_': '/tools/buildbot/bin/python'} 07:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:02:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:02:06 INFO - Installing collected packages: mozsystemmonitor 07:02:06 INFO - Running setup.py install for mozsystemmonitor 07:02:07 INFO - Successfully installed mozsystemmonitor 07:02:07 INFO - Cleaning up... 07:02:07 INFO - Return code: 0 07:02:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:07 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 0x7f6ac6016c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, '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': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', '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 07:02:07 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 07:02:07 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 07:02:07 INFO - Using env: {'DISPLAY': ':0', 07:02:07 INFO - 'HOME': '/home/cltbld', 07:02:07 INFO - 'LANG': 'en_US.UTF-8', 07:02:07 INFO - 'LANGUAGE': 'en_US:en', 07:02:07 INFO - 'LOGNAME': 'cltbld', 07:02:07 INFO - 'MAIL': '/var/mail/cltbld', 07:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:07 INFO - 'MOZ_NO_REMOTE': '1', 07:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:07 INFO - 'NO_EM_RESTART': '1', 07:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:07 INFO - 'SHELL': '/bin/bash', 07:02:07 INFO - 'SHLVL': '1', 07:02:07 INFO - 'TERM': 'linux', 07:02:07 INFO - 'TMOUT': '86400', 07:02:07 INFO - 'USER': 'cltbld', 07:02:07 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:07 INFO - '_': '/tools/buildbot/bin/python'} 07:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:02:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:02:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:02:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:02:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:09 INFO - Downloading docopt-0.6.1.tar.gz 07:02:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:02:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:02:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:02:09 INFO - Running setup.py install for blobuploader 07:02:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:02:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:02:09 INFO - Running setup.py install for requests 07:02:10 INFO - Running setup.py install for docopt 07:02:10 INFO - Successfully installed blobuploader requests docopt 07:02:10 INFO - Cleaning up... 07:02:10 INFO - Return code: 0 07:02:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:10 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 0x7f6ac6016c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, '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': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', '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 07:02:10 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 07:02:10 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 07:02:10 INFO - Using env: {'DISPLAY': ':0', 07:02:10 INFO - 'HOME': '/home/cltbld', 07:02:10 INFO - 'LANG': 'en_US.UTF-8', 07:02:10 INFO - 'LANGUAGE': 'en_US:en', 07:02:10 INFO - 'LOGNAME': 'cltbld', 07:02:10 INFO - 'MAIL': '/var/mail/cltbld', 07:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:10 INFO - 'MOZ_NO_REMOTE': '1', 07:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:10 INFO - 'NO_EM_RESTART': '1', 07:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:10 INFO - 'SHELL': '/bin/bash', 07:02:10 INFO - 'SHLVL': '1', 07:02:10 INFO - 'TERM': 'linux', 07:02:10 INFO - 'TMOUT': '86400', 07:02:10 INFO - 'USER': 'cltbld', 07:02:10 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:10 INFO - '_': '/tools/buildbot/bin/python'} 07:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:10 INFO - Running setup.py (path:/tmp/pip-EdvWct-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:10 INFO - Running setup.py (path:/tmp/pip-WrXB3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:10 INFO - Running setup.py (path:/tmp/pip-WnrZY2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:10 INFO - Running setup.py (path:/tmp/pip-FaQ4qQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:10 INFO - Running setup.py (path:/tmp/pip-3ADsjd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:10 INFO - Running setup.py (path:/tmp/pip-dypuhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:10 INFO - Running setup.py (path:/tmp/pip-TJmV81-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:10 INFO - Running setup.py (path:/tmp/pip-ay6R32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:10 INFO - Running setup.py (path:/tmp/pip-aHaWLg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:11 INFO - Running setup.py (path:/tmp/pip-G1Kf72-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:11 INFO - Running setup.py (path:/tmp/pip-3le9iS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:11 INFO - Running setup.py (path:/tmp/pip-JizGJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:11 INFO - Running setup.py (path:/tmp/pip-9c6s8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:11 INFO - Running setup.py (path:/tmp/pip-NpuyMu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:11 INFO - Running setup.py (path:/tmp/pip-rmC40c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:11 INFO - Running setup.py (path:/tmp/pip-NOOHbW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:11 INFO - Running setup.py (path:/tmp/pip-KQtXPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:02:11 INFO - Running setup.py install for manifestparser 07:02:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:02:11 INFO - Running setup.py install for mozcrash 07:02:11 INFO - Running setup.py install for mozdebug 07:02:11 INFO - Running setup.py install for mozdevice 07:02:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Running setup.py install for mozfile 07:02:12 INFO - Running setup.py install for mozhttpd 07:02:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Running setup.py install for mozinfo 07:02:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Running setup.py install for mozInstall 07:02:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Running setup.py install for mozleak 07:02:12 INFO - Running setup.py install for mozlog 07:02:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Running setup.py install for moznetwork 07:02:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Running setup.py install for mozprocess 07:02:12 INFO - Running setup.py install for mozprofile 07:02:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:02:12 INFO - Running setup.py install for mozrunner 07:02:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:02:13 INFO - Running setup.py install for mozscreenshot 07:02:13 INFO - Running setup.py install for moztest 07:02:13 INFO - Running setup.py install for mozversion 07:02:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:02:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:02:13 INFO - Cleaning up... 07:02:13 INFO - Return code: 0 07:02:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:13 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 0x7f6ac6016c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, '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': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', '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 07:02:13 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 07:02:13 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 07:02:13 INFO - Using env: {'DISPLAY': ':0', 07:02:13 INFO - 'HOME': '/home/cltbld', 07:02:13 INFO - 'LANG': 'en_US.UTF-8', 07:02:13 INFO - 'LANGUAGE': 'en_US:en', 07:02:13 INFO - 'LOGNAME': 'cltbld', 07:02:13 INFO - 'MAIL': '/var/mail/cltbld', 07:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:13 INFO - 'MOZ_NO_REMOTE': '1', 07:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:13 INFO - 'NO_EM_RESTART': '1', 07:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:13 INFO - 'SHELL': '/bin/bash', 07:02:13 INFO - 'SHLVL': '1', 07:02:13 INFO - 'TERM': 'linux', 07:02:13 INFO - 'TMOUT': '86400', 07:02:13 INFO - 'USER': 'cltbld', 07:02:13 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:13 INFO - '_': '/tools/buildbot/bin/python'} 07:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:13 INFO - Running setup.py (path:/tmp/pip-f8HSAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:13 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)) 07:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:13 INFO - Running setup.py (path:/tmp/pip-GcgoxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:13 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)) 07:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:13 INFO - Running setup.py (path:/tmp/pip-8eKw98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:13 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)) 07:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:13 INFO - Running setup.py (path:/tmp/pip-4WGdF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 07:02:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:13 INFO - Running setup.py (path:/tmp/pip-tOzVOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:14 INFO - Running setup.py (path:/tmp/pip-iBrtJl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:14 INFO - Running setup.py (path:/tmp/pip-e6qG7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:14 INFO - Running setup.py (path:/tmp/pip-PF84_0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:14 INFO - Running setup.py (path:/tmp/pip-JgqEBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:14 INFO - Running setup.py (path:/tmp/pip-7itINZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:14 INFO - Running setup.py (path:/tmp/pip-9VuRbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:14 INFO - Running setup.py (path:/tmp/pip-wsC49b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:14 INFO - Running setup.py (path:/tmp/pip-5avEfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:14 INFO - Running setup.py (path:/tmp/pip-22eGPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:14 INFO - Running setup.py (path:/tmp/pip-uCHENd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:14 INFO - Running setup.py (path:/tmp/pip-VVpxon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:14 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)) 07:02:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:14 INFO - Running setup.py (path:/tmp/pip-L9EDJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:14 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)) 07:02:14 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)) 07:02:14 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)) 07:02:14 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)) 07:02:14 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:14 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:16 INFO - Downloading blessings-1.5.1.tar.gz 07:02:16 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 07:02:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:02:16 INFO - Installing collected packages: blessings 07:02:16 INFO - Running setup.py install for blessings 07:02:16 INFO - Successfully installed blessings 07:02:16 INFO - Cleaning up... 07:02:16 INFO - Return code: 0 07:02:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:02:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:02:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:02:16 INFO - Reading from file tmpfile_stdout 07:02:16 INFO - Current package versions: 07:02:16 INFO - argparse == 1.2.1 07:02:16 INFO - blessings == 1.5.1 07:02:16 INFO - blobuploader == 1.2.4 07:02:16 INFO - docopt == 0.6.1 07:02:16 INFO - manifestparser == 1.1 07:02:16 INFO - mozInstall == 1.12 07:02:16 INFO - mozcrash == 0.16 07:02:16 INFO - mozdebug == 0.1 07:02:16 INFO - mozdevice == 0.47 07:02:16 INFO - mozfile == 1.2 07:02:16 INFO - mozhttpd == 0.7 07:02:16 INFO - mozinfo == 0.9 07:02:16 INFO - mozleak == 0.1 07:02:16 INFO - mozlog == 3.0 07:02:16 INFO - moznetwork == 0.27 07:02:16 INFO - mozprocess == 0.22 07:02:16 INFO - mozprofile == 0.27 07:02:16 INFO - mozrunner == 6.11 07:02:16 INFO - mozscreenshot == 0.1 07:02:16 INFO - mozsystemmonitor == 0.0 07:02:16 INFO - moztest == 0.7 07:02:16 INFO - mozversion == 1.4 07:02:16 INFO - psutil == 3.1.1 07:02:16 INFO - requests == 1.2.3 07:02:16 INFO - wsgiref == 0.1.2 07:02:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:16 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 0x7f6ac6016c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, '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': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', '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 07:02:16 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 07:02:16 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 07:02:17 INFO - Using env: {'DISPLAY': ':0', 07:02:17 INFO - 'HOME': '/home/cltbld', 07:02:17 INFO - 'LANG': 'en_US.UTF-8', 07:02:17 INFO - 'LANGUAGE': 'en_US:en', 07:02:17 INFO - 'LOGNAME': 'cltbld', 07:02:17 INFO - 'MAIL': '/var/mail/cltbld', 07:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:17 INFO - 'MOZ_NO_REMOTE': '1', 07:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:17 INFO - 'NO_EM_RESTART': '1', 07:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:17 INFO - 'SHELL': '/bin/bash', 07:02:17 INFO - 'SHLVL': '1', 07:02:17 INFO - 'TERM': 'linux', 07:02:17 INFO - 'TMOUT': '86400', 07:02:17 INFO - 'USER': 'cltbld', 07:02:17 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:17 INFO - '_': '/tools/buildbot/bin/python'} 07:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 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)) 07:02:17 INFO - Cleaning up... 07:02:17 INFO - Return code: 0 07:02:17 INFO - Running post-action listener: _resource_record_post_action 07:02:17 INFO - Running post-action listener: _start_resource_monitoring 07:02:17 INFO - Starting resource monitoring. 07:02:17 INFO - ##### 07:02:17 INFO - ##### Running install step. 07:02:17 INFO - ##### 07:02:17 INFO - Running pre-action listener: _resource_record_pre_action 07:02:17 INFO - Running main action method: install 07:02:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:02:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:02:17 INFO - Reading from file tmpfile_stdout 07:02:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:02:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:02:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:02:17 INFO - Reading from file tmpfile_stdout 07:02:17 INFO - Output received: 07:02:17 INFO - Usage: mozinstall [options] installer 07:02:17 INFO - Options: 07:02:17 INFO - -h, --help show this help message and exit 07:02:17 INFO - -d DEST, --destination=DEST 07:02:17 INFO - Directory to install application into. [default: 07:02:17 INFO - "/builds/slave/test-pgo"] 07:02:17 INFO - --app=APP Application being installed. [default: firefox] 07:02:17 INFO - mkdir: /builds/slave/test-pgo/build/application 07:02:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:02:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:02:32 INFO - Reading from file tmpfile_stdout 07:02:32 INFO - Output received: 07:02:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:02:32 INFO - Running post-action listener: _resource_record_post_action 07:02:32 INFO - ##### 07:02:32 INFO - ##### Running run-tests step. 07:02:32 INFO - ##### 07:02:32 INFO - Running pre-action listener: _resource_record_pre_action 07:02:32 INFO - Running main action method: run_tests 07:02:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:02:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:02:32 INFO - Python 2.7.3 07:02:32 INFO - Return code: 0 07:02:32 INFO - grabbing minidump binary from tooltool 07:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:32 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 0x1ce68c0>, '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 0x1c93420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c938b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:02:32 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 07:02:32 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 07:02:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:02:32 INFO - Return code: 0 07:02:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:02:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:02:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:02:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:02:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:02:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:02:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 07:02:32 INFO - Using env: {'DISPLAY': ':0', 07:02:32 INFO - 'HOME': '/home/cltbld', 07:02:32 INFO - 'LANG': 'en_US.UTF-8', 07:02:32 INFO - 'LANGUAGE': 'en_US:en', 07:02:32 INFO - 'LOGNAME': 'cltbld', 07:02:32 INFO - 'MAIL': '/var/mail/cltbld', 07:02:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:02:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:32 INFO - 'MOZ_NO_REMOTE': '1', 07:02:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:32 INFO - 'NO_EM_RESTART': '1', 07:02:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:02:32 INFO - 'SHELL': '/bin/bash', 07:02:32 INFO - 'SHLVL': '1', 07:02:32 INFO - 'TERM': 'linux', 07:02:32 INFO - 'TMOUT': '86400', 07:02:32 INFO - 'USER': 'cltbld', 07:02:32 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216', 07:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:32 INFO - '_': '/tools/buildbot/bin/python'} 07:02:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 07:02:32 INFO - mozversion INFO | application_buildid: 20151116053004 07:02:32 INFO - mozversion INFO | application_changeset: d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4 07:02:32 INFO - mozversion INFO | application_display_name: Nightly 07:02:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:02:32 INFO - mozversion INFO | application_name: Firefox 07:02:32 INFO - mozversion INFO | application_remotingname: firefox 07:02:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:02:32 INFO - mozversion INFO | application_vendor: Mozilla 07:02:32 INFO - mozversion INFO | application_version: 45.0a1 07:02:32 INFO - mozversion INFO | platform_buildid: 20151116053004 07:02:32 INFO - mozversion INFO | platform_changeset: d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4 07:02:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:02:32 INFO - mozversion INFO | platform_version: 45.0a1 07:02:32 INFO - 2015-11-16 07:02:32,284 DEBUG : using testdate: 1447686152 07:02:32 INFO - 2015-11-16 07:02:32,284 DEBUG : actual date: 1447686152 07:02:32 INFO - 2015-11-16 07:02:32,384 INFO : starting webserver on 'localhost:46540' 07:02:32 INFO - 2015-11-16 07:02:32,385 INFO : Starting test suite talos-linux64-ix-042.e 07:02:32 INFO - 2015-11-16 07:02:32,385 INFO : Starting test dromaeo_css 07:02:32 INFO - 2015-11-16 07:02:32,385 DEBUG : operating with platform_type : linux_ 07:02:32 INFO - 2015-11-16 07:02:32,385 INFO : Initialising browser for dromaeo_css test... 07:02:32 INFO - 2015-11-16 07:02:32,396 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBuS_8W/profile http://localhost:46540/getInfo.html 07:02:38 INFO - 2015-11-16 07:02:38,827 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:02:38 INFO - 2015-11-16 07:02:38,827 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:02:38 INFO - 2015-11-16 07:02:38,827 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:02:38 INFO - 2015-11-16 07:02:38,827 DEBUG : BROWSER_OUTPUT: __metrics 07:02:40 INFO - 2015-11-16 07:02:40,013 INFO : Browser initialized. 07:02:40 INFO - 2015-11-16 07:02:40,014 INFO : Running cycle 1/1 for dromaeo_css test... 07:02:40 INFO - 2015-11-16 07:02:40,014 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBuS_8W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:02:51 INFO - 2015-11-16 07:02:51,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 141447168 07:02:51 INFO - 2015-11-16 07:02:51,820 DEBUG : BROWSER_OUTPUT: 07:03:41 INFO - 2015-11-16 07:03:41,447 DEBUG : BROWSER_OUTPUT: 1447686221446 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] 07:05:50 INFO - 2015-11-16 07:05:50,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46540/tests/dromaeo/cssquery-ext.html) 07:05:51 INFO - 2015-11-16 07:05:51,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 146853888 07:05:51 INFO - 2015-11-16 07:05:51,283 DEBUG : BROWSER_OUTPUT: 07:08:53 INFO - 2015-11-16 07:08:53,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/dromaeo/cssquery-ext.html (next: http://localhost:46540/tests/dromaeo/cssquery-jquery.html) 07:08:53 INFO - 2015-11-16 07:08:53,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 141008896 07:08:53 INFO - 2015-11-16 07:08:53,743 DEBUG : BROWSER_OUTPUT: 07:11:55 INFO - 2015-11-16 07:11:55,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46540/tests/dromaeo/cssquery-mootools.html) 07:11:56 INFO - 2015-11-16 07:11:56,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 141447168 07:11:56 INFO - 2015-11-16 07:11:56,016 DEBUG : BROWSER_OUTPUT: 07:14:57 INFO - 2015-11-16 07:14:57,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46540/tests/dromaeo/cssquery-prototype.html) 07:14:58 INFO - 2015-11-16 07:14:58,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 139649024 07:14:58 INFO - 2015-11-16 07:14:58,226 DEBUG : BROWSER_OUTPUT: 07:18:00 INFO - 2015-11-16 07:18:00,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46540/tests/dromaeo/cssquery-yui.html) 07:18:01 INFO - 2015-11-16 07:18:01,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 141275136 07:18:01 INFO - 2015-11-16 07:18:01,070 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/dromaeo/cssquery-yui.html (next: http://localhost:46540/tests/dromaeo/cssquery-dojo.html) 07:21:03 INFO - 2015-11-16 07:21:03,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 144023552 07:21:03 INFO - 2015-11-16 07:21:03,543 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,543 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:21:03 INFO - 2015-11-16 07:21:03,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:21:03 INFO - 2015-11-16 07:21:03,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:21:03 INFO - 2015-11-16 07:21:03,544 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:21:03 INFO - 2015-11-16 07:21:03,544 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3270.983645081775;3324.800511969282;3328.217868800831;3353.7820041697273;3358.4290670586006;5470.5350045246205;5543.113101903701;5543.140813173959;5580.386157522679;5619.044762390393;5622.91565626516;5625.071863142576;5671.602987790856;5689.971550142254;5729.799457019005;5073.188289873612;5168.32811734474;5228.947710522884;5233.136532472137;5235.240890070956;5073.264376665381;5146.948530514703;5158.252053452247;5192.818251361203;5241.371035475749;4980.5019498049905;4996.775145118442;5088.643794934337;5110.233464980282;5159.76781044852;5111.131107711661;5114.718690472023;5121.052605268037;5145.511176438233;5178.689278643255;5101.642884998052;5113.948860511385;5125.513076257786;5128.512791284859;5134.922976155361;5290.65610735301;5398.379186393576;5408.864778380533;5452.672839629595;5464.672119672792;5890.087036509348;5926.674032928187;5932.851678708023;5936.673482958436;5938.8812223755285;5855.443732845415;5963.7912673056235;5970.283565972111;5981.1028345748055;5991.730372133265;5584.078627026536;5623.325200975868;5654.604177707603;5660.29246344207;5722.484976352107;5980.521558275327;6027.30685971119;6029.758809647565;6031.9396806032255;6075.908861367083;5803.332616749043;5846.532277417797;5864.179014937912;5870.911936320873;5901.675407852524;5995.190649262294;6025.096235564701;6032.366601506867;6034.788782392595;6060.181875446847;6088.908666370008;6093.39066093396;6097.298810636745;6097.451229389376;6107.328193898667;5852.092925596539;5971.313298970587;5978.701064946736;6020.157177995085;6027.758889644453;4604.562566556172;4613.284940834176;4624.699394539344;4624.930626040612;4655.720656760605;4104.056067104582;4136.4415803866095;4145.523264824524;4151.750894946313;4188.602082802129;5623.718814059281;5724.4561766632105;5728.713564321767;5803.665157013826;5895.764169433174;6031.09533569968;6066.090086487062;6075.088736689532;6092.5430592705725;6111.877762444815;5776.19133321327;5793.8551536211935;5802.448767367094;5808.244928159313;5817.621854579439;5133.768980395891;5246.632735708464;5247.7113758743635;5249.895002099936;5252.448492908266;6297.086922396227;6377.904331435032;6412.615243085336;6466.4503517201565;6493.5454518184215;6042.607230530001;6070.78752243687;6084.361142080018;6086.1175129606845;6090.177825993434;6100.066499260575;6127.372786728296;6196.845078873064;6247.625142491465;6306.810795676137;5910.70446477683;5978.282606087298;5980.8803823924145;5984.491318237999;6015.248093988252;6070.6357618543025;6099.603525770811;6101.816945491642;6106.114613380946;6123.418275263843;5661.405552416937;5761.452661997104;5880.059190529666;5930.406959304035;5983.640981541122;5829.7085145743395;5855.531557475477;5884.35272120075;5886.793962211474;5888.705564721832;5736.196932429547;5792.623479473821;5795.188673585786;5798.797042103506;5805.3614102447855;5752.338481074563;5861.531077513874;5959.255093113361;6022.819315420545;6074.36219196978;5786;5791.391903850035;5825.009748342707;5828.475437210672;5838.824835254949 07:21:03 INFO - 2015-11-16 07:21:03,544 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.8790653962668;579.0474669169216;580.8983427900116;591.9556033297504;598.9279190249454;38293.42559861604;38937;39461.60538394619;39486.40770388446;39692.20615587686;42776.35835462463;42833.7858310708;42842.14315713692;43245.35131973015;43359.56640433595;8799;8872.645094196225;8933.910660893373;8936.106389361077;8963.865542016842;8661.220490155885;8786.560671966408;8835.160659737314;8842.204201621853;8847.380683352168;8806.515641639708;8832.55837208137;8874.068222836606;8891.95554022229;8894;8794.25248853845;8862.689805856764;8880.467171969638;8884.555772211428;8885.822283554326;8603.698870539563;8653.783655408602;8727.694530691395;8761.605727742266;8762.167594078552;39149.41275880836;39377.80311098455;39651.20697586061;39666.40500392496;39669.80165099185;3476.4090104682264;3527.435610302365;3828.5214348206473;3929.0766669832565;4062.837486500536;29072.70927290721;29603.259918501994;29713.70286297131;29788.40423191524;29810.254743631365;3103.193169775852;3149.889753858627;3316.369889720945;3361.764676472648;3403.0981789825714;262785;265237.9999999981;266209;266638;266830;58864;59096.70451647714;59097.40902591005;59099.40900591025;59398.10902836461;62426;63107.368926311065;63236.367636323965;63561.68219158875;63584.364156358766;14330.140191588538;14336.784948225784;14379.640508987359;14432.350544225535;15053;11459.598914037968;11463.541458341573;11578.305301681758;11622.593209237637;11653.941730291464;20208.595828083355;20221.595568088556;20370.287039953826;20421.387358379274;20460.48848778763;8104.1085480597085;8276.544790036485;8286.088530261666;8353.624086916103;8406.159384061668;873.886394768676;913.7030465098869;914.7255823252998;939.3096074385321;965.0205041882494;28623.57064644032;28626.856865715537;28688.569671454945;28787.42425151485;29015;1038.672818062308;1048.5858086056119;1055.3245922609535;1074.2909679611419;1099.8240281554913;14893.404263829541;14899.106053636817;14904.329305181293;15026.624334391729;15211.239438028055;305794;312337;315019;315392;316540;50711.49288507141;50818.74590627023;51200.74399628052;51432;51440;1294.4886769725906;1305.8041293806004;1322.107577385261;1323.7286356296936;1325.4830616059937;26874.596881046407;28088.859555702908;28534;31991;32571.579984102274;49172;49429.50570494393;49887.75056124696;50064.49935500598;50065;276195;277747;278789;280233;280381;42229.78885105555;45639.087218256114;45999.08001840011;46660.300095499275;46818.76590617025;43602;43818;43977.12045759131;44076.77961610172;44334.778326108164;37134.07311810786;37491.43762843505;37755.62244377631;38012.80993595125;38855.22289554137;37334.43998339973;37631.62368376281;37871;37874.431883522324;38618.22763544769;37205.81397092997;40394.192116156926;41052.384214237405;41222.58777412307;41238.38142427926;30810.383792324476;33607.15982100467;33718.325633486704;34285.48571771475;34322.82838585791;25803.225903222934;26216.60675089837;26225.4754904897;26303.473930521664;26396.736032639426 07:21:03 INFO - 2015-11-16 07:21:03,545 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.05916144732106;352.4853713578176;354.3426943020697;356.5436241610738;358.20121129880357;13987.300634968262;13992.440302387919;16639.500814975556;17131.657366852654;17848.464546063624;15527.844721552781;15792.921035394807;17377.565560860985;17588.296468141292;17620.471385858444;4339.674524410674;4498.932516012263;4503.887402814939;4506.52681468446;4507.391502147201;4449.243628583149;4468.486124095722;4469.575390337913;4478.373027776114;4631.560001799824;4540.841070562531;4542.409486766715;4551.817927282921;4590.173768721629;4605.585497305242;4526.4794548627;4550;4571.542845715435;4594.793234304431;4618.376519169936;4141.192467468844;4213.4522512073545;4227.154569086164;4229.851955181553;4257.97871010646;13858.644030514837;14022.649433764136;14119.364628591738;14198.148111113263;14296.857031429656;1852.6479968805884;1857.7863545692283;1880.981190188108;1926.422073377981;1926.8554858385678;9821.656242031495;9949.602015919354;9963.402195868272;10196.89803101967;10224.64213752515;1600.0959457906363;1614.079974414584;1647.5057482755126;1696.6267421167324;1800.7568978187908;59912.400875991116;62684;62943;62988.68505657488;62997;6973.895391569131;7014.824629384204;7023;7026.648667566601;7089.397401220954;8028.558429286445;8108.067572229151;8156.83686326282;8400.159984001551;8424.157584241526;5432.619716619878;5541.113421852565;5587.189857470644;5623.2408624835125;5651.689157096399;5742.598018138774;5756.971215143897;5769.798057067983;5770.826875193751;5830.3586605473365;3210.6147262328204;3242.821644809511;3250.967490325114;3274.148721332423;3294.4399452093203;1148.8563929508812;1161.4018780328138;1163.6043745126528;1165.347405452949;1207.7403358278013;479.20212845611667;480.7211817146047;486.1880659298979;489.3149590573226;489.6034212287987;11063.944680276547;11314.094872410187;11440.828387574193;11535.480903359368;11704.531818727326;464.3777338366605;473.49336210254694;483.8185680369861;491.52567772100093;517.1880148167342;6272.560920735505;6311.715972781236;6369.777057802955;6387.137736405526;6441.32366101562;528183;528480;529553;539276;566814;72206;73834.63082684552;75418.62290688511;75836.43494117375;78840.6057969718;544.0886515087213;547.5619504396467;547.7398235837945;547.8685115572314;548.3118686049063;10586.576536938435;10846.18653600999;11114.38870862078;11138.498767555317;11199.21605487608;32345;32382.35235295328;35146;36257.63742362543;36338.63661363353;43974.560254397045;44544;46330.76834615805;46519.76740116413;46537.767311163225;6785.660716964231;6933.618650974245;6947.201071876799;6959.373656370951;6992.545484543489;12586;12779.36103194818;12962.481500739865;13008.414621341873;13016.28410437435;10418.166546676399;10491;10654.467276636293;10838.458077095956;10998.450077495932;10573.682789516326;10954.233203675985;11009.229353945148;11153.721156970816;11162.38606876597;11146.164037697366;11394.658160255205;11434.313941163557;11523.423828808358;11664.125190610568;6784.253732089367;6920.100386949664;6929.757458488929;6947.513674042971;6966.512344135862;11021.283616564897;11135.10919126484;11309.886901130883;11314.377709226072;11358.54565817391 07:21:03 INFO - 2015-11-16 07:21:03,546 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1463.860933211345;1532.5862017255342;1603.0622086079643;1656.7763351947492;1739.36513172692;7565.583892885889;7822.491538050022;7873.527588344703;7898.684052637887;8013.278804907557;7939.285464308211;7958.641861116249;7974.840503189933;7995.960020199891;8036.116027237013;2294.7819957104048;2327.3948773318975;2330.6853574767442;2331.1258278145697;2332.9968113711097;2311.8034967027825;2329.149860300995;2347.6361164019604;2347.7417484076736;2353.3881190890406;2248.7526372099055;2269.693591365169;2295.2999335202758;2296.7932886040253;2297.8161747060194;2275.8065564427043;2302.4359032037173;2340.473393486469;2341.9180328688585;2343.3907184132077;2313.2944451942153;2318.8144948404088;2330.860148391102;2338.9064437422485;2342.3090188394463;7633.198514156044;7750.922490775077;7753.922460775377;7761.417893657998;7769.1842356552315;4592.74739889306;4661.300804879262;4669.6731228814;4681.882952926204;4690.929636055462;2968.3766409054124;2976.56839758236;3040.528718048706;3048.695130486956;3080.430120427728;929.5073610986188;974.5176137811758;986.363795351994;991.9652812151612;994.2543092680489;10353.792924141475;10398.896011039868;10401.739956501073;10405.79188416235;10417.531211095444;4139.0480189555965;4146.626803587692;4153.293940030202;4193.5387107418155;4270.7010509264055;8556.914430855737;8607.698730544525;8622.78443038929;8630.093840146694;8634.438761480484;4664.346991421204;4664.510226426244;4672.1356549037855;4706.929396059062;4710.788014539354;4317.762523061199;4322.502912165141;4327.7186982846015;4329.004329004347;4345.217860785026;3460.7058400035776;3466.4107101792756;3470.3926812808163;3481.89554313371;3498.9475157872653;1021.7496713305288;1023.6110278094277;1025.8461230815287;1057.2599180573475;1130.5873356224918;994.1798016636304;1006.1296978113879;1067.964074847397;1152.815549512074;1322.0481253497467;7300.160481544584;7311.268873112753;7342.4493163012985;7342.779716608404;7374;1050.144132531984;1051.8264486359817;1105.9612913547987;1114.1087130295732;1134.9319040857574;5517.5585953124455;5579.860503487364;5611.9438805612235;5627;5633.492985631313;8935.865962010575;9043;9083.500407477652;9179.95410022959;9242.768930776785;9056.683016094405;9064.048274931169;9111;9191.540422978824;9193.264538836876;7063.71745130189;7078.929210707827;7183.173934997542;7184.676689548983;7217.639118044077;7075.71697132109;7084.2915708428745;7107.715691372287;7111.395531379684;7194.100737407824;7806.414518911218;8297.087320394872;8360.540170290693;8399.95800020996;8417.537035463109;8324.6670133194;8357.874631880648;8415.789605259917;8431.831363372821;8440.53577053268;6901.102856628606;6909.861802763816;6954.930450695429;7002.5798452091;7019.052427922165;7541.509801862861;7555.471117021756;7595.3164215220895;7615.695372185272;7634.732784352521;7000.789976300719;7122.501424900207;7125.928740712527;7286.817829554304;7290.635468226674;7000.684969176297;7071.964640176972;7085.539439936388;7110.0401445804155;7124.786256412316;7110.928890711233;7124.358807707124;7151.141862976476;7155.391791697764;7176.21061683204;6417.1657684500715;6476.676166191577;6483.7730679425995;6484.416402523795;6509.316521765336;6575.342465753386;6598.769043083661;6603.438707709898;6616.206055273398;6641.435477984232 07:21:03 INFO - 2015-11-16 07:21:03,547 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.24543060100564;325.4516140303587;325.6808327838718;330.0395848082081;335.71799688261854;6241.126242326078;6309.242890853098;6346.428821406084;6369.012803015534;6452.064450654652;6291.716872740726;6320.620762754226;6334;6336.3030066692745;6347.809565713036;4724.173269677801;4725.645576581753;4732.9763351183365;4739.218029025206;4747.7388743619085;4697.318888761128;4734.887301484148;4737.952620473786;4740.857774266778;4743.359646447737;4599.149157405891;4678.789454474557;4687.086018226447;4703.670743047988;4705.294205869112;4662.836800711959;4669.626429885601;4679.321498382716;4686.742229177394;4690.648201384893;4010.8997275068355;4015.638592526687;4020.0954785173394;4020.3567429211184;4022.597740225983;5902.409759024106;5937.970310148465;5952.9107063394085;5955.880882382371;5957.851053723692;5331.93361327736;5418.458154184589;5425.593080518976;5437.293151890269;5458.918116228259;6604.603723776589;6607.933920660828;6625.039369291426;6629.834254143685;6637.701303441357;4436.334549817521;4457.754823484707;4460.50934397216;4465.129299786543;4469.150861336336;6728.697208625624;6860.279670634562;6872.587644741331;6925.861482770417;6939.167299923991;4552.521985191507;4567.5432456754725;4574.382458368144;4579.9084018319445;4581.954180458153;4638.141943740419;4639.30410438437;4639.605633521189;4642.86071417858;4646.372739680168;5417.864553386118;5422.40353561108;5430.348358197041;5444.40111587725;5449.482299181572;6563.540552161303;6681.866362672817;6695.598264104072;6702.128723265944;6715.899261511081;1612.9032258064553;1613.5804690780246;1651;1652.9504114876572;1658.8921720088156;1063.4629512096496;1064.1486810551528;1073.608133031438;1075.6127793994156;1076.10683133001;6412.39082287182;6413.35866413355;6429.6142231466265;6429.967850160813;6443;6749.3250674932115;6764.425023873026;6796.218434879953;6808.659567021728;6844.28135045823;6255.6872156392;6342.334054924167;6392.584482008655;6393.296737358887;6395.456386207132;3725.5343082114737;3742.0644838790304;3752.5309336332957;3759.172981943968;3760.4923335349376;7110.253423390573;7117.82205444868;7125.038119853753;7142.464315176382;7151.2848715128075;6910.654467276616;6929.618870962045;6968.860622787617;6972.302769723088;6998.895016574756;7272.927270727225;7275.708971641181;7277.490575659653;7327.047483827068;7349.8162545936775;6926.826829329307;6996.265392133752;7000.684969176297;7004.649767511502;7012.509124361246;6804.489663275175;6894.172699276119;6897.137857767779;6898.758543450955;6915.135608048994;7252.2747725227055;7273.781786546412;7290.708371665074;7301.561906285639;7316.158641756266;4516.864494065183;4566.977165114153;4568.977155114336;4570.314452832102;4579.74811385377;6811.89782153278;6931.653417329013;6986.615736134561;7003.3346832050875;7004.684789184397;6758.459323254029;6790.966045169743;6802.3537763912345;6804.387605115563;6811.829704257433;6765.492588056014;6772.864542709217;6790.762323318858;6791.592504449749;6813.863722725617;6532.41208291256;6689.531732778659;6691.297413771484;6692.899606505809;6700.6984685688285;6777.254502004677;6783.491238157059;6830.385265326145;6840.179178498612;6850.075239842757;6654.567453115532;6657.73369065232;6673.632950187786;6680.432163266177;6689.163854518185 07:21:03 INFO - 2015-11-16 07:21:03,547 DEBUG : BROWSER_OUTPUT: |5;yui.html;749.7938067031565;758.9772306830794;775.1705674927828;825.1707034430397;826.5454000299834;14036.789448158273;14044.578662640111;14345.856541434583;14363.425462981468;14410.927945360272;12662.873371266285;13722.725545489084;13800.1719896806;13822.239776812272;13874;820.5815034332503;826.4586695714316;835.1189495082685;838.4591938199858;841.9410641255115;819.2462934100641;823.4071468542639;824.4352618456346;826.5040975414763;826.7726375246795;845.5603086395071;848.3891598049426;849.1890244816217;849.3205435651485;851.4508142248246;833.6832003838563;833.9416240863142;835.3108685334593;838.1074156023876;838.4340570115148;611.245112286326;612.7671484835779;612.7671484835779;613.3559762249664;615.1541630258395;13363.131396459296;13370.331483425887;13370.598882033555;13397.598072057854;13459.66350841227;10043.19654427644;10332.276740628158;10368.481575921174;10566.630167944162;10851.403172825492;9562.61749530018;9751.707448776477;9842.901570984342;9942.403455792675;10057.346272492265;3139.5918530591107;3223.8226897520626;3227.386796508656;3282.5240340150785;3301.4552598821406;44848.103037939385;45132;45866;45893.31160032602;45917.77041114806;7052.753153639598;7083.681234344467;7109;7338.119425668847;7687.461877668509;12707.301098439675;12849.743005140032;12854.457465104248;12861.807072893915;12877.549285774952;6534.313897040837;6556.737730490822;6649.401553860079;6742.123523941857;6885.690143943534;4228.323468245066;4325.783710814447;4379.364992076131;4379.926917905133;4395.648348132142;2744.135597286848;2756.6967633560294;2762.4198918226994;2778.861056947185;2784.7911406644585;451.38160719814067;455.2556570008061;461.0686413444823;461.24356056068075;462.6067842333989;589.7906243283659;625.4152367536368;659.1595715462728;672.6367761408784;686.4885660183096;8552.914470855336;8680.826383472295;8727.170918762708;8757.343199259954;8927.598258078273;647.4780729060284;663.2604645819972;678.7386856060452;712.2912701861577;761.565907432758;4022;4189.224993376235;4441.533638967927;4445.244308467568;4625.167469855391;53401.46598533965;53980.73009635005;54024;57038.714806425705;57567.424325756205;48767.26849097267;49130.26304605434;49351.753241234284;49829;50903.23645145326;43109.904559067465;44543.52781221263;45017.774911125234;45150.77424612856;45465.31802022972;8823.470591764515;8971.260809650443;9404.294677899321;9544.618215271312;9545.140937315675;35223.82388088043;35261.64738352584;35772.821135894155;36023.27953440969;36258.4561231587;44175.558244417145;46056.53943460523;48092;48371;48591.757041214565;7945.602719863868;8037.638306276349;8058.597070146587;8087.47431416956;8505.404621676424;12092.39538023113;12115.212511186744;12242.693932651755;12244.938775306067;12288.631341059783;11424.82862757076;11494.540218391505;11499.885001149882;11820.113491488344;12105.152639315163;10989.06592939609;11194.496247669038;11258.155638327322;11910;11974.521019159136;10206;10221.233407494616;10492.370457772558;10559.947200263949;10607.575696972342;9536.523173841419;9603.615855365708;9622.951885240529;9652.469114198786;9841.26190535727;8827.405795075769;9442.197413219954;9461.810763784548;9465.148136667733;9486.95256523713 07:21:03 INFO - 2015-11-16 07:21:03,547 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:21:03 INFO - 2015-11-16 07:21:03,547 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,284 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687263537__endTimestamp 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,548 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5598.73 Median:5805.36 stddev:626.79 (10.8%) stddev-sans-first:601.52 07:21:03 INFO - 2015-11-16 07:21:03,549 DEBUG : BROWSER_OUTPUT: Values: 3271.0 3324.8 3328.2 3353.8 3358.4 5470.5 5543.1 5543.1 5580.4 5619.0 5622.9 5625.1 5671.6 5690.0 5729.8 5073.2 5168.3 5228.9 5233.1 5235.2 5073.3 5146.9 5158.3 5192.8 5241.4 4980.5 4996.8 5088.6 5110.2 5159.8 5111.1 5114.7 5121.1 5145.5 5178.7 5101.6 5113.9 5125.5 5128.5 5134.9 5290.7 5398.4 5408.9 5452.7 5464.7 5890.1 5926.7 5932.9 5936.7 5938.9 5855.4 5963.8 5970.3 5981.1 5991.7 5584.1 5623.3 5654.6 5660.3 5722.5 5980.5 6027.3 6029.8 6031.9 6075.9 5803.3 5846.5 5864.2 5870.9 5901.7 5995.2 6025.1 6032.4 6034.8 6060.2 6088.9 6093.4 6097.3 6097.5 6107.3 5852.1 5971.3 5978.7 6020.2 6027.8 4604.6 4613.3 4624.7 4624.9 4655.7 4104.1 4136.4 4145.5 4151.8 4188.6 5623.7 5724.5 5728.7 5803.7 5895.8 6031.1 6066.1 6075.1 6092.5 6111.9 5776.2 5793.9 5802.4 5808.2 5817.6 5133.8 5246.6 5247.7 5249.9 5252.4 6297.1 6377.9 6412.6 6466.5 6493.5 6042.6 6070.8 6084.4 6086.1 6090.2 6100.1 6127.4 6196.8 6247.6 6306.8 5910.7 5978.3 5980.9 5984.5 6015.2 6070.6 6099.6 6101.8 6106.1 6123.4 5661.4 5761.5 5880.1 5930.4 5983.6 5829.7 5855.5 5884.4 5886.8 5888.7 5736.2 5792.6 5795.2 5798.8 5805.4 5752.3 5861.5 5959.3 6022.8 6074.4 5786.0 5791.4 5825.0 5828.5 5838.8 07:21:03 INFO - 2015-11-16 07:21:03,550 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,550 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46656.21 Median:39043.21 stddev:74680.59 (191.3%) stddev-sans-first:74809.94 07:21:03 INFO - 2015-11-16 07:21:03,551 DEBUG : BROWSER_OUTPUT: Values: 575.9 579.0 580.9 592.0 598.9 38293.4 38937.0 39461.6 39486.4 39692.2 42776.4 42833.8 42842.1 43245.4 43359.6 8799.0 8872.6 8933.9 8936.1 8963.9 8661.2 8786.6 8835.2 8842.2 8847.4 8806.5 8832.6 8874.1 8892.0 8894.0 8794.3 8862.7 8880.5 8884.6 8885.8 8603.7 8653.8 8727.7 8761.6 8762.2 39149.4 39377.8 39651.2 39666.4 39669.8 3476.4 3527.4 3828.5 3929.1 4062.8 29072.7 29603.3 29713.7 29788.4 29810.3 3103.2 3149.9 3316.4 3361.8 3403.1 262785.0 265238.0 266209.0 266638.0 266830.0 58864.0 59096.7 59097.4 59099.4 59398.1 62426.0 63107.4 63236.4 63561.7 63584.4 14330.1 14336.8 14379.6 14432.4 15053.0 11459.6 11463.5 11578.3 11622.6 11653.9 20208.6 20221.6 20370.3 20421.4 20460.5 8104.1 8276.5 8286.1 8353.6 8406.2 873.9 913.7 914.7 939.3 965.0 28623.6 28626.9 28688.6 28787.4 29015.0 1038.7 1048.6 1055.3 1074.3 1099.8 14893.4 14899.1 14904.3 15026.6 15211.2 305794.0 312337.0 315019.0 315392.0 316540.0 50711.5 50818.7 51200.7 51432.0 51440.0 1294.5 1305.8 1322.1 1323.7 1325.5 26874.6 28088.9 28534.0 31991.0 32571.6 49172.0 49429.5 49887.8 50064.5 50065.0 276195.0 277747.0 278789.0 280233.0 280381.0 42229.8 45639.1 45999.1 46660.3 46818.8 43602.0 43818.0 43977.1 44076.8 44334.8 37134.1 37491.4 37755.6 38012.8 38855.2 37334.4 37631.6 37871.0 37874.4 38618.2 37205.8 40394.2 41052.4 41222.6 41238.4 30810.4 33607.2 33718.3 34285.5 34322.8 25803.2 26216.6 26225.5 26303.5 26396.7 07:21:03 INFO - 2015-11-16 07:21:03,551 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,551 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26984.21 Median:24506.24 stddev:88271.19 (360.2%) stddev-sans-first:88496.16 07:21:03 INFO - 2015-11-16 07:21:03,552 DEBUG : BROWSER_OUTPUT: Values: 351.1 352.5 354.3 356.5 358.2 13987.3 13992.4 16639.5 17131.7 17848.5 15527.8 15792.9 17377.6 17588.3 17620.5 4339.7 4498.9 4503.9 4506.5 4507.4 4449.2 4468.5 4469.6 4478.4 4631.6 4540.8 4542.4 4551.8 4590.2 4605.6 4526.5 4550.0 4571.5 4594.8 4618.4 4141.2 4213.5 4227.2 4229.9 4258.0 13858.6 14022.6 14119.4 14198.1 14296.9 1852.6 1857.8 1881.0 1926.4 1926.9 9821.7 9949.6 9963.4 10196.9 10224.6 1600.1 1614.1 1647.5 1696.6 1800.8 59912.4 62684.0 62943.0 62988.7 62997.0 6973.9 7014.8 7023.0 7026.6 7089.4 8028.6 8108.1 8156.8 8400.2 8424.2 5432.6 5541.1 5587.2 5623.2 5651.7 5742.6 5757.0 5769.8 5770.8 5830.4 3210.6 3242.8 3251.0 3274.1 3294.4 1148.9 1161.4 1163.6 1165.3 1207.7 479.2 480.7 486.2 489.3 489.6 11063.9 11314.1 11440.8 11535.5 11704.5 464.4 473.5 483.8 491.5 517.2 6272.6 6311.7 6369.8 6387.1 6441.3 528183.0 528480.0 529553.0 539276.0 566814.0 72206.0 73834.6 75418.6 75836.4 78840.6 544.1 547.6 547.7 547.9 548.3 10586.6 10846.2 11114.4 11138.5 11199.2 32345.0 32382.4 35146.0 36257.6 36338.6 43974.6 44544.0 46330.8 46519.8 46537.8 6785.7 6933.6 6947.2 6959.4 6992.5 12586.0 12779.4 12962.5 13008.4 13016.3 10418.2 10491.0 10654.5 10838.5 10998.5 10573.7 10954.2 11009.2 11153.7 11162.4 11146.2 11394.7 11434.3 11523.4 11664.1 6784.3 6920.1 6929.8 6947.5 6966.5 11021.3 11135.1 11309.9 11314.4 11358.5 07:21:03 INFO - 2015-11-16 07:21:03,553 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,553 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5427.75 Median:6601.10 stddev:2782.08 (42.1%) stddev-sans-first:2773.93 07:21:03 INFO - 2015-11-16 07:21:03,554 DEBUG : BROWSER_OUTPUT: Values: 1463.9 1532.6 1603.1 1656.8 1739.4 7565.6 7822.5 7873.5 7898.7 8013.3 7939.3 7958.6 7974.8 7996.0 8036.1 2294.8 2327.4 2330.7 2331.1 2333.0 2311.8 2329.1 2347.6 2347.7 2353.4 2248.8 2269.7 2295.3 2296.8 2297.8 2275.8 2302.4 2340.5 2341.9 2343.4 2313.3 2318.8 2330.9 2338.9 2342.3 7633.2 7750.9 7753.9 7761.4 7769.2 4592.7 4661.3 4669.7 4681.9 4690.9 2968.4 2976.6 3040.5 3048.7 3080.4 929.5 974.5 986.4 992.0 994.3 10353.8 10398.9 10401.7 10405.8 10417.5 4139.0 4146.6 4153.3 4193.5 4270.7 8556.9 8607.7 8622.8 8630.1 8634.4 4664.3 4664.5 4672.1 4706.9 4710.8 4317.8 4322.5 4327.7 4329.0 4345.2 3460.7 3466.4 3470.4 3481.9 3498.9 1021.7 1023.6 1025.8 1057.3 1130.6 994.2 1006.1 1068.0 1152.8 1322.0 7300.2 7311.3 7342.4 7342.8 7374.0 1050.1 1051.8 1106.0 1114.1 1134.9 5517.6 5579.9 5611.9 5627.0 5633.5 8935.9 9043.0 9083.5 9180.0 9242.8 9056.7 9064.0 9111.0 9191.5 9193.3 7063.7 7078.9 7183.2 7184.7 7217.6 7075.7 7084.3 7107.7 7111.4 7194.1 7806.4 8297.1 8360.5 8400.0 8417.5 8324.7 8357.9 8415.8 8431.8 8440.5 6901.1 6909.9 6954.9 7002.6 7019.1 7541.5 7555.5 7595.3 7615.7 7634.7 7000.8 7122.5 7125.9 7286.8 7290.6 7000.7 7072.0 7085.5 7110.0 7124.8 7110.9 7124.4 7151.1 7155.4 7176.2 6417.2 6476.7 6483.8 6484.4 6509.3 6575.3 6598.8 6603.4 6616.2 6641.4 07:21:03 INFO - 2015-11-16 07:21:03,554 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,554 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5562.83 Median:6380.80 stddev:1729.77 (27.1%) stddev-sans-first:1689.36 07:21:03 INFO - 2015-11-16 07:21:03,554 DEBUG : BROWSER_OUTPUT: Values: 325.2 325.5 325.7 330.0 335.7 6241.1 6309.2 6346.4 6369.0 6452.1 6291.7 6320.6 6334.0 6336.3 6347.8 4724.2 4725.6 4733.0 4739.2 4747.7 4697.3 4734.9 4738.0 4740.9 4743.4 4599.1 4678.8 4687.1 4703.7 4705.3 4662.8 4669.6 4679.3 4686.7 4690.6 4010.9 4015.6 4020.1 4020.4 4022.6 5902.4 5938.0 5952.9 5955.9 5957.9 5331.9 5418.5 5425.6 5437.3 5458.9 6604.6 6607.9 6625.0 6629.8 6637.7 4436.3 4457.8 4460.5 4465.1 4469.2 6728.7 6860.3 6872.6 6925.9 6939.2 4552.5 4567.5 4574.4 4579.9 4582.0 4638.1 4639.3 4639.6 4642.9 4646.4 5417.9 5422.4 5430.3 5444.4 5449.5 6563.5 6681.9 6695.6 6702.1 6715.9 1612.9 1613.6 1651.0 1653.0 1658.9 1063.5 1064.1 1073.6 1075.6 1076.1 6412.4 6413.4 6429.6 6430.0 6443.0 6749.3 6764.4 6796.2 6808.7 6844.3 6255.7 6342.3 6392.6 6393.3 6395.5 3725.5 3742.1 3752.5 3759.2 3760.5 7110.3 7117.8 7125.0 7142.5 7151.3 6910.7 6929.6 6968.9 6972.3 6998.9 7272.9 7275.7 7277.5 7327.0 7349.8 6926.8 6996.3 7000.7 7004.6 7012.5 6804.5 6894.2 6897.1 6898.8 6915.1 7252.3 7273.8 7290.7 7301.6 7316.2 4516.9 4567.0 4569.0 4570.3 4579.7 6811.9 6931.7 6986.6 7003.3 7004.7 6758.5 6791.0 6802.4 6804.4 6811.8 6765.5 6772.9 6790.8 6791.6 6813.9 6532.4 6689.5 6691.3 6692.9 6700.7 6777.3 6783.5 6830.4 6840.2 6850.1 6654.6 6657.7 6673.6 6680.4 6689.2 07:21:03 INFO - 2015-11-16 07:21:03,554 DEBUG : BROWSER_OUTPUT: 07:21:03 INFO - 2015-11-16 07:21:03,554 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13279.45 Median:48679.51 stddev:15635.24 (32.1%) stddev-sans-first:15650.79 07:21:03 INFO - 2015-11-16 07:21:03,555 DEBUG : BROWSER_OUTPUT: Values: 749.8 759.0 775.2 825.2 826.5 14036.8 14044.6 14345.9 14363.4 14410.9 12662.9 13722.7 13800.2 13822.2 13874.0 820.6 826.5 835.1 838.5 841.9 819.2 823.4 824.4 826.5 826.8 845.6 848.4 849.2 849.3 851.5 833.7 833.9 835.3 838.1 838.4 611.2 612.8 612.8 613.4 615.2 13363.1 13370.3 13370.6 13397.6 13459.7 10043.2 10332.3 10368.5 10566.6 10851.4 9562.6 9751.7 9842.9 9942.4 10057.3 3139.6 3223.8 3227.4 3282.5 3301.5 44848.1 45132.0 45866.0 45893.3 45917.8 7052.8 7083.7 7109.0 7338.1 7687.5 12707.3 12849.7 12854.5 12861.8 12877.5 6534.3 6556.7 6649.4 6742.1 6885.7 4228.3 4325.8 4379.4 4379.9 4395.6 2744.1 2756.7 2762.4 2778.9 2784.8 451.4 455.3 461.1 461.2 462.6 589.8 625.4 659.2 672.6 686.5 8552.9 8680.8 8727.2 8757.3 8927.6 647.5 663.3 678.7 712.3 761.6 4022.0 4189.2 4441.5 4445.2 4625.2 53401.5 53980.7 54024.0 57038.7 57567.4 48767.3 49130.3 49351.8 49829.0 50903.2 43109.9 44543.5 45017.8 45150.8 45465.3 8823.5 8971.3 9404.3 9544.6 9545.1 35223.8 35261.6 35772.8 36023.3 36258.5 44175.6 46056.5 48092.0 48371.0 48591.8 7945.6 8037.6 8058.6 8087.5 8505.4 12092.4 12115.2 12242.7 12244.9 12288.6 11424.8 11494.5 11499.9 11820.1 12105.2 10989.1 11194.5 11258.2 11910.0 11974.5 10206.0 10221.2 10492.4 10559.9 10607.6 9536.5 9603.6 9623.0 9652.5 9841.3 8827.4 9442.2 9461.8 9465.1 9487.0 07:21:03 INFO - 2015-11-16 07:21:03,555 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:21:03 INFO - 2015-11-16 07:21:03,556 DEBUG : BROWSER_OUTPUT: 07:21:04 INFO - 2015-11-16 07:21:04,221 INFO : Browser exited with error code: 0 07:21:04 INFO - 2015-11-16 07:21:04,238 INFO : Completed test dromaeo_css (00:18:31) 07:21:04 INFO - 2015-11-16 07:21:04,238 INFO : Starting test kraken 07:21:04 INFO - 2015-11-16 07:21:04,238 DEBUG : operating with platform_type : linux_ 07:21:04 INFO - 2015-11-16 07:21:04,238 INFO : Initialising browser for kraken test... 07:21:04 INFO - 2015-11-16 07:21:04,244 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptEYTvW/profile http://localhost:46540/getInfo.html 07:21:09 INFO - 2015-11-16 07:21:09,519 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:21:09 INFO - 2015-11-16 07:21:09,520 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:21:09 INFO - 2015-11-16 07:21:09,520 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:21:09 INFO - 2015-11-16 07:21:09,520 DEBUG : BROWSER_OUTPUT: __metrics 07:21:10 INFO - 2015-11-16 07:21:10,685 INFO : Browser initialized. 07:21:10 INFO - 2015-11-16 07:21:10,686 INFO : Running cycle 1/1 for kraken test... 07:21:10 INFO - 2015-11-16 07:21:10,686 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptEYTvW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:21:22 INFO - 2015-11-16 07:21:22,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568 07:21:22 INFO - 2015-11-16 07:21:22,562 DEBUG : BROWSER_OUTPUT: 07:21:25 INFO - 2015-11-16 07:21:25,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46540/tests/kraken/driver.html?testName=audio-beat-detection) 07:21:25 INFO - 2015-11-16 07:21:25,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 142704640 07:21:25 INFO - 2015-11-16 07:21:25,686 DEBUG : BROWSER_OUTPUT: 07:21:28 INFO - 2015-11-16 07:21:28,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46540/tests/kraken/driver.html?testName=audio-dft) 07:21:28 INFO - 2015-11-16 07:21:28,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 142020608 07:21:28 INFO - 2015-11-16 07:21:28,917 DEBUG : BROWSER_OUTPUT: 07:21:31 INFO - 2015-11-16 07:21:31,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46540/tests/kraken/driver.html?testName=audio-fft) 07:21:32 INFO - 2015-11-16 07:21:32,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 137396224 07:21:32 INFO - 2015-11-16 07:21:32,377 DEBUG : BROWSER_OUTPUT: 07:21:34 INFO - 2015-11-16 07:21:34,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46540/tests/kraken/driver.html?testName=audio-oscillator) 07:21:34 INFO - 2015-11-16 07:21:34,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 137097216 07:21:34 INFO - 2015-11-16 07:21:34,932 DEBUG : BROWSER_OUTPUT: 07:21:37 INFO - 2015-11-16 07:21:37,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46540/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:21:37 INFO - 2015-11-16 07:21:37,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 137211904 07:21:37 INFO - 2015-11-16 07:21:37,690 DEBUG : BROWSER_OUTPUT: 07:21:40 INFO - 2015-11-16 07:21:40,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46540/tests/kraken/driver.html?testName=imaging-darkroom) 07:21:41 INFO - 2015-11-16 07:21:41,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 138424320 07:21:41 INFO - 2015-11-16 07:21:41,275 DEBUG : BROWSER_OUTPUT: 07:21:44 INFO - 2015-11-16 07:21:44,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46540/tests/kraken/driver.html?testName=imaging-desaturate) 07:21:45 INFO - 2015-11-16 07:21:45,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 139931648 07:21:45 INFO - 2015-11-16 07:21:45,244 DEBUG : BROWSER_OUTPUT: 07:21:48 INFO - 2015-11-16 07:21:48,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46540/tests/kraken/driver.html?testName=json-parse-financial) 07:21:48 INFO - 2015-11-16 07:21:48,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 137707520 07:21:48 INFO - 2015-11-16 07:21:48,780 DEBUG : BROWSER_OUTPUT: 07:21:50 INFO - 2015-11-16 07:21:50,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46540/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:21:50 INFO - 2015-11-16 07:21:50,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 139350016 07:21:50 INFO - 2015-11-16 07:21:50,944 DEBUG : BROWSER_OUTPUT: 07:21:52 INFO - 2015-11-16 07:21:52,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:21:53 INFO - 2015-11-16 07:21:53,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 138981376 07:21:53 INFO - 2015-11-16 07:21:53,407 DEBUG : BROWSER_OUTPUT: 07:21:55 INFO - 2015-11-16 07:21:55,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:21:56 INFO - 2015-11-16 07:21:56,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 139018240 07:21:56 INFO - 2015-11-16 07:21:56,102 DEBUG : BROWSER_OUTPUT: 07:21:58 INFO - 2015-11-16 07:21:58,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:21:59 INFO - 2015-11-16 07:21:59,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 139300864 07:21:59 INFO - 2015-11-16 07:21:59,149 DEBUG : BROWSER_OUTPUT: 07:22:01 INFO - 2015-11-16 07:22:01,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:22:02 INFO - 2015-11-16 07:22:02,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 139657216 07:22:02 INFO - 2015-11-16 07:22:02,318 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46540/tests/kraken/driver.html?testName=ai-astar) 07:22:04 INFO - 2015-11-16 07:22:04,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 139935744 07:22:04 INFO - 2015-11-16 07:22:04,252 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,255 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:22:04 INFO - 2015-11-16 07:22:04,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:22:04 INFO - 2015-11-16 07:22:04,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;106;111;111;112;122;111;110;112;111 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;137;153;159;126;153;153;127;162;130 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;164;162;163;161;165;174;163;162 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;73;73;135;72;72;73;73 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;130;90;91;90;134;92;91;135 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;109;109;109;110;111 07:22:04 INFO - 2015-11-16 07:22:04,256 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;146;147;147;146;146;147;146;151 07:22:04 INFO - 2015-11-16 07:22:04,257 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;95;96;96;95;96;96;96;96;95 07:22:04 INFO - 2015-11-16 07:22:04,257 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;61;63;70;61;62;62;60;59 07:22:04 INFO - 2015-11-16 07:22:04,257 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;70;71;73;71;71;70;70 07:22:04 INFO - 2015-11-16 07:22:04,257 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;85;94;94;87;88;84;87;84 07:22:04 INFO - 2015-11-16 07:22:04,257 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;124;124;128;118;127;117;119;122;120 07:22:04 INFO - 2015-11-16 07:22:04,257 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;151;150;154;148;152;158;140;150;138 07:22:04 INFO - 2015-11-16 07:22:04,257 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;67;67;68;69;67;66;67;66 07:22:04 INFO - 2015-11-16 07:22:04,258 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:22:04 INFO - 2015-11-16 07:22:04,258 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:22:04 INFO - 2015-11-16 07:22:04,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,727 07:22:04 INFO - 2015-11-16 07:22:04,258 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:22:04 INFO - 2015-11-16 07:22:04,258 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687324253__endTimestamp 07:22:04 INFO - 2015-11-16 07:22:04,258 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,262 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:22:04 INFO - 2015-11-16 07:22:04,262 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:22:04 INFO - 2015-11-16 07:22:04,262 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,262 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.01 (3.6%) stddev-sans-first:4.24 07:22:04 INFO - 2015-11-16 07:22:04,263 DEBUG : BROWSER_OUTPUT: Values: 113.0 106.0 111.0 111.0 112.0 122.0 111.0 110.0 112.0 111.0 07:22:04 INFO - 2015-11-16 07:22:04,263 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,263 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.50 Median:153.00 stddev:13.94 (9.1%) stddev-sans-first:14.35 07:22:04 INFO - 2015-11-16 07:22:04,263 DEBUG : BROWSER_OUTPUT: Values: 155.0 137.0 153.0 159.0 126.0 153.0 153.0 127.0 162.0 130.0 07:22:04 INFO - 2015-11-16 07:22:04,263 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,264 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.67 (2.2%) stddev-sans-first:3.89 07:22:04 INFO - 2015-11-16 07:22:04,264 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 164.0 162.0 163.0 161.0 165.0 174.0 163.0 162.0 07:22:04 INFO - 2015-11-16 07:22:04,264 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,264 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:73.00 stddev:19.75 (27.1%) stddev-sans-first:20.80 07:22:04 INFO - 2015-11-16 07:22:04,265 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 73.0 73.0 135.0 72.0 72.0 73.0 73.0 07:22:04 INFO - 2015-11-16 07:22:04,265 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,265 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:91.00 stddev:20.40 (22.4%) stddev-sans-first:21.13 07:22:04 INFO - 2015-11-16 07:22:04,265 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 130.0 90.0 91.0 90.0 134.0 92.0 91.0 135.0 07:22:04 INFO - 2015-11-16 07:22:04,266 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,266 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 07:22:04 INFO - 2015-11-16 07:22:04,266 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 111.0 07:22:04 INFO - 2015-11-16 07:22:04,266 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,267 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.62 (1.1%) stddev-sans-first:1.58 07:22:04 INFO - 2015-11-16 07:22:04,267 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 151.0 07:22:04 INFO - 2015-11-16 07:22:04,267 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,267 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 07:22:04 INFO - 2015-11-16 07:22:04,267 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 07:22:04 INFO - 2015-11-16 07:22:04,268 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,268 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.90 Median:61.50 stddev:3.07 (5.0%) stddev-sans-first:3.24 07:22:04 INFO - 2015-11-16 07:22:04,268 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 61.0 63.0 70.0 61.0 62.0 62.0 60.0 59.0 07:22:04 INFO - 2015-11-16 07:22:04,268 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,269 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.50 stddev:1.08 (1.5%) stddev-sans-first:1.00 07:22:04 INFO - 2015-11-16 07:22:04,269 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 71.0 73.0 71.0 71.0 70.0 70.0 07:22:04 INFO - 2015-11-16 07:22:04,269 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,270 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:3.72 (4.3%) stddev-sans-first:3.84 07:22:04 INFO - 2015-11-16 07:22:04,270 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 85.0 94.0 94.0 87.0 88.0 84.0 87.0 84.0 07:22:04 INFO - 2015-11-16 07:22:04,270 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,270 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:123.00 stddev:4.17 (3.4%) stddev-sans-first:3.92 07:22:04 INFO - 2015-11-16 07:22:04,270 DEBUG : BROWSER_OUTPUT: Values: 116.0 124.0 124.0 128.0 118.0 127.0 117.0 119.0 122.0 120.0 07:22:04 INFO - 2015-11-16 07:22:04,270 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,271 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.50 stddev:6.64 (4.4%) stddev-sans-first:6.36 07:22:04 INFO - 2015-11-16 07:22:04,271 DEBUG : BROWSER_OUTPUT: Values: 140.0 151.0 150.0 154.0 148.0 152.0 158.0 140.0 150.0 138.0 07:22:04 INFO - 2015-11-16 07:22:04,271 DEBUG : BROWSER_OUTPUT: 07:22:04 INFO - 2015-11-16 07:22:04,271 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 07:22:04 INFO - 2015-11-16 07:22:04,271 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 67.0 68.0 69.0 67.0 66.0 67.0 66.0 07:22:04 INFO - 2015-11-16 07:22:04,271 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:22:04 INFO - 2015-11-16 07:22:04,271 DEBUG : BROWSER_OUTPUT: 07:22:05 INFO - 2015-11-16 07:22:05,193 INFO : Browser exited with error code: 0 07:22:05 INFO - 2015-11-16 07:22:05,249 INFO : Completed test kraken (00:01:01) 07:22:05 INFO - 2015-11-16 07:22:05,249 INFO : Starting test v8_7 07:22:05 INFO - 2015-11-16 07:22:05,249 DEBUG : operating with platform_type : linux_ 07:22:05 INFO - 2015-11-16 07:22:05,250 INFO : Initialising browser for v8_7 test... 07:22:05 INFO - 2015-11-16 07:22:05,256 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxsK_Gq/profile http://localhost:46540/getInfo.html 07:22:10 INFO - 2015-11-16 07:22:10,406 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:22:10 INFO - 2015-11-16 07:22:10,406 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:22:10 INFO - 2015-11-16 07:22:10,406 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:22:10 INFO - 2015-11-16 07:22:10,407 DEBUG : BROWSER_OUTPUT: __metrics 07:22:11 INFO - 2015-11-16 07:22:11,449 INFO : Browser initialized. 07:22:11 INFO - 2015-11-16 07:22:11,450 INFO : Running cycle 1/1 for v8_7 test... 07:22:11 INFO - 2015-11-16 07:22:11,450 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxsK_Gq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:22:23 INFO - 2015-11-16 07:22:23,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 141266944 07:22:23 INFO - 2015-11-16 07:22:23,245 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46540/tests/v8_7/run.html (next: http://localhost:46540/tests/v8_7/run.html) 07:22:44 INFO - 2015-11-16 07:22:44,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 138604544 07:22:44 INFO - 2015-11-16 07:22:44,892 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,893 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:22:44 INFO - 2015-11-16 07:22:44,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:22:44 INFO - 2015-11-16 07:22:44,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:22:44 INFO - 2015-11-16 07:22:44,893 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:22:44 INFO - 2015-11-16 07:22:44,893 DEBUG : BROWSER_OUTPUT: |0;Richards;162.813415825464 07:22:44 INFO - 2015-11-16 07:22:44,894 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.25442354255912 07:22:44 INFO - 2015-11-16 07:22:44,894 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 07:22:44 INFO - 2015-11-16 07:22:44,894 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 07:22:44 INFO - 2015-11-16 07:22:44,894 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 07:22:44 INFO - 2015-11-16 07:22:44,894 DEBUG : BROWSER_OUTPUT: |5;Earley;722.543352601156 07:22:44 INFO - 2015-11-16 07:22:44,894 DEBUG : BROWSER_OUTPUT: |6;Boyer;12035.714285714286 07:22:44 INFO - 2015-11-16 07:22:44,895 DEBUG : BROWSER_OUTPUT: |7;RegExp;25525 07:22:44 INFO - 2015-11-16 07:22:44,895 DEBUG : BROWSER_OUTPUT: |8;Splay;637.7551020408164 07:22:44 INFO - 2015-11-16 07:22:44,895 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4812.5 07:22:44 INFO - 2015-11-16 07:22:44,895 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:22:44 INFO - 2015-11-16 07:22:44,895 DEBUG : BROWSER_OUTPUT: __startTimestamp1447687364889__endTimestamp 07:22:44 INFO - 2015-11-16 07:22:44,895 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,896 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:22:44 INFO - 2015-11-16 07:22:44,896 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:22:44 INFO - 2015-11-16 07:22:44,896 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,896 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.81 Median:162.81 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,896 DEBUG : BROWSER_OUTPUT: Values: 162.8 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.25 Median:186.25 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: Values: 186.3 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: Values: 282.1 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: Values: 5055.6 07:22:44 INFO - 2015-11-16 07:22:44,897 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: Values: 1063.8 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:722.54 Median:722.54 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: Values: 722.5 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12035.71 Median:12035.71 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: Values: 12035.7 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,898 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: Values: 25525.0 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:637.76 Median:637.76 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: Values: 637.8 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: Values: 4812.5 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:22:44 INFO - 2015-11-16 07:22:44,899 DEBUG : BROWSER_OUTPUT: 07:22:45 INFO - 2015-11-16 07:22:45,769 INFO : Browser exited with error code: 0 07:22:45 INFO - 2015-11-16 07:22:45,786 INFO : Completed test v8_7 (00:00:40) 07:22:45 INFO - 2015-11-16 07:22:45,906 INFO : Completed test suite (00:20:13) 07:22:45 INFO - 2015-11-16 07:22:45,906 DEBUG : Working with test: dromaeo_css 07:22:45 INFO - 2015-11-16 07:22:45,906 DEBUG : Generating results file: dromaeo_css 07:22:45 INFO - 2015-11-16 07:22:45,907 DEBUG : Working with test: kraken 07:22:45 INFO - 2015-11-16 07:22:45,907 DEBUG : Generating results file: kraken 07:22:45 INFO - 2015-11-16 07:22:45,907 INFO : javascript benchmark 07:22:45 INFO - 2015-11-16 07:22:45,908 DEBUG : Working with test: v8_7 07:22:45 INFO - 2015-11-16 07:22:45,908 DEBUG : Generating results file: v8_7 07:22:45 INFO - 2015-11-16 07:22:45,908 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:45 INFO - 2015-11-16 07:22:45,973 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 07:22:45 INFO - 2015-11-16 07:22:45,973 DEBUG : process_Request line: dromaeo_css 6785.17 graph.html#tests=[[72,64,43]] 07:22:45 INFO - 2015-11-16 07:22:45,973 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:46 INFO - 2015-11-16 07:22:46,006 DEBUG : process_Request line: kraken 1513.30 graph.html#tests=[[232,64,43]] 07:22:46 INFO - 2015-11-16 07:22:46,006 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:22:46 INFO - 2015-11-16 07:22:46,037 DEBUG : process_Request line: v8_7 21371.72 graph.html#tests=[[230,64,43]] 07:22:46 INFO - 2015-11-16 07:22:46,038 INFO : javascript benchmark 07:22:46 INFO - 2015-11-16 07:22:46,042 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [351.05916144732106, 352.4853713578176, 354.3426943020697, 356.5436241610738, 358.20121129880357, 13987.300634968262, 13992.440302387919, 16639.500814975556, 17131.657366852654, 17848.464546063624, 15527.844721552781, 15792.921035394807, 17377.565560860985, 17588.296468141292, 17620.471385858444, 4339.674524410674, 4498.932516012263, 4503.887402814939, 4506.52681468446, 4507.391502147201, 4449.243628583149, 4468.486124095722, 4469.575390337913, 4478.373027776114, 4631.560001799824, 4540.841070562531, 4542.409486766715, 4551.817927282921, 4590.173768721629, 4605.585497305242, 4526.4794548627, 4550.0, 4571.542845715435, 4594.793234304431, 4618.376519169936, 4141.192467468844, 4213.4522512073545, 4227.154569086164, 4229.851955181553, 4257.97871010646, 13858.644030514837, 14022.649433764136, 14119.364628591738, 14198.148111113263, 14296.857031429656, 1852.6479968805884, 1857.7863545692283, 1880.981190188108, 1926.422073377981, 1926.8554858385678, 9821.656242031495, 9949.602015919354, 9963.402195868272, 10196.89803101967, 10224.64213752515, 1600.0959457906363, 1614.079974414584, 1647.5057482755126, 1696.6267421167324, 1800.7568978187908, 59912.400875991116, 62684.0, 62943.0, 62988.68505657488, 62997.0, 6973.895391569131, 7014.824629384204, 7023.0, 7026.648667566601, 7089.397401220954, 8028.558429286445, 8108.067572229151, 8156.83686326282, 8400.159984001551, 8424.157584241526, 5432.619716619878, 5541.113421852565, 5587.189857470644, 5623.2408624835125, 5651.689157096399, 5742.598018138774, 5756.971215143897, 5769.798057067983, 5770.826875193751, 5830.3586605473365, 3210.6147262328204, 3242.821644809511, 3250.967490325114, 3274.148721332423, 3294.4399452093203, 1148.8563929508812, 1161.4018780328138, 1163.6043745126528, 1165.347405452949, 1207.7403358278013, 479.20212845611667, 480.7211817146047, 486.1880659298979, 489.3149590573226, 489.6034212287987, 11063.944680276547, 11314.094872410187, 11440.828387574193, 11535.480903359368, 11704.531818727326, 464.3777338366605, 473.49336210254694, 483.8185680369861, 491.52567772100093, 517.1880148167342, 6272.560920735505, 6311.715972781236, 6369.777057802955, 6387.137736405526, 6441.32366101562, 528183.0, 528480.0, 529553.0, 539276.0, 566814.0, 72206.0, 73834.63082684552, 75418.62290688511, 75836.43494117375, 78840.6057969718, 544.0886515087213, 547.5619504396467, 547.7398235837945, 547.8685115572314, 548.3118686049063, 10586.576536938435, 10846.18653600999, 11114.38870862078, 11138.498767555317, 11199.21605487608, 32345.0, 32382.35235295328, 35146.0, 36257.63742362543, 36338.63661363353, 43974.560254397045, 44544.0, 46330.76834615805, 46519.76740116413, 46537.767311163225, 6785.660716964231, 6933.618650974245, 6947.201071876799, 6959.373656370951, 6992.545484543489, 12586.0, 12779.36103194818, 12962.481500739865, 13008.414621341873, 13016.28410437435, 10418.166546676399, 10491.0, 10654.467276636293, 10838.458077095956, 10998.450077495932, 10573.682789516326, 10954.233203675985, 11009.229353945148, 11153.721156970816, 11162.38606876597, 11146.164037697366, 11394.658160255205, 11434.313941163557, 11523.423828808358, 11664.125190610568, 6784.253732089367, 6920.100386949664, 6929.757458488929, 6947.513674042971, 6966.512344135862, 11021.283616564897, 11135.10919126484, 11309.886901130883, 11314.377709226072, 11358.54565817391], "dojo.html": [3270.983645081775, 3324.800511969282, 3328.217868800831, 3353.7820041697273, 3358.4290670586006, 5470.5350045246205, 5543.113101903701, 5543.140813173959, 5580.386157522679, 5619.044762390393, 5622.91565626516, 5625.071863142576, 5671.602987790856, 5689.971550142254, 5729.799457019005, 5073.188289873612, 5168.32811734474, 5228.947710522884, 5233.136532472137, 5235.240890070956, 5073.264376665381, 5146.948530514703, 5158.252053452247, 5192.818251361203, 5241.371035475749, 4980.5019498049905, 4996.775145118442, 5088.643794934337, 5110.233464980282, 5159.76781044852, 5111.131107711661, 5114.718690472023, 5121.052605268037, 5145.511176438233, 5178.689278643255, 5101.642884998052, 5113.948860511385, 5125.513076257786, 5128.512791284859, 5134.922976155361, 5290.65610735301, 5398.379186393576, 5408.864778380533, 5452.672839629595, 5464.672119672792, 5890.087036509348, 5926.674032928187, 5932.851678708023, 5936.673482958436, 5938.8812223755285, 5855.443732845415, 5963.7912673056235, 5970.283565972111, 5981.1028345748055, 5991.730372133265, 5584.078627026536, 5623.325200975868, 5654.604177707603, 5660.29246344207, 5722.484976352107, 5980.521558275327, 6027.30685971119, 6029.758809647565, 6031.9396806032255, 6075.908861367083, 5803.332616749043, 5846.532277417797, 5864.179014937912, 5870.911936320873, 5901.675407852524, 5995.190649262294, 6025.096235564701, 6032.366601506867, 6034.788782392595, 6060.181875446847, 6088.908666370008, 6093.39066093396, 6097.298810636745, 6097.451229389376, 6107.328193898667, 5852.092925596539, 5971.313298970587, 5978.701064946736, 6020.157177995085, 6027.758889644453, 4604.562566556172, 4613.284940834176, 4624.699394539344, 4624.930626040612, 4655.720656760605, 4104.056067104582, 4136.4415803866095, 4145.523264824524, 4151.750894946313, 4188.602082802129, 5623.718814059281, 5724.4561766632105, 5728.713564321767, 5803.665157013826, 5895.764169433174, 6031.09533569968, 6066.090086487062, 6075.088736689532, 6092.5430592705725, 6111.877762444815, 5776.19133321327, 5793.8551536211935, 5802.448767367094, 5808.244928159313, 5817.621854579439, 5133.768980395891, 5246.632735708464, 5247.7113758743635, 5249.895002099936, 5252.448492908266, 6297.086922396227, 6377.904331435032, 6412.615243085336, 6466.4503517201565, 6493.5454518184215, 6042.607230530001, 6070.78752243687, 6084.361142080018, 6086.1175129606845, 6090.177825993434, 6100.066499260575, 6127.372786728296, 6196.845078873064, 6247.625142491465, 6306.810795676137, 5910.70446477683, 5978.282606087298, 5980.8803823924145, 5984.491318237999, 6015.248093988252, 6070.6357618543025, 6099.603525770811, 6101.816945491642, 6106.114613380946, 6123.418275263843, 5661.405552416937, 5761.452661997104, 5880.059190529666, 5930.406959304035, 5983.640981541122, 5829.7085145743395, 5855.531557475477, 5884.35272120075, 5886.793962211474, 5888.705564721832, 5736.196932429547, 5792.623479473821, 5795.188673585786, 5798.797042103506, 5805.3614102447855, 5752.338481074563, 5861.531077513874, 5959.255093113361, 6022.819315420545, 6074.36219196978, 5786.0, 5791.391903850035, 5825.009748342707, 5828.475437210672, 5838.824835254949], "mootools.html": [1463.860933211345, 1532.5862017255342, 1603.0622086079643, 1656.7763351947492, 1739.36513172692, 7565.583892885889, 7822.491538050022, 7873.527588344703, 7898.684052637887, 8013.278804907557, 7939.285464308211, 7958.641861116249, 7974.840503189933, 7995.960020199891, 8036.116027237013, 2294.7819957104048, 2327.3948773318975, 2330.6853574767442, 2331.1258278145697, 2332.9968113711097, 2311.8034967027825, 2329.149860300995, 2347.6361164019604, 2347.7417484076736, 2353.3881190890406, 2248.7526372099055, 2269.693591365169, 2295.2999335202758, 2296.7932886040253, 2297.8161747060194, 2275.8065564427043, 2302.4359032037173, 2340.473393486469, 2341.9180328688585, 2343.3907184132077, 2313.2944451942153, 2318.8144948404088, 2330.860148391102, 2338.9064437422485, 2342.3090188394463, 7633.198514156044, 7750.922490775077, 7753.922460775377, 7761.417893657998, 7769.1842356552315, 4592.74739889306, 4661.300804879262, 4669.6731228814, 4681.882952926204, 4690.929636055462, 2968.3766409054124, 2976.56839758236, 3040.528718048706, 3048.695130486956, 3080.430120427728, 929.5073610986188, 974.5176137811758, 986.363795351994, 991.9652812151612, 994.2543092680489, 10353.792924141475, 10398.896011039868, 10401.739956501073, 10405.79188416235, 10417.531211095444, 4139.0480189555965, 4146.626803587692, 4153.293940030202, 4193.5387107418155, 4270.7010509264055, 8556.914430855737, 8607.698730544525, 8622.78443038929, 8630.093840146694, 8634.438761480484, 4664.346991421204, 4664.510226426244, 4672.1356549037855, 4706.929396059062, 4710.788014539354, 4317.762523061199, 4322.502912165141, 4327.7186982846015, 4329.004329004347, 4345.217860785026, 3460.7058400035776, 3466.4107101792756, 3470.3926812808163, 3481.89554313371, 3498.9475157872653, 1021.7496713305288, 1023.6110278094277, 1025.8461230815287, 1057.2599180573475, 1130.5873356224918, 994.1798016636304, 1006.1296978113879, 1067.964074847397, 1152.815549512074, 1322.0481253497467, 7300.160481544584, 7311.268873112753, 7342.4493163012985, 7342.779716608404, 7374.0, 1050.144132531984, 1051.8264486359817, 1105.9612913547987, 1114.1087130295732, 1134.9319040857574, 5517.5585953124455, 5579.860503487364, 5611.9438805612235, 5627.0, 5633.492985631313, 8935.865962010575, 9043.0, 9083.500407477652, 9179.95410022959, 9242.768930776785, 9056.683016094405, 9064.048274931169, 9111.0, 9191.540422978824, 9193.264538836876, 7063.71745130189, 7078.929210707827, 7183.173934997542, 7184.676689548983, 7217.639118044077, 7075.71697132109, 7084.2915708428745, 7107.715691372287, 7111.395531379684, 7194.100737407824, 7806.414518911218, 8297.087320394872, 8360.540170290693, 8399.95800020996, 8417.537035463109, 8324.6670133194, 8357.874631880648, 8415.789605259917, 8431.831363372821, 8440.53577053268, 6901.102856628606, 6909.861802763816, 6954.930450695429, 7002.5798452091, 7019.052427922165, 7541.509801862861, 7555.471117021756, 7595.3164215220895, 7615.695372185272, 7634.732784352521, 7000.789976300719, 7122.501424900207, 7125.928740712527, 7286.817829554304, 7290.635468226674, 7000.684969176297, 7071.964640176972, 7085.539439936388, 7110.0401445804155, 7124.786256412316, 7110.928890711233, 7124.358807707124, 7151.141862976476, 7155.391791697764, 7176.21061683204, 6417.1657684500715, 6476.676166191577, 6483.7730679425995, 6484.416402523795, 6509.316521765336, 6575.342465753386, 6598.769043083661, 6603.438707709898, 6616.206055273398, 6641.435477984232], "ext.html": [575.8790653962668, 579.0474669169216, 580.8983427900116, 591.9556033297504, 598.9279190249454, 38293.42559861604, 38937.0, 39461.60538394619, 39486.40770388446, 39692.20615587686, 42776.35835462463, 42833.7858310708, 42842.14315713692, 43245.35131973015, 43359.56640433595, 8799.0, 8872.645094196225, 8933.910660893373, 8936.106389361077, 8963.865542016842, 8661.220490155885, 8786.560671966408, 8835.160659737314, 8842.204201621853, 8847.380683352168, 8806.515641639708, 8832.55837208137, 8874.068222836606, 8891.95554022229, 8894.0, 8794.25248853845, 8862.689805856764, 8880.467171969638, 8884.555772211428, 8885.822283554326, 8603.698870539563, 8653.783655408602, 8727.694530691395, 8761.605727742266, 8762.167594078552, 39149.41275880836, 39377.80311098455, 39651.20697586061, 39666.40500392496, 39669.80165099185, 3476.4090104682264, 3527.435610302365, 3828.5214348206473, 3929.0766669832565, 4062.837486500536, 29072.70927290721, 29603.259918501994, 29713.70286297131, 29788.40423191524, 29810.254743631365, 3103.193169775852, 3149.889753858627, 3316.369889720945, 3361.764676472648, 3403.0981789825714, 262785.0, 265237.9999999981, 266209.0, 266638.0, 266830.0, 58864.0, 59096.70451647714, 59097.40902591005, 59099.40900591025, 59398.10902836461, 62426.0, 63107.368926311065, 63236.367636323965, 63561.68219158875, 63584.364156358766, 14330.140191588538, 14336.784948225784, 14379.640508987359, 14432.350544225535, 15053.0, 11459.598914037968, 11463.541458341573, 11578.305301681758, 11622.593209237637, 11653.941730291464, 20208.595828083355, 20221.595568088556, 20370.287039953826, 20421.387358379274, 20460.48848778763, 8104.1085480597085, 8276.544790036485, 8286.088530261666, 8353.624086916103, 8406.159384061668, 873.886394768676, 913.7030465098869, 914.7255823252998, 939.3096074385321, 965.0205041882494, 28623.57064644032, 28626.856865715537, 28688.569671454945, 28787.42425151485, 29015.0, 1038.672818062308, 1048.5858086056119, 1055.3245922609535, 1074.2909679611419, 1099.8240281554913, 14893.404263829541, 14899.106053636817, 14904.329305181293, 15026.624334391729, 15211.239438028055, 305794.0, 312337.0, 315019.0, 315392.0, 316540.0, 50711.49288507141, 50818.74590627023, 51200.74399628052, 51432.0, 51440.0, 1294.4886769725906, 1305.8041293806004, 1322.107577385261, 1323.7286356296936, 1325.4830616059937, 26874.596881046407, 28088.859555702908, 28534.0, 31991.0, 32571.579984102274, 49172.0, 49429.50570494393, 49887.75056124696, 50064.49935500598, 50065.0, 276195.0, 277747.0, 278789.0, 280233.0, 280381.0, 42229.78885105555, 45639.087218256114, 45999.08001840011, 46660.300095499275, 46818.76590617025, 43602.0, 43818.0, 43977.12045759131, 44076.77961610172, 44334.778326108164, 37134.07311810786, 37491.43762843505, 37755.62244377631, 38012.80993595125, 38855.22289554137, 37334.43998339973, 37631.62368376281, 37871.0, 37874.431883522324, 38618.22763544769, 37205.81397092997, 40394.192116156926, 41052.384214237405, 41222.58777412307, 41238.38142427926, 30810.383792324476, 33607.15982100467, 33718.325633486704, 34285.48571771475, 34322.82838585791, 25803.225903222934, 26216.60675089837, 26225.4754904897, 26303.473930521664, 26396.736032639426], "prototype.html": [325.24543060100564, 325.4516140303587, 325.6808327838718, 330.0395848082081, 335.71799688261854, 6241.126242326078, 6309.242890853098, 6346.428821406084, 6369.012803015534, 6452.064450654652, 6291.716872740726, 6320.620762754226, 6334.0, 6336.3030066692745, 6347.809565713036, 4724.173269677801, 4725.645576581753, 4732.9763351183365, 4739.218029025206, 4747.7388743619085, 4697.318888761128, 4734.887301484148, 4737.952620473786, 4740.857774266778, 4743.359646447737, 4599.149157405891, 4678.789454474557, 4687.086018226447, 4703.670743047988, 4705.294205869112, 4662.836800711959, 4669.626429885601, 4679.321498382716, 4686.742229177394, 4690.648201384893, 4010.8997275068355, 4015.638592526687, 4020.0954785173394, 4020.3567429211184, 4022.597740225983, 5902.409759024106, 5937.970310148465, 5952.9107063394085, 5955.880882382371, 5957.851053723692, 5331.93361327736, 5418.458154184589, 5425.593080518976, 5437.293151890269, 5458.918116228259, 6604.603723776589, 6607.933920660828, 6625.039369291426, 6629.834254143685, 6637.701303441357, 4436.334549817521, 4457.754823484707, 4460.50934397216, 4465.129299786543, 4469.150861336336, 6728.697208625624, 6860.279670634562, 6872.587644741331, 6925.861482770417, 6939.167299923991, 4552.521985191507, 4567.5432456754725, 4574.382458368144, 4579.9084018319445, 4581.954180458153, 4638.141943740419, 4639.30410438437, 4639.605633521189, 4642.86071417858, 4646.372739680168, 5417.864553386118, 5422.40353561108, 5430.348358197041, 5444.40111587725, 5449.482299181572, 6563.540552161303, 6681.866362672817, 6695.598264104072, 6702.128723265944, 6715.899261511081, 1612.9032258064553, 1613.5804690780246, 1651.0, 1652.9504114876572, 1658.8921720088156, 1063.4629512096496, 1064.1486810551528, 1073.608133031438, 1075.6127793994156, 1076.10683133001, 6412.39082287182, 6413.35866413355, 6429.6142231466265, 6429.967850160813, 6443.0, 6749.3250674932115, 6764.425023873026, 6796.218434879953, 6808.659567021728, 6844.28135045823, 6255.6872156392, 6342.334054924167, 6392.584482008655, 6393.296737358887, 6395.456386207132, 3725.5343082114737, 3742.0644838790304, 3752.5309336332957, 3759.172981943968, 3760.4923335349376, 7110.253423390573, 7117.82205444868, 7125.038119853753, 7142.464315176382, 7151.2848715128075, 6910.654467276616, 6929.618870962045, 6968.860622787617, 6972.302769723088, 6998.895016574756, 7272.927270727225, 7275.708971641181, 7277.490575659653, 7327.047483827068, 7349.8162545936775, 6926.826829329307, 6996.265392133752, 7000.684969176297, 7004.649767511502, 7012.509124361246, 6804.489663275175, 6894.172699276119, 6897.137857767779, 6898.758543450955, 6915.135608048994, 7252.2747725227055, 7273.781786546412, 7290.708371665074, 7301.561906285639, 7316.158641756266, 4516.864494065183, 4566.977165114153, 4568.977155114336, 4570.314452832102, 4579.74811385377, 6811.89782153278, 6931.653417329013, 6986.615736134561, 7003.3346832050875, 7004.684789184397, 6758.459323254029, 6790.966045169743, 6802.3537763912345, 6804.387605115563, 6811.829704257433, 6765.492588056014, 6772.864542709217, 6790.762323318858, 6791.592504449749, 6813.863722725617, 6532.41208291256, 6689.531732778659, 6691.297413771484, 6692.899606505809, 6700.6984685688285, 6777.254502004677, 6783.491238157059, 6830.385265326145, 6840.179178498612, 6850.075239842757, 6654.567453115532, 6657.73369065232, 6673.632950187786, 6680.432163266177, 6689.163854518185], "yui.html": [749.7938067031565, 758.9772306830794, 775.1705674927828, 825.1707034430397, 826.5454000299834, 14036.789448158273, 14044.578662640111, 14345.856541434583, 14363.425462981468, 14410.927945360272, 12662.873371266285, 13722.725545489084, 13800.1719896806, 13822.239776812272, 13874.0, 820.5815034332503, 826.4586695714316, 835.1189495082685, 838.4591938199858, 841.9410641255115, 819.2462934100641, 823.4071468542639, 824.4352618456346, 826.5040975414763, 826.7726375246795, 845.5603086395071, 848.3891598049426, 849.1890244816217, 849.3205435651485, 851.4508142248246, 833.6832003838563, 833.9416240863142, 835.3108685334593, 838.1074156023876, 838.4340570115148, 611.245112286326, 612.7671484835779, 612.7671484835779, 613.3559762249664, 615.1541630258395, 13363.131396459296, 13370.331483425887, 13370.598882033555, 13397.598072057854, 13459.66350841227, 10043.19654427644, 10332.276740628158, 10368.481575921174, 10566.630167944162, 10851.403172825492, 9562.61749530018, 9751.707448776477, 9842.901570984342, 9942.403455792675, 10057.346272492265, 3139.5918530591107, 3223.8226897520626, 3227.386796508656, 3282.5240340150785, 3301.4552598821406, 44848.103037939385, 45132.0, 45866.0, 45893.31160032602, 45917.77041114806, 7052.753153639598, 7083.681234344467, 7109.0, 7338.119425668847, 7687.461877668509, 12707.301098439675, 12849.743005140032, 12854.457465104248, 12861.807072893915, 12877.549285774952, 6534.313897040837, 6556.737730490822, 6649.401553860079, 6742.123523941857, 6885.690143943534, 4228.323468245066, 4325.783710814447, 4379.364992076131, 4379.926917905133, 4395.648348132142, 2744.135597286848, 2756.6967633560294, 2762.4198918226994, 2778.861056947185, 2784.7911406644585, 451.38160719814067, 455.2556570008061, 461.0686413444823, 461.24356056068075, 462.6067842333989, 589.7906243283659, 625.4152367536368, 659.1595715462728, 672.6367761408784, 686.4885660183096, 8552.914470855336, 8680.826383472295, 8727.170918762708, 8757.343199259954, 8927.598258078273, 647.4780729060284, 663.2604645819972, 678.7386856060452, 712.2912701861577, 761.565907432758, 4022.0, 4189.224993376235, 4441.533638967927, 4445.244308467568, 4625.167469855391, 53401.46598533965, 53980.73009635005, 54024.0, 57038.714806425705, 57567.424325756205, 48767.26849097267, 49130.26304605434, 49351.753241234284, 49829.0, 50903.23645145326, 43109.904559067465, 44543.52781221263, 45017.774911125234, 45150.77424612856, 45465.31802022972, 8823.470591764515, 8971.260809650443, 9404.294677899321, 9544.618215271312, 9545.140937315675, 35223.82388088043, 35261.64738352584, 35772.821135894155, 36023.27953440969, 36258.4561231587, 44175.558244417145, 46056.53943460523, 48092.0, 48371.0, 48591.757041214565, 7945.602719863868, 8037.638306276349, 8058.597070146587, 8087.47431416956, 8505.404621676424, 12092.39538023113, 12115.212511186744, 12242.693932651755, 12244.938775306067, 12288.631341059783, 11424.82862757076, 11494.540218391505, 11499.885001149882, 11820.113491488344, 12105.152639315163, 10989.06592939609, 11194.496247669038, 11258.155638327322, 11910.0, 11974.521019159136, 10206.0, 10221.233407494616, 10492.370457772558, 10559.947200263949, 10607.575696972342, 9536.523173841419, 9603.615855365708, 9622.951885240529, 9652.469114198786, 9841.26190535727, 8827.405795075769, 9442.197413219954, 9461.810763784548, 9465.148136667733, 9486.95256523713]}, "summary": {"lowerIsBetter": false, "suite": 6785.168205922731, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6946.854842011659, "unit": "ms", "value": 6946.854842011659}, "dojo.html": {"lowerIsBetter": false, "filtered": 5557.481985944439, "unit": "ms", "value": 5557.481985944439}, "mootools.html": {"lowerIsBetter": false, "filtered": 4458.604731498747, "unit": "ms", "value": 4458.604731498747}, "ext.html": {"lowerIsBetter": false, "filtered": 18828.601885635697, "unit": "ms", "value": 18828.601885635697}, "prototype.html": {"lowerIsBetter": false, "filtered": 4988.039512883315, "unit": "ms", "value": 4988.039512883315}, "yui.html": {"lowerIsBetter": false, "filtered": 6035.515677579366, "unit": "ms", "value": 6035.515677579366}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-042.e"}, "testrun": {"date": 1447686152, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116053004", "branch": "Fx-Team", "revision": "d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 163.0, 164.0, 162.0, 163.0, 161.0, 165.0, 174.0, 163.0, 162.0], "ai-astar": [113.0, 106.0, 111.0, 111.0, 112.0, 122.0, 111.0, 110.0, 112.0, 111.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 111.0], "audio-beat-detection": [155.0, 137.0, 153.0, 159.0, 126.0, 153.0, 153.0, 127.0, 162.0, 130.0], "json-stringify-tinderbox": [69.0, 70.0, 70.0, 70.0, 71.0, 73.0, 71.0, 71.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [140.0, 151.0, 150.0, 154.0, 148.0, 152.0, 158.0, 140.0, 150.0, 138.0], "json-parse-financial": [61.0, 60.0, 61.0, 63.0, 70.0, 61.0, 62.0, 62.0, 60.0, 59.0], "stanford-crypto-sha256-iterative": [68.0, 68.0, 67.0, 67.0, 68.0, 69.0, 67.0, 66.0, 67.0, 66.0], "audio-fft": [72.0, 73.0, 72.0, 73.0, 73.0, 135.0, 72.0, 72.0, 73.0, 73.0], "imaging-darkroom": [149.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 151.0], "stanford-crypto-ccm": [116.0, 124.0, 124.0, 128.0, 118.0, 127.0, 117.0, 119.0, 122.0, 120.0], "audio-oscillator": [91.0, 91.0, 130.0, 90.0, 91.0, 90.0, 134.0, 92.0, 91.0, 135.0], "stanford-crypto-aes": [85.0, 86.0, 85.0, 94.0, 94.0, 87.0, 88.0, 84.0, 87.0, 84.0], "imaging-desaturate": [97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1513.3, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.8, "unit": "ms", "value": 78.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.1, "unit": "ms", "value": 148.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.5, "unit": "ms", "value": 145.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.5, "unit": "ms", "value": 121.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.2, "unit": "ms", "value": 147.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.9, "unit": "ms", "value": 61.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.5, "unit": "ms", "value": 103.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.9, "unit": "ms", "value": 111.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.1, "unit": "ms", "value": 164.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.3, "unit": "ms", "value": 67.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.5, "unit": "ms", "value": 70.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.4, "unit": "ms", "value": 87.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-042.e"}, "testrun": {"date": 1447686152, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116053004", "branch": "Fx-Team", "revision": "d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4"}}, {"talos_counters": {}, "results": {"DeltaBlue": [186.25442354255912], "Encrypt": [282.08744710860367], "NavierStokes": [4812.5], "Decrypt": [5055.555555555556], "Splay": [637.7551020408164], "Richards": [162.813415825464], "RegExp": [25525.0], "Earley": [722.543352601156], "Boyer": [12035.714285714286], "RayTrace": [1063.8297872340424]}, "summary": {"lowerIsBetter": false, "suite": 21371.723458452023, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 354.98754199999996, "unit": "score", "value": 354.98754199999996}, "Encrypt": {"lowerIsBetter": false, "filtered": 943.6116450000002, "unit": "score", "value": 943.6116450000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.3636363636364, "unit": "score", "value": 308.3636363636364}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.65118681318681, "unit": "score", "value": 52.65118681318681}, "Splay": {"lowerIsBetter": false, "filtered": 127.77788800000003, "unit": "score", "value": 127.77788800000003}, "RegExp": {"lowerIsBetter": false, "filtered": 35.689911851126354, "unit": "score", "value": 35.689911851126354}, "Richards": {"lowerIsBetter": false, "filtered": 216.82488399999997, "unit": "score", "value": 216.82488399999997}, "Earley": {"lowerIsBetter": false, "filtered": 922.3847919999998, "unit": "score", "value": 922.3847919999998}, "Boyer": {"lowerIsBetter": false, "filtered": 55.37378041543021, "unit": "score", "value": 55.37378041543021}, "RayTrace": {"lowerIsBetter": false, "filtered": 695.5896600000003, "unit": "score", "value": 695.5896600000003}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-042.e"}, "testrun": {"date": 1447686152, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116053004", "branch": "Fx-Team", "revision": "d1cae7deae1ac0aa4c2a4b1aca1f3b6966fa58b4"}}] 07:22:46 INFO - RETURN: dromaeo_css: 6785.17 07:22:46 INFO - RETURN: kraken: 1513.30 07:22:46 INFO - RETURN: v8_7: 21371.72 07:22:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21371.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1513.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6785.17"}}} 07:22:46 INFO - Return code: 0 07:22:46 INFO - # TBPL SUCCESS # 07:22:46 INFO - Running post-action listener: _resource_record_post_action 07:22:46 INFO - Running post-run listener: _resource_record_post_run 07:22:47 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521789440; Read time: 780; Write time: 1138524 07:22:47 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 221802496; Read time: 0; Write time: 660796 07:22:47 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275423232; Read time: 780; Write time: 373116 07:22:47 INFO - Running post-run listener: _upload_blobber_files 07:22:47 INFO - Blob upload gear active. 07:22:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:22:47 INFO - Copying logs to upload dir... 07:22:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.755044 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-16 07:22:46.338347) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:22:46.342312) ========= 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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010011 build_url: 'https://queue.taskcluster.net/v1/task/NqPUSdhPRB6mAaMSsjg3vg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 07:22:46.394138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:22:46.394489) ========= 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=c402a24d74c70935940d60dd000001de-1447684515.97640-1417022216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 07:22:46.444692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:22:46.445052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 07:22:46.445348) ========= ========= Total master_lag: 0.22 =========