builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1446071569.25 results: success (0) buildid: 20151028130740 builduid: 53e43dc0af8448aaa02751bcdf791d83 revision: 2f90ffb5ee459777a90e34cea18f6621157bf9c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.247838) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.248339) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.248684) ========= 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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.002902 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.308802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.309138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.341125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.341448) ========= 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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018875 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.388985) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.389297) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.389705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.390020) ========= 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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-28 15:32:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.0M=0s 2015-10-28 15:32:49 (86.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.251964 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.655312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.655719) ========= 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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.137932 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.805826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:49.806503) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2f90ffb5ee459777a90e34cea18f6621157bf9c3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2f90ffb5ee459777a90e34cea18f6621157bf9c3 --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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-28 15:32:50,167 truncating revision to first 12 chars 2015-10-28 15:32:50,167 Setting DEBUG logging. 2015-10-28 15:32:50,167 attempt 1/10 2015-10-28 15:32:50,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2f90ffb5ee45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-28 15:32:50,390 unpacking tar archive at: mozilla-aurora-2f90ffb5ee45/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536834 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:50.359310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:50.359716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:50.369008) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:50.369297) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 15:32:50.369772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-10-28 15:32:50.370105) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:32:50 INFO - MultiFileLogger online at 20151028 15:32:50 in /builds/slave/test-pgo 15:32:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:32:50 INFO - Guessing talos json url... 15:32:50 INFO - Using buildbot properties: 15:32:50 INFO - { 15:32:50 INFO - "properties": { 15:32:50 INFO - "buildnumber": 4, 15:32:50 INFO - "product": "firefox", 15:32:50 INFO - "script_repo_revision": "production", 15:32:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:32:50 INFO - "repository": "", 15:32:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:32:50 INFO - "buildid": "20151028130740", 15:32:50 INFO - "slavename": "talos-linux64-ix-028", 15:32:50 INFO - "pgo_build": "True", 15:32:50 INFO - "basedir": "/builds/slave/test-pgo", 15:32:50 INFO - "project": "", 15:32:50 INFO - "platform": "ubuntu64_hw", 15:32:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:32:50 INFO - "slavebuilddir": "test", 15:32:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:32:50 INFO - "branch": "mozilla-aurora", 15:32:50 INFO - "repo_path": "releases/mozilla-aurora", 15:32:50 INFO - "stage_platform": "linux64-pgo", 15:32:50 INFO - "builduid": "53e43dc0af8448aaa02751bcdf791d83", 15:32:50 INFO - "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3" 15:32:50 INFO - }, 15:32:50 INFO - "sourcestamp": { 15:32:50 INFO - "repository": "", 15:32:50 INFO - "hasPatch": false, 15:32:50 INFO - "project": "", 15:32:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:32:50 INFO - "changes": [ 15:32:50 INFO - { 15:32:50 INFO - "category": null, 15:32:50 INFO - "files": [ 15:32:50 INFO - { 15:32:50 INFO - "url": null, 15:32:50 INFO - "name": "https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 15:32:50 INFO - } 15:32:50 INFO - ], 15:32:50 INFO - "repository": "", 15:32:50 INFO - "rev": "2f90ffb5ee459777a90e34cea18f6621157bf9c3", 15:32:50 INFO - "who": "kwierso@gmail.com", 15:32:50 INFO - "when": 1446071396, 15:32:50 INFO - "number": 6589669, 15:32:50 INFO - "comments": "Bug 1213007: Part 1. Implementing gfxCrash. Aurora patch. r=dvander a=lizzard", 15:32:50 INFO - "project": "", 15:32:50 INFO - "at": "Wed 28 Oct 2015 15:29:56", 15:32:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:32:50 INFO - "revlink": "", 15:32:50 INFO - "properties": [ 15:32:50 INFO - [ 15:32:50 INFO - "buildid", 15:32:50 INFO - "20151028130740", 15:32:50 INFO - "Change" 15:32:50 INFO - ], 15:32:50 INFO - [ 15:32:50 INFO - "builduid", 15:32:50 INFO - "53e43dc0af8448aaa02751bcdf791d83", 15:32:50 INFO - "Change" 15:32:50 INFO - ], 15:32:50 INFO - [ 15:32:50 INFO - "pgo_build", 15:32:50 INFO - "True", 15:32:50 INFO - "Change" 15:32:50 INFO - ] 15:32:50 INFO - ], 15:32:50 INFO - "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3" 15:32:50 INFO - } 15:32:50 INFO - ], 15:32:50 INFO - "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3" 15:32:50 INFO - } 15:32:50 INFO - } 15:32:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 15:32:50 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')]} 15:32:50 INFO - https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 15:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:32:50 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt'), kwargs: {}, attempt #1 15:32:51 INFO - Downloaded 107 bytes. 15:32:51 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:32:51 INFO - Contents: 15:32:51 INFO - 20151028130740 15:32:51 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/2f90ffb5ee459777a90e34cea18f6621157bf9c3 15:32: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')]} 15:32:51 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/2f90ffb5ee/testing/talos/talos.json 15:32:51 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/2f90ffb5ee/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 15:32:51 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/2f90ffb5ee/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 15:32:51 INFO - Downloaded 6818 bytes. 15:32:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:32:51 INFO - '../fennec_ids.txt'], 15:32:51 INFO - 'tests': ['tcheck2']}, 15:32:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:51 INFO - '--tppagecycles', 15:32:51 INFO - '7'], 15:32:51 INFO - 'tests': ['tsvgm']}}, 15:32:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:32:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:32:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:32:51 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:32:51 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:51 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:32:51 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:32:51 INFO - 'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:51 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'tests': ['damp', 'tps']}, 15:32:51 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['damp', 'tps']}, 15:32:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:32:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:51 INFO - 'other': {'tests': ['a11yr', 15:32:51 INFO - 'ts_paint', 15:32:51 INFO - 'tpaint', 15:32:51 INFO - 'sessionrestore', 15:32:51 INFO - 'sessionrestore_no_auto_restore']}, 15:32:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['a11yr', 15:32:51 INFO - 'ts_paint', 15:32:51 INFO - 'tpaint', 15:32:51 INFO - 'sessionrestore', 15:32:51 INFO - 'sessionrestore_no_auto_restore']}, 15:32:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['a11yr', 15:32:51 INFO - 'ts_paint', 15:32:51 INFO - 'tpaint', 15:32:51 INFO - 'sessionrestore', 15:32:51 INFO - 'sessionrestore_no_auto_restore']}, 15:32:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['a11yr', 15:32:51 INFO - 'ts_paint', 15:32:51 INFO - 'tpaint', 15:32:51 INFO - 'sessionrestore', 15:32:51 INFO - 'sessionrestore_no_auto_restore']}, 15:32:51 INFO - 'other_l64': {'tests': ['a11yr', 15:32:51 INFO - 'ts_paint', 15:32:51 INFO - 'tpaint', 15:32:51 INFO - 'sessionrestore', 15:32:51 INFO - 'sessionrestore_no_auto_restore']}, 15:32:51 INFO - 'other_nol64': {'tests': ['a11yr', 15:32:51 INFO - 'ts_paint', 15:32:51 INFO - 'tpaint', 15:32:51 INFO - 'sessionrestore', 15:32:51 INFO - 'sessionrestore_no_auto_restore']}, 15:32:51 INFO - 'svgr': {'tests': ['tsvgx', 15:32:51 INFO - 'tsvgr_opacity', 15:32:51 INFO - 'tart', 15:32:51 INFO - 'tscrollx', 15:32:51 INFO - 'cart']}, 15:32:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['tsvgx', 15:32:51 INFO - 'tsvgr_opacity', 15:32:51 INFO - 'tart', 15:32:51 INFO - 'tscrollx', 15:32:51 INFO - 'cart']}, 15:32:51 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:32:51 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:32:51 INFO - 'tests': ['tp5o']}, 15:32:51 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:32:51 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:32:51 INFO - 'talos_options': ['--e10s'], 15:32:51 INFO - 'tests': ['tp5o']}, 15:32:51 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:32:51 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:32:51 INFO - 'talos_options': ['--xperf_path', 15:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:51 INFO - 'tests': ['tp5n']}, 15:32:51 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 15:32:51 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:32:51 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:51 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:32:51 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:32:51 INFO - 'talos_options': ['--e10s', 15:32:51 INFO - '--xperf_path', 15:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 15:32:51 INFO - 'C:/slave/talos-data/talos/xperf.config'], 15:32:51 INFO - 'tests': ['tp5n']}}, 15:32:51 INFO - 'talos.zip': {'path': '', 15:32:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:32:51 INFO - {'append_to_log': False, 15:32:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:32:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:32:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:32:51 INFO - 'branch': 'Mozilla-Aurora', 15:32:51 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:51 INFO - 'config_files': ('talos/linux_config.py',), 15:32:51 INFO - 'default_actions': ('clobber', 15:32:51 INFO - 'read-buildbot-config', 15:32:51 INFO - 'download-and-extract', 15:32:51 INFO - 'populate-webroot', 15:32:51 INFO - 'create-virtualenv', 15:32:51 INFO - 'install', 15:32:51 INFO - 'run-tests'), 15:32:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:51 INFO - 'download_minidump_stackwalk': True, 15:32:51 INFO - 'download_symbols': 'ondemand', 15:32:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:51 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:51 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:51 INFO - 'installer_path': 'installer.exe', 15:32:51 INFO - 'log_level': 'info', 15:32:51 INFO - 'log_name': 'talos', 15:32:51 INFO - 'log_to_console': True, 15:32:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:32:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:32:51 INFO - 'opt_config_files': (), 15:32:51 INFO - 'pip_index': False, 15:32:51 INFO - 'python_webserver': False, 15:32:51 INFO - 'sps_profile': False, 15:32:51 INFO - 'sps_profile_interval': 0, 15:32:51 INFO - 'suite': 'dromaeojs', 15:32:51 INFO - 'system_bits': '64', 15:32:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:51 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 15:32:51 INFO - 'tests': (), 15:32:51 INFO - 'title': 'talos-linux64-ix-028', 15:32:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:51 INFO - 'use_talos_json': True, 15:32:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:32:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:51 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 15:32:51 INFO - 'work_dir': 'build'} 15:32:51 INFO - ##### 15:32:51 INFO - ##### Running clobber step. 15:32:51 INFO - ##### 15:32:51 INFO - Running pre-action listener: _resource_record_pre_action 15:32:51 INFO - Running main action method: clobber 15:32:51 INFO - rmtree: /builds/slave/test-pgo/build 15:32:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:32:56 INFO - Running post-action listener: _resource_record_post_action 15:32:56 INFO - ##### 15:32:56 INFO - ##### Running read-buildbot-config step. 15:32:56 INFO - ##### 15:32:56 INFO - Running pre-action listener: _resource_record_pre_action 15:32:56 INFO - Running main action method: read_buildbot_config 15:32:56 INFO - Using buildbot properties: 15:32:56 INFO - { 15:32:56 INFO - "properties": { 15:32:56 INFO - "buildnumber": 4, 15:32:56 INFO - "product": "firefox", 15:32:56 INFO - "script_repo_revision": "production", 15:32:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:32:56 INFO - "repository": "", 15:32:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:32:56 INFO - "buildid": "20151028130740", 15:32:56 INFO - "slavename": "talos-linux64-ix-028", 15:32:56 INFO - "pgo_build": "True", 15:32:56 INFO - "basedir": "/builds/slave/test-pgo", 15:32:56 INFO - "project": "", 15:32:56 INFO - "platform": "ubuntu64_hw", 15:32:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:32:56 INFO - "slavebuilddir": "test", 15:32:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:32:56 INFO - "branch": "mozilla-aurora", 15:32:56 INFO - "repo_path": "releases/mozilla-aurora", 15:32:56 INFO - "stage_platform": "linux64-pgo", 15:32:56 INFO - "builduid": "53e43dc0af8448aaa02751bcdf791d83", 15:32:56 INFO - "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3" 15:32:56 INFO - }, 15:32:56 INFO - "sourcestamp": { 15:32:56 INFO - "repository": "", 15:32:56 INFO - "hasPatch": false, 15:32:56 INFO - "project": "", 15:32:56 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:32:56 INFO - "changes": [ 15:32:56 INFO - { 15:32:56 INFO - "category": null, 15:32:56 INFO - "files": [ 15:32:56 INFO - { 15:32:56 INFO - "url": null, 15:32:56 INFO - "name": "https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 15:32:56 INFO - } 15:32:56 INFO - ], 15:32:56 INFO - "repository": "", 15:32:56 INFO - "rev": "2f90ffb5ee459777a90e34cea18f6621157bf9c3", 15:32:56 INFO - "who": "kwierso@gmail.com", 15:32:56 INFO - "when": 1446071396, 15:32:56 INFO - "number": 6589669, 15:32:56 INFO - "comments": "Bug 1213007: Part 1. Implementing gfxCrash. Aurora patch. r=dvander a=lizzard", 15:32:56 INFO - "project": "", 15:32:56 INFO - "at": "Wed 28 Oct 2015 15:29:56", 15:32:56 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:32:56 INFO - "revlink": "", 15:32:56 INFO - "properties": [ 15:32:56 INFO - [ 15:32:56 INFO - "buildid", 15:32:56 INFO - "20151028130740", 15:32:56 INFO - "Change" 15:32:56 INFO - ], 15:32:56 INFO - [ 15:32:56 INFO - "builduid", 15:32:56 INFO - "53e43dc0af8448aaa02751bcdf791d83", 15:32:56 INFO - "Change" 15:32:56 INFO - ], 15:32:56 INFO - [ 15:32:56 INFO - "pgo_build", 15:32:56 INFO - "True", 15:32:56 INFO - "Change" 15:32:56 INFO - ] 15:32:56 INFO - ], 15:32:56 INFO - "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3" 15:32:56 INFO - } 15:32:56 INFO - ], 15:32:56 INFO - "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3" 15:32:56 INFO - } 15:32:56 INFO - } 15:32:56 INFO - Running post-action listener: _resource_record_post_action 15:32:56 INFO - ##### 15:32:56 INFO - ##### Running download-and-extract step. 15:32:56 INFO - ##### 15:32:56 INFO - Running pre-action listener: _resource_record_pre_action 15:32:56 INFO - Running main action method: download_and_extract 15:32:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:32:56 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')]} 15:32:56 INFO - https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:32:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/test_packages.json 15:32:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/test_packages.json 15:32:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:32:56 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 15:32:57 INFO - Downloaded 1302 bytes. 15:32:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:32:57 INFO - Using the following test package requirements: 15:32:57 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 15:32:57 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:32:57 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:57 INFO - u'jsshell-linux-x86_64.zip'], 15:32:57 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:32:57 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 15:32:57 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:32:57 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:32:57 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:32:57 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 15:32:57 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:32:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:32:57 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:57 INFO - https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:32:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:32:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:32:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:32:57 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 15:32:58 INFO - Downloaded 22908465 bytes. 15:32:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:32:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:32:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:32:59 INFO - Return code: 0 15:32:59 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:32:59 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')]} 15:32:59 INFO - https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:32:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:32:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:32:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:32:59 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 15:33:01 INFO - Downloaded 22908465 bytes. 15:33:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:33:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:33:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:33:02 INFO - Return code: 0 15:33: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')]} 15:33:02 INFO - https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:33:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:33:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:33:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:33:02 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'), kwargs: {}, attempt #1 15:33:04 INFO - Downloaded 10881672 bytes. 15:33:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:33:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:33:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:33:04 INFO - Return code: 0 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:04 INFO - https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:33:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:33:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:33:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:33:04 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2'), kwargs: {}, attempt #1 15:33:05 INFO - Downloaded 56985615 bytes. 15:33:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:33:05 INFO - mkdir: /builds/slave/test-pgo/properties 15:33:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:33:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:33:05 INFO - Contents: 15:33:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:33:05 INFO - Running post-action listener: _resource_record_post_action 15:33:05 INFO - Running post-action listener: _set_extra_try_arguments 15:33:05 INFO - ##### 15:33:05 INFO - ##### Running populate-webroot step. 15:33:05 INFO - ##### 15:33:05 INFO - Running pre-action listener: _resource_record_pre_action 15:33:05 INFO - Running main action method: populate_webroot 15:33:05 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 15:33:05 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 15:33:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 15:33:17 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 15:33:17 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 15:33:17 INFO - Running post-action listener: _resource_record_post_action 15:33:17 INFO - ##### 15:33:17 INFO - ##### Running create-virtualenv step. 15:33:17 INFO - ##### 15:33:17 INFO - Running pre-action listener: _resource_record_pre_action 15:33:17 INFO - Running main action method: create_virtualenv 15:33:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:33:17 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 15:33:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:33:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:17 INFO - Using real prefix '/usr' 15:33:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:33:18 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:20 INFO - Installing pip.................done. 15:33:20 INFO - Return code: 0 15:33:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:33:20 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')]} 15:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:20 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')]} 15:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:20 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 0x7ffe61f94b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19637b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a284a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, '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': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', '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 15:33:20 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 15:33:20 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 15:33:20 INFO - Using env: {'DISPLAY': ':0', 15:33:20 INFO - 'HOME': '/home/cltbld', 15:33:20 INFO - 'LANG': 'en_US.UTF-8', 15:33:20 INFO - 'LANGUAGE': 'en_US:en', 15:33:20 INFO - 'LOGNAME': 'cltbld', 15:33:20 INFO - 'MAIL': '/var/mail/cltbld', 15:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:20 INFO - 'MOZ_NO_REMOTE': '1', 15:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:20 INFO - 'NO_EM_RESTART': '1', 15:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:20 INFO - 'SHELL': '/bin/bash', 15:33:20 INFO - 'SHLVL': '1', 15:33:20 INFO - 'TERM': 'linux', 15:33:20 INFO - 'TMOUT': '86400', 15:33:20 INFO - 'USER': 'cltbld', 15:33:20 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:20 INFO - '_': '/tools/buildbot/bin/python'} 15:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:20 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 15:33:20 INFO - Cleaning up... 15:33:20 INFO - Return code: 0 15:33:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:33:20 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')]} 15:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:20 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')]} 15:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:20 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 0x7ffe61f94b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19637b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a284a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, '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': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', '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 15:33:20 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 15:33:20 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 15:33:20 INFO - Using env: {'DISPLAY': ':0', 15:33:20 INFO - 'HOME': '/home/cltbld', 15:33:20 INFO - 'LANG': 'en_US.UTF-8', 15:33:20 INFO - 'LANGUAGE': 'en_US:en', 15:33:20 INFO - 'LOGNAME': 'cltbld', 15:33:20 INFO - 'MAIL': '/var/mail/cltbld', 15:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:20 INFO - 'MOZ_NO_REMOTE': '1', 15:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:20 INFO - 'NO_EM_RESTART': '1', 15:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:20 INFO - 'SHELL': '/bin/bash', 15:33:20 INFO - 'SHLVL': '1', 15:33:20 INFO - 'TERM': 'linux', 15:33:20 INFO - 'TMOUT': '86400', 15:33:20 INFO - 'USER': 'cltbld', 15:33:20 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:20 INFO - '_': '/tools/buildbot/bin/python'} 15:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:20 INFO - Downloading/unpacking psutil>=0.7.1 15:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:22 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:33:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:33:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:22 INFO - Installing collected packages: psutil 15:33:22 INFO - Running setup.py install for psutil 15:33:22 INFO - building 'psutil._psutil_linux' extension 15:33:22 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 15:33:23 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 15:33:23 INFO - building 'psutil._psutil_posix' extension 15:33:23 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 15:33:23 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 15:33:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:23 INFO - Successfully installed psutil 15:33:23 INFO - Cleaning up... 15:33:24 INFO - Return code: 0 15:33:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:24 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 0x7ffe61f94b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19637b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a284a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, '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': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', '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 15:33:24 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 15:33:24 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 15:33:24 INFO - Using env: {'DISPLAY': ':0', 15:33:24 INFO - 'HOME': '/home/cltbld', 15:33:24 INFO - 'LANG': 'en_US.UTF-8', 15:33:24 INFO - 'LANGUAGE': 'en_US:en', 15:33:24 INFO - 'LOGNAME': 'cltbld', 15:33:24 INFO - 'MAIL': '/var/mail/cltbld', 15:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:24 INFO - 'MOZ_NO_REMOTE': '1', 15:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:24 INFO - 'NO_EM_RESTART': '1', 15:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:24 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:24 INFO - 'SHELL': '/bin/bash', 15:33:24 INFO - 'SHLVL': '1', 15:33:24 INFO - 'TERM': 'linux', 15:33:24 INFO - 'TMOUT': '86400', 15:33:24 INFO - 'USER': 'cltbld', 15:33:24 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:24 INFO - '_': '/tools/buildbot/bin/python'} 15:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:33:24 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 15:33:24 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 15:33:24 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 15:33:24 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 15:33:24 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 15:33:24 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 15:33:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:33:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:33:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:33:26 INFO - Installing collected packages: mozsystemmonitor 15:33:26 INFO - Running setup.py install for mozsystemmonitor 15:33:26 INFO - Successfully installed mozsystemmonitor 15:33:26 INFO - Cleaning up... 15:33:26 INFO - Return code: 0 15:33:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:33:26 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')]} 15:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:26 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')]} 15:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:26 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 0x7ffe61f94b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19637b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a284a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, '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': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', '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 15:33:26 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 15:33:26 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 15:33:26 INFO - Using env: {'DISPLAY': ':0', 15:33:26 INFO - 'HOME': '/home/cltbld', 15:33:26 INFO - 'LANG': 'en_US.UTF-8', 15:33:26 INFO - 'LANGUAGE': 'en_US:en', 15:33:26 INFO - 'LOGNAME': 'cltbld', 15:33:26 INFO - 'MAIL': '/var/mail/cltbld', 15:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:26 INFO - 'MOZ_NO_REMOTE': '1', 15:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:26 INFO - 'NO_EM_RESTART': '1', 15:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:26 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:26 INFO - 'SHELL': '/bin/bash', 15:33:26 INFO - 'SHLVL': '1', 15:33:26 INFO - 'TERM': 'linux', 15:33:26 INFO - 'TMOUT': '86400', 15:33:26 INFO - 'USER': 'cltbld', 15:33:26 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:26 INFO - '_': '/tools/buildbot/bin/python'} 15:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:26 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 15:33:26 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 15:33:26 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 15:33:26 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 15:33:26 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 15:33:26 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 15:33:27 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:33:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:33:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:33:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 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 15:33:28 INFO - Downloading docopt-0.6.1.tar.gz 15:33:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:33:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:28 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:28 INFO - Running setup.py install for blobuploader 15:33:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:33:29 INFO - Running setup.py install for requests 15:33:29 INFO - Running setup.py install for docopt 15:33:29 INFO - Successfully installed blobuploader requests docopt 15:33:29 INFO - Cleaning up... 15:33:29 INFO - Return code: 0 15:33:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:29 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 0x7ffe61f94b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19637b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a284a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, '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': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', '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 15:33:29 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 15:33:29 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 15:33:29 INFO - Using env: {'DISPLAY': ':0', 15:33:29 INFO - 'HOME': '/home/cltbld', 15:33:29 INFO - 'LANG': 'en_US.UTF-8', 15:33:29 INFO - 'LANGUAGE': 'en_US:en', 15:33:29 INFO - 'LOGNAME': 'cltbld', 15:33:29 INFO - 'MAIL': '/var/mail/cltbld', 15:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:29 INFO - 'MOZ_NO_REMOTE': '1', 15:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:29 INFO - 'NO_EM_RESTART': '1', 15:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:29 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:29 INFO - 'SHELL': '/bin/bash', 15:33:29 INFO - 'SHLVL': '1', 15:33:29 INFO - 'TERM': 'linux', 15:33:29 INFO - 'TMOUT': '86400', 15:33:29 INFO - 'USER': 'cltbld', 15:33:29 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:29 INFO - '_': '/tools/buildbot/bin/python'} 15:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:29 INFO - Running setup.py (path:/tmp/pip-oWTGvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:29 INFO - Running setup.py (path:/tmp/pip-c8LqcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:29 INFO - Running setup.py (path:/tmp/pip-l4AVOO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:29 INFO - Running setup.py (path:/tmp/pip-38oE__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:30 INFO - Running setup.py (path:/tmp/pip-5pVp_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:30 INFO - Running setup.py (path:/tmp/pip-IJDu_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:30 INFO - Running setup.py (path:/tmp/pip-B0oAbK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:30 INFO - Running setup.py (path:/tmp/pip-wUTQov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:30 INFO - Running setup.py (path:/tmp/pip-a4wIgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:30 INFO - Running setup.py (path:/tmp/pip-sAsK9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:30 INFO - Running setup.py (path:/tmp/pip-oP_wAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:30 INFO - Running setup.py (path:/tmp/pip-sHEeL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:30 INFO - Running setup.py (path:/tmp/pip-vq6qKt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:30 INFO - Running setup.py (path:/tmp/pip-aM2R3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:30 INFO - Running setup.py (path:/tmp/pip-PiLWlN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:30 INFO - Running setup.py (path:/tmp/pip-oFcIUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:30 INFO - Running setup.py (path:/tmp/pip-6_8YrZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:30 INFO - Running setup.py install for manifestparser 15:33:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Running setup.py install for mozcrash 15:33:31 INFO - Running setup.py install for mozdebug 15:33:31 INFO - Running setup.py install for mozdevice 15:33:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Running setup.py install for mozfile 15:33:31 INFO - Running setup.py install for mozhttpd 15:33:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Running setup.py install for mozinfo 15:33:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Running setup.py install for mozInstall 15:33:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Running setup.py install for mozleak 15:33:31 INFO - Running setup.py install for mozlog 15:33:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:33:31 INFO - Running setup.py install for moznetwork 15:33:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:33:32 INFO - Running setup.py install for mozprocess 15:33:32 INFO - Running setup.py install for mozprofile 15:33:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:33:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:33:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:33:32 INFO - Running setup.py install for mozrunner 15:33:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:33:32 INFO - Running setup.py install for mozscreenshot 15:33:32 INFO - Running setup.py install for moztest 15:33:32 INFO - Running setup.py install for mozversion 15:33:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:33:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:32 INFO - Cleaning up... 15:33:32 INFO - Return code: 0 15:33:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:33: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')]} 15:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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')]} 15:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:32 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 0x7ffe61f94b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19637b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a284a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, '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': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', '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 15:33:32 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 15:33:32 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 15:33:32 INFO - Using env: {'DISPLAY': ':0', 15:33:32 INFO - 'HOME': '/home/cltbld', 15:33:32 INFO - 'LANG': 'en_US.UTF-8', 15:33:32 INFO - 'LANGUAGE': 'en_US:en', 15:33:32 INFO - 'LOGNAME': 'cltbld', 15:33:32 INFO - 'MAIL': '/var/mail/cltbld', 15:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:32 INFO - 'MOZ_NO_REMOTE': '1', 15:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:32 INFO - 'NO_EM_RESTART': '1', 15:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:32 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:32 INFO - 'SHELL': '/bin/bash', 15:33:32 INFO - 'SHLVL': '1', 15:33:32 INFO - 'TERM': 'linux', 15:33:32 INFO - 'TMOUT': '86400', 15:33:32 INFO - 'USER': 'cltbld', 15:33:32 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:32 INFO - '_': '/tools/buildbot/bin/python'} 15:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:32 INFO - Running setup.py (path:/tmp/pip-x6Xfsp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:33:32 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)) 15:33:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:32 INFO - Running setup.py (path:/tmp/pip-KLjKoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:33 INFO - Running setup.py (path:/tmp/pip-YOTvjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:33 INFO - Running setup.py (path:/tmp/pip-clSL6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:33 INFO - Running setup.py (path:/tmp/pip-ZvDEFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:33 INFO - Running setup.py (path:/tmp/pip-YpAzNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:33 INFO - Running setup.py (path:/tmp/pip-u3aSqf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:33 INFO - Running setup.py (path:/tmp/pip-Gls_zf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:33 INFO - Running setup.py (path:/tmp/pip-EcqaR3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:33 INFO - Running setup.py (path:/tmp/pip-GZgaww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:33 INFO - Running setup.py (path:/tmp/pip-jhj98_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:33 INFO - Running setup.py (path:/tmp/pip-eb_8vr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:33 INFO - Running setup.py (path:/tmp/pip-_Zm3Bc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:33:33 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:33 INFO - Running setup.py (path:/tmp/pip-Yu7y7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 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)) 15:33:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:33 INFO - Running setup.py (path:/tmp/pip-uDzzoH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:33:34 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)) 15:33:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:34 INFO - Running setup.py (path:/tmp/pip-UEEbdC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:33:34 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)) 15:33:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:34 INFO - Running setup.py (path:/tmp/pip-SdhSzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:33:34 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)) 15:33:34 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)) 15:33:34 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)) 15:33:34 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)) 15:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:33:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:34 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 15:33:34 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 15:33:34 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 15:33:34 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 15:33:34 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 15:33:34 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 15:33:35 INFO - Downloading blessings-1.5.1.tar.gz 15:33:35 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 15:33:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:35 INFO - Installing collected packages: blessings 15:33:35 INFO - Running setup.py install for blessings 15:33:35 INFO - Successfully installed blessings 15:33:35 INFO - Cleaning up... 15:33:36 INFO - Return code: 0 15:33:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:33:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:33:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:33:36 INFO - Reading from file tmpfile_stdout 15:33:36 INFO - Current package versions: 15:33:36 INFO - argparse == 1.2.1 15:33:36 INFO - blessings == 1.5.1 15:33:36 INFO - blobuploader == 1.2.4 15:33:36 INFO - docopt == 0.6.1 15:33:36 INFO - manifestparser == 1.1 15:33:36 INFO - mozInstall == 1.12 15:33:36 INFO - mozcrash == 0.16 15:33:36 INFO - mozdebug == 0.1 15:33:36 INFO - mozdevice == 0.46 15:33:36 INFO - mozfile == 1.2 15:33:36 INFO - mozhttpd == 0.7 15:33:36 INFO - mozinfo == 0.8 15:33:36 INFO - mozleak == 0.1 15:33:36 INFO - mozlog == 3.0 15:33:36 INFO - moznetwork == 0.27 15:33:36 INFO - mozprocess == 0.22 15:33:36 INFO - mozprofile == 0.27 15:33:36 INFO - mozrunner == 6.10 15:33:36 INFO - mozscreenshot == 0.1 15:33:36 INFO - mozsystemmonitor == 0.0 15:33:36 INFO - moztest == 0.7 15:33:36 INFO - mozversion == 1.4 15:33:36 INFO - psutil == 3.1.1 15:33:36 INFO - requests == 1.2.3 15:33:36 INFO - wsgiref == 0.1.2 15:33:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:36 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 0x7ffe61f94b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19637b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a284a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, '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': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', '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 15:33:36 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 15:33:36 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 15:33:36 INFO - Using env: {'DISPLAY': ':0', 15:33:36 INFO - 'HOME': '/home/cltbld', 15:33:36 INFO - 'LANG': 'en_US.UTF-8', 15:33:36 INFO - 'LANGUAGE': 'en_US:en', 15:33:36 INFO - 'LOGNAME': 'cltbld', 15:33:36 INFO - 'MAIL': '/var/mail/cltbld', 15:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:36 INFO - 'MOZ_NO_REMOTE': '1', 15:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:36 INFO - 'NO_EM_RESTART': '1', 15:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:36 INFO - 'SHELL': '/bin/bash', 15:33:36 INFO - 'SHLVL': '1', 15:33:36 INFO - 'TERM': 'linux', 15:33:36 INFO - 'TMOUT': '86400', 15:33:36 INFO - 'USER': 'cltbld', 15:33:36 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:36 INFO - '_': '/tools/buildbot/bin/python'} 15:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 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)) 15:33:36 INFO - Cleaning up... 15:33:36 INFO - Return code: 0 15:33:36 INFO - Running post-action listener: _resource_record_post_action 15:33:36 INFO - Running post-action listener: _start_resource_monitoring 15:33:36 INFO - Starting resource monitoring. 15:33:36 INFO - ##### 15:33:36 INFO - ##### Running install step. 15:33:36 INFO - ##### 15:33:36 INFO - Running pre-action listener: _resource_record_pre_action 15:33:36 INFO - Running main action method: install 15:33:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:33:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:33:36 INFO - Reading from file tmpfile_stdout 15:33:36 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:33:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:33:36 INFO - Reading from file tmpfile_stdout 15:33:36 INFO - Output received: 15:33:36 INFO - Usage: mozinstall [options] installer 15:33:36 INFO - Options: 15:33:36 INFO - -h, --help show this help message and exit 15:33:36 INFO - -d DEST, --destination=DEST 15:33:36 INFO - Directory to install application into. [default: 15:33:36 INFO - "/builds/slave/test-pgo"] 15:33:36 INFO - --app=APP Application being installed. [default: firefox] 15:33:36 INFO - mkdir: /builds/slave/test-pgo/build/application 15:33:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:33:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:33:50 INFO - Reading from file tmpfile_stdout 15:33:50 INFO - Output received: 15:33:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:33:50 INFO - Running post-action listener: _resource_record_post_action 15:33:50 INFO - ##### 15:33:50 INFO - ##### Running run-tests step. 15:33:50 INFO - ##### 15:33:50 INFO - Running pre-action listener: _resource_record_pre_action 15:33:50 INFO - Running main action method: run_tests 15:33:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:33:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:33:51 INFO - Python 2.7.3 15:33:51 INFO - Return code: 0 15:33:51 INFO - grabbing minidump binary from tooltool 15:33: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')]} 15:33:51 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 0x17babf0>, '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 0x1ab84f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab89a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:33:51 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 15:33:51 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 15:33:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:51 INFO - Return code: 0 15:33:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:33:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:33:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:33:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:33:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:33:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--activeTests', 'dromaeo_css:kraken:v8_7', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:33:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --symbolsPath https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --activeTests dromaeo_css:kraken:v8_7 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --title talos-linux64-ix-028 --webServer localhost 15:33:51 INFO - Using env: {'DISPLAY': ':0', 15:33:51 INFO - 'HOME': '/home/cltbld', 15:33:51 INFO - 'LANG': 'en_US.UTF-8', 15:33:51 INFO - 'LANGUAGE': 'en_US:en', 15:33:51 INFO - 'LOGNAME': 'cltbld', 15:33:51 INFO - 'MAIL': '/var/mail/cltbld', 15:33:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:33:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:51 INFO - 'MOZ_NO_REMOTE': '1', 15:33:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:51 INFO - 'NO_EM_RESTART': '1', 15:33:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:33:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:33:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:33:51 INFO - 'SHELL': '/bin/bash', 15:33:51 INFO - 'SHLVL': '1', 15:33:51 INFO - 'TERM': 'linux', 15:33:51 INFO - 'TMOUT': '86400', 15:33:51 INFO - 'USER': 'cltbld', 15:33:51 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075', 15:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:51 INFO - '_': '/tools/buildbot/bin/python'} 15:33:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--activeTests', 'dromaeo_css:kraken:v8_7', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 15:33:51 INFO - mozversion INFO | application_buildid: 20151028130740 15:33:51 INFO - mozversion INFO | application_changeset: 2f90ffb5ee459777a90e34cea18f6621157bf9c3 15:33:51 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 15:33:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:51 INFO - mozversion INFO | application_name: Firefox 15:33:51 INFO - mozversion INFO | application_remotingname: firefox-dev 15:33:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:33:51 INFO - mozversion INFO | application_vendor: Mozilla 15:33:51 INFO - mozversion INFO | application_version: 43.0a2 15:33:51 INFO - mozversion INFO | platform_buildid: 20151028130740 15:33:51 INFO - mozversion INFO | platform_changeset: 2f90ffb5ee459777a90e34cea18f6621157bf9c3 15:33:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:33:51 INFO - mozversion INFO | platform_version: 43.0a2 15:33:51 INFO - 2015-10-28 15:33:51,337 DEBUG : using testdate: 1446071631 15:33:51 INFO - 2015-10-28 15:33:51,337 DEBUG : actual date: 1446071631 15:33:51 INFO - 2015-10-28 15:33:51,350 INFO : Starting test suite talos-linux64-ix-028 15:33:51 INFO - 2015-10-28 15:33:51,350 INFO : Starting test dromaeo_css 15:33:51 INFO - 2015-10-28 15:33:51,350 DEBUG : operating with platform_type : linux_ 15:33:51 INFO - 2015-10-28 15:33:51,350 INFO : Initialising browser for dromaeo_css test... 15:33:51 INFO - 2015-10-28 15:33:51,377 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuKQkpg/profile http://localhost/getInfo.html 15:33:56 INFO - 2015-10-28 15:33:56,870 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:33:56 INFO - 2015-10-28 15:33:56,870 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:33:56 INFO - 2015-10-28 15:33:56,870 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:33:56 INFO - 2015-10-28 15:33:56,870 DEBUG : BROWSER_OUTPUT: __metrics 15:33:58 INFO - 2015-10-28 15:33:58,797 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:34:00 INFO - 2015-10-28 15:34:00,248 INFO : Browser initialized. 15:34:00 INFO - 2015-10-28 15:34:00,249 INFO : Running cycle 1/1 for dromaeo_css test... 15:34:00 INFO - 2015-10-28 15:34:00,249 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuKQkpg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:34:11 INFO - 2015-10-28 15:34:11,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 131440640 15:34:11 INFO - 2015-10-28 15:34:11,898 DEBUG : BROWSER_OUTPUT: 15:37:11 INFO - 2015-10-28 15:37:11,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-dojo.html (next: http://localhost/page_load_test/dromaeo/cssquery-ext.html) 15:37:12 INFO - 2015-10-28 15:37:12,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 223621120 15:37:12 INFO - 2015-10-28 15:37:12,285 DEBUG : BROWSER_OUTPUT: 15:40:14 INFO - 2015-10-28 15:40:14,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-ext.html (next: http://localhost/page_load_test/dromaeo/cssquery-jquery.html) 15:40:14 INFO - 2015-10-28 15:40:14,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 214671360 15:40:14 INFO - 2015-10-28 15:40:14,952 DEBUG : BROWSER_OUTPUT: 15:43:16 INFO - 2015-10-28 15:43:16,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-jquery.html (next: http://localhost/page_load_test/dromaeo/cssquery-mootools.html) 15:43:17 INFO - 2015-10-28 15:43:17,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 216358912 15:43:17 INFO - 2015-10-28 15:43:17,256 DEBUG : BROWSER_OUTPUT: 15:46:18 INFO - 2015-10-28 15:46:18,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-mootools.html (next: http://localhost/page_load_test/dromaeo/cssquery-prototype.html) 15:46:19 INFO - 2015-10-28 15:46:19,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 199966720 15:46:19 INFO - 2015-10-28 15:46:19,513 DEBUG : BROWSER_OUTPUT: 15:49:21 INFO - 2015-10-28 15:49:21,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-prototype.html (next: http://localhost/page_load_test/dromaeo/cssquery-yui.html) 15:49:22 INFO - 2015-10-28 15:49:22,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 194990080 15:49:22 INFO - 2015-10-28 15:49:22,436 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-yui.html (next: http://localhost/page_load_test/dromaeo/cssquery-dojo.html) 15:52:24 INFO - 2015-10-28 15:52:24,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 240254976 15:52:24 INFO - 2015-10-28 15:52:24,789 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:52:24 INFO - 2015-10-28 15:52:24,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:52:24 INFO - 2015-10-28 15:52:24,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:52:24 INFO - 2015-10-28 15:52:24,789 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:52:24 INFO - 2015-10-28 15:52:24,789 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3283.720883724883;3316.1046517440277;3396.7112795412404;3404.1829960809396;3423.332450172217;5565.582581306403;5602.4117467665865;5611.523020543259;5614.29821272341;5623.662580245188;5620.57845661576;5660.745266463009;5679.148127780835;5694.658320500773;5696.401877802823;5042.319286896277;5090.363704536933;5137.229415587654;5148.871278218037;5224.346956630421;5140.280360749498;5143.897122057557;5148.099082660538;5158.742062896859;5159.974200129013;5032.245163225527;5106.183010718286;5108.540231379176;5133.153029750087;5177.611679124062;5152.639315247934;5167.509086636764;5170.638055336128;5173.793048278046;5189.065968125736;4939.185034469308;5123.359580052494;5123.718195499246;5172.767225474862;5200.635955483118;5247.86880327991;5323.600729945231;5403.675779453206;5411.864703382407;5429.891402171974;6025.216721826135;6065.818025459199;6065.909011364833;6066.696665166768;6080.574359794816;5879.882402351929;5993.101034844764;6095.116208149793;6099.207103076572;6100.267967843843;5533.059379905426;5592.440755924456;5595.384507704109;5601.915971260434;5622.718864056822;6114.847128821726;6115.571909966259;6129.417705317987;6133.44798968095;6136.631802091889;5754.9424505754405;5848;5954.3783956534835;5972.671503067286;5973.671448070398;6019.849503762353;6023.909641355383;6031.638101713911;6073.635581865102;6088.786892458743;6004.159417681528;6004.54965877561;6005.459508644243;6011.09833524966;6029;5842;5966.940330596639;5967.224260846062;5997.220361353084;6072.969635151796;4591.770411479412;4591.977040114778;4599.965007873202;4605.539446055368;4630.675852690347;4115.691323150776;4121.402396652468;4122.525909520384;4142.171565686875;4142.2543942090115;5625.887482250332;5726.942730572641;5739.512141467939;5829.417058294137;5842.123681447817;5923.822285331447;6072.878542429126;6087.512998960073;6090.056041313604;6098.481629061491;5862.443067908542;5891.204687367236;5898.115282707542;5902.321233058167;5907.527397808165;5153.974230128901;5172.431032586413;5204.583633309327;5230.267762513251;5237.188235823453;6366.236051673736;6367.42693157618;6374.107624932513;6378.107065010902;6396.168498095218;5942.940570594239;6106.6336019838955;6108.511319094373;6112;6128.264608247039;6164.3835616438;6199.907001394892;6262;6262.185915830913;6276.560640755286;5962;5969.7313620888035;5970.402959703995;6001.909971350346;6015.0676645120075;5785.82642520725;5893;6064.120702498025;6068.8786224276155;6080.148779170831;5838.095095260242;5890.52875769946;5896.3514013457625;5897.587168898136;5910.52715782745;5851.61964472308;5897.5281977440845;5939.643621382731;5945.851353716192;5947.583669143119;5544.916826247529;5607.775688972395;5647.068233741551;5801.622894512012;5803.767849285981;5952.166696662557;5955.583109182316;5970.253718285215;5981;5991.460768530853;5792.189093526994;5799.710014499174;5838.32859221195;5845.035569131216;5851.063829787214 15:52:24 INFO - 2015-10-28 15:52:24,789 DEBUG : BROWSER_OUTPUT: |1;ext.html;605.772835186805;644.9226092868856;652.6019128331717;653.4184575727601;662.5329142954216;36029.27941441169;45816.312755308696;46288.30567541489;46542.534574654244;46620.76689616556;49509.75245123769;49990;50008;50053.49946500534;50212.74893625536;7983.680652773882;8083;9244.306676999235;9416.058394160564;10773.730656733565;10954.452277386139;10968.890311096866;11073.778524429506;11077.50151243192;11077.778444431107;10826.891731082707;10923.962223588745;10930.56277748889;10932.890671093306;10935.726606834813;10837.078848297904;10868.891311086867;10875.891241087567;10905.127589792797;10962.287451315678;10651.467426628715;10735.463226838705;10738.463076846205;10783.730406739816;10812.513436895359;46129;46525;46602.766986164854;46745.532544674796;46794.76602616999;3826.502554667903;3888.338982372975;3899.805009749501;3969.980150099231;4218.282891908383;34359.828200858836;34698;35017.29965400703;35065.29869402598;35154;3862.729608927348;3903.258380907647;3973.6821054315587;3998.1204135090234;4032.5362583303004;361316;361959;361986;362043;363749;58226.70886645625;59628.70185649131;66177.66911165413;66959.66520167368;67056.66471667709;65501.67249163819;65507;65786;65793.34206657967;65803.67098164478;16527.091009994565;16605.750913736305;16708.248128833988;16768.245428955724;16895.07077110771;15181.16503592291;15518.767218491732;15523.767143492856;15524.14617196065;15526.223688815515;21280.148794048375;21513.462163445725;21564.676529852066;21584.352469425943;21591.352259432242;7766.223377662302;7990.200979901963;8060.717874874351;8070.314023308085;8115.229053239933;989.9950500247453;1135.4039129456935;1135.5968631135827;1168.182272409317;1271.7075072733323;32057.51913721296;32084.839575802438;32469.350612987608;33053.504197436574;33132.66867331344;1195.3007490618086;1234.703671118925;1268.3594784633885;1272.9816147082297;1292.0051560298705;14172.645683857985;16849.49451516432;16964.491065268063;17254.741178882326;17772.91113544424;304945;307006;309564;309763;310336;58820.882538222766;59184.11223831646;59724.402755972755;60441.395586044455;61572.38427615666;1429.1496559547054;1441.7837324401423;1442.2572375226766;1445.595233334647;1452.4916279302372;32673.509897351083;32686.83656581702;33011;33770.49344259887;33796.831015844764;49921.50078499169;51131.23303150381;56735;58093.128603070145;58153.4184658148;269963;270328;271292;272466;272616;33482.66517334795;33721.49417758785;33742.32515349728;33799.49300760441;33801.49297760585;45842;46765.29852052154;46811;46840.53159468498;46973.76513117413;41167.1766564661;41872.581274186865;42172.789136054125;42383.94040149021;42922.35616465818;42452;42582.57417425786;42997.785011076;43550.346744799484;43588.34617480677;42468;42856.57143428526;43195;43278.567214328716;43570.34644480272;37276.44085338668;37390.62609373871;37622;38068;38196.80901595474;29156.562651560667;29395.7060429393;29413.70586294195;29477.557836632895;29484.11547653574 15:52:24 INFO - 2015-10-28 15:52:24,791 DEBUG : BROWSER_OUTPUT: |2;jquery.html;408.31607058177565;414.7179917655994;416.7353730381209;417.5511325325276;420.451311039094;15021;15445.150516721576;18822.153003114858;18882.811171888294;19394.806051939475;16707.164641767893;18403.263869445207;18663.813361866378;19353.129109190086;19360;5736.024875771119;5879.823605291826;5881.617694849821;5881.67650779207;5883.529317654598;4174.666026717855;4676.508966558514;5807.01280782268;6410.1666783318105;6436.967815160918;5287.074761916669;6308.463780578656;6314.46327062198;6323.77866774663;6348.650824204667;5334.786608535674;5352.795620985286;5353.437889021636;5361.410244873041;5367.624266301361;4621.953780462186;4667.696599721041;4680.3915490985955;4684.203685373494;4686.601638860701;15302.770458443021;15436.305366258433;15506.689866202725;15663.451779187788;15672;2240.1487434774845;2294.73610534789;2340.976590234093;2358.716953965518;2377.679013333195;10933.671989840317;10948.835767463494;11008.504617292241;11225.550977960871;11271.774564508745;1791.70436877915;1833.5049536625036;1857.8606604504716;1906.3327835257687;1906.494778883597;69413.65293173552;69989.30010699929;71567;71685.64157179232;72293.63853180753;7872.134065252818;7883.763487095396;7883.881741773878;7976;7988.640511177011;9687.17658998979;9689.321747477608;9697.418154910727;9708.514574271258;9711.708648740549;6383.489320854321;6398.712057957403;6418.775342862978;6423.678816059179;6439.8068057958335;6706.7652632158615;6723;6741.662916854138;6752.5948443093575;6777.220619628806;3402.1834759657504;3664.04734768962;3691.372466680617;3692.5199724036243;3718.2377612589894;1279.5457612547411;1285.7878450055823;1287.189070885355;1292.134270039076;1294.8640392758814;510.6884800271831;521.434243845432;531.8617159538547;535.7963973689973;538.4507802041895;12155;13164.736705265841;13742.93128534371;13831.723365532633;14202.644933876736;554.2960440240871;567.1577707104946;569.4789267819981;569.851838521979;592.7865968251426;6625.238097618739;7043.401310888529;7416.888746668804;7523.548587084792;7540.773776786705;638074;642552;651383;672337;678320;82635;83342.58328708318;84250;86761;89167;602.286290745468;610.2798697536861;612.1277180018367;612.8130920069333;613.6716856481761;11976.28142311464;12173.817392738938;12386.938065309616;12429.12996090265;12492.812607810709;40175.59824401719;40538;40744.79627601843;41561.168776623694;42129.157416852104;51537.22694159666;52830;54047.18929215986;54065;54398.72800635971;7701.422393320411;7752.922470775446;7938.801529961797;7940.920590794018;7941.722039728582;10599.205059620404;12782.169159004636;13482.595522134352;13842;14201.502947396792;11874.525018999144;11885.881141188824;12003.09834258544;12047.75904481923;12049.096317776377;11948.163628545919;12114.697132571757;12198.32909190003;12210.26738395699;12325.876741232833;12064.396780160781;12443.688907777378;12478.563250286197;12667.239965602093;12690;7746.070471543451;7780.221977802401;7849.058113026474;7850.0972388173805;7855.096663883726;11905.047596192457;11909.880901190878;12225.449854756735;12250.571230006906;12391.814122788346 15:52:24 INFO - 2015-10-28 15:52:24,791 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1493.3727834309589;1633.0691505841667;1838.2003828334675;1984.1369004483042;2014.4774980169523;8388.538630375328;9187.862182067265;9341.346105772598;9351.48566828825;9359.157675809176;9101.408408453446;9192.31057670674;9198.586063627135;9243.676471323504;9336.719898403042;2139.5827813576357;2168.609650262952;2380.8571485710827;2387.7731615496587;2473.863937483438;2466.7163276223287;2521.0798058708624;2528.4184637533376;2532.8860201290986;2534.4550921551863;2377.619580867062;2403.8677872716994;2422.2369953464604;2426.7087949446004;2433;2144.6997420361163;2179.411558879102;2431.8784060797066;2485.453200295932;2497.962530562043;2456.57010023247;2475.7771800537857;2483.888225029878;2484.0560586976835;2497.625356196567;9565.473898935556;9635.13283804461;9669;9709.61161553537;9722.222222222204;5579.553635709133;5622.465865742748;5640.464155905182;5648.124540696199;5649.604527683064;3545.4150065239205;3559.94660080099;3639.508666330038;3790.9620903790883;3805.6955443564448;1269.092598791859;1277.9488820447264;1305.5561109222815;1316.1313533068128;1319.5579480873919;14359;14379.928100359535;14384.928075359661;14395.352209150613;14398.352074156688;4963.329950456714;4979.3526841510375;4990.975045124751;5055.949440505621;5064.7214403207445;11292.491837867316;11329.773404531863;11331.716707082223;11336.773264534828;11338.376389298668;5683.658980461103;5688.573356998241;5692.829215123553;5696.772129114789;5697.344805347355;5148.485151484896;5155.200943853633;5158.664686795421;5160.690358578498;5171.922421163686;4296.119295544406;4302.82788688449;4316.287812510964;4338.869833904988;4377.78111094444;1322.9338533073308;1332.9333533323488;1337.8862796662197;1348.6426097084282;1355.1394864261067;1465.2087872548918;1482.8443013483645;1496.393960446021;1507.186119495482;1527.2821773766311;9240.630374784932;9295.814083718287;9312.115349041831;9321.953390233006;9332.06679332075;556.5964675610151;567.0275477556012;569.8233547600257;572.977080916767;573.6128113523355;7032.437405007587;7116.608586527791;7146;7149;7532.17146113927;12284.754304913851;12404;12425.875741242653;12426.068044896669;12450.75098498025;12190.2076365036;12328;12424.440900159514;12520.186187897758;12524.561640342545;8655.783605409915;9202.401843880127;9269.629214831466;9294.581743821544;9298.628054877865;9078.137576930181;9099.408538444979;9125.589348479201;9136.26909847224;9141.588628511867;10348.637797677045;10471.68584942453;10565.735856603646;10614.1508679307;10619.94690026545;10705.715314162351;10848.40333781618;10886.346819190874;10903.945480272865;10915.781684366428;8616.310695144248;8648.827023459622;8713.30293576525;8716.215540601377;8728.825423491367;9559.235261179228;9657;9667.854982175413;9672.709818705169;9677.951610241904;7276.163241227327;8845.4250473719;8848.823023539364;9028.18746312835;9111.498867562083;8534.189252021048;8589.52757598338;8712.564371781513;8740.257078148428;8816.426932249384;8740.694075707319;8754.21212090915;8778.34162437807;8788.648454061766;8797.076306987674;7844.058712954482;7860.3318717909615;7993.72021979228;8002.599870006593;8012.359011278967;7942.444028918151;7949.562774047483;7966.362690984592;7968.960155199187;7985 15:52:24 INFO - 2015-10-28 15:52:24,792 DEBUG : BROWSER_OUTPUT: |4;prototype.html;384.9037740564858;384.95957924417917;387.9495665563478;389.4644863312945;393.3293734183216;5866.501347385467;5961.88076238475;5983.700814959251;6019.879602407949;6029.487493563041;5843.152742852284;5931.970340148293;5943.167956486084;5959.582829201958;5966.254218222723;4758.952410475903;4763.285507173917;4766.475687674353;4769.427668679763;4771.665983381165;4603.10239503297;4676.532346765331;4677.6959497632715;4758.976205118969;4797.808087676489;4711.952880471185;4728.267118596623;4731;4739.194336962724;4761.047790441926;4694.624430045588;4720.315554244649;4721.3862197914395;4738.620910327166;4741.95258047422;4272.935905961382;4273.059926816096;4274.829006839723;4277.700560960734;4291.8068686908855;5552.944470555283;5634.042212823789;5651.32184137902;5657.1514272858985;5673.744681489343;5591.832245032656;5595.720213989284;5596.608237423382;5599.720013999284;5602.327720673505;6396.712147953353;6428.967855160694;6431.035344698286;6432.163818703585;6435.066915297256;4671.229247174246;4755.595774359183;4757.024809913959;4761.785719642589;4769.785359658824;6533.314002029813;6601.70292336846;6603.93396066038;6604.6697665117035;6614.503912206652;4916.754162291871;4917.532834380728;4918.754062296943;4919.2867034279825;4919.77860996256;4967.801287948514;4969.254611808257;4971.950280497221;4972.328735620717;4972.602191824645;5475.890482190334;5562.332520097533;5567.944320556823;5576.330840299109;5576.525995290446;6401.263854656774;6444.130042444303;6455.7740479083;6460.127882735865;6468.223813142359;1776.6269083492612;1806.060848358846;1806.7470554122433;1807.268056437145;1809.2039502618807;1255.5354518828092;1257.1577043380958;1262.3498898067503;1284;1288.7809072457705;6311.431971122621;6324.557280990287;6326.43062124411;6326.4622507087415;6335.3981371769605;6411.519136064814;6487.7080531376205;6529.934700652932;6616.4045235929;6623.602583844985;6280.246370435577;6295.213098362705;6301.275353334334;6304.495640348761;6310.968445157745;3614.2590768892314;3640.399334109842;3646.762960407565;3647.0517665406655;3649.489071529988;6841.076454678654;6958.547694399847;6978.371946524736;6999.23008469068;7006.369426751617;6808.38724514796;6836.658167091626;6848.075509806212;6848.3494068063455;6849.657517124124;6947.548409353376;6951.2353641099435;6953.269906659728;6961.721531138698;6967.790966270919;6534.379233972765;6630.53586248958;6632.50256230775;6636.369544893228;6645.700943457653;6538.542302038812;6554.8361290968105;6555.115059466911;6555.672216389066;6560.343965603402;6847.863042739217;6909.792706218822;6942.652867356511;6951.0616066830335;6971.930280697331;4822.8794280143275;4898.755062246944;4901.6323775716255;4904.2643603459765;4915.483874193301;6582.3746744059235;6590.47276217911;6631.038499417654;6662.367075128049;6662.56693314933;6411.4229719325485;6416.711247993758;6418.037294405876;6439.613623182624;6455.2576453708425;6303.149074875017;6461.256955450183;6462.127612772216;6469.159009328945;6476.967615162082;6292.52806039558;6295.024271237966;6300.180976473029;6302.086197501429;6303.338149494237;6425.132607098169;6447;6475.514336424692;6476.352364763486;6479.708413121515;6133.50931925436;6174.598651087665;6210.782622608187;6215.875682486235;6307.779227727007 15:52:24 INFO - 2015-10-28 15:52:24,793 DEBUG : BROWSER_OUTPUT: |5;yui.html;824.7113510271402;832.9671207702444;840.6805413942701;947.3510645208031;947.4492703352246;13783.862161378383;13854.168749875002;13941.790873136886;14022.929885350584;14038.859611403883;13198.53805116821;13794.241316727575;13815.51645692401;13846.584602461942;13846.653833654163;787.9054513458365;793.5000949401868;944.2870632672323;955.068807912287;956.5504213019905;948.8292107420662;964.1563631822156;973.3381300715511;973.595957677563;974.6539978307705;989.6585677941134;1009.1119814563174;1010.7675234696025;1010.959561617538;1011.2163073617968;819.1890028871404;827.0530242871909;981.9361741486781;987.5457289646771;995.721198064543;732.0300601702766;733.2630706140295;733.3326672727792;733.9522931009467;734.533571182303;13992.16047037181;14145.929270353685;14148.151110933273;14149.363278652485;14156.575302740934;12011.399430028463;12185.451654675473;12263.509459621604;12298.812959271718;12303.261804291771;10789.946050269777;10874.945625271823;11015.889841101647;11018.338899666045;11067.667969960914;3667.2665466906724;3697.2975134724315;3713.8885833425043;3746.9063273418383;3790.2419516096893;45422.77288613536;45498.54501454976;45536.08927821458;46502;46577.53422465766;10152.949235253924;10459.058684718411;10464.162866970624;10527.789444211074;10578.365298081986;19029.333973311146;19088.33190838314;19088.522786930436;19109.426717198505;19115.23539058422;8041.718539851077;8067.959660201779;8109.75670729879;8241.8351632967;8249.463784853966;4538.92388229623;4667.6265898728025;4690.413698287714;4768.070226305837;4778.95221047792;3225.4355487790012;3254.316593515341;3257.820819854931;3261.2010057536054;3267.2485328374605;521.4264309259784;528.2261486921678;528.2736237673199;530.2364594983212;532.475511621053;593.9970300148472;606.9635821850703;693.968771405288;698.1099098649263;708.7909066825196;8519.914800852037;8794.472331660121;8799.164079412445;9471.384360016576;9595.664151754656;719.639880625618;733.3070248615007;734.3134169551487;753.4499815134982;769.9769006929689;4020.4572382727956;4222.619964203175;4263.488381394191;4300.462442194726;4385.429894113745;54655;54668.45331546634;54716.179257311174;54936.725316373166;54957.450425496034;47164;47241.76379118151;47474.762626186646;47485.525144748804;47714.28428573574;37996.62003379986;38411.80794096012;38969.2206155881;38970.80514597409;39664.80167599144;8574.742757717278;8623.267022303175;9181.816363672555;9288.953555232181;9329.813403732023;27224.591631125153;27673.308167295174;28524.286892827844;28636.14091577256;28659.426811464073;37597.62402375941;37742.73543587283;38162.42756358712;39932.60067399405;39953.80023099866;8282.461639993382;8521.744347669579;8576.056633770406;8615.138486151334;8617.69838055665;12905.354732263537;12958.611241662766;12976.610701678965;13114.60656180316;13224.933875330562;11743.29540227555;11787.469563869476;11798.41007949582;12275.017998560272;12446.190997585129;11862.881371186179;12046.578369757017;12089.032877369613;12129.75317711397;12521.56174533887;11399.373034482851;11550.94224528872;11562.248453850472;11607.30356178632;12077.698057548632;9389.342746007987;9715.677502733926;9904.260148972935;9967.40195588267;9977.50112494358;9702.126808587262;10053.346532475365;10061.69814905554;10085.546150423103;10121.493925303852 15:52:24 INFO - 2015-10-28 15:52:24,793 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:52:24 INFO - 2015-10-28 15:52:24,793 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:52:24 INFO - 2015-10-28 15:52:24,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,723 15:52:24 INFO - 2015-10-28 15:52:24,793 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: __startTimestamp1446072744784__endTimestamp 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5605.33 Median:5845.04 stddev:630.54 (10.8%) stddev-sans-first:605.60 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: Values: 3283.7 3316.1 3396.7 3404.2 3423.3 5565.6 5602.4 5611.5 5614.3 5623.7 5620.6 5660.7 5679.1 5694.7 5696.4 5042.3 5090.4 5137.2 5148.9 5224.3 5140.3 5143.9 5148.1 5158.7 5160.0 5032.2 5106.2 5108.5 5133.2 5177.6 5152.6 5167.5 5170.6 5173.8 5189.1 4939.2 5123.4 5123.7 5172.8 5200.6 5247.9 5323.6 5403.7 5411.9 5429.9 6025.2 6065.8 6065.9 6066.7 6080.6 5879.9 5993.1 6095.1 6099.2 6100.3 5533.1 5592.4 5595.4 5601.9 5622.7 6114.8 6115.6 6129.4 6133.4 6136.6 5754.9 5848.0 5954.4 5972.7 5973.7 6019.8 6023.9 6031.6 6073.6 6088.8 6004.2 6004.5 6005.5 6011.1 6029.0 5842.0 5966.9 5967.2 5997.2 6073.0 4591.8 4592.0 4600.0 4605.5 4630.7 4115.7 4121.4 4122.5 4142.2 4142.3 5625.9 5726.9 5739.5 5829.4 5842.1 5923.8 6072.9 6087.5 6090.1 6098.5 5862.4 5891.2 5898.1 5902.3 5907.5 5154.0 5172.4 5204.6 5230.3 5237.2 6366.2 6367.4 6374.1 6378.1 6396.2 5942.9 6106.6 6108.5 6112.0 6128.3 6164.4 6199.9 6262.0 6262.2 6276.6 5962.0 5969.7 5970.4 6001.9 6015.1 5785.8 5893.0 6064.1 6068.9 6080.1 5838.1 5890.5 5896.4 5897.6 5910.5 5851.6 5897.5 5939.6 5945.9 5947.6 5544.9 5607.8 5647.1 5801.6 5803.8 5952.2 5955.6 5970.3 5981.0 5991.5 5792.2 5799.7 5838.3 5845.0 5851.1 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51285.79 Median:198672.64 stddev:82420.95 (41.5%) stddev-sans-first:82564.32 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: Values: 605.8 644.9 652.6 653.4 662.5 36029.3 45816.3 46288.3 46542.5 46620.8 49509.8 49990.0 50008.0 50053.5 50212.7 7983.7 8083.0 9244.3 9416.1 10773.7 10954.5 10968.9 11073.8 11077.5 11077.8 10826.9 10924.0 10930.6 10932.9 10935.7 10837.1 10868.9 10875.9 10905.1 10962.3 10651.5 10735.5 10738.5 10783.7 10812.5 46129.0 46525.0 46602.8 46745.5 46794.8 3826.5 3888.3 3899.8 3970.0 4218.3 34359.8 34698.0 35017.3 35065.3 35154.0 3862.7 3903.3 3973.7 3998.1 4032.5 361316.0 361959.0 361986.0 362043.0 363749.0 58226.7 59628.7 66177.7 66959.7 67056.7 65501.7 65507.0 65786.0 65793.3 65803.7 16527.1 16605.8 16708.2 16768.2 16895.1 15181.2 15518.8 15523.8 15524.1 15526.2 21280.1 21513.5 21564.7 21584.4 21591.4 7766.2 7990.2 8060.7 8070.3 8115.2 990.0 1135.4 1135.6 1168.2 1271.7 32057.5 32084.8 32469.4 33053.5 33132.7 1195.3 1234.7 1268.4 1273.0 1292.0 14172.6 16849.5 16964.5 17254.7 17772.9 304945.0 307006.0 309564.0 309763.0 310336.0 58820.9 59184.1 59724.4 60441.4 61572.4 1429.1 1441.8 1442.3 1445.6 1452.5 32673.5 32686.8 33011.0 33770.5 33796.8 49921.5 51131.2 56735.0 58093.1 58153.4 269963.0 270328.0 271292.0 272466.0 272616.0 33482.7 33721.5 33742.3 33799.5 33801.5 45842.0 46765.3 46811.0 46840.5 46973.8 41167.2 41872.6 42172.8 42383.9 42922.4 42452.0 42582.6 42997.8 43550.3 43588.3 42468.0 42856.6 43195.0 43278.6 43570.3 37276.4 37390.6 37622.0 38068.0 38196.8 29156.6 29395.7 29413.7 29477.6 29484.1 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,794 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31932.98 Median:4685.40 stddev:107555.12 (2295.5%) stddev-sans-first:107830.79 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: Values: 408.3 414.7 416.7 417.6 420.5 15021.0 15445.2 18822.2 18882.8 19394.8 16707.2 18403.3 18663.8 19353.1 19360.0 5736.0 5879.8 5881.6 5881.7 5883.5 4174.7 4676.5 5807.0 6410.2 6437.0 5287.1 6308.5 6314.5 6323.8 6348.7 5334.8 5352.8 5353.4 5361.4 5367.6 4622.0 4667.7 4680.4 4684.2 4686.6 15302.8 15436.3 15506.7 15663.5 15672.0 2240.1 2294.7 2341.0 2358.7 2377.7 10933.7 10948.8 11008.5 11225.6 11271.8 1791.7 1833.5 1857.9 1906.3 1906.5 69413.7 69989.3 71567.0 71685.6 72293.6 7872.1 7883.8 7883.9 7976.0 7988.6 9687.2 9689.3 9697.4 9708.5 9711.7 6383.5 6398.7 6418.8 6423.7 6439.8 6706.8 6723.0 6741.7 6752.6 6777.2 3402.2 3664.0 3691.4 3692.5 3718.2 1279.5 1285.8 1287.2 1292.1 1294.9 510.7 521.4 531.9 535.8 538.5 12155.0 13164.7 13742.9 13831.7 14202.6 554.3 567.2 569.5 569.9 592.8 6625.2 7043.4 7416.9 7523.5 7540.8 638074.0 642552.0 651383.0 672337.0 678320.0 82635.0 83342.6 84250.0 86761.0 89167.0 602.3 610.3 612.1 612.8 613.7 11976.3 12173.8 12386.9 12429.1 12492.8 40175.6 40538.0 40744.8 41561.2 42129.2 51537.2 52830.0 54047.2 54065.0 54398.7 7701.4 7752.9 7938.8 7940.9 7941.7 10599.2 12782.2 13482.6 13842.0 14201.5 11874.5 11885.9 12003.1 12047.8 12049.1 11948.2 12114.7 12198.3 12210.3 12325.9 12064.4 12443.7 12478.6 12667.2 12690.0 7746.1 7780.2 7849.1 7850.1 7855.1 11905.0 11909.9 12225.4 12250.6 12391.8 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:6749.78 Median:5151.84 stddev:3760.52 (73.0%) stddev-sans-first:3750.31 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: Values: 1493.4 1633.1 1838.2 1984.1 2014.5 8388.5 9187.9 9341.3 9351.5 9359.2 9101.4 9192.3 9198.6 9243.7 9336.7 2139.6 2168.6 2380.9 2387.8 2473.9 2466.7 2521.1 2528.4 2532.9 2534.5 2377.6 2403.9 2422.2 2426.7 2433.0 2144.7 2179.4 2431.9 2485.5 2498.0 2456.6 2475.8 2483.9 2484.1 2497.6 9565.5 9635.1 9669.0 9709.6 9722.2 5579.6 5622.5 5640.5 5648.1 5649.6 3545.4 3559.9 3639.5 3791.0 3805.7 1269.1 1277.9 1305.6 1316.1 1319.6 14359.0 14379.9 14384.9 14395.4 14398.4 4963.3 4979.4 4991.0 5055.9 5064.7 11292.5 11329.8 11331.7 11336.8 11338.4 5683.7 5688.6 5692.8 5696.8 5697.3 5148.5 5155.2 5158.7 5160.7 5171.9 4296.1 4302.8 4316.3 4338.9 4377.8 1322.9 1332.9 1337.9 1348.6 1355.1 1465.2 1482.8 1496.4 1507.2 1527.3 9240.6 9295.8 9312.1 9322.0 9332.1 556.6 567.0 569.8 573.0 573.6 7032.4 7116.6 7146.0 7149.0 7532.2 12284.8 12404.0 12425.9 12426.1 12450.8 12190.2 12328.0 12424.4 12520.2 12524.6 8655.8 9202.4 9269.6 9294.6 9298.6 9078.1 9099.4 9125.6 9136.3 9141.6 10348.6 10471.7 10565.7 10614.2 10619.9 10705.7 10848.4 10886.3 10903.9 10915.8 8616.3 8648.8 8713.3 8716.2 8728.8 9559.2 9657.0 9667.9 9672.7 9678.0 7276.2 8845.4 8848.8 9028.2 9111.5 8534.2 8589.5 8712.6 8740.3 8816.4 8740.7 8754.2 8778.3 8788.6 8797.1 7844.1 7860.3 7993.7 8002.6 8012.4 7942.4 7949.6 7966.4 7969.0 7985.0 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5456.35 Median:6154.05 stddev:1566.17 (25.4%) stddev-sans-first:1523.60 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: Values: 384.9 385.0 387.9 389.5 393.3 5866.5 5961.9 5983.7 6019.9 6029.5 5843.2 5932.0 5943.2 5959.6 5966.3 4759.0 4763.3 4766.5 4769.4 4771.7 4603.1 4676.5 4677.7 4759.0 4797.8 4712.0 4728.3 4731.0 4739.2 4761.0 4694.6 4720.3 4721.4 4738.6 4742.0 4272.9 4273.1 4274.8 4277.7 4291.8 5552.9 5634.0 5651.3 5657.2 5673.7 5591.8 5595.7 5596.6 5599.7 5602.3 6396.7 6429.0 6431.0 6432.2 6435.1 4671.2 4755.6 4757.0 4761.8 4769.8 6533.3 6601.7 6603.9 6604.7 6614.5 4916.8 4917.5 4918.8 4919.3 4919.8 4967.8 4969.3 4972.0 4972.3 4972.6 5475.9 5562.3 5567.9 5576.3 5576.5 6401.3 6444.1 6455.8 6460.1 6468.2 1776.6 1806.1 1806.7 1807.3 1809.2 1255.5 1257.2 1262.3 1284.0 1288.8 6311.4 6324.6 6326.4 6326.5 6335.4 6411.5 6487.7 6529.9 6616.4 6623.6 6280.2 6295.2 6301.3 6304.5 6311.0 3614.3 3640.4 3646.8 3647.1 3649.5 6841.1 6958.5 6978.4 6999.2 7006.4 6808.4 6836.7 6848.1 6848.3 6849.7 6947.5 6951.2 6953.3 6961.7 6967.8 6534.4 6630.5 6632.5 6636.4 6645.7 6538.5 6554.8 6555.1 6555.7 6560.3 6847.9 6909.8 6942.7 6951.1 6971.9 4822.9 4898.8 4901.6 4904.3 4915.5 6582.4 6590.5 6631.0 6662.4 6662.6 6411.4 6416.7 6418.0 6439.6 6455.3 6303.1 6461.3 6462.1 6469.2 6477.0 6292.5 6295.0 6300.2 6302.1 6303.3 6425.1 6447.0 6475.5 6476.4 6479.7 6133.5 6174.6 6210.8 6215.9 6307.8 15:52:24 INFO - 2015-10-28 15:52:24,796 DEBUG : BROWSER_OUTPUT: 15:52:24 INFO - 2015-10-28 15:52:24,797 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13186.42 Median:4281.98 stddev:14360.07 (335.4%) stddev-sans-first:14370.34 15:52:24 INFO - 2015-10-28 15:52:24,797 DEBUG : BROWSER_OUTPUT: Values: 824.7 833.0 840.7 947.4 947.4 13783.9 13854.2 13941.8 14022.9 14038.9 13198.5 13794.2 13815.5 13846.6 13846.7 787.9 793.5 944.3 955.1 956.6 948.8 964.2 973.3 973.6 974.7 989.7 1009.1 1010.8 1011.0 1011.2 819.2 827.1 981.9 987.5 995.7 732.0 733.3 733.3 734.0 734.5 13992.2 14145.9 14148.2 14149.4 14156.6 12011.4 12185.5 12263.5 12298.8 12303.3 10789.9 10874.9 11015.9 11018.3 11067.7 3667.3 3697.3 3713.9 3746.9 3790.2 45422.8 45498.5 45536.1 46502.0 46577.5 10152.9 10459.1 10464.2 10527.8 10578.4 19029.3 19088.3 19088.5 19109.4 19115.2 8041.7 8068.0 8109.8 8241.8 8249.5 4538.9 4667.6 4690.4 4768.1 4779.0 3225.4 3254.3 3257.8 3261.2 3267.2 521.4 528.2 528.3 530.2 532.5 594.0 607.0 694.0 698.1 708.8 8519.9 8794.5 8799.2 9471.4 9595.7 719.6 733.3 734.3 753.4 770.0 4020.5 4222.6 4263.5 4300.5 4385.4 54655.0 54668.5 54716.2 54936.7 54957.5 47164.0 47241.8 47474.8 47485.5 47714.3 37996.6 38411.8 38969.2 38970.8 39664.8 8574.7 8623.3 9181.8 9289.0 9329.8 27224.6 27673.3 28524.3 28636.1 28659.4 37597.6 37742.7 38162.4 39932.6 39953.8 8282.5 8521.7 8576.1 8615.1 8617.7 12905.4 12958.6 12976.6 13114.6 13224.9 11743.3 11787.5 11798.4 12275.0 12446.2 11862.9 12046.6 12089.0 12129.8 12521.6 11399.4 11550.9 11562.2 11607.3 12077.7 9389.3 9715.7 9904.3 9967.4 9977.5 9702.1 10053.3 10061.7 10085.5 10121.5 15:52:24 INFO - 2015-10-28 15:52:24,798 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:52:24 INFO - 2015-10-28 15:52:24,798 DEBUG : BROWSER_OUTPUT: 15:52:25 INFO - 2015-10-28 15:52:25,357 INFO : Browser exited with error code: 0 15:52:25 INFO - 2015-10-28 15:52:25,376 INFO : Completed test dromaeo_css (00:18:34) 15:52:25 INFO - 2015-10-28 15:52:25,376 INFO : Starting test kraken 15:52:25 INFO - 2015-10-28 15:52:25,376 DEBUG : operating with platform_type : linux_ 15:52:25 INFO - 2015-10-28 15:52:25,376 INFO : Initialising browser for kraken test... 15:52:25 INFO - 2015-10-28 15:52:25,382 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3RL_Kf/profile http://localhost/getInfo.html 15:52:28 INFO - 2015-10-28 15:52:28,893 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:52:28 INFO - 2015-10-28 15:52:28,893 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:52:28 INFO - 2015-10-28 15:52:28,893 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:52:28 INFO - 2015-10-28 15:52:28,893 DEBUG : BROWSER_OUTPUT: __metrics 15:52:29 INFO - 2015-10-28 15:52:29,042 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:30 INFO - 2015-10-28 15:52:30,152 INFO : Browser initialized. 15:52:30 INFO - 2015-10-28 15:52:30,152 INFO : Running cycle 1/1 for kraken test... 15:52:30 INFO - 2015-10-28 15:52:30,152 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3RL_Kf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:52:41 INFO - 2015-10-28 15:52:41,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 132734976 15:52:41 INFO - 2015-10-28 15:52:41,848 DEBUG : BROWSER_OUTPUT: 15:52:44 INFO - 2015-10-28 15:52:44,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=ai-astar (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection) 15:52:45 INFO - 2015-10-28 15:52:45,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 166674432 15:52:45 INFO - 2015-10-28 15:52:45,299 DEBUG : BROWSER_OUTPUT: 15:52:47 INFO - 2015-10-28 15:52:47,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-dft) 15:52:48 INFO - 2015-10-28 15:52:48,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 163491840 15:52:48 INFO - 2015-10-28 15:52:48,381 DEBUG : BROWSER_OUTPUT: 15:52:51 INFO - 2015-10-28 15:52:51,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-dft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-fft) 15:52:51 INFO - 2015-10-28 15:52:51,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 162729984 15:52:51 INFO - 2015-10-28 15:52:51,710 DEBUG : BROWSER_OUTPUT: 15:52:53 INFO - 2015-10-28 15:52:53,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-fft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator) 15:52:54 INFO - 2015-10-28 15:52:54,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 158801920 15:52:54 INFO - 2015-10-28 15:52:54,204 DEBUG : BROWSER_OUTPUT: 15:52:56 INFO - 2015-10-28 15:52:56,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:56 INFO - 2015-10-28 15:52:56,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 155795456 15:52:56 INFO - 2015-10-28 15:52:56,843 DEBUG : BROWSER_OUTPUT: 15:52:59 INFO - 2015-10-28 15:52:59,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom) 15:53:00 INFO - 2015-10-28 15:53:00,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 155062272 15:53:00 INFO - 2015-10-28 15:53:00,229 DEBUG : BROWSER_OUTPUT: 15:53:03 INFO - 2015-10-28 15:53:03,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate) 15:53:04 INFO - 2015-10-28 15:53:04,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 156389376 15:53:04 INFO - 2015-10-28 15:53:04,092 DEBUG : BROWSER_OUTPUT: 15:53:06 INFO - 2015-10-28 15:53:06,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate (next: http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial) 15:53:07 INFO - 2015-10-28 15:53:07,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 155283456 15:53:07 INFO - 2015-10-28 15:53:07,343 DEBUG : BROWSER_OUTPUT: 15:53:08 INFO - 2015-10-28 15:53:08,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial (next: http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox) 15:53:09 INFO - 2015-10-28 15:53:09,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 165965824 15:53:09 INFO - 2015-10-28 15:53:09,377 DEBUG : BROWSER_OUTPUT: 15:53:11 INFO - 2015-10-28 15:53:11,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes) 15:53:11 INFO - 2015-10-28 15:53:11,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 165388288 15:53:11 INFO - 2015-10-28 15:53:11,670 DEBUG : BROWSER_OUTPUT: 15:53:13 INFO - 2015-10-28 15:53:13,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:14 INFO - 2015-10-28 15:53:14,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 171503616 15:53:14 INFO - 2015-10-28 15:53:14,190 DEBUG : BROWSER_OUTPUT: 15:53:16 INFO - 2015-10-28 15:53:16,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:17 INFO - 2015-10-28 15:53:17,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 174342144 15:53:17 INFO - 2015-10-28 15:53:17,047 DEBUG : BROWSER_OUTPUT: 15:53:19 INFO - 2015-10-28 15:53:19,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:19 INFO - 2015-10-28 15:53:19,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 173039616 15:53:19 INFO - 2015-10-28 15:53:19,973 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost/page_load_test/kraken/driver.html?testName=ai-astar) 15:53:21 INFO - 2015-10-28 15:53:21,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 231550976 15:53:21 INFO - 2015-10-28 15:53:21,788 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,790 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:53:21 INFO - 2015-10-28 15:53:21,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:53:21 INFO - 2015-10-28 15:53:21,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:53:21 INFO - 2015-10-28 15:53:21,790 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:53:21 INFO - 2015-10-28 15:53:21,791 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;109;110;110;109;109;116;109;110;108 15:53:21 INFO - 2015-10-28 15:53:21,791 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;143;120;151;164;122;154;143;121;167;127 15:53:21 INFO - 2015-10-28 15:53:21,791 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;159;160;160;161;159;161;161;160 15:53:21 INFO - 2015-10-28 15:53:21,792 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;71;147;72;71;70;72;155;71 15:53:21 INFO - 2015-10-28 15:53:21,792 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;88;131;87;87;88;131;87;88;129 15:53:21 INFO - 2015-10-28 15:53:21,792 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;109;110;109;109;110 15:53:21 INFO - 2015-10-28 15:53:21,792 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;145;145;147;145;145;146 15:53:21 INFO - 2015-10-28 15:53:21,792 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;95;96;96;96;96 15:53:21 INFO - 2015-10-28 15:53:21,792 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;51;56;54;53;52;52;52;54;64;50 15:53:21 INFO - 2015-10-28 15:53:21,793 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;61;61;61;62;67;62;61;61;62 15:53:21 INFO - 2015-10-28 15:53:21,793 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;77;78;79;78;78;78;79;84 15:53:21 INFO - 2015-10-28 15:53:21,793 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;106;107;105;108;110;113;119;113;108 15:53:21 INFO - 2015-10-28 15:53:21,793 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;133;134;136;133;133;138;132;132;133 15:53:21 INFO - 2015-10-28 15:53:21,793 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;60;60;60;59;60;60;60;61;62;62 15:53:21 INFO - 2015-10-28 15:53:21,793 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:53:21 INFO - 2015-10-28 15:53:21,793 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:53:21 INFO - 2015-10-28 15:53:21,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,897 15:53:21 INFO - 2015-10-28 15:53:21,794 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:53:21 INFO - 2015-10-28 15:53:21,794 DEBUG : BROWSER_OUTPUT: __startTimestamp1446072801789__endTimestamp 15:53:21 INFO - 2015-10-28 15:53:21,794 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,801 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:109.50 stddev:2.72 (2.5%) stddev-sans-first:2.35 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: Values: 105.0 109.0 110.0 110.0 109.0 109.0 116.0 109.0 110.0 108.0 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.20 Median:147.00 stddev:17.89 (12.2%) stddev-sans-first:18.96 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: Values: 143.0 120.0 151.0 164.0 122.0 154.0 143.0 121.0 167.0 127.0 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 159.0 160.0 160.0 161.0 159.0 161.0 161.0 160.0 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.90 Median:71.00 stddev:33.84 (47.7%) stddev-sans-first:35.34 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 147.0 72.0 71.0 70.0 72.0 155.0 71.0 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.40 Median:87.50 stddev:20.67 (23.6%) stddev-sans-first:21.43 15:53:21 INFO - 2015-10-28 15:53:21,802 DEBUG : BROWSER_OUTPUT: Values: 88.0 88.0 131.0 87.0 87.0 88.0 131.0 87.0 88.0 129.0 15:53:21 INFO - 2015-10-28 15:53:21,803 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,803 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:53:21 INFO - 2015-10-28 15:53:21,803 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 15:53:21 INFO - 2015-10-28 15:53:21,803 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,803 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:53:21 INFO - 2015-10-28 15:53:21,803 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 145.0 145.0 147.0 145.0 145.0 146.0 15:53:21 INFO - 2015-10-28 15:53:21,803 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:3.97 (7.4%) stddev-sans-first:4.08 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: Values: 51.0 56.0 54.0 53.0 52.0 52.0 52.0 54.0 64.0 50.0 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:61.50 stddev:1.85 (3.0%) stddev-sans-first:1.94 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 61.0 62.0 67.0 62.0 61.0 61.0 62.0 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.00 stddev:2.07 (2.7%) stddev-sans-first:2.12 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 77.0 78.0 79.0 78.0 78.0 78.0 79.0 84.0 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:111.50 stddev:4.48 (4.0%) stddev-sans-first:4.43 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: Values: 115.0 106.0 107.0 105.0 108.0 110.0 113.0 119.0 113.0 108.0 15:53:21 INFO - 2015-10-28 15:53:21,804 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,805 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.90 Median:133.50 stddev:1.91 (1.4%) stddev-sans-first:1.99 15:53:21 INFO - 2015-10-28 15:53:21,805 DEBUG : BROWSER_OUTPUT: Values: 135.0 133.0 134.0 136.0 133.0 133.0 138.0 132.0 132.0 133.0 15:53:21 INFO - 2015-10-28 15:53:21,805 DEBUG : BROWSER_OUTPUT: 15:53:21 INFO - 2015-10-28 15:53:21,805 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 15:53:21 INFO - 2015-10-28 15:53:21,805 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 60.0 59.0 60.0 60.0 60.0 61.0 62.0 62.0 15:53:21 INFO - 2015-10-28 15:53:21,805 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:53:21 INFO - 2015-10-28 15:53:21,805 DEBUG : BROWSER_OUTPUT: 15:53:22 INFO - 2015-10-28 15:53:22,617 INFO : Browser exited with error code: 0 15:53:22 INFO - 2015-10-28 15:53:22,665 INFO : Completed test kraken (00:00:57) 15:53:22 INFO - 2015-10-28 15:53:22,665 INFO : Starting test v8_7 15:53:22 INFO - 2015-10-28 15:53:22,665 DEBUG : operating with platform_type : linux_ 15:53:22 INFO - 2015-10-28 15:53:22,665 INFO : Initialising browser for v8_7 test... 15:53:22 INFO - 2015-10-28 15:53:22,671 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY7J8rS/profile http://localhost/getInfo.html 15:53:26 INFO - 2015-10-28 15:53:26,021 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:53:26 INFO - 2015-10-28 15:53:26,021 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:53:26 INFO - 2015-10-28 15:53:26,021 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:53:26 INFO - 2015-10-28 15:53:26,021 DEBUG : BROWSER_OUTPUT: __metrics 15:53:26 INFO - 2015-10-28 15:53:26,097 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:27 INFO - 2015-10-28 15:53:27,290 INFO : Browser initialized. 15:53:27 INFO - 2015-10-28 15:53:27,291 INFO : Running cycle 1/1 for v8_7 test... 15:53:27 INFO - 2015-10-28 15:53:27,291 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY7J8rS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:53:38 INFO - 2015-10-28 15:53:38,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 131670016 15:53:38 INFO - 2015-10-28 15:53:38,950 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/v8_7/run.html (next: http://localhost/page_load_test/v8_7/run.html) 15:54:00 INFO - 2015-10-28 15:54:00,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 430678016 15:54:00 INFO - 2015-10-28 15:54:00,592 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,593 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: |0;Richards;167.8697330871244 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.58196181698486 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.0567734682406 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 15:54:00 INFO - 2015-10-28 15:54:00,594 DEBUG : BROWSER_OUTPUT: |4;RayTrace;953.2888465204957 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: |5;Earley;539.6654074473827 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: |6;Boyer;10319.58762886598 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: |7;RegExp;23255.81395348837 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: |8;Splay;538.2131324004306 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: __startTimestamp1446072840592__endTimestamp 15:54:00 INFO - 2015-10-28 15:54:00,595 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: Values: 167.9 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.58 Median:164.58 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: Values: 164.6 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: Values: 281.1 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,596 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: Values: 5154.6 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:953.29 Median:953.29 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: Values: 953.3 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:539.67 Median:539.67 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: Values: 539.7 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10319.59 Median:10319.59 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: Values: 10319.6 15:54:00 INFO - 2015-10-28 15:54:00,597 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,598 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23255.81 Median:23255.81 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,598 DEBUG : BROWSER_OUTPUT: Values: 23255.8 15:54:00 INFO - 2015-10-28 15:54:00,598 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,599 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:538.21 Median:538.21 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,599 DEBUG : BROWSER_OUTPUT: Values: 538.2 15:54:00 INFO - 2015-10-28 15:54:00,599 DEBUG : BROWSER_OUTPUT: 15:54:00 INFO - 2015-10-28 15:54:00,599 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 15:54:00 INFO - 2015-10-28 15:54:00,599 DEBUG : BROWSER_OUTPUT: Values: 4822.1 15:54:00 INFO - 2015-10-28 15:54:00,599 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:54:00 INFO - 2015-10-28 15:54:00,599 DEBUG : BROWSER_OUTPUT: 15:54:01 INFO - 2015-10-28 15:54:01,425 INFO : Browser exited with error code: 0 15:54:01 INFO - 2015-10-28 15:54:01,439 INFO : Completed test v8_7 (00:00:38) 15:54:01 INFO - 2015-10-28 15:54:01,440 INFO : Completed test suite (00:20:10) 15:54:01 INFO - 2015-10-28 15:54:01,440 DEBUG : Working with test: dromaeo_css 15:54:01 INFO - 2015-10-28 15:54:01,440 DEBUG : Generating results file: dromaeo_css 15:54:01 INFO - 2015-10-28 15:54:01,441 DEBUG : Working with test: kraken 15:54:01 INFO - 2015-10-28 15:54:01,441 DEBUG : Generating results file: kraken 15:54:01 INFO - 2015-10-28 15:54:01,441 INFO : javascript benchmark 15:54:01 INFO - 2015-10-28 15:54:01,441 DEBUG : Working with test: v8_7 15:54:01 INFO - 2015-10-28 15:54:01,441 DEBUG : Generating results file: v8_7 15:54:01 INFO - 2015-10-28 15:54:01,441 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:54:01 INFO - 2015-10-28 15:54:01,511 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 15:54:01 INFO - 2015-10-28 15:54:01,511 DEBUG : process_Request line: dromaeo_css 7358.06 graph.html#tests=[[72,52,35]] 15:54:01 INFO - 2015-10-28 15:54:01,511 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:54:01 INFO - 2015-10-28 15:54:01,545 DEBUG : process_Request line: kraken 1447.90 graph.html#tests=[[232,52,35]] 15:54:01 INFO - 2015-10-28 15:54:01,545 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:54:01 INFO - 2015-10-28 15:54:01,585 DEBUG : process_Request line: v8_7 23363.62 graph.html#tests=[[230,52,35]] 15:54:01 INFO - 2015-10-28 15:54:01,588 INFO : javascript benchmark 15:54:01 INFO - 2015-10-28 15:54:01,592 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [408.31607058177565, 414.7179917655994, 416.7353730381209, 417.5511325325276, 420.451311039094, 15021.0, 15445.150516721576, 18822.153003114858, 18882.811171888294, 19394.806051939475, 16707.164641767893, 18403.263869445207, 18663.813361866378, 19353.129109190086, 19360.0, 5736.024875771119, 5879.823605291826, 5881.617694849821, 5881.67650779207, 5883.529317654598, 4174.666026717855, 4676.508966558514, 5807.01280782268, 6410.1666783318105, 6436.967815160918, 5287.074761916669, 6308.463780578656, 6314.46327062198, 6323.77866774663, 6348.650824204667, 5334.786608535674, 5352.795620985286, 5353.437889021636, 5361.410244873041, 5367.624266301361, 4621.953780462186, 4667.696599721041, 4680.3915490985955, 4684.203685373494, 4686.601638860701, 15302.770458443021, 15436.305366258433, 15506.689866202725, 15663.451779187788, 15672.0, 2240.1487434774845, 2294.73610534789, 2340.976590234093, 2358.716953965518, 2377.679013333195, 10933.671989840317, 10948.835767463494, 11008.504617292241, 11225.550977960871, 11271.774564508745, 1791.70436877915, 1833.5049536625036, 1857.8606604504716, 1906.3327835257687, 1906.494778883597, 69413.65293173552, 69989.30010699929, 71567.0, 71685.64157179232, 72293.63853180753, 7872.134065252818, 7883.763487095396, 7883.881741773878, 7976.0, 7988.640511177011, 9687.17658998979, 9689.321747477608, 9697.418154910727, 9708.514574271258, 9711.708648740549, 6383.489320854321, 6398.712057957403, 6418.775342862978, 6423.678816059179, 6439.8068057958335, 6706.7652632158615, 6723.0, 6741.662916854138, 6752.5948443093575, 6777.220619628806, 3402.1834759657504, 3664.04734768962, 3691.372466680617, 3692.5199724036243, 3718.2377612589894, 1279.5457612547411, 1285.7878450055823, 1287.189070885355, 1292.134270039076, 1294.8640392758814, 510.6884800271831, 521.434243845432, 531.8617159538547, 535.7963973689973, 538.4507802041895, 12155.0, 13164.736705265841, 13742.93128534371, 13831.723365532633, 14202.644933876736, 554.2960440240871, 567.1577707104946, 569.4789267819981, 569.851838521979, 592.7865968251426, 6625.238097618739, 7043.401310888529, 7416.888746668804, 7523.548587084792, 7540.773776786705, 638074.0, 642552.0, 651383.0, 672337.0, 678320.0, 82635.0, 83342.58328708318, 84250.0, 86761.0, 89167.0, 602.286290745468, 610.2798697536861, 612.1277180018367, 612.8130920069333, 613.6716856481761, 11976.28142311464, 12173.817392738938, 12386.938065309616, 12429.12996090265, 12492.812607810709, 40175.59824401719, 40538.0, 40744.79627601843, 41561.168776623694, 42129.157416852104, 51537.22694159666, 52830.0, 54047.18929215986, 54065.0, 54398.72800635971, 7701.422393320411, 7752.922470775446, 7938.801529961797, 7940.920590794018, 7941.722039728582, 10599.205059620404, 12782.169159004636, 13482.595522134352, 13842.0, 14201.502947396792, 11874.525018999144, 11885.881141188824, 12003.09834258544, 12047.75904481923, 12049.096317776377, 11948.163628545919, 12114.697132571757, 12198.32909190003, 12210.26738395699, 12325.876741232833, 12064.396780160781, 12443.688907777378, 12478.563250286197, 12667.239965602093, 12690.0, 7746.070471543451, 7780.221977802401, 7849.058113026474, 7850.0972388173805, 7855.096663883726, 11905.047596192457, 11909.880901190878, 12225.449854756735, 12250.571230006906, 12391.814122788346], "dojo.html": [3283.720883724883, 3316.1046517440277, 3396.7112795412404, 3404.1829960809396, 3423.332450172217, 5565.582581306403, 5602.4117467665865, 5611.523020543259, 5614.29821272341, 5623.662580245188, 5620.57845661576, 5660.745266463009, 5679.148127780835, 5694.658320500773, 5696.401877802823, 5042.319286896277, 5090.363704536933, 5137.229415587654, 5148.871278218037, 5224.346956630421, 5140.280360749498, 5143.897122057557, 5148.099082660538, 5158.742062896859, 5159.974200129013, 5032.245163225527, 5106.183010718286, 5108.540231379176, 5133.153029750087, 5177.611679124062, 5152.639315247934, 5167.509086636764, 5170.638055336128, 5173.793048278046, 5189.065968125736, 4939.185034469308, 5123.359580052494, 5123.718195499246, 5172.767225474862, 5200.635955483118, 5247.86880327991, 5323.600729945231, 5403.675779453206, 5411.864703382407, 5429.891402171974, 6025.216721826135, 6065.818025459199, 6065.909011364833, 6066.696665166768, 6080.574359794816, 5879.882402351929, 5993.101034844764, 6095.116208149793, 6099.207103076572, 6100.267967843843, 5533.059379905426, 5592.440755924456, 5595.384507704109, 5601.915971260434, 5622.718864056822, 6114.847128821726, 6115.571909966259, 6129.417705317987, 6133.44798968095, 6136.631802091889, 5754.9424505754405, 5848.0, 5954.3783956534835, 5972.671503067286, 5973.671448070398, 6019.849503762353, 6023.909641355383, 6031.638101713911, 6073.635581865102, 6088.786892458743, 6004.159417681528, 6004.54965877561, 6005.459508644243, 6011.09833524966, 6029.0, 5842.0, 5966.940330596639, 5967.224260846062, 5997.220361353084, 6072.969635151796, 4591.770411479412, 4591.977040114778, 4599.965007873202, 4605.539446055368, 4630.675852690347, 4115.691323150776, 4121.402396652468, 4122.525909520384, 4142.171565686875, 4142.2543942090115, 5625.887482250332, 5726.942730572641, 5739.512141467939, 5829.417058294137, 5842.123681447817, 5923.822285331447, 6072.878542429126, 6087.512998960073, 6090.056041313604, 6098.481629061491, 5862.443067908542, 5891.204687367236, 5898.115282707542, 5902.321233058167, 5907.527397808165, 5153.974230128901, 5172.431032586413, 5204.583633309327, 5230.267762513251, 5237.188235823453, 6366.236051673736, 6367.42693157618, 6374.107624932513, 6378.107065010902, 6396.168498095218, 5942.940570594239, 6106.6336019838955, 6108.511319094373, 6112.0, 6128.264608247039, 6164.3835616438, 6199.907001394892, 6262.0, 6262.185915830913, 6276.560640755286, 5962.0, 5969.7313620888035, 5970.402959703995, 6001.909971350346, 6015.0676645120075, 5785.82642520725, 5893.0, 6064.120702498025, 6068.8786224276155, 6080.148779170831, 5838.095095260242, 5890.52875769946, 5896.3514013457625, 5897.587168898136, 5910.52715782745, 5851.61964472308, 5897.5281977440845, 5939.643621382731, 5945.851353716192, 5947.583669143119, 5544.916826247529, 5607.775688972395, 5647.068233741551, 5801.622894512012, 5803.767849285981, 5952.166696662557, 5955.583109182316, 5970.253718285215, 5981.0, 5991.460768530853, 5792.189093526994, 5799.710014499174, 5838.32859221195, 5845.035569131216, 5851.063829787214], "mootools.html": [1493.3727834309589, 1633.0691505841667, 1838.2003828334675, 1984.1369004483042, 2014.4774980169523, 8388.538630375328, 9187.862182067265, 9341.346105772598, 9351.48566828825, 9359.157675809176, 9101.408408453446, 9192.31057670674, 9198.586063627135, 9243.676471323504, 9336.719898403042, 2139.5827813576357, 2168.609650262952, 2380.8571485710827, 2387.7731615496587, 2473.863937483438, 2466.7163276223287, 2521.0798058708624, 2528.4184637533376, 2532.8860201290986, 2534.4550921551863, 2377.619580867062, 2403.8677872716994, 2422.2369953464604, 2426.7087949446004, 2433.0, 2144.6997420361163, 2179.411558879102, 2431.8784060797066, 2485.453200295932, 2497.962530562043, 2456.57010023247, 2475.7771800537857, 2483.888225029878, 2484.0560586976835, 2497.625356196567, 9565.473898935556, 9635.13283804461, 9669.0, 9709.61161553537, 9722.222222222204, 5579.553635709133, 5622.465865742748, 5640.464155905182, 5648.124540696199, 5649.604527683064, 3545.4150065239205, 3559.94660080099, 3639.508666330038, 3790.9620903790883, 3805.6955443564448, 1269.092598791859, 1277.9488820447264, 1305.5561109222815, 1316.1313533068128, 1319.5579480873919, 14359.0, 14379.928100359535, 14384.928075359661, 14395.352209150613, 14398.352074156688, 4963.329950456714, 4979.3526841510375, 4990.975045124751, 5055.949440505621, 5064.7214403207445, 11292.491837867316, 11329.773404531863, 11331.716707082223, 11336.773264534828, 11338.376389298668, 5683.658980461103, 5688.573356998241, 5692.829215123553, 5696.772129114789, 5697.344805347355, 5148.485151484896, 5155.200943853633, 5158.664686795421, 5160.690358578498, 5171.922421163686, 4296.119295544406, 4302.82788688449, 4316.287812510964, 4338.869833904988, 4377.78111094444, 1322.9338533073308, 1332.9333533323488, 1337.8862796662197, 1348.6426097084282, 1355.1394864261067, 1465.2087872548918, 1482.8443013483645, 1496.393960446021, 1507.186119495482, 1527.2821773766311, 9240.630374784932, 9295.814083718287, 9312.115349041831, 9321.953390233006, 9332.06679332075, 556.5964675610151, 567.0275477556012, 569.8233547600257, 572.977080916767, 573.6128113523355, 7032.437405007587, 7116.608586527791, 7146.0, 7149.0, 7532.17146113927, 12284.754304913851, 12404.0, 12425.875741242653, 12426.068044896669, 12450.75098498025, 12190.2076365036, 12328.0, 12424.440900159514, 12520.186187897758, 12524.561640342545, 8655.783605409915, 9202.401843880127, 9269.629214831466, 9294.581743821544, 9298.628054877865, 9078.137576930181, 9099.408538444979, 9125.589348479201, 9136.26909847224, 9141.588628511867, 10348.637797677045, 10471.68584942453, 10565.735856603646, 10614.1508679307, 10619.94690026545, 10705.715314162351, 10848.40333781618, 10886.346819190874, 10903.945480272865, 10915.781684366428, 8616.310695144248, 8648.827023459622, 8713.30293576525, 8716.215540601377, 8728.825423491367, 9559.235261179228, 9657.0, 9667.854982175413, 9672.709818705169, 9677.951610241904, 7276.163241227327, 8845.4250473719, 8848.823023539364, 9028.18746312835, 9111.498867562083, 8534.189252021048, 8589.52757598338, 8712.564371781513, 8740.257078148428, 8816.426932249384, 8740.694075707319, 8754.21212090915, 8778.34162437807, 8788.648454061766, 8797.076306987674, 7844.058712954482, 7860.3318717909615, 7993.72021979228, 8002.599870006593, 8012.359011278967, 7942.444028918151, 7949.562774047483, 7966.362690984592, 7968.960155199187, 7985.0], "ext.html": [605.772835186805, 644.9226092868856, 652.6019128331717, 653.4184575727601, 662.5329142954216, 36029.27941441169, 45816.312755308696, 46288.30567541489, 46542.534574654244, 46620.76689616556, 49509.75245123769, 49990.0, 50008.0, 50053.49946500534, 50212.74893625536, 7983.680652773882, 8083.0, 9244.306676999235, 9416.058394160564, 10773.730656733565, 10954.452277386139, 10968.890311096866, 11073.778524429506, 11077.50151243192, 11077.778444431107, 10826.891731082707, 10923.962223588745, 10930.56277748889, 10932.890671093306, 10935.726606834813, 10837.078848297904, 10868.891311086867, 10875.891241087567, 10905.127589792797, 10962.287451315678, 10651.467426628715, 10735.463226838705, 10738.463076846205, 10783.730406739816, 10812.513436895359, 46129.0, 46525.0, 46602.766986164854, 46745.532544674796, 46794.76602616999, 3826.502554667903, 3888.338982372975, 3899.805009749501, 3969.980150099231, 4218.282891908383, 34359.828200858836, 34698.0, 35017.29965400703, 35065.29869402598, 35154.0, 3862.729608927348, 3903.258380907647, 3973.6821054315587, 3998.1204135090234, 4032.5362583303004, 361316.0, 361959.0, 361986.0, 362043.0, 363749.0, 58226.70886645625, 59628.70185649131, 66177.66911165413, 66959.66520167368, 67056.66471667709, 65501.67249163819, 65507.0, 65786.0, 65793.34206657967, 65803.67098164478, 16527.091009994565, 16605.750913736305, 16708.248128833988, 16768.245428955724, 16895.07077110771, 15181.16503592291, 15518.767218491732, 15523.767143492856, 15524.14617196065, 15526.223688815515, 21280.148794048375, 21513.462163445725, 21564.676529852066, 21584.352469425943, 21591.352259432242, 7766.223377662302, 7990.200979901963, 8060.717874874351, 8070.314023308085, 8115.229053239933, 989.9950500247453, 1135.4039129456935, 1135.5968631135827, 1168.182272409317, 1271.7075072733323, 32057.51913721296, 32084.839575802438, 32469.350612987608, 33053.504197436574, 33132.66867331344, 1195.3007490618086, 1234.703671118925, 1268.3594784633885, 1272.9816147082297, 1292.0051560298705, 14172.645683857985, 16849.49451516432, 16964.491065268063, 17254.741178882326, 17772.91113544424, 304945.0, 307006.0, 309564.0, 309763.0, 310336.0, 58820.882538222766, 59184.11223831646, 59724.402755972755, 60441.395586044455, 61572.38427615666, 1429.1496559547054, 1441.7837324401423, 1442.2572375226766, 1445.595233334647, 1452.4916279302372, 32673.509897351083, 32686.83656581702, 33011.0, 33770.49344259887, 33796.831015844764, 49921.50078499169, 51131.23303150381, 56735.0, 58093.128603070145, 58153.4184658148, 269963.0, 270328.0, 271292.0, 272466.0, 272616.0, 33482.66517334795, 33721.49417758785, 33742.32515349728, 33799.49300760441, 33801.49297760585, 45842.0, 46765.29852052154, 46811.0, 46840.53159468498, 46973.76513117413, 41167.1766564661, 41872.581274186865, 42172.789136054125, 42383.94040149021, 42922.35616465818, 42452.0, 42582.57417425786, 42997.785011076, 43550.346744799484, 43588.34617480677, 42468.0, 42856.57143428526, 43195.0, 43278.567214328716, 43570.34644480272, 37276.44085338668, 37390.62609373871, 37622.0, 38068.0, 38196.80901595474, 29156.562651560667, 29395.7060429393, 29413.70586294195, 29477.557836632895, 29484.11547653574], "prototype.html": [384.9037740564858, 384.95957924417917, 387.9495665563478, 389.4644863312945, 393.3293734183216, 5866.501347385467, 5961.88076238475, 5983.700814959251, 6019.879602407949, 6029.487493563041, 5843.152742852284, 5931.970340148293, 5943.167956486084, 5959.582829201958, 5966.254218222723, 4758.952410475903, 4763.285507173917, 4766.475687674353, 4769.427668679763, 4771.665983381165, 4603.10239503297, 4676.532346765331, 4677.6959497632715, 4758.976205118969, 4797.808087676489, 4711.952880471185, 4728.267118596623, 4731.0, 4739.194336962724, 4761.047790441926, 4694.624430045588, 4720.315554244649, 4721.3862197914395, 4738.620910327166, 4741.95258047422, 4272.935905961382, 4273.059926816096, 4274.829006839723, 4277.700560960734, 4291.8068686908855, 5552.944470555283, 5634.042212823789, 5651.32184137902, 5657.1514272858985, 5673.744681489343, 5591.832245032656, 5595.720213989284, 5596.608237423382, 5599.720013999284, 5602.327720673505, 6396.712147953353, 6428.967855160694, 6431.035344698286, 6432.163818703585, 6435.066915297256, 4671.229247174246, 4755.595774359183, 4757.024809913959, 4761.785719642589, 4769.785359658824, 6533.314002029813, 6601.70292336846, 6603.93396066038, 6604.6697665117035, 6614.503912206652, 4916.754162291871, 4917.532834380728, 4918.754062296943, 4919.2867034279825, 4919.77860996256, 4967.801287948514, 4969.254611808257, 4971.950280497221, 4972.328735620717, 4972.602191824645, 5475.890482190334, 5562.332520097533, 5567.944320556823, 5576.330840299109, 5576.525995290446, 6401.263854656774, 6444.130042444303, 6455.7740479083, 6460.127882735865, 6468.223813142359, 1776.6269083492612, 1806.060848358846, 1806.7470554122433, 1807.268056437145, 1809.2039502618807, 1255.5354518828092, 1257.1577043380958, 1262.3498898067503, 1284.0, 1288.7809072457705, 6311.431971122621, 6324.557280990287, 6326.43062124411, 6326.4622507087415, 6335.3981371769605, 6411.519136064814, 6487.7080531376205, 6529.934700652932, 6616.4045235929, 6623.602583844985, 6280.246370435577, 6295.213098362705, 6301.275353334334, 6304.495640348761, 6310.968445157745, 3614.2590768892314, 3640.399334109842, 3646.762960407565, 3647.0517665406655, 3649.489071529988, 6841.076454678654, 6958.547694399847, 6978.371946524736, 6999.23008469068, 7006.369426751617, 6808.38724514796, 6836.658167091626, 6848.075509806212, 6848.3494068063455, 6849.657517124124, 6947.548409353376, 6951.2353641099435, 6953.269906659728, 6961.721531138698, 6967.790966270919, 6534.379233972765, 6630.53586248958, 6632.50256230775, 6636.369544893228, 6645.700943457653, 6538.542302038812, 6554.8361290968105, 6555.115059466911, 6555.672216389066, 6560.343965603402, 6847.863042739217, 6909.792706218822, 6942.652867356511, 6951.0616066830335, 6971.930280697331, 4822.8794280143275, 4898.755062246944, 4901.6323775716255, 4904.2643603459765, 4915.483874193301, 6582.3746744059235, 6590.47276217911, 6631.038499417654, 6662.367075128049, 6662.56693314933, 6411.4229719325485, 6416.711247993758, 6418.037294405876, 6439.613623182624, 6455.2576453708425, 6303.149074875017, 6461.256955450183, 6462.127612772216, 6469.159009328945, 6476.967615162082, 6292.52806039558, 6295.024271237966, 6300.180976473029, 6302.086197501429, 6303.338149494237, 6425.132607098169, 6447.0, 6475.514336424692, 6476.352364763486, 6479.708413121515, 6133.50931925436, 6174.598651087665, 6210.782622608187, 6215.875682486235, 6307.779227727007], "yui.html": [824.7113510271402, 832.9671207702444, 840.6805413942701, 947.3510645208031, 947.4492703352246, 13783.862161378383, 13854.168749875002, 13941.790873136886, 14022.929885350584, 14038.859611403883, 13198.53805116821, 13794.241316727575, 13815.51645692401, 13846.584602461942, 13846.653833654163, 787.9054513458365, 793.5000949401868, 944.2870632672323, 955.068807912287, 956.5504213019905, 948.8292107420662, 964.1563631822156, 973.3381300715511, 973.595957677563, 974.6539978307705, 989.6585677941134, 1009.1119814563174, 1010.7675234696025, 1010.959561617538, 1011.2163073617968, 819.1890028871404, 827.0530242871909, 981.9361741486781, 987.5457289646771, 995.721198064543, 732.0300601702766, 733.2630706140295, 733.3326672727792, 733.9522931009467, 734.533571182303, 13992.16047037181, 14145.929270353685, 14148.151110933273, 14149.363278652485, 14156.575302740934, 12011.399430028463, 12185.451654675473, 12263.509459621604, 12298.812959271718, 12303.261804291771, 10789.946050269777, 10874.945625271823, 11015.889841101647, 11018.338899666045, 11067.667969960914, 3667.2665466906724, 3697.2975134724315, 3713.8885833425043, 3746.9063273418383, 3790.2419516096893, 45422.77288613536, 45498.54501454976, 45536.08927821458, 46502.0, 46577.53422465766, 10152.949235253924, 10459.058684718411, 10464.162866970624, 10527.789444211074, 10578.365298081986, 19029.333973311146, 19088.33190838314, 19088.522786930436, 19109.426717198505, 19115.23539058422, 8041.718539851077, 8067.959660201779, 8109.75670729879, 8241.8351632967, 8249.463784853966, 4538.92388229623, 4667.6265898728025, 4690.413698287714, 4768.070226305837, 4778.95221047792, 3225.4355487790012, 3254.316593515341, 3257.820819854931, 3261.2010057536054, 3267.2485328374605, 521.4264309259784, 528.2261486921678, 528.2736237673199, 530.2364594983212, 532.475511621053, 593.9970300148472, 606.9635821850703, 693.968771405288, 698.1099098649263, 708.7909066825196, 8519.914800852037, 8794.472331660121, 8799.164079412445, 9471.384360016576, 9595.664151754656, 719.639880625618, 733.3070248615007, 734.3134169551487, 753.4499815134982, 769.9769006929689, 4020.4572382727956, 4222.619964203175, 4263.488381394191, 4300.462442194726, 4385.429894113745, 54655.0, 54668.45331546634, 54716.179257311174, 54936.725316373166, 54957.450425496034, 47164.0, 47241.76379118151, 47474.762626186646, 47485.525144748804, 47714.28428573574, 37996.62003379986, 38411.80794096012, 38969.2206155881, 38970.80514597409, 39664.80167599144, 8574.742757717278, 8623.267022303175, 9181.816363672555, 9288.953555232181, 9329.813403732023, 27224.591631125153, 27673.308167295174, 28524.286892827844, 28636.14091577256, 28659.426811464073, 37597.62402375941, 37742.73543587283, 38162.42756358712, 39932.60067399405, 39953.80023099866, 8282.461639993382, 8521.744347669579, 8576.056633770406, 8615.138486151334, 8617.69838055665, 12905.354732263537, 12958.611241662766, 12976.610701678965, 13114.60656180316, 13224.933875330562, 11743.29540227555, 11787.469563869476, 11798.41007949582, 12275.017998560272, 12446.190997585129, 11862.881371186179, 12046.578369757017, 12089.032877369613, 12129.75317711397, 12521.56174533887, 11399.373034482851, 11550.94224528872, 11562.248453850472, 11607.30356178632, 12077.698057548632, 9389.342746007987, 9715.677502733926, 9904.260148972935, 9967.40195588267, 9977.50112494358, 9702.126808587262, 10053.346532475365, 10061.69814905554, 10085.546150423103, 10121.493925303852]}, "summary": {"suite": 7358.065351946967, "subtests": {"jquery.html": {"std": 107255.93936123012, "min": 408.31607058177565, "max": 678320.0, "median": 7911.341635867838, "filtered": 7949.039828813095, "mean": 31932.982948162247}, "dojo.html": {"std": 628.6265392543586, "min": 3283.720883724883, "max": 6396.168498095218, "median": 5845.035569131216, "filtered": 5563.899941266574, "mean": 5605.32670177405}, "mootools.html": {"std": 3750.055771954149, "min": 556.5964675610151, "max": 14398.352074156688, "median": 7957.962732516037, "filtered": 5311.821909598119, "mean": 6749.777942847767}, "ext.html": {"std": 82191.68649063486, "min": 605.772835186805, "max": 363749.0, "median": 32848.91828290851, "filtered": 21048.035955960782, "mean": 51285.78516836192}, "prototype.html": {"std": 1561.8136580623936, "min": 384.9037740564858, "max": 7006.369426751617, "median": 6081.4984064087, "filtered": 4972.433608455305, "mean": 5456.345395552596}, "yui.html": {"std": 14320.124527517684, "min": 521.4264309259784, "max": 54957.450425496034, "median": 9972.451540413123, "filtered": 6453.9889129001, "mean": 13186.415792618162}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-028"}, "testrun": {"date": 1446071631, "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": "43.0a2", "id": "20151028130740", "branch": "Mozilla-Aurora", "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 159.0, 160.0, 160.0, 161.0, 159.0, 161.0, 161.0, 160.0], "ai-astar": [105.0, 109.0, 110.0, 110.0, 109.0, 109.0, 116.0, 109.0, 110.0, 108.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "audio-beat-detection": [143.0, 120.0, 151.0, 164.0, 122.0, 154.0, 143.0, 121.0, 167.0, 127.0], "json-stringify-tinderbox": [61.0, 61.0, 61.0, 61.0, 62.0, 67.0, 62.0, 61.0, 61.0, 62.0], "stanford-crypto-pbkdf2": [135.0, 133.0, 134.0, 136.0, 133.0, 133.0, 138.0, 132.0, 132.0, 133.0], "json-parse-financial": [51.0, 56.0, 54.0, 53.0, 52.0, 52.0, 52.0, 54.0, 64.0, 50.0], "stanford-crypto-sha256-iterative": [60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 61.0, 62.0, 62.0], "audio-fft": [70.0, 70.0, 71.0, 147.0, 72.0, 71.0, 70.0, 72.0, 155.0, 71.0], "imaging-darkroom": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [115.0, 106.0, 107.0, 105.0, 108.0, 110.0, 113.0, 119.0, 113.0, 108.0], "audio-oscillator": [88.0, 88.0, 131.0, 87.0, 87.0, 88.0, 131.0, 87.0, 88.0, 129.0], "stanford-crypto-aes": [77.0, 77.0, 77.0, 78.0, 79.0, 78.0, 78.0, 78.0, 79.0, 84.0], "imaging-desaturate": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"suite": 1447.9000000000003, "subtests": {"audio-fft": {"std": 32.10747576499903, "min": 70.0, "max": 155.0, "median": 71.0, "filtered": 86.9, "mean": 86.9}, "stanford-crypto-pbkdf2": {"std": 1.8138357147217055, "min": 132.0, "max": 138.0, "median": 133.0, "filtered": 133.9, "mean": 133.9}, "audio-beat-detection": {"std": 16.96938419625179, "min": 120.0, "max": 167.0, "median": 143.0, "filtered": 141.2, "mean": 141.2}, "stanford-crypto-ccm": {"std": 4.24735211631906, "min": 105.0, "max": 119.0, "median": 109.0, "filtered": 110.4, "mean": 110.4}, "imaging-darkroom": {"std": 0.66332495807108, "min": 145.0, "max": 147.0, "median": 145.0, "filtered": 145.4, "mean": 145.4}, "json-parse-financial": {"std": 3.7629775444453557, "min": 50.0, "max": 64.0, "median": 52.5, "filtered": 53.8, "mean": 53.8}, "audio-oscillator": {"std": 19.607141556075938, "min": 87.0, "max": 131.0, "median": 88.0, "filtered": 100.4, "mean": 100.4}, "ai-astar": {"std": 2.5787593916455256, "min": 105.0, "max": 116.0, "median": 109.0, "filtered": 109.5, "mean": 109.5}, "audio-dft": {"std": 0.9165151389911679, "min": 159.0, "max": 162.0, "median": 160.5, "filtered": 160.4, "mean": 160.4}, "stanford-crypto-sha256-iterative": {"std": 0.9165151389911679, "min": 59.0, "max": 62.0, "median": 60.0, "filtered": 60.4, "mean": 60.4}, "json-stringify-tinderbox": {"std": 1.7578395831246947, "min": 61.0, "max": 67.0, "median": 61.0, "filtered": 61.9, "mean": 61.9}, "imaging-gaussian-blur": {"std": 0.5, "min": 109.0, "max": 110.0, "median": 109.5, "filtered": 109.5, "mean": 109.5}, "stanford-crypto-aes": {"std": 1.9621416870348585, "min": 77.0, "max": 84.0, "median": 78.0, "filtered": 78.5, "mean": 78.5}, "imaging-desaturate": {"std": 0.45825756949558394, "min": 95.0, "max": 96.0, "median": 96.0, "filtered": 95.7, "mean": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-028"}, "testrun": {"date": 1446071631, "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": "43.0a2", "id": "20151028130740", "branch": "Mozilla-Aurora", "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.58196181698486], "Encrypt": [281.0567734682406], "NavierStokes": [4822.115384615385], "Decrypt": [5154.639175257732], "Splay": [538.2131324004306], "Richards": [167.8697330871244], "RegExp": [23255.81395348837], "Earley": [539.6654074473827], "Boyer": [10319.58762886598], "RayTrace": [953.2888465204957]}, "summary": {"suite": 23363.62299748019, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.58196181698486, "max": 164.58196181698486, "median": 164.58196181698486, "value": 401.7329680000002, "filtered": 401.7329680000002, "mean": 164.58196181698486}, "Encrypt": {"std": 0.0, "min": 281.0567734682406, "max": 281.0567734682406, "median": 281.0567734682406, "value": 947.0719979999998, "filtered": 947.0719979999998, "mean": 281.0567734682406}, "NavierStokes": {"std": 0.0, "min": 4822.115384615385, "max": 4822.115384615385, "median": 4822.115384615385, "value": 307.7487537387835, "filtered": 307.7487537387835, "mean": 4822.115384615385}, "Decrypt": {"std": 0.0, "min": 5154.639175257732, "max": 5154.639175257732, "median": 5154.639175257732, "value": 51.63911399999997, "filtered": 51.63911399999997, "mean": 5154.639175257732}, "Splay": {"std": 0.0, "min": 538.2131324004306, "max": 538.2131324004306, "median": 538.2131324004306, "value": 151.41027799999995, "filtered": 151.41027799999995, "mean": 538.2131324004306}, "RegExp": {"std": 0.0, "min": 23255.81395348837, "max": 23255.81395348837, "median": 23255.81395348837, "value": 39.17235499999998, "filtered": 39.17235499999998, "mean": 23255.81395348837}, "Richards": {"std": 0.0, "min": 167.8697330871244, "max": 167.8697330871244, "median": 167.8697330871244, "value": 210.29401399999998, "filtered": 210.29401399999998, "mean": 167.8697330871244}, "Earley": {"std": 0.0, "min": 539.6654074473827, "max": 539.6654074473827, "median": 539.6654074473827, "value": 1234.9559390000002, "filtered": 1234.9559390000002, "mean": 539.6654074473827}, "Boyer": {"std": 0.0, "min": 10319.58762886598, "max": 10319.58762886598, "median": 10319.58762886598, "value": 64.58232867132864, "filtered": 64.58232867132864, "mean": 10319.58762886598}, "RayTrace": {"std": 0.0, "min": 953.2888465204957, "max": 953.2888465204957, "median": 953.2888465204957, "value": 776.2484609999998, "filtered": 776.2484609999998, "mean": 953.2888465204957}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-028"}, "testrun": {"date": 1446071631, "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": "43.0a2", "id": "20151028130740", "branch": "Mozilla-Aurora", "revision": "2f90ffb5ee459777a90e34cea18f6621157bf9c3"}}] 15:54:01 INFO - RETURN: dromaeo_css: 7358.06 15:54:01 INFO - RETURN: kraken: 1447.90 15:54:01 INFO - RETURN: v8_7: 23363.62 15:54:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23363.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1447.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7358.06"}}} 15:54:01 INFO - Return code: 0 15:54:01 INFO - # TBPL SUCCESS # 15:54:01 INFO - Running post-action listener: _resource_record_post_action 15:54:01 INFO - Running post-run listener: _resource_record_post_run 15:54:02 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 7458816; Write bytes: 427679744; Read time: 2624; Write time: 355440 15:54:02 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 479232; Read time: 0; Write time: 40 15:54:02 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 5283840; Write bytes: 409608192; Read time: 2488; Write time: 351588 15:54:02 INFO - Running post-run listener: _upload_blobber_files 15:54:02 INFO - Blob upload gear active. 15:54:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:54:02 INFO - Copying logs to upload dir... 15:54:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.087813 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-10-28 15:54:02.874871) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:54:02.878039) ========= 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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009819 build_url: 'https://queue.taskcluster.net/v1/task/Nn9cQE12Q4OwjCClEkvi4g/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:54:02.931173) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:54:02.931569) ========= 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=b00de3c228505fac2445e70d000001bb-1446071568.151688-718275075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:54:02.982212) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-28 15:54:02.982588) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-28 15:54:07.827971) =========