builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1446193178.41 results: success (0) buildid: 20151029012446 builduid: 3d43e8ca7be54163b739961a6150cca7 revision: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.410868) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.411284) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.411575) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005608 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.473728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.474001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.529808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.530210) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.039025 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.587819) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.588082) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.588462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.588745) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-30 01:19:38-- 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% 227M=0s 2015-10-30 01:19:38 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.295662 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.896692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.896985) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.226852 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.136295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.136646) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 --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 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 --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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-30 01:19:39,164 truncating revision to first 12 chars 2015-10-30 01:19:39,164 Setting DEBUG logging. 2015-10-30 01:19:39,164 attempt 1/10 2015-10-30 01:19:39,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5e1587041f9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-30 01:19:39,422 unpacking tar archive at: mozilla-aurora-5e1587041f9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585232 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.734558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.734874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.743200) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.743514) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.743916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-10-30 01:19:39.744244) ========= /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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:19:40 INFO - MultiFileLogger online at 20151030 01:19:40 in /builds/slave/test-pgo 01:19:40 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 01:19:40 INFO - Guessing talos json url... 01:19:40 INFO - Using buildbot properties: 01:19:40 INFO - { 01:19:40 INFO - "properties": { 01:19:40 INFO - "buildnumber": 18, 01:19:40 INFO - "product": "firefox", 01:19:40 INFO - "script_repo_revision": "production", 01:19:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:19:40 INFO - "repository": "", 01:19:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:19:40 INFO - "buildid": "20151029012446", 01:19:40 INFO - "slavename": "talos-linux64-ix-004", 01:19:40 INFO - "pgo_build": "True", 01:19:40 INFO - "basedir": "/builds/slave/test-pgo", 01:19:40 INFO - "project": "", 01:19:40 INFO - "platform": "ubuntu64_hw", 01:19:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:19:40 INFO - "slavebuilddir": "test", 01:19:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:19:40 INFO - "branch": "mozilla-aurora", 01:19:40 INFO - "repo_path": "releases/mozilla-aurora", 01:19:40 INFO - "stage_platform": "linux64-pgo", 01:19:40 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 01:19:40 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:40 INFO - }, 01:19:40 INFO - "sourcestamp": { 01:19:40 INFO - "repository": "", 01:19:40 INFO - "hasPatch": false, 01:19:40 INFO - "project": "", 01:19:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:40 INFO - "changes": [ 01:19:40 INFO - { 01:19:40 INFO - "category": null, 01:19:40 INFO - "files": [ 01:19:40 INFO - { 01:19:40 INFO - "url": null, 01:19:40 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 01:19:40 INFO - } 01:19:40 INFO - ], 01:19:40 INFO - "repository": "", 01:19:40 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 01:19:40 INFO - "who": "bobowencode@gmail.com", 01:19:40 INFO - "when": 1446115088, 01:19:40 INFO - "number": 6592843, 01:19:40 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 01:19:40 INFO - "project": "", 01:19:40 INFO - "at": "Thu 29 Oct 2015 03:38:08", 01:19:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:40 INFO - "revlink": "", 01:19:40 INFO - "properties": [ 01:19:40 INFO - [ 01:19:40 INFO - "buildid", 01:19:40 INFO - "20151029012446", 01:19:40 INFO - "Change" 01:19:40 INFO - ], 01:19:40 INFO - [ 01:19:40 INFO - "builduid", 01:19:40 INFO - "3d43e8ca7be54163b739961a6150cca7", 01:19:40 INFO - "Change" 01:19:40 INFO - ], 01:19:40 INFO - [ 01:19:40 INFO - "pgo_build", 01:19:40 INFO - "True", 01:19:40 INFO - "Change" 01:19:40 INFO - ] 01:19:40 INFO - ], 01:19:40 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:40 INFO - } 01:19:40 INFO - ], 01:19:40 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:40 INFO - } 01:19:40 INFO - } 01:19:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 01:19:40 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')]} 01:19:40 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 01:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:19:40 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:19:43 INFO - Downloaded 107 bytes. 01:19:43 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:43 INFO - Contents: 01:19:43 INFO - 20151029012446 01:19:43 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:43 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json 01:19:43 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 01:19:43 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 01:19:44 INFO - Downloaded 6818 bytes. 01:19:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:19:44 INFO - '../fennec_ids.txt'], 01:19:44 INFO - 'tests': ['tcheck2']}, 01:19:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:44 INFO - '--tppagecycles', 01:19:44 INFO - '7'], 01:19:44 INFO - 'tests': ['tsvgm']}}, 01:19:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:19:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:19:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:19:44 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:44 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:44 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:44 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:44 INFO - 'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:44 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'tests': ['damp', 'tps']}, 01:19:44 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['damp', 'tps']}, 01:19:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:19:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:44 INFO - 'other': {'tests': ['a11yr', 01:19:44 INFO - 'ts_paint', 01:19:44 INFO - 'tpaint', 01:19:44 INFO - 'sessionrestore', 01:19:44 INFO - 'sessionrestore_no_auto_restore']}, 01:19:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['a11yr', 01:19:44 INFO - 'ts_paint', 01:19:44 INFO - 'tpaint', 01:19:44 INFO - 'sessionrestore', 01:19:44 INFO - 'sessionrestore_no_auto_restore']}, 01:19:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['a11yr', 01:19:44 INFO - 'ts_paint', 01:19:44 INFO - 'tpaint', 01:19:44 INFO - 'sessionrestore', 01:19:44 INFO - 'sessionrestore_no_auto_restore']}, 01:19:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['a11yr', 01:19:44 INFO - 'ts_paint', 01:19:44 INFO - 'tpaint', 01:19:44 INFO - 'sessionrestore', 01:19:44 INFO - 'sessionrestore_no_auto_restore']}, 01:19:44 INFO - 'other_l64': {'tests': ['a11yr', 01:19:44 INFO - 'ts_paint', 01:19:44 INFO - 'tpaint', 01:19:44 INFO - 'sessionrestore', 01:19:44 INFO - 'sessionrestore_no_auto_restore']}, 01:19:44 INFO - 'other_nol64': {'tests': ['a11yr', 01:19:44 INFO - 'ts_paint', 01:19:44 INFO - 'tpaint', 01:19:44 INFO - 'sessionrestore', 01:19:44 INFO - 'sessionrestore_no_auto_restore']}, 01:19:44 INFO - 'svgr': {'tests': ['tsvgx', 01:19:44 INFO - 'tsvgr_opacity', 01:19:44 INFO - 'tart', 01:19:44 INFO - 'tscrollx', 01:19:44 INFO - 'cart']}, 01:19:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['tsvgx', 01:19:44 INFO - 'tsvgr_opacity', 01:19:44 INFO - 'tart', 01:19:44 INFO - 'tscrollx', 01:19:44 INFO - 'cart']}, 01:19:44 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:44 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:44 INFO - 'tests': ['tp5o']}, 01:19:44 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:44 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:44 INFO - 'talos_options': ['--e10s'], 01:19:44 INFO - 'tests': ['tp5o']}, 01:19:44 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:44 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:44 INFO - 'talos_options': ['--xperf_path', 01:19:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:44 INFO - 'tests': ['tp5n']}, 01:19:44 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 01:19:44 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:44 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:44 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:44 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:44 INFO - 'talos_options': ['--e10s', 01:19:44 INFO - '--xperf_path', 01:19:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 01:19:44 INFO - 'C:/slave/talos-data/talos/xperf.config'], 01:19:44 INFO - 'tests': ['tp5n']}}, 01:19:44 INFO - 'talos.zip': {'path': '', 01:19:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:19:44 INFO - {'append_to_log': False, 01:19:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:19:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:19:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:19:44 INFO - 'branch': 'Mozilla-Aurora', 01:19:44 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:44 INFO - 'config_files': ('talos/linux_config.py',), 01:19:44 INFO - 'default_actions': ('clobber', 01:19:44 INFO - 'read-buildbot-config', 01:19:44 INFO - 'download-and-extract', 01:19:44 INFO - 'populate-webroot', 01:19:44 INFO - 'create-virtualenv', 01:19:44 INFO - 'install', 01:19:44 INFO - 'run-tests'), 01:19:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:44 INFO - 'download_minidump_stackwalk': True, 01:19:44 INFO - 'download_symbols': 'ondemand', 01:19:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:44 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:44 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:44 INFO - 'installer_path': 'installer.exe', 01:19:44 INFO - 'log_level': 'info', 01:19:44 INFO - 'log_name': 'talos', 01:19:44 INFO - 'log_to_console': True, 01:19:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:19:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:19:44 INFO - 'opt_config_files': (), 01:19:44 INFO - 'pip_index': False, 01:19:44 INFO - 'python_webserver': False, 01:19:44 INFO - 'sps_profile': False, 01:19:44 INFO - 'sps_profile_interval': 0, 01:19:44 INFO - 'suite': 'dromaeojs', 01:19:44 INFO - 'system_bits': '64', 01:19:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:44 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 01:19:44 INFO - 'tests': (), 01:19:44 INFO - 'title': 'talos-linux64-ix-004', 01:19:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:44 INFO - 'use_talos_json': True, 01:19:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:19:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:44 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 01:19:44 INFO - 'work_dir': 'build'} 01:19:44 INFO - ##### 01:19:44 INFO - ##### Running clobber step. 01:19:44 INFO - ##### 01:19:44 INFO - Running pre-action listener: _resource_record_pre_action 01:19:44 INFO - Running main action method: clobber 01:19:44 INFO - rmtree: /builds/slave/test-pgo/build 01:19:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:19:50 INFO - Running post-action listener: _resource_record_post_action 01:19:50 INFO - ##### 01:19:50 INFO - ##### Running read-buildbot-config step. 01:19:50 INFO - ##### 01:19:50 INFO - Running pre-action listener: _resource_record_pre_action 01:19:50 INFO - Running main action method: read_buildbot_config 01:19:50 INFO - Using buildbot properties: 01:19:50 INFO - { 01:19:50 INFO - "properties": { 01:19:50 INFO - "buildnumber": 18, 01:19:50 INFO - "product": "firefox", 01:19:50 INFO - "script_repo_revision": "production", 01:19:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:19:50 INFO - "repository": "", 01:19:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:19:50 INFO - "buildid": "20151029012446", 01:19:50 INFO - "slavename": "talos-linux64-ix-004", 01:19:50 INFO - "pgo_build": "True", 01:19:50 INFO - "basedir": "/builds/slave/test-pgo", 01:19:50 INFO - "project": "", 01:19:50 INFO - "platform": "ubuntu64_hw", 01:19:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:19:50 INFO - "slavebuilddir": "test", 01:19:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:19:50 INFO - "branch": "mozilla-aurora", 01:19:50 INFO - "repo_path": "releases/mozilla-aurora", 01:19:50 INFO - "stage_platform": "linux64-pgo", 01:19:50 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 01:19:50 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:50 INFO - }, 01:19:50 INFO - "sourcestamp": { 01:19:50 INFO - "repository": "", 01:19:50 INFO - "hasPatch": false, 01:19:50 INFO - "project": "", 01:19:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:50 INFO - "changes": [ 01:19:50 INFO - { 01:19:50 INFO - "category": null, 01:19:50 INFO - "files": [ 01:19:50 INFO - { 01:19:50 INFO - "url": null, 01:19:50 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 01:19:50 INFO - } 01:19:50 INFO - ], 01:19:50 INFO - "repository": "", 01:19:50 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 01:19:50 INFO - "who": "bobowencode@gmail.com", 01:19:50 INFO - "when": 1446115088, 01:19:50 INFO - "number": 6592843, 01:19:50 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 01:19:50 INFO - "project": "", 01:19:50 INFO - "at": "Thu 29 Oct 2015 03:38:08", 01:19:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:50 INFO - "revlink": "", 01:19:50 INFO - "properties": [ 01:19:50 INFO - [ 01:19:50 INFO - "buildid", 01:19:50 INFO - "20151029012446", 01:19:50 INFO - "Change" 01:19:50 INFO - ], 01:19:50 INFO - [ 01:19:50 INFO - "builduid", 01:19:50 INFO - "3d43e8ca7be54163b739961a6150cca7", 01:19:50 INFO - "Change" 01:19:50 INFO - ], 01:19:50 INFO - [ 01:19:50 INFO - "pgo_build", 01:19:50 INFO - "True", 01:19:50 INFO - "Change" 01:19:50 INFO - ] 01:19:50 INFO - ], 01:19:50 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:50 INFO - } 01:19:50 INFO - ], 01:19:50 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:50 INFO - } 01:19:50 INFO - } 01:19:50 INFO - Running post-action listener: _resource_record_post_action 01:19:50 INFO - ##### 01:19:50 INFO - ##### Running download-and-extract step. 01:19:50 INFO - ##### 01:19:50 INFO - Running pre-action listener: _resource_record_pre_action 01:19:50 INFO - Running main action method: download_and_extract 01:19:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:19: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')]} 01:19:50 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:19:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 01:19:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 01:19:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:19:50 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 01:19:54 INFO - Downloaded 1302 bytes. 01:19:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:19:54 INFO - Using the following test package requirements: 01:19:54 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:54 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:54 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:19:54 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:54 INFO - u'jsshell-linux-x86_64.zip'], 01:19:54 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:54 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:19:54 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:54 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:54 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:19:54 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:54 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:19:54 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:54 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:19:54 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:54 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:54 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:19:54 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:54 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:19:54 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:20:00 INFO - Downloaded 22906880 bytes. 01:20:00 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 01:20:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:20:00 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 01:20:02 INFO - Return code: 0 01:20:02 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 01:20: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')]} 01:20:02 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:20:02 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:20:05 INFO - Downloaded 22906880 bytes. 01:20:05 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 01:20:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:20:05 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 01:20:06 INFO - Return code: 0 01:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:06 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:20:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:20:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:20:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:20:06 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:20:07 INFO - Downloaded 10881672 bytes. 01:20:07 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 01:20:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:20:07 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 01:20:08 INFO - Return code: 0 01:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:08 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:20:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:20:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:20:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:20:08 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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 01:20:09 INFO - Downloaded 56983114 bytes. 01:20:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:20:09 INFO - mkdir: /builds/slave/test-pgo/properties 01:20:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:20:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:20:09 INFO - Contents: 01:20:09 INFO - build_url:https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:20:09 INFO - Running post-action listener: _resource_record_post_action 01:20:09 INFO - Running post-action listener: _set_extra_try_arguments 01:20:09 INFO - ##### 01:20:09 INFO - ##### Running populate-webroot step. 01:20:09 INFO - ##### 01:20:09 INFO - Running pre-action listener: _resource_record_pre_action 01:20:09 INFO - Running main action method: populate_webroot 01:20:09 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 01:20:09 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 01:20:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 01:20:13 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 01:20:13 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 01:20:13 INFO - Running post-action listener: _resource_record_post_action 01:20:13 INFO - ##### 01:20:13 INFO - ##### Running create-virtualenv step. 01:20:13 INFO - ##### 01:20:13 INFO - Running pre-action listener: _resource_record_pre_action 01:20:13 INFO - Running main action method: create_virtualenv 01:20:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:20:13 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 01:20:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:20:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:20:13 INFO - Using real prefix '/usr' 01:20:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:20:14 INFO - Installing distribute.............................................................................................................................................................................................done. 01:20:17 INFO - Installing pip.................done. 01:20:17 INFO - Return code: 0 01:20:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:20:17 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')]} 01:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 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')]} 01:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 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 0x7ffa7f1b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229f4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', '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 01:20:17 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 01:20:17 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 01:20:17 INFO - Using env: {'DISPLAY': ':0', 01:20:17 INFO - 'HOME': '/home/cltbld', 01:20:17 INFO - 'LANG': 'en_US.UTF-8', 01:20:17 INFO - 'LANGUAGE': 'en_US:en', 01:20:17 INFO - 'LOGNAME': 'cltbld', 01:20:17 INFO - 'MAIL': '/var/mail/cltbld', 01:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:17 INFO - 'MOZ_NO_REMOTE': '1', 01:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:17 INFO - 'NO_EM_RESTART': '1', 01:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:17 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:17 INFO - 'SHELL': '/bin/bash', 01:20:17 INFO - 'SHLVL': '1', 01:20:17 INFO - 'TERM': 'linux', 01:20:17 INFO - 'TMOUT': '86400', 01:20:17 INFO - 'USER': 'cltbld', 01:20:17 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:17 INFO - '_': '/tools/buildbot/bin/python'} 01:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:17 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 01:20:17 INFO - Cleaning up... 01:20:17 INFO - Return code: 0 01:20:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:20:17 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')]} 01:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 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')]} 01:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 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 0x7ffa7f1b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229f4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', '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 01:20:17 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 01:20:17 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 01:20:17 INFO - Using env: {'DISPLAY': ':0', 01:20:17 INFO - 'HOME': '/home/cltbld', 01:20:17 INFO - 'LANG': 'en_US.UTF-8', 01:20:17 INFO - 'LANGUAGE': 'en_US:en', 01:20:17 INFO - 'LOGNAME': 'cltbld', 01:20:17 INFO - 'MAIL': '/var/mail/cltbld', 01:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:17 INFO - 'MOZ_NO_REMOTE': '1', 01:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:17 INFO - 'NO_EM_RESTART': '1', 01:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:17 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:17 INFO - 'SHELL': '/bin/bash', 01:20:17 INFO - 'SHLVL': '1', 01:20:17 INFO - 'TERM': 'linux', 01:20:17 INFO - 'TMOUT': '86400', 01:20:17 INFO - 'USER': 'cltbld', 01:20:17 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:17 INFO - '_': '/tools/buildbot/bin/python'} 01:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:17 INFO - Downloading/unpacking psutil>=0.7.1 01:20:17 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 01:20:17 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 01:20:17 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 01:20:17 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 01:20:17 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 01:20:17 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 01:20:19 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:20:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:20:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:20:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:19 INFO - Installing collected packages: psutil 01:20:19 INFO - Running setup.py install for psutil 01:20:19 INFO - building 'psutil._psutil_linux' extension 01:20:19 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 01:20:20 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 01:20:20 INFO - building 'psutil._psutil_posix' extension 01:20:20 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 01:20:21 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 01:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:21 INFO - Successfully installed psutil 01:20:21 INFO - Cleaning up... 01:20:21 INFO - Return code: 0 01:20:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffa7f1b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229f4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', '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 01:20:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:20:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:20:21 INFO - Using env: {'DISPLAY': ':0', 01:20:21 INFO - 'HOME': '/home/cltbld', 01:20:21 INFO - 'LANG': 'en_US.UTF-8', 01:20:21 INFO - 'LANGUAGE': 'en_US:en', 01:20:21 INFO - 'LOGNAME': 'cltbld', 01:20:21 INFO - 'MAIL': '/var/mail/cltbld', 01:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:21 INFO - 'MOZ_NO_REMOTE': '1', 01:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:21 INFO - 'NO_EM_RESTART': '1', 01:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:21 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:21 INFO - 'SHELL': '/bin/bash', 01:20:21 INFO - 'SHLVL': '1', 01:20:21 INFO - 'TERM': 'linux', 01:20:21 INFO - 'TMOUT': '86400', 01:20:21 INFO - 'USER': 'cltbld', 01:20:21 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:21 INFO - '_': '/tools/buildbot/bin/python'} 01:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:20:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:20:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:20:23 INFO - Installing collected packages: mozsystemmonitor 01:20:23 INFO - Running setup.py install for mozsystemmonitor 01:20:23 INFO - Successfully installed mozsystemmonitor 01:20:23 INFO - Cleaning up... 01:20:23 INFO - Return code: 0 01:20:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:20:23 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')]} 01:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:23 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')]} 01:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:23 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 0x7ffa7f1b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229f4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', '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 01:20:23 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 01:20:23 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 01:20:23 INFO - Using env: {'DISPLAY': ':0', 01:20:23 INFO - 'HOME': '/home/cltbld', 01:20:23 INFO - 'LANG': 'en_US.UTF-8', 01:20:23 INFO - 'LANGUAGE': 'en_US:en', 01:20:23 INFO - 'LOGNAME': 'cltbld', 01:20:23 INFO - 'MAIL': '/var/mail/cltbld', 01:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:23 INFO - 'MOZ_NO_REMOTE': '1', 01:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:23 INFO - 'NO_EM_RESTART': '1', 01:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:23 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:23 INFO - 'SHELL': '/bin/bash', 01:20:23 INFO - 'SHLVL': '1', 01:20:23 INFO - 'TERM': 'linux', 01:20:23 INFO - 'TMOUT': '86400', 01:20:23 INFO - 'USER': 'cltbld', 01:20:23 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:23 INFO - '_': '/tools/buildbot/bin/python'} 01:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:23 INFO - Downloading/unpacking blobuploader==1.2.4 01:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:25 INFO - Downloading blobuploader-1.2.4.tar.gz 01:20:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:20:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:20:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:20:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:20:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 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 01:20:25 INFO - Downloading docopt-0.6.1.tar.gz 01:20:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:20:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:20:26 INFO - Installing collected packages: blobuploader, requests, docopt 01:20:26 INFO - Running setup.py install for blobuploader 01:20:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:20:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:20:26 INFO - Running setup.py install for requests 01:20:26 INFO - Running setup.py install for docopt 01:20:26 INFO - Successfully installed blobuploader requests docopt 01:20:26 INFO - Cleaning up... 01:20:26 INFO - Return code: 0 01:20:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20: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')]} 01:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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')]} 01:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:26 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 0x7ffa7f1b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229f4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', '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 01:20:26 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 01:20:26 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 01:20:26 INFO - Using env: {'DISPLAY': ':0', 01:20:26 INFO - 'HOME': '/home/cltbld', 01:20:26 INFO - 'LANG': 'en_US.UTF-8', 01:20:26 INFO - 'LANGUAGE': 'en_US:en', 01:20:26 INFO - 'LOGNAME': 'cltbld', 01:20:26 INFO - 'MAIL': '/var/mail/cltbld', 01:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:26 INFO - 'MOZ_NO_REMOTE': '1', 01:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:26 INFO - 'NO_EM_RESTART': '1', 01:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:26 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:26 INFO - 'SHELL': '/bin/bash', 01:20:26 INFO - 'SHLVL': '1', 01:20:26 INFO - 'TERM': 'linux', 01:20:26 INFO - 'TMOUT': '86400', 01:20:26 INFO - 'USER': 'cltbld', 01:20:26 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:26 INFO - '_': '/tools/buildbot/bin/python'} 01:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:26 INFO - Running setup.py (path:/tmp/pip-uDRu6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:26 INFO - Running setup.py (path:/tmp/pip-NRggu1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:26 INFO - Running setup.py (path:/tmp/pip-8baqJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:27 INFO - Running setup.py (path:/tmp/pip-Rggeuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:27 INFO - Running setup.py (path:/tmp/pip-wAt9wm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:27 INFO - Running setup.py (path:/tmp/pip-LwxRoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:27 INFO - Running setup.py (path:/tmp/pip-8PJII1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:27 INFO - Running setup.py (path:/tmp/pip-9rmGFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:27 INFO - Running setup.py (path:/tmp/pip-0cacaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:27 INFO - Running setup.py (path:/tmp/pip-QWPA94-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:27 INFO - Running setup.py (path:/tmp/pip-1NrB9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:27 INFO - Running setup.py (path:/tmp/pip-zNblXk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:27 INFO - Running setup.py (path:/tmp/pip-OaSLZi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:27 INFO - Running setup.py (path:/tmp/pip-pHrARN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:27 INFO - Running setup.py (path:/tmp/pip-mEmq1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:27 INFO - Running setup.py (path:/tmp/pip-alFInj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:28 INFO - Running setup.py (path:/tmp/pip-9qViKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:20:28 INFO - Running setup.py install for manifestparser 01:20:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Running setup.py install for mozcrash 01:20:28 INFO - Running setup.py install for mozdebug 01:20:28 INFO - Running setup.py install for mozdevice 01:20:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Running setup.py install for mozfile 01:20:28 INFO - Running setup.py install for mozhttpd 01:20:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Running setup.py install for mozinfo 01:20:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Running setup.py install for mozInstall 01:20:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:20:28 INFO - Running setup.py install for mozleak 01:20:28 INFO - Running setup.py install for mozlog 01:20:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:20:29 INFO - Running setup.py install for moznetwork 01:20:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:20:29 INFO - Running setup.py install for mozprocess 01:20:29 INFO - Running setup.py install for mozprofile 01:20:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:20:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:20:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:20:29 INFO - Running setup.py install for mozrunner 01:20:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:20:29 INFO - Running setup.py install for mozscreenshot 01:20:29 INFO - Running setup.py install for moztest 01:20:29 INFO - Running setup.py install for mozversion 01:20:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:20:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:20:29 INFO - Cleaning up... 01:20:29 INFO - Return code: 0 01:20:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20: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')]} 01:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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')]} 01:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:29 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 0x7ffa7f1b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229f4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', '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 01:20:29 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 01:20:29 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 01:20:29 INFO - Using env: {'DISPLAY': ':0', 01:20:29 INFO - 'HOME': '/home/cltbld', 01:20:29 INFO - 'LANG': 'en_US.UTF-8', 01:20:29 INFO - 'LANGUAGE': 'en_US:en', 01:20:29 INFO - 'LOGNAME': 'cltbld', 01:20:29 INFO - 'MAIL': '/var/mail/cltbld', 01:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:29 INFO - 'MOZ_NO_REMOTE': '1', 01:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:29 INFO - 'NO_EM_RESTART': '1', 01:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:29 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:29 INFO - 'SHELL': '/bin/bash', 01:20:29 INFO - 'SHLVL': '1', 01:20:29 INFO - 'TERM': 'linux', 01:20:29 INFO - 'TMOUT': '86400', 01:20:29 INFO - 'USER': 'cltbld', 01:20:29 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:29 INFO - '_': '/tools/buildbot/bin/python'} 01:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:30 INFO - Running setup.py (path:/tmp/pip-LW8STa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:30 INFO - Running setup.py (path:/tmp/pip-HoM6TJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:30 INFO - Running setup.py (path:/tmp/pip-ckdUqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:30 INFO - Running setup.py (path:/tmp/pip-Bprs4j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:30 INFO - Running setup.py (path:/tmp/pip-Ny5RpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:30 INFO - Running setup.py (path:/tmp/pip-vZVodS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:30 INFO - Running setup.py (path:/tmp/pip-mcHBws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:30 INFO - Running setup.py (path:/tmp/pip-4djZm2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:30 INFO - Running setup.py (path:/tmp/pip-dVNKSX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:30 INFO - Running setup.py (path:/tmp/pip-_IYRGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:30 INFO - Running setup.py (path:/tmp/pip-_8QdVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:30 INFO - Running setup.py (path:/tmp/pip-vWwM9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:30 INFO - Running setup.py (path:/tmp/pip-JCNEsu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:30 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)) 01:20:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:31 INFO - Running setup.py (path:/tmp/pip-cHkOFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:31 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)) 01:20:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:31 INFO - Running setup.py (path:/tmp/pip-ws1i_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:31 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)) 01:20:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:31 INFO - Running setup.py (path:/tmp/pip-ur0prL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:31 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)) 01:20:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:31 INFO - Running setup.py (path:/tmp/pip-auJ9dB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:31 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)) 01:20:31 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)) 01:20:31 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)) 01:20:31 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)) 01:20:31 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)) 01:20:31 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)) 01:20:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:20:31 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 01:20:31 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 01:20:31 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 01:20:31 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 01:20:31 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 01:20:31 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 01:20:32 INFO - Downloading blessings-1.5.1.tar.gz 01:20:32 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 01:20:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:20:33 INFO - Installing collected packages: blessings 01:20:33 INFO - Running setup.py install for blessings 01:20:33 INFO - Successfully installed blessings 01:20:33 INFO - Cleaning up... 01:20:33 INFO - Return code: 0 01:20:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:20:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:20:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:20:33 INFO - Reading from file tmpfile_stdout 01:20:33 INFO - Current package versions: 01:20:33 INFO - argparse == 1.2.1 01:20:33 INFO - blessings == 1.5.1 01:20:33 INFO - blobuploader == 1.2.4 01:20:33 INFO - docopt == 0.6.1 01:20:33 INFO - manifestparser == 1.1 01:20:33 INFO - mozInstall == 1.12 01:20:33 INFO - mozcrash == 0.16 01:20:33 INFO - mozdebug == 0.1 01:20:33 INFO - mozdevice == 0.46 01:20:33 INFO - mozfile == 1.2 01:20:33 INFO - mozhttpd == 0.7 01:20:33 INFO - mozinfo == 0.8 01:20:33 INFO - mozleak == 0.1 01:20:33 INFO - mozlog == 3.0 01:20:33 INFO - moznetwork == 0.27 01:20:33 INFO - mozprocess == 0.22 01:20:33 INFO - mozprofile == 0.27 01:20:33 INFO - mozrunner == 6.10 01:20:33 INFO - mozscreenshot == 0.1 01:20:33 INFO - mozsystemmonitor == 0.0 01:20:33 INFO - moztest == 0.7 01:20:33 INFO - mozversion == 1.4 01:20:33 INFO - psutil == 3.1.1 01:20:33 INFO - requests == 1.2.3 01:20:33 INFO - wsgiref == 0.1.2 01:20:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20:33 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')]} 01:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:33 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')]} 01:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:33 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 0x7ffa7f1b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229f4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', '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 01:20:33 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 01:20:33 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 01:20:33 INFO - Using env: {'DISPLAY': ':0', 01:20:33 INFO - 'HOME': '/home/cltbld', 01:20:33 INFO - 'LANG': 'en_US.UTF-8', 01:20:33 INFO - 'LANGUAGE': 'en_US:en', 01:20:33 INFO - 'LOGNAME': 'cltbld', 01:20:33 INFO - 'MAIL': '/var/mail/cltbld', 01:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:33 INFO - 'MOZ_NO_REMOTE': '1', 01:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:33 INFO - 'NO_EM_RESTART': '1', 01:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:33 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:33 INFO - 'SHELL': '/bin/bash', 01:20:33 INFO - 'SHLVL': '1', 01:20:33 INFO - 'TERM': 'linux', 01:20:33 INFO - 'TMOUT': '86400', 01:20:33 INFO - 'USER': 'cltbld', 01:20:33 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:33 INFO - '_': '/tools/buildbot/bin/python'} 01:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 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)) 01:20:33 INFO - Cleaning up... 01:20:33 INFO - Return code: 0 01:20:33 INFO - Running post-action listener: _resource_record_post_action 01:20:33 INFO - Running post-action listener: _start_resource_monitoring 01:20:33 INFO - Starting resource monitoring. 01:20:33 INFO - ##### 01:20:33 INFO - ##### Running install step. 01:20:33 INFO - ##### 01:20:33 INFO - Running pre-action listener: _resource_record_pre_action 01:20:33 INFO - Running main action method: install 01:20:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:20:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:20:33 INFO - Reading from file tmpfile_stdout 01:20:33 INFO - Detecting whether we're running mozinstall >=1.0... 01:20:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:20:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:20:34 INFO - Reading from file tmpfile_stdout 01:20:34 INFO - Output received: 01:20:34 INFO - Usage: mozinstall [options] installer 01:20:34 INFO - Options: 01:20:34 INFO - -h, --help show this help message and exit 01:20:34 INFO - -d DEST, --destination=DEST 01:20:34 INFO - Directory to install application into. [default: 01:20:34 INFO - "/builds/slave/test-pgo"] 01:20:34 INFO - --app=APP Application being installed. [default: firefox] 01:20:34 INFO - mkdir: /builds/slave/test-pgo/build/application 01:20:34 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'] 01:20:34 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 01:20:48 INFO - Reading from file tmpfile_stdout 01:20:48 INFO - Output received: 01:20:48 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:20:48 INFO - Running post-action listener: _resource_record_post_action 01:20:48 INFO - ##### 01:20:48 INFO - ##### Running run-tests step. 01:20:48 INFO - ##### 01:20:48 INFO - Running pre-action listener: _resource_record_pre_action 01:20:48 INFO - Running main action method: run_tests 01:20:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:20:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:20:48 INFO - Python 2.7.3 01:20:48 INFO - Return code: 0 01:20:48 INFO - grabbing minidump binary from tooltool 01:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:48 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 0x2031bf0>, '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 0x232f4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f9a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:20:48 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 01:20:48 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 01:20:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:48 INFO - Return code: 0 01:20:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:20:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:20:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:20:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:20:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:20:48 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/JrMmOwYyQSuLn5q77Sd6Cg/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-004', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:20:48 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/JrMmOwYyQSuLn5q77Sd6Cg/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-004 --webServer localhost 01:20:48 INFO - Using env: {'DISPLAY': ':0', 01:20:48 INFO - 'HOME': '/home/cltbld', 01:20:48 INFO - 'LANG': 'en_US.UTF-8', 01:20:48 INFO - 'LANGUAGE': 'en_US:en', 01:20:48 INFO - 'LOGNAME': 'cltbld', 01:20:48 INFO - 'MAIL': '/var/mail/cltbld', 01:20:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:20:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:48 INFO - 'MOZ_NO_REMOTE': '1', 01:20:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:48 INFO - 'NO_EM_RESTART': '1', 01:20:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:20:48 INFO - 'SHELL': '/bin/bash', 01:20:48 INFO - 'SHLVL': '1', 01:20:48 INFO - 'TERM': 'linux', 01:20:48 INFO - 'TMOUT': '86400', 01:20:48 INFO - 'USER': 'cltbld', 01:20:48 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934', 01:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:48 INFO - '_': '/tools/buildbot/bin/python'} 01:20:48 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/JrMmOwYyQSuLn5q77Sd6Cg/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-004', '--webServer', 'localhost'] with output_timeout 3600 01:20:48 INFO - mozversion INFO | application_buildid: 20151029012446 01:20:48 INFO - mozversion INFO | application_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:20:48 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 01:20:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:48 INFO - mozversion INFO | application_name: Firefox 01:20:48 INFO - mozversion INFO | application_remotingname: firefox-dev 01:20:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:48 INFO - mozversion INFO | application_vendor: Mozilla 01:20:48 INFO - mozversion INFO | application_version: 43.0a2 01:20:48 INFO - mozversion INFO | platform_buildid: 20151029012446 01:20:48 INFO - mozversion INFO | platform_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:20:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:48 INFO - mozversion INFO | platform_version: 43.0a2 01:20:48 INFO - 2015-10-30 01:20:48,665 DEBUG : using testdate: 1446193248 01:20:48 INFO - 2015-10-30 01:20:48,665 DEBUG : actual date: 1446193248 01:20:48 INFO - 2015-10-30 01:20:48,713 INFO : Starting test suite talos-linux64-ix-004 01:20:48 INFO - 2015-10-30 01:20:48,714 INFO : Starting test dromaeo_css 01:20:48 INFO - 2015-10-30 01:20:48,714 DEBUG : operating with platform_type : linux_ 01:20:48 INFO - 2015-10-30 01:20:48,714 INFO : Initialising browser for dromaeo_css test... 01:20:48 INFO - 2015-10-30 01:20:48,740 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRCEY8B/profile http://localhost/getInfo.html 01:20:54 INFO - 2015-10-30 01:20:54,580 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:20:54 INFO - 2015-10-30 01:20:54,580 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:20:54 INFO - 2015-10-30 01:20:54,580 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:20:54 INFO - 2015-10-30 01:20:54,580 DEBUG : BROWSER_OUTPUT: __metrics 01:20:54 INFO - 2015-10-30 01:20:54,705 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:58 INFO - 2015-10-30 01:20:58,361 INFO : Browser initialized. 01:20:58 INFO - 2015-10-30 01:20:58,362 INFO : Running cycle 1/1 for dromaeo_css test... 01:20:58 INFO - 2015-10-30 01:20:58,362 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRCEY8B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:21:10 INFO - 2015-10-30 01:21:10,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 132468736 01:21:10 INFO - 2015-10-30 01:21:10,027 DEBUG : BROWSER_OUTPUT: 01:24:09 INFO - 2015-10-30 01:24:09,859 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) 01:24:10 INFO - 2015-10-30 01:24:10,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 215109632 01:24:10 INFO - 2015-10-30 01:24:10,844 DEBUG : BROWSER_OUTPUT: 01:27:13 INFO - 2015-10-30 01:27:13,073 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) 01:27:13 INFO - 2015-10-30 01:27:13,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 213356544 01:27:13 INFO - 2015-10-30 01:27:13,640 DEBUG : BROWSER_OUTPUT: 01:30:15 INFO - 2015-10-30 01:30:15,422 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) 01:30:15 INFO - 2015-10-30 01:30:15,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 220651520 01:30:15 INFO - 2015-10-30 01:30:15,984 DEBUG : BROWSER_OUTPUT: 01:33:17 INFO - 2015-10-30 01:33:17,663 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) 01:33:18 INFO - 2015-10-30 01:33:18,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 207572992 01:33:18 INFO - 2015-10-30 01:33:18,229 DEBUG : BROWSER_OUTPUT: 01:36:20 INFO - 2015-10-30 01:36:20,518 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) 01:36:21 INFO - 2015-10-30 01:36:21,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 200466432 01:36:21 INFO - 2015-10-30 01:36:21,101 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,206 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) 01:39:23 INFO - 2015-10-30 01:39:23,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 247070720 01:39:23 INFO - 2015-10-30 01:39:23,463 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,464 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:39:23 INFO - 2015-10-30 01:39:23,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:39:23 INFO - 2015-10-30 01:39:23,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:39:23 INFO - 2015-10-30 01:39:23,464 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:39:23 INFO - 2015-10-30 01:39:23,464 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3367.124547617619;3418.880339188129;3452.03343063942;3453.3783918894605;3478.40867052601;5760.7695692172365;5770.480656740892;5779.595428320014;5794.0729483282685;5812.215350927634;5781.653100813944;5816.098504731763;5834.066549352105;5839.678817665027;5859.44335288147;5224.346956630421;5264.078786212417;5278.287431196797;5306.628536002481;5368.087425137716;5266.578673706094;5268.710220937847;5287;5287.021900948318;5295.311609490761;5179.482051794809;5184.818531351403;5232;5278.973605131988;5317.867053323678;5319.840404787863;5375.784968601251;5376.059189641797;5380.973095134538;5383.4616538346045;5302.734863256822;5306.363236411656;5311.681299122027;5333.040052790496;5370.785168593252;5400.972995134999;5497.5601951844155;5498.367687715884;5627.127795191752;5627.6904770237625;6248.125262463259;6263.686815659199;6266.060090986389;6277.246730392337;6291.716872740738;6045.45590896817;6296.433321001132;6296.496280297565;6299.149614801989;6301.968490157566;5775.711214439303;5785.855353616151;5879.32387775407;5892.116182572563;5896.882062358729;6318.873622527523;6382.648954307465;6385.074164246158;6386.042093685891;6387.073874288202;6035.185249991283;6118.908216376758;6137.570370074052;6193.349698281706;6210.627362358183;6114.92353857414;6213.347598502182;6222.315545290015;6228;6245.313015568284;6216.875662486725;6243.0635404688755;6243.687815609202;6253.874922501524;6254.249490061222;5948.256467941507;6060.696965151725;6143.846403839851;6265.467435268053;6271.655058971709;4715.434147902205;4719.669623126349;4724.456687480915;4727.479977202505;4729.408823897013;4184.184084103632;4188.015816283171;4210.221109094766;4215.388768628532;4220.177065472203;5702;5802.767889284381;5877.52979761618;5888.970555147197;5890.440408161217;6117.785877494266;6226.750929962841;6245.75016999324;6247.406496382836;6252.030935205051;5884.823455296262;5892.7642894283745;5917.260342457193;5937.643741375531;5948.613340132878;5189.221616757516;5286.471352864683;5311.867203319948;5424.159255315432;5432.456754324536;6510;6511.772087976993;6517.706703198368;6522.510811689048;6525.412712855866;6345.524085693499;6347.143135676624;6349.111124442674;6359.141515895295;6366.267879193952;6180.134781130735;6286.717097730521;6293.433590976834;6402.583832050902;6516.055172000129;6099.4815440688035;6109.7861574844665;6118.449339559283;6154.661493617715;6161;6209.348018457997;6222.377762223741;6226.813195604139;6227.439530442282;6232.501399887908;5812.9709351452975;5922.496587790086;6005.7297421617;6129.862342918601;6136.881217787523;6123.374584456894;6129.754809807736;6134.079888016655;6134.35589263121;6138.355472675305;5868.031774757117;5992.310884248367;6035.486983606443;6039.48664363534;6056.757729690763;6020.638761674313;6111.449969502766;6116.969415152896;6131.785387511416;6147.016477363601;5998.190244317136;6045.274567051806;6046.818595442144;6062.242219722535;6081.604695694766 01:39:23 INFO - 2015-10-30 01:39:23,464 DEBUG : BROWSER_OUTPUT: |1;ext.html;605.2646035067394;611.578011172291;652.2531701202126;652.3378770547891;685.7771224352081;45429.09141817166;45980.54019459804;46211.30683039753;46230;46296.30555541669;48214;48827;48836;48862;48878.755606221916;8300.626471808753;8446.61990210442;8884.600192991331;10731.248812583122;10942.398168100752;10887.510062047188;10999.560017599286;11020.118390528738;11026.724331891686;11035.337879727202;8537.060923298463;10927.945360273226;11057.170712196577;11058.060064894493;11058.391788451632;8474.661013559451;10954.726131846688;11167.218294719372;11189.384583847885;11193.440327983568;10741.087007604363;10852.620158294421;10864.185186110994;10866.185036122244;10866.348019118877;45812.3128153078;46207;46278.53721462776;46362.76818615885;46372;3872.2642697887313;3948.8420463181437;3983.5618082010956;4057.8173982170874;4610.654200934943;34722.131946701535;34790.652093478995;35044.47433288477;35069.64930350715;36268;3776.9055773605605;3797.9430308545393;3834.616538346171;4018.7789671568053;4028.0735430850777;354231;354676.22661886783;356607;357707;360101;60965.39034609686;63327.68336158382;68381.65809170922;70460.64769676221;70471.2952870475;66182;66465.33534664688;66987;67006.66496667583;67069.32930670728;18290.359837405627;18810.905945470186;19388.4183474496;19540.804591954184;19649.705254421195;13758.65603359904;13998.090124141898;14017.229052402012;14022.368993395321;14028.649283767987;23188.53622927532;23454.413639658804;23499.530009399718;23526.176583819826;23537.234707397012;8958.10418958099;8989.370744047854;9079.273658107335;9085.500297483703;9149.660373963456;1093.9288946218471;1102.7077824376386;1136.0003197186422;1139.4132022008673;1187.8833896137603;29109.72588507928;29272.414551708847;29786.702132978826;29939.700602994126;29955.700442995727;1124.1793490751797;1125.7523344864117;1183.9644810655693;1192.4574318684977;1272.9809052864214;15560.92219538895;15867.444639437796;16189;18811.3416030441;18842;591246;596137;600442;600812;601727;60972.69513652403;65432.67283663551;65990;66231.66884165548;66292.33707662861;1376.7521846067805;1513.7199618070472;1524.6798172383924;1525.0925699208954;1547.257316488092;33830.569899447684;33880;34013.319733605684;34032.31935361229;34438.48342274818;49627.75186124046;50810.98378032345;52375.21437178369;52864.735676321376;55811;284812;285343;286038;286581;288622;37534.249315013;37664.62335376611;38140.809295953346;38162.618373817015;38323.42514862335;48940.510594893596;49529.25706114339;49835;50070.749646251534;50235.49764502308;41399.7930010348;42640.573594264904;42811.7859410701;43093.784531077144;43585.56414435815;41896.581034189265;42402.78798605987;42589.5741042598;43080.138397231254;43375.566244337155;42048.579514204466;42389.15221695611;42741;42814.57185428106;42933.785331073144;36859.63140368562;37358.813205933795;37675.81162094282;38092.428613570264;38257.80871095627;28555.857220713762;28637;28656.713432865403;28736.137915862557;28761.42477150487 01:39:23 INFO - 2015-10-30 01:39:23,465 DEBUG : BROWSER_OUTPUT: |2;jquery.html;418.41213095600693;420.96842736794747;422.51410877490883;426.4030357499502;434.1339028637867;16582.170891455407;16923.238454269558;19829.702554461677;20377.592448151026;20415.285465008747;19631.509212269666;20509.589808203826;20573.382798516068;20761;20771.792282077175;5876.588638795297;5904.3800400957925;5995.580309378345;6010.669413182273;6012.609180403281;4262.827722376341;4375.781210939456;5951.464368206861;6371.713272902707;6562.507811914102;6385.457236134934;6459.063435801806;6475.449586785129;6509.511786615999;6510.5442619016685;6400.455961243277;6457.935420645827;6465.288818229991;6467;6468.353164683517;5800.8839823203725;5884.823455296348;5885.823425297248;5895.4399332063385;5901.262342207224;24877.378065548324;24951.750482495125;25245.747542524525;25315;25340.746592534208;2422.382292515415;2436.0864675746593;2465.6055031194924;2474.752524747511;2514.157757151338;10887.782244355149;10958.452077396178;11145.275557088764;14388.92805535976;15078.698426031418;1820.945371638853;1844.7325137854937;1851.1577232359243;1886.6415381077552;1917.319351630165;74294.62852685756;75063.62468187678;75692.24307756907;75692.62153689252;76159;7918.326942209861;8054.436189466681;8142.104368519458;8169.4689845161065;8182.836343273101;10025.899741002497;10027.649032283834;10042.347247428894;10058.094771470604;10070.093691567794;6498.967505162444;6532.150820393318;6553;6562.4578224117295;6610.504212184105;6521.67391630426;6553.770618028346;6587.571807832475;6597.538172327891;6863.519553631298;3736.981315093407;3761.717871159674;3763.435484677266;3783.2244389900006;3804.1060350817534;1276.716899515999;1289.5164313382481;1305.0799186573443;1326.1843965960866;1333.8266025416829;544.9209864569694;553.6318348298337;557.1086261980798;577.9046457334492;584.5820238529471;12007.759844803055;13290.136141150795;13368.532101376406;13680.863191368158;13773;543.2910052381601;555.6638233868532;560.7616762875762;577.0968434400235;588.0414923674468;7126.2161162272105;7357.889631655529;7380.630968451556;7457.216992215847;7924.48490848093;636157;649252.0770091054;657391;702831;703250;82737;91765.54117229371;94017;94462;94515;614.6342925959048;627.3412916437813;629.3266205160435;635.7997230872261;638.4317957018164;11616.419179041182;12263.509459621871;12521.060920430822;12557.434915428645;12582.496700131893;41590.37614435725;41626.791866040476;41875.53435629739;42494.78423190873;43019;55969;55983.44016559782;56142.719286403306;57048.42951570431;57288.713556431954;7715.729949451742;7785.182555831782;7806.88289675644;7814.4529882907655;7817.374610031297;13125.34373281313;13230.404631791786;13300.733985320432;13499.257540835348;13604.115732477358;11856.17006809515;11889.167758256839;11961.880381196077;12104.031677465606;12153.81769273444;11535.423228838692;11536.134789890624;11808.76382472363;11914;12095.395230238277;10371;11171.776564468502;12140.33228172459;12178.75642487163;12302.81545776832;7776.805579860549;7832.099308579358;7909.485883417559;7910.762677119696;7914.0503139623615;11893.643190704293;12192.780721927737;12492.562760303346;12581.056420768296;12633.494660213488 01:39:23 INFO - 2015-10-30 01:39:23,465 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1576.4718819195568;1703.7188863837468;1865.524291305717;2104.4633618427297;2109.767925528193;9354.953225233872;10401.167906567476;10606.734831629203;10619.84070238947;10631.255812093137;10019.549120289586;10094.242931780127;10140.5436755346;10151.644692435766;10166.64416745414;2090.540081182145;2119.79861913118;2350.7884290413904;2359.9764002360016;2414.95170096598;2403.7476065013184;2435.1233555919853;2440.9389765255833;2449.4856080223176;2452.411421258903;2336.2991102669216;2381.559411508868;2382.916597919073;2385.2844146755992;2386.5226954609147;2129.105775574255;2176.1513009926143;2391.5456063347997;2430.4409985703387;2446.13162327373;2417.093589903786;2441.060191826142;2442.658027876099;2444.1567659157563;2490.3525083478244;10464.267501274913;10550.894491055067;10567.94716026415;10576.206784491116;10582.253928101854;5803.361630220672;5889.7644094236175;5901.439363260483;5901.645901245939;5903.409659034105;3588.5873124590485;3617.475466057433;3630.6550877666577;3690.4833323334756;3725.8137093145506;1129.807932651443;1135.818269076952;1151.0906383956665;1181.2085902445383;1181.2794195540714;16195.676086478323;16368.918155409146;16375.59061023472;16380.754288685679;16400.26198821056;5278.97360513195;5282.524572788468;5343.412224655285;5408.0535906216255;5429.104197807317;13577.86422135766;13581.320933953262;13586;13586.86413135856;13617.387217575233;5984.910226346608;5987.6108052976415;5996.070609055603;5998.760049597967;6003.519718422515;5371.409144994048;5374.596905232123;5393.352797664227;5396.109641909041;5434.64674796137;4137.172565486914;4146.647534959502;4175.8956026099595;4184.225918205142;4196.538380778112;1319.459021801057;1350.6083235861686;1355.986440135586;1358.5041459867077;1359.5377571625695;1449.2608769527617;1459.5402448228774;1483.8961272711022;1488.1368806092441;1496.4463148634857;9334.439933604006;9338.252939764803;9391.577379017961;9409.294302927308;9410.106039926197;580.7270582826065;585.1018686316484;586.3813676571173;589.0810335876047;595.1429940885112;7454.701811927463;7506.587137707478;7536.7362142324755;7544.3210111089165;7571.772846814494;13400.195988240737;13804.792928106086;13827.51603693866;13855.722885542233;13878;13368.33158342079;13590.864091359157;13660.316984150753;13671.453141874214;13685.657858553615;9575.856362154573;9778.217742580577;9778.902210978084;9781.657641982496;9848.409095454295;9263.305252106255;9327.766805829908;9342.53287335644;9370.297227707813;9394.67118650844;11503.252288601214;11623.1282653803;11659.417029148679;11701.2979221247;11800.704982375166;11829.171957963204;11994.160408771302;12117.27296362221;12170.208936419105;12179.208351457128;8868.334874884538;9066.50134242623;9099.408538444979;9103.817923641622;9107.817843643223;9714.562844671866;9753;9831.213502919893;9841.163501102486;10031.047050530187;8321.251087402163;8802.515861627671;9456.290778191526;9490.525473726148;9553.570089345858;9041.321900857594;9051.773705657411;9166.954165229132;9186.448813071238;9269.119433653792;9550.37922535033;9631.470269135265;9664.9033509664;9706.272029597949;9735.756606084904;8624.611892464729;8666.869996950178;8670.696525621574;8672.349573781865;8679.479231246145;8476.321894248322;8591.87112193305;8614.22471977525;8638.438501497383;8647.135286471554 01:39:23 INFO - 2015-10-30 01:39:23,465 DEBUG : BROWSER_OUTPUT: |4;prototype.html;391.21366054230987;392.9744566603171;394.55809493367434;396.7401352114365;399.51658493223215;6028.547858910577;6038.516918646509;6055.5761096723245;6065.2418447694035;6180.3510631383615;5866.530677545797;5998.100284957259;6029.75880964762;6038.637681739087;6042.939570604292;4639.559241872017;4702.952970470285;4721.480637129913;4789.712617242976;4791.065742180276;4757.976210118944;4762.428508578958;4773.832915847946;4784.282357646363;4795.352627395309;4714.057188562301;4740.217864052427;4742.596879265249;4745.715257084568;4748.8575342739605;4716.080364328957;4733.55031272032;4741.099191153669;4745.952540474603;4746;4117.07365842686;4171.687123465722;4180.456540649727;4198.223328684173;4247.256730072256;5689.857753556153;5703.800366987177;5704.087346024658;5706.657600543981;5725.484706376446;5252.107141785906;5369.24830523727;5479.0959491683825;5483.150111732648;5486.725663716838;6311.589746666452;6361.650109243989;6379;6388.744450221986;6393.168888044571;4738.265568836836;4739.905201895943;4740.407449068866;4746.050789842046;4747.548982846624;6437.388448097423;6497.805065848032;6545.116409284781;6574.342565743435;6580.14458120446;4879.463259041502;4881.560659540587;4882.658213925062;4916.827911023097;4931.802727890844;4984.252362145635;4991;4998.875028124326;5000.424951130666;5001.699898006132;5546.251256080377;5592.021396255639;5597.076482380443;5602.411746766612;5602.439756024446;6362.363763623601;6443.96778016107;6458.031295305742;6466.870662586816;6484.221893372825;1789.4810504953678;1809.5657042309751;1810.1401834128683;1810.2306519729063;1811.2664370929795;1234.2717796499928;1255.1841303153024;1265.816456613786;1268.695513076855;1286.826278452397;6132.233470816148;6180.536459765535;6183.134361189437;6189;6191.040388739662;6616.4045235929;6618.238902526271;6625.304343043911;6626.138601981712;6636.966815165893;6048.243969503812;6163.445289923929;6166.352532983972;6168.691565421711;6171.290301615282;3652.4886515887797;3669.743117981769;3677.79772112531;3685.8894233173046;3687.649673281034;6793.116894803743;6799.422049125879;6810.216825065082;6844.452443804484;6845.623490708059;6677.298883617247;6788.558743681645;6799.660016999131;6800.4219641330055;6804.115464989619;6679.432248258855;6744.359285867835;6785.050092986986;6788.355106264897;6812.352826481477;6549.214094308713;6563.0811686362995;6565.606063636197;6583.144191255297;6636.867262654817;6394.360563943568;6467.773627923;6489.772857949949;6506.154199953976;6506.316836732264;6768;6802.3537763912345;6813.4889883257965;6817.147856517935;6821.420179284816;4867.075255701406;4868.3427737255015;4870.099031679009;4873.926891096708;4878.756062196947;6581.045748366364;6590.538662293593;6590.5716128451495;6591.538592298493;6596;6398.296187419287;6516.609003459618;6518.641474718936;6518.73925042993;6518.804435866931;6485;6514.413702766774;6520.673966301761;6527.967360163168;6532.869342613026;6269.874602508015;6407.455366293917;6410.262819775786;6412;6425.614463132227;6524.9673751630935;6546.410823025951;6547.148870646785;6553.148090748363;6558.770443034471;6337.081123237012;6341.0805433212845;6388.265349484683;6388.776392826228;6396.808095757135 01:39:23 INFO - 2015-10-30 01:39:23,465 DEBUG : BROWSER_OUTPUT: |5;yui.html;845.7966995975488;851.1658574596895;907.6505545365037;934.2245935873226;955.8996305387934;12794.680132996667;13090.869091309083;13107.410166542504;13107.606771796838;13147.73704525909;13327.400266987985;13445.394957226923;13469.259190744506;13488.258145801978;13504.797428038588;758.4084414156966;763.8510490454364;909.495230147268;923.2521657457447;938.0994245524271;933.7992331648694;938.8685584018243;946.2902822882838;947;947.147567189528;981.2738573455628;990.3364745620452;990.5988074829705;991.0683957080357;991.2367477042673;795.4789612803623;798.6166640012798;973.493783232715;989.8713167288206;993.3195760903732;736.2674139231445;737.2553720742089;737.5464089584921;739.2939742545909;740.5852722475431;12803;13143.802842957364;13225.677432256698;13266.66833329165;13276.336183190802;12279.877201227962;12736.36318184087;12945;12990.415431305613;13021.047979860665;10218.131458826008;10289;10308.69073927776;10322.122619577345;10348;3792.469054332396;3797.886063418102;3813.180166264239;3841.750286231386;3845.442410850411;46334.76832615849;46968.295475567895;47201.763991179825;47436.288455672846;47467;8001.199880011952;8102.351811855037;10525;10594.470276486145;10600.469976501145;11863.525458981716;11954.52181912731;11976.46105925218;12001.399930003465;12022.398880055962;7084.079069720903;7294.234105418961;7317.963410183022;7394.5932973685885;7538.698452061966;4301.182775272689;4344.087741574242;4392.297232442794;4600.056988317387;4646.721196728207;3108.098651391071;3131.8120912745308;3137.3882092992103;3147.1345380020675;3148.0870547541413;542.4792199488535;545.9836204913859;552.2958228259002;556.118552094926;561.4189314059928;628.0798630007062;704.8555046215514;708.8334241453255;715.2382712411265;730.3098571849551;8205;8264.545450000187;8277.503349799032;8349.457285276438;8550.486970781772;644.8968165093656;688.686647575352;702.4661257444277;744.4751450227576;747.768191860525;4190.28765109932;4206.032612499082;4209.894752631209;4212.157568486315;4240.660747140221;54826;55243;55307.44692553103;55372.72313638406;56026.43973560294;46770.06459870784;46926.296105558446;47359.28961065587;47520;47750.76124619424;39164.412533812014;39456.80271598624;39708.40437393441;39721.40417893734;39876.60123398845;8362.832743345221;8645.783855403664;8836.646534138563;8950.597223124845;9098.90901091007;27844.860775695994;27926.02258920928;28154.85922570374;28369.716302837533;28755.28111797222;38537.292541492374;38876.6112338873;39006.80496597499;39390.80304598458;39435;11567;11792.469338879942;11863.703407414883;12382.071344649368;12385.62843114708;12284.754304914031;12383.938080309541;12701.93649031749;12882.67793305175;13213.273269970245;11702.473388697359;11826;11920.76158476843;12427.37863106823;12587.559435419716;11912.702182445162;11921.10591705643;11925.92298688692;11973;12214.26714397139;11693.941530292293;11958.521659133537;11976.28142311464;11977.461014254206;12468.251904885736;9399.530023498934;9628.277879159232;9707.223422126071;9718.514074296116;10090.527820683687;9878.753031174278;9886.159676427584;10007.349522281029;10016.39901605906;10061.949690251502 01:39:23 INFO - 2015-10-30 01:39:23,465 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:39:23 INFO - 2015-10-30 01:39:23,466 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:39:23 INFO - 2015-10-30 01:39:23,466 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,736 01:39:23 INFO - 2015-10-30 01:39:23,466 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:39:23 INFO - 2015-10-30 01:39:23,466 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194363457__endTimestamp 01:39:23 INFO - 2015-10-30 01:39:23,466 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,466 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:39:23 INFO - 2015-10-30 01:39:23,467 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:39:23 INFO - 2015-10-30 01:39:23,467 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,467 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5775.73 Median:6020.64 stddev:658.33 (10.9%) stddev-sans-first:632.65 01:39:23 INFO - 2015-10-30 01:39:23,468 DEBUG : BROWSER_OUTPUT: Values: 3367.1 3418.9 3452.0 3453.4 3478.4 5760.8 5770.5 5779.6 5794.1 5812.2 5781.7 5816.1 5834.1 5839.7 5859.4 5224.3 5264.1 5278.3 5306.6 5368.1 5266.6 5268.7 5287.0 5287.0 5295.3 5179.5 5184.8 5232.0 5279.0 5317.9 5319.8 5375.8 5376.1 5381.0 5383.5 5302.7 5306.4 5311.7 5333.0 5370.8 5401.0 5497.6 5498.4 5627.1 5627.7 6248.1 6263.7 6266.1 6277.2 6291.7 6045.5 6296.4 6296.5 6299.1 6302.0 5775.7 5785.9 5879.3 5892.1 5896.9 6318.9 6382.6 6385.1 6386.0 6387.1 6035.2 6118.9 6137.6 6193.3 6210.6 6114.9 6213.3 6222.3 6228.0 6245.3 6216.9 6243.1 6243.7 6253.9 6254.2 5948.3 6060.7 6143.8 6265.5 6271.7 4715.4 4719.7 4724.5 4727.5 4729.4 4184.2 4188.0 4210.2 4215.4 4220.2 5702.0 5802.8 5877.5 5889.0 5890.4 6117.8 6226.8 6245.8 6247.4 6252.0 5884.8 5892.8 5917.3 5937.6 5948.6 5189.2 5286.5 5311.9 5424.2 5432.5 6510.0 6511.8 6517.7 6522.5 6525.4 6345.5 6347.1 6349.1 6359.1 6366.3 6180.1 6286.7 6293.4 6402.6 6516.1 6099.5 6109.8 6118.4 6154.7 6161.0 6209.3 6222.4 6226.8 6227.4 6232.5 5813.0 5922.5 6005.7 6129.9 6136.9 6123.4 6129.8 6134.1 6134.4 6138.4 5868.0 5992.3 6035.5 6039.5 6056.8 6020.6 6111.4 6117.0 6131.8 6147.0 5998.2 6045.3 6046.8 6062.2 6081.6 01:39:23 INFO - 2015-10-30 01:39:23,468 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,469 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60028.34 Median:3787.42 stddev:115385.58 (3046.5%) stddev-sans-first:115623.01 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: Values: 605.3 611.6 652.3 652.3 685.8 45429.1 45980.5 46211.3 46230.0 46296.3 48214.0 48827.0 48836.0 48862.0 48878.8 8300.6 8446.6 8884.6 10731.2 10942.4 10887.5 10999.6 11020.1 11026.7 11035.3 8537.1 10927.9 11057.2 11058.1 11058.4 8474.7 10954.7 11167.2 11189.4 11193.4 10741.1 10852.6 10864.2 10866.2 10866.3 45812.3 46207.0 46278.5 46362.8 46372.0 3872.3 3948.8 3983.6 4057.8 4610.7 34722.1 34790.7 35044.5 35069.6 36268.0 3776.9 3797.9 3834.6 4018.8 4028.1 354231.0 354676.2 356607.0 357707.0 360101.0 60965.4 63327.7 68381.7 70460.6 70471.3 66182.0 66465.3 66987.0 67006.7 67069.3 18290.4 18810.9 19388.4 19540.8 19649.7 13758.7 13998.1 14017.2 14022.4 14028.6 23188.5 23454.4 23499.5 23526.2 23537.2 8958.1 8989.4 9079.3 9085.5 9149.7 1093.9 1102.7 1136.0 1139.4 1187.9 29109.7 29272.4 29786.7 29939.7 29955.7 1124.2 1125.8 1184.0 1192.5 1273.0 15560.9 15867.4 16189.0 18811.3 18842.0 591246.0 596137.0 600442.0 600812.0 601727.0 60972.7 65432.7 65990.0 66231.7 66292.3 1376.8 1513.7 1524.7 1525.1 1547.3 33830.6 33880.0 34013.3 34032.3 34438.5 49627.8 50811.0 52375.2 52864.7 55811.0 284812.0 285343.0 286038.0 286581.0 288622.0 37534.2 37664.6 38140.8 38162.6 38323.4 48940.5 49529.3 49835.0 50070.7 50235.5 41399.8 42640.6 42811.8 43093.8 43585.6 41896.6 42402.8 42589.6 43080.1 43375.6 42048.6 42389.2 42741.0 42814.6 42933.8 36859.6 37358.8 37675.8 38092.4 38257.8 28555.9 28637.0 28656.7 28736.1 28761.4 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33196.87 Median:2404.96 stddev:109854.90 (4567.9%) stddev-sans-first:110135.50 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: Values: 418.4 421.0 422.5 426.4 434.1 16582.2 16923.2 19829.7 20377.6 20415.3 19631.5 20509.6 20573.4 20761.0 20771.8 5876.6 5904.4 5995.6 6010.7 6012.6 4262.8 4375.8 5951.5 6371.7 6562.5 6385.5 6459.1 6475.4 6509.5 6510.5 6400.5 6457.9 6465.3 6467.0 6468.4 5800.9 5884.8 5885.8 5895.4 5901.3 24877.4 24951.8 25245.7 25315.0 25340.7 2422.4 2436.1 2465.6 2474.8 2514.2 10887.8 10958.5 11145.3 14388.9 15078.7 1820.9 1844.7 1851.2 1886.6 1917.3 74294.6 75063.6 75692.2 75692.6 76159.0 7918.3 8054.4 8142.1 8169.5 8182.8 10025.9 10027.6 10042.3 10058.1 10070.1 6499.0 6532.2 6553.0 6562.5 6610.5 6521.7 6553.8 6587.6 6597.5 6863.5 3737.0 3761.7 3763.4 3783.2 3804.1 1276.7 1289.5 1305.1 1326.2 1333.8 544.9 553.6 557.1 577.9 584.6 12007.8 13290.1 13368.5 13680.9 13773.0 543.3 555.7 560.8 577.1 588.0 7126.2 7357.9 7380.6 7457.2 7924.5 636157.0 649252.1 657391.0 702831.0 703250.0 82737.0 91765.5 94017.0 94462.0 94515.0 614.6 627.3 629.3 635.8 638.4 11616.4 12263.5 12521.1 12557.4 12582.5 41590.4 41626.8 41875.5 42494.8 43019.0 55969.0 55983.4 56142.7 57048.4 57288.7 7715.7 7785.2 7806.9 7814.5 7817.4 13125.3 13230.4 13300.7 13499.3 13604.1 11856.2 11889.2 11961.9 12104.0 12153.8 11535.4 11536.1 11808.8 11914.0 12095.4 10371.0 11171.8 12140.3 12178.8 12302.8 7776.8 7832.1 7909.5 7910.8 7914.1 11893.6 12192.8 12492.6 12581.1 12633.5 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7243.21 Median:3603.03 stddev:4260.55 (118.2%) stddev-sans-first:4251.22 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: Values: 1576.5 1703.7 1865.5 2104.5 2109.8 9355.0 10401.2 10606.7 10619.8 10631.3 10019.5 10094.2 10140.5 10151.6 10166.6 2090.5 2119.8 2350.8 2360.0 2415.0 2403.7 2435.1 2440.9 2449.5 2452.4 2336.3 2381.6 2382.9 2385.3 2386.5 2129.1 2176.2 2391.5 2430.4 2446.1 2417.1 2441.1 2442.7 2444.2 2490.4 10464.3 10550.9 10567.9 10576.2 10582.3 5803.4 5889.8 5901.4 5901.6 5903.4 3588.6 3617.5 3630.7 3690.5 3725.8 1129.8 1135.8 1151.1 1181.2 1181.3 16195.7 16368.9 16375.6 16380.8 16400.3 5279.0 5282.5 5343.4 5408.1 5429.1 13577.9 13581.3 13586.0 13586.9 13617.4 5984.9 5987.6 5996.1 5998.8 6003.5 5371.4 5374.6 5393.4 5396.1 5434.6 4137.2 4146.6 4175.9 4184.2 4196.5 1319.5 1350.6 1356.0 1358.5 1359.5 1449.3 1459.5 1483.9 1488.1 1496.4 9334.4 9338.3 9391.6 9409.3 9410.1 580.7 585.1 586.4 589.1 595.1 7454.7 7506.6 7536.7 7544.3 7571.8 13400.2 13804.8 13827.5 13855.7 13878.0 13368.3 13590.9 13660.3 13671.5 13685.7 9575.9 9778.2 9778.9 9781.7 9848.4 9263.3 9327.8 9342.5 9370.3 9394.7 11503.3 11623.1 11659.4 11701.3 11800.7 11829.2 11994.2 12117.3 12170.2 12179.2 8868.3 9066.5 9099.4 9103.8 9107.8 9714.6 9753.0 9831.2 9841.2 10031.0 8321.3 8802.5 9456.3 9490.5 9553.6 9041.3 9051.8 9167.0 9186.4 9269.1 9550.4 9631.5 9664.9 9706.3 9735.8 8624.6 8666.9 8670.7 8672.3 8679.5 8476.3 8591.9 8614.2 8638.4 8647.1 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,470 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5443.83 Median:6147.84 stddev:1555.38 (25.3%) stddev-sans-first:1512.80 01:39:23 INFO - 2015-10-30 01:39:23,472 DEBUG : BROWSER_OUTPUT: Values: 391.2 393.0 394.6 396.7 399.5 6028.5 6038.5 6055.6 6065.2 6180.4 5866.5 5998.1 6029.8 6038.6 6042.9 4639.6 4703.0 4721.5 4789.7 4791.1 4758.0 4762.4 4773.8 4784.3 4795.4 4714.1 4740.2 4742.6 4745.7 4748.9 4716.1 4733.6 4741.1 4746.0 4746.0 4117.1 4171.7 4180.5 4198.2 4247.3 5689.9 5703.8 5704.1 5706.7 5725.5 5252.1 5369.2 5479.1 5483.2 5486.7 6311.6 6361.7 6379.0 6388.7 6393.2 4738.3 4739.9 4740.4 4746.1 4747.5 6437.4 6497.8 6545.1 6574.3 6580.1 4879.5 4881.6 4882.7 4916.8 4931.8 4984.3 4991.0 4998.9 5000.4 5001.7 5546.3 5592.0 5597.1 5602.4 5602.4 6362.4 6444.0 6458.0 6466.9 6484.2 1789.5 1809.6 1810.1 1810.2 1811.3 1234.3 1255.2 1265.8 1268.7 1286.8 6132.2 6180.5 6183.1 6189.0 6191.0 6616.4 6618.2 6625.3 6626.1 6637.0 6048.2 6163.4 6166.4 6168.7 6171.3 3652.5 3669.7 3677.8 3685.9 3687.6 6793.1 6799.4 6810.2 6844.5 6845.6 6677.3 6788.6 6799.7 6800.4 6804.1 6679.4 6744.4 6785.1 6788.4 6812.4 6549.2 6563.1 6565.6 6583.1 6636.9 6394.4 6467.8 6489.8 6506.2 6506.3 6768.0 6802.4 6813.5 6817.1 6821.4 4867.1 4868.3 4870.1 4873.9 4878.8 6581.0 6590.5 6590.6 6591.5 6596.0 6398.3 6516.6 6518.6 6518.7 6518.8 6485.0 6514.4 6520.7 6528.0 6532.9 6269.9 6407.5 6410.3 6412.0 6425.6 6525.0 6546.4 6547.1 6553.1 6558.8 6337.1 6341.1 6388.3 6388.8 6396.8 01:39:23 INFO - 2015-10-30 01:39:23,472 DEBUG : BROWSER_OUTPUT: 01:39:23 INFO - 2015-10-30 01:39:23,472 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13017.28 Median:4226.41 stddev:14507.61 (343.3%) stddev-sans-first:14519.52 01:39:23 INFO - 2015-10-30 01:39:23,472 DEBUG : BROWSER_OUTPUT: Values: 845.8 851.2 907.7 934.2 955.9 12794.7 13090.9 13107.4 13107.6 13147.7 13327.4 13445.4 13469.3 13488.3 13504.8 758.4 763.9 909.5 923.3 938.1 933.8 938.9 946.3 947.0 947.1 981.3 990.3 990.6 991.1 991.2 795.5 798.6 973.5 989.9 993.3 736.3 737.3 737.5 739.3 740.6 12803.0 13143.8 13225.7 13266.7 13276.3 12279.9 12736.4 12945.0 12990.4 13021.0 10218.1 10289.0 10308.7 10322.1 10348.0 3792.5 3797.9 3813.2 3841.8 3845.4 46334.8 46968.3 47201.8 47436.3 47467.0 8001.2 8102.4 10525.0 10594.5 10600.5 11863.5 11954.5 11976.5 12001.4 12022.4 7084.1 7294.2 7318.0 7394.6 7538.7 4301.2 4344.1 4392.3 4600.1 4646.7 3108.1 3131.8 3137.4 3147.1 3148.1 542.5 546.0 552.3 556.1 561.4 628.1 704.9 708.8 715.2 730.3 8205.0 8264.5 8277.5 8349.5 8550.5 644.9 688.7 702.5 744.5 747.8 4190.3 4206.0 4209.9 4212.2 4240.7 54826.0 55243.0 55307.4 55372.7 56026.4 46770.1 46926.3 47359.3 47520.0 47750.8 39164.4 39456.8 39708.4 39721.4 39876.6 8362.8 8645.8 8836.6 8950.6 9098.9 27844.9 27926.0 28154.9 28369.7 28755.3 38537.3 38876.6 39006.8 39390.8 39435.0 11567.0 11792.5 11863.7 12382.1 12385.6 12284.8 12383.9 12701.9 12882.7 13213.3 11702.5 11826.0 11920.8 12427.4 12587.6 11912.7 11921.1 11925.9 11973.0 12214.3 11693.9 11958.5 11976.3 11977.5 12468.3 9399.5 9628.3 9707.2 9718.5 10090.5 9878.8 9886.2 10007.3 10016.4 10061.9 01:39:23 INFO - 2015-10-30 01:39:23,472 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:39:23 INFO - 2015-10-30 01:39:23,472 DEBUG : BROWSER_OUTPUT: 01:39:24 INFO - 2015-10-30 01:39:24,129 INFO : Browser exited with error code: 0 01:39:24 INFO - 2015-10-30 01:39:24,148 INFO : Completed test dromaeo_css (00:18:35) 01:39:24 INFO - 2015-10-30 01:39:24,148 INFO : Starting test kraken 01:39:24 INFO - 2015-10-30 01:39:24,148 DEBUG : operating with platform_type : linux_ 01:39:24 INFO - 2015-10-30 01:39:24,148 INFO : Initialising browser for kraken test... 01:39:24 INFO - 2015-10-30 01:39:24,154 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH2K0ZK/profile http://localhost/getInfo.html 01:39:28 INFO - 2015-10-30 01:39:28,558 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:39:28 INFO - 2015-10-30 01:39:28,558 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:39:28 INFO - 2015-10-30 01:39:28,560 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:39:28 INFO - 2015-10-30 01:39:28,560 DEBUG : BROWSER_OUTPUT: __metrics 01:39:28 INFO - 2015-10-30 01:39:28,777 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:39:30 INFO - 2015-10-30 01:39:30,473 INFO : Browser initialized. 01:39:30 INFO - 2015-10-30 01:39:30,474 INFO : Running cycle 1/1 for kraken test... 01:39:30 INFO - 2015-10-30 01:39:30,474 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH2K0ZK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:39:42 INFO - 2015-10-30 01:39:42,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 132014080 01:39:42 INFO - 2015-10-30 01:39:42,146 DEBUG : BROWSER_OUTPUT: 01:39:45 INFO - 2015-10-30 01:39:45,032 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) 01:39:45 INFO - 2015-10-30 01:39:45,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 166912000 01:39:45 INFO - 2015-10-30 01:39:45,614 DEBUG : BROWSER_OUTPUT: 01:39:48 INFO - 2015-10-30 01:39:48,136 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) 01:39:48 INFO - 2015-10-30 01:39:48,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 163237888 01:39:48 INFO - 2015-10-30 01:39:48,706 DEBUG : BROWSER_OUTPUT: 01:39:51 INFO - 2015-10-30 01:39:51,469 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) 01:39:52 INFO - 2015-10-30 01:39:52,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 162181120 01:39:52 INFO - 2015-10-30 01:39:52,035 DEBUG : BROWSER_OUTPUT: 01:39:53 INFO - 2015-10-30 01:39:53,972 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) 01:39:54 INFO - 2015-10-30 01:39:54,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 159768576 01:39:54 INFO - 2015-10-30 01:39:54,534 DEBUG : BROWSER_OUTPUT: 01:39:56 INFO - 2015-10-30 01:39:56,632 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) 01:39:57 INFO - 2015-10-30 01:39:57,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 154038272 01:39:57 INFO - 2015-10-30 01:39:57,194 DEBUG : BROWSER_OUTPUT: 01:40:00 INFO - 2015-10-30 01:40:00,037 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) 01:40:00 INFO - 2015-10-30 01:40:00,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 156573696 01:40:00 INFO - 2015-10-30 01:40:00,604 DEBUG : BROWSER_OUTPUT: 01:40:03 INFO - 2015-10-30 01:40:03,918 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) 01:40:04 INFO - 2015-10-30 01:40:04,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 157626368 01:40:04 INFO - 2015-10-30 01:40:04,500 DEBUG : BROWSER_OUTPUT: 01:40:07 INFO - 2015-10-30 01:40:07,182 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) 01:40:07 INFO - 2015-10-30 01:40:07,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 156590080 01:40:07 INFO - 2015-10-30 01:40:07,749 DEBUG : BROWSER_OUTPUT: 01:40:09 INFO - 2015-10-30 01:40:09,257 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) 01:40:09 INFO - 2015-10-30 01:40:09,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 164560896 01:40:09 INFO - 2015-10-30 01:40:09,811 DEBUG : BROWSER_OUTPUT: 01:40:11 INFO - 2015-10-30 01:40:11,484 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) 01:40:12 INFO - 2015-10-30 01:40:12,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 165142528 01:40:12 INFO - 2015-10-30 01:40:12,079 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,035 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) 01:40:14 INFO - 2015-10-30 01:40:14,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 169623552 01:40:14 INFO - 2015-10-30 01:40:14,596 DEBUG : BROWSER_OUTPUT: 01:40:16 INFO - 2015-10-30 01:40:16,849 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) 01:40:17 INFO - 2015-10-30 01:40:17,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 178753536 01:40:17 INFO - 2015-10-30 01:40:17,420 DEBUG : BROWSER_OUTPUT: 01:40:19 INFO - 2015-10-30 01:40:19,815 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) 01:40:20 INFO - 2015-10-30 01:40:20,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 175435776 01:40:20 INFO - 2015-10-30 01:40:20,385 DEBUG : BROWSER_OUTPUT: 01:40:21 INFO - 2015-10-30 01:40:21,962 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) 01:40:22 INFO - 2015-10-30 01:40:22,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 235069440 01:40:22 INFO - 2015-10-30 01:40:22,213 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,216 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:40:22 INFO - 2015-10-30 01:40:22,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: |0;ai-astar;102;108;109;109;110;108;115;112;109;109 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;128;144;152;123;150;157;130;159;123 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;158;160;159;158;159;161;158;160 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;71;154;71;72;72;71;154;71 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;87;89;135;89;89;89;137;87;88;133 01:40:22 INFO - 2015-10-30 01:40:22,217 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;110;109;109;110;109 01:40:22 INFO - 2015-10-30 01:40:22,218 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;147;146;145;145;144;145;146 01:40:22 INFO - 2015-10-30 01:40:22,218 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;96;96;96 01:40:22 INFO - 2015-10-30 01:40:22,218 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;52;53;53;57;55;53;53;54;67;52 01:40:22 INFO - 2015-10-30 01:40:22,218 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;61;61;60;61;60;61;61;61;60 01:40:22 INFO - 2015-10-30 01:40:22,218 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;77;78;79;80;79;79;79;78;85 01:40:22 INFO - 2015-10-30 01:40:22,218 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;109;106;110;116;114;111;106;121;113 01:40:22 INFO - 2015-10-30 01:40:22,218 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;137;135;135;136;134;135;135;136;134 01:40:22 INFO - 2015-10-30 01:40:22,219 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;65;60;59;61;61;60;62;60;59 01:40:22 INFO - 2015-10-30 01:40:22,219 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:40:22 INFO - 2015-10-30 01:40:22,219 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:40:22 INFO - 2015-10-30 01:40:22,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,882 01:40:22 INFO - 2015-10-30 01:40:22,219 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:40:22 INFO - 2015-10-30 01:40:22,219 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194422214__endTimestamp 01:40:22 INFO - 2015-10-30 01:40:22,219 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:109.00 stddev:3.28 (3.0%) stddev-sans-first:2.26 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: Values: 102.0 108.0 109.0 109.0 110.0 108.0 115.0 112.0 109.0 109.0 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:149.00 stddev:14.05 (9.4%) stddev-sans-first:14.70 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: Values: 148.0 128.0 144.0 152.0 123.0 150.0 157.0 130.0 159.0 123.0 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.50 Median:160.00 stddev:1.35 (0.8%) stddev-sans-first:1.09 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 158.0 160.0 159.0 158.0 159.0 161.0 158.0 160.0 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,223 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:71.00 stddev:34.84 (49.1%) stddev-sans-first:36.48 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 154.0 71.0 72.0 72.0 71.0 154.0 71.0 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:88.50 stddev:22.60 (25.5%) stddev-sans-first:23.28 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: Values: 87.0 89.0 135.0 89.0 89.0 89.0 137.0 87.0 88.0 133.0 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,224 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 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 147.0 146.0 145.0 145.0 144.0 145.0 146.0 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.90 Median:53.50 stddev:4.51 (8.4%) stddev-sans-first:4.66 01:40:22 INFO - 2015-10-30 01:40:22,224 DEBUG : BROWSER_OUTPUT: Values: 52.0 53.0 53.0 57.0 55.0 53.0 53.0 54.0 67.0 52.0 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 61.0 60.0 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.40 (3.0%) stddev-sans-first:2.29 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 78.0 79.0 80.0 79.0 79.0 79.0 78.0 85.0 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:111.40 Median:112.00 stddev:4.72 (4.2%) stddev-sans-first:4.84 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 106.0 110.0 116.0 114.0 111.0 106.0 121.0 113.0 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:135.50 stddev:2.04 (1.5%) stddev-sans-first:0.97 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: Values: 141.0 137.0 135.0 135.0 136.0 134.0 135.0 135.0 136.0 134.0 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:61.00 stddev:1.75 (2.9%) stddev-sans-first:1.86 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: Values: 61.0 65.0 60.0 59.0 61.0 61.0 60.0 62.0 60.0 59.0 01:40:22 INFO - 2015-10-30 01:40:22,225 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:40:22 INFO - 2015-10-30 01:40:22,226 DEBUG : BROWSER_OUTPUT: 01:40:23 INFO - 2015-10-30 01:40:23,017 INFO : Browser exited with error code: 0 01:40:23 INFO - 2015-10-30 01:40:23,062 INFO : Completed test kraken (00:00:58) 01:40:23 INFO - 2015-10-30 01:40:23,062 INFO : Starting test v8_7 01:40:23 INFO - 2015-10-30 01:40:23,062 DEBUG : operating with platform_type : linux_ 01:40:23 INFO - 2015-10-30 01:40:23,062 INFO : Initialising browser for v8_7 test... 01:40:23 INFO - 2015-10-30 01:40:23,068 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz9QbcV/profile http://localhost/getInfo.html 01:40:27 INFO - 2015-10-30 01:40:27,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:40:27 INFO - 2015-10-30 01:40:27,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:40:27 INFO - 2015-10-30 01:40:27,138 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:40:27 INFO - 2015-10-30 01:40:27,139 DEBUG : BROWSER_OUTPUT: __metrics 01:40:27 INFO - 2015-10-30 01:40:27,255 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:40:29 INFO - 2015-10-30 01:40:29,073 INFO : Browser initialized. 01:40:29 INFO - 2015-10-30 01:40:29,074 INFO : Running cycle 1/1 for v8_7 test... 01:40:29 INFO - 2015-10-30 01:40:29,074 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz9QbcV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:40:40 INFO - 2015-10-30 01:40:40,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 132689920 01:40:40 INFO - 2015-10-30 01:40:40,772 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,151 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) 01:41:02 INFO - 2015-10-30 01:41:02,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 427659264 01:41:02 INFO - 2015-10-30 01:41:02,402 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,403 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:41:02 INFO - 2015-10-30 01:41:02,403 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:41:02 INFO - 2015-10-30 01:41:02,403 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:41:02 INFO - 2015-10-30 01:41:02,403 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:41:02 INFO - 2015-10-30 01:41:02,404 DEBUG : BROWSER_OUTPUT: |0;Richards;168.20857863751053 01:41:02 INFO - 2015-10-30 01:41:02,404 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.20733520568314 01:41:02 INFO - 2015-10-30 01:41:02,404 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.2466836014677 01:41:02 INFO - 2015-10-30 01:41:02,404 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5076.1421319796955 01:41:02 INFO - 2015-10-30 01:41:02,404 DEBUG : BROWSER_OUTPUT: |4;RayTrace;957.8544061302682 01:41:02 INFO - 2015-10-30 01:41:02,405 DEBUG : BROWSER_OUTPUT: |5;Earley;540.8328826392644 01:41:02 INFO - 2015-10-30 01:41:02,405 DEBUG : BROWSER_OUTPUT: |6;Boyer;10244.897959183674 01:41:02 INFO - 2015-10-30 01:41:02,405 DEBUG : BROWSER_OUTPUT: |7;RegExp;25350 01:41:02 INFO - 2015-10-30 01:41:02,405 DEBUG : BROWSER_OUTPUT: |8;Splay;531.632110579479 01:41:02 INFO - 2015-10-30 01:41:02,406 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4868.9320388349515 01:41:02 INFO - 2015-10-30 01:41:02,406 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:41:02 INFO - 2015-10-30 01:41:02,406 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194462402__endTimestamp 01:41:02 INFO - 2015-10-30 01:41:02,406 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,407 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:41:02 INFO - 2015-10-30 01:41:02,407 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:41:02 INFO - 2015-10-30 01:41:02,407 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,407 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.21 Median:168.21 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,407 DEBUG : BROWSER_OUTPUT: Values: 168.2 01:41:02 INFO - 2015-10-30 01:41:02,408 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,408 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.21 Median:165.21 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,408 DEBUG : BROWSER_OUTPUT: Values: 165.2 01:41:02 INFO - 2015-10-30 01:41:02,408 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,409 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.25 Median:282.25 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,410 DEBUG : BROWSER_OUTPUT: Values: 282.2 01:41:02 INFO - 2015-10-30 01:41:02,410 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,410 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5076.14 Median:5076.14 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,410 DEBUG : BROWSER_OUTPUT: Values: 5076.1 01:41:02 INFO - 2015-10-30 01:41:02,410 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,410 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:957.85 Median:957.85 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,410 DEBUG : BROWSER_OUTPUT: Values: 957.9 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.83 Median:540.83 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: Values: 540.8 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10244.90 Median:10244.90 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: Values: 10244.9 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25350.00 Median:25350.00 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: Values: 25350.0 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,411 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:531.63 Median:531.63 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,412 DEBUG : BROWSER_OUTPUT: Values: 531.6 01:41:02 INFO - 2015-10-30 01:41:02,412 DEBUG : BROWSER_OUTPUT: 01:41:02 INFO - 2015-10-30 01:41:02,412 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 01:41:02 INFO - 2015-10-30 01:41:02,412 DEBUG : BROWSER_OUTPUT: Values: 4868.9 01:41:02 INFO - 2015-10-30 01:41:02,412 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:41:02 INFO - 2015-10-30 01:41:02,412 DEBUG : BROWSER_OUTPUT: 01:41:03 INFO - 2015-10-30 01:41:03,293 INFO : Browser exited with error code: 0 01:41:03 INFO - 2015-10-30 01:41:03,310 INFO : Completed test v8_7 (00:00:40) 01:41:03 INFO - 2015-10-30 01:41:03,310 INFO : Completed test suite (00:20:14) 01:41:03 INFO - 2015-10-30 01:41:03,310 DEBUG : Working with test: dromaeo_css 01:41:03 INFO - 2015-10-30 01:41:03,310 DEBUG : Generating results file: dromaeo_css 01:41:03 INFO - 2015-10-30 01:41:03,311 DEBUG : Working with test: kraken 01:41:03 INFO - 2015-10-30 01:41:03,311 DEBUG : Generating results file: kraken 01:41:03 INFO - 2015-10-30 01:41:03,311 INFO : javascript benchmark 01:41:03 INFO - 2015-10-30 01:41:03,311 DEBUG : Working with test: v8_7 01:41:03 INFO - 2015-10-30 01:41:03,312 DEBUG : Generating results file: v8_7 01:41:03 INFO - 2015-10-30 01:41:03,312 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:41:03 INFO - 2015-10-30 01:41:03,373 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 01:41:03 INFO - 2015-10-30 01:41:03,373 DEBUG : process_Request line: dromaeo_css 7526.09 graph.html#tests=[[72,52,35]] 01:41:03 INFO - 2015-10-30 01:41:03,374 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:41:03 INFO - 2015-10-30 01:41:03,407 DEBUG : process_Request line: kraken 1453.10 graph.html#tests=[[232,52,35]] 01:41:03 INFO - 2015-10-30 01:41:03,407 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:41:03 INFO - 2015-10-30 01:41:03,446 DEBUG : process_Request line: v8_7 23185.69 graph.html#tests=[[230,52,35]] 01:41:03 INFO - 2015-10-30 01:41:03,449 INFO : javascript benchmark 01:41:03 INFO - 2015-10-30 01:41:03,453 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [418.41213095600693, 420.96842736794747, 422.51410877490883, 426.4030357499502, 434.1339028637867, 16582.170891455407, 16923.238454269558, 19829.702554461677, 20377.592448151026, 20415.285465008747, 19631.509212269666, 20509.589808203826, 20573.382798516068, 20761.0, 20771.792282077175, 5876.588638795297, 5904.3800400957925, 5995.580309378345, 6010.669413182273, 6012.609180403281, 4262.827722376341, 4375.781210939456, 5951.464368206861, 6371.713272902707, 6562.507811914102, 6385.457236134934, 6459.063435801806, 6475.449586785129, 6509.511786615999, 6510.5442619016685, 6400.455961243277, 6457.935420645827, 6465.288818229991, 6467.0, 6468.353164683517, 5800.8839823203725, 5884.823455296348, 5885.823425297248, 5895.4399332063385, 5901.262342207224, 24877.378065548324, 24951.750482495125, 25245.747542524525, 25315.0, 25340.746592534208, 2422.382292515415, 2436.0864675746593, 2465.6055031194924, 2474.752524747511, 2514.157757151338, 10887.782244355149, 10958.452077396178, 11145.275557088764, 14388.92805535976, 15078.698426031418, 1820.945371638853, 1844.7325137854937, 1851.1577232359243, 1886.6415381077552, 1917.319351630165, 74294.62852685756, 75063.62468187678, 75692.24307756907, 75692.62153689252, 76159.0, 7918.326942209861, 8054.436189466681, 8142.104368519458, 8169.4689845161065, 8182.836343273101, 10025.899741002497, 10027.649032283834, 10042.347247428894, 10058.094771470604, 10070.093691567794, 6498.967505162444, 6532.150820393318, 6553.0, 6562.4578224117295, 6610.504212184105, 6521.67391630426, 6553.770618028346, 6587.571807832475, 6597.538172327891, 6863.519553631298, 3736.981315093407, 3761.717871159674, 3763.435484677266, 3783.2244389900006, 3804.1060350817534, 1276.716899515999, 1289.5164313382481, 1305.0799186573443, 1326.1843965960866, 1333.8266025416829, 544.9209864569694, 553.6318348298337, 557.1086261980798, 577.9046457334492, 584.5820238529471, 12007.759844803055, 13290.136141150795, 13368.532101376406, 13680.863191368158, 13773.0, 543.2910052381601, 555.6638233868532, 560.7616762875762, 577.0968434400235, 588.0414923674468, 7126.2161162272105, 7357.889631655529, 7380.630968451556, 7457.216992215847, 7924.48490848093, 636157.0, 649252.0770091054, 657391.0, 702831.0, 703250.0, 82737.0, 91765.54117229371, 94017.0, 94462.0, 94515.0, 614.6342925959048, 627.3412916437813, 629.3266205160435, 635.7997230872261, 638.4317957018164, 11616.419179041182, 12263.509459621871, 12521.060920430822, 12557.434915428645, 12582.496700131893, 41590.37614435725, 41626.791866040476, 41875.53435629739, 42494.78423190873, 43019.0, 55969.0, 55983.44016559782, 56142.719286403306, 57048.42951570431, 57288.713556431954, 7715.729949451742, 7785.182555831782, 7806.88289675644, 7814.4529882907655, 7817.374610031297, 13125.34373281313, 13230.404631791786, 13300.733985320432, 13499.257540835348, 13604.115732477358, 11856.17006809515, 11889.167758256839, 11961.880381196077, 12104.031677465606, 12153.81769273444, 11535.423228838692, 11536.134789890624, 11808.76382472363, 11914.0, 12095.395230238277, 10371.0, 11171.776564468502, 12140.33228172459, 12178.75642487163, 12302.81545776832, 7776.805579860549, 7832.099308579358, 7909.485883417559, 7910.762677119696, 7914.0503139623615, 11893.643190704293, 12192.780721927737, 12492.562760303346, 12581.056420768296, 12633.494660213488], "dojo.html": [3367.124547617619, 3418.880339188129, 3452.03343063942, 3453.3783918894605, 3478.40867052601, 5760.7695692172365, 5770.480656740892, 5779.595428320014, 5794.0729483282685, 5812.215350927634, 5781.653100813944, 5816.098504731763, 5834.066549352105, 5839.678817665027, 5859.44335288147, 5224.346956630421, 5264.078786212417, 5278.287431196797, 5306.628536002481, 5368.087425137716, 5266.578673706094, 5268.710220937847, 5287.0, 5287.021900948318, 5295.311609490761, 5179.482051794809, 5184.818531351403, 5232.0, 5278.973605131988, 5317.867053323678, 5319.840404787863, 5375.784968601251, 5376.059189641797, 5380.973095134538, 5383.4616538346045, 5302.734863256822, 5306.363236411656, 5311.681299122027, 5333.040052790496, 5370.785168593252, 5400.972995134999, 5497.5601951844155, 5498.367687715884, 5627.127795191752, 5627.6904770237625, 6248.125262463259, 6263.686815659199, 6266.060090986389, 6277.246730392337, 6291.716872740738, 6045.45590896817, 6296.433321001132, 6296.496280297565, 6299.149614801989, 6301.968490157566, 5775.711214439303, 5785.855353616151, 5879.32387775407, 5892.116182572563, 5896.882062358729, 6318.873622527523, 6382.648954307465, 6385.074164246158, 6386.042093685891, 6387.073874288202, 6035.185249991283, 6118.908216376758, 6137.570370074052, 6193.349698281706, 6210.627362358183, 6114.92353857414, 6213.347598502182, 6222.315545290015, 6228.0, 6245.313015568284, 6216.875662486725, 6243.0635404688755, 6243.687815609202, 6253.874922501524, 6254.249490061222, 5948.256467941507, 6060.696965151725, 6143.846403839851, 6265.467435268053, 6271.655058971709, 4715.434147902205, 4719.669623126349, 4724.456687480915, 4727.479977202505, 4729.408823897013, 4184.184084103632, 4188.015816283171, 4210.221109094766, 4215.388768628532, 4220.177065472203, 5702.0, 5802.767889284381, 5877.52979761618, 5888.970555147197, 5890.440408161217, 6117.785877494266, 6226.750929962841, 6245.75016999324, 6247.406496382836, 6252.030935205051, 5884.823455296262, 5892.7642894283745, 5917.260342457193, 5937.643741375531, 5948.613340132878, 5189.221616757516, 5286.471352864683, 5311.867203319948, 5424.159255315432, 5432.456754324536, 6510.0, 6511.772087976993, 6517.706703198368, 6522.510811689048, 6525.412712855866, 6345.524085693499, 6347.143135676624, 6349.111124442674, 6359.141515895295, 6366.267879193952, 6180.134781130735, 6286.717097730521, 6293.433590976834, 6402.583832050902, 6516.055172000129, 6099.4815440688035, 6109.7861574844665, 6118.449339559283, 6154.661493617715, 6161.0, 6209.348018457997, 6222.377762223741, 6226.813195604139, 6227.439530442282, 6232.501399887908, 5812.9709351452975, 5922.496587790086, 6005.7297421617, 6129.862342918601, 6136.881217787523, 6123.374584456894, 6129.754809807736, 6134.079888016655, 6134.35589263121, 6138.355472675305, 5868.031774757117, 5992.310884248367, 6035.486983606443, 6039.48664363534, 6056.757729690763, 6020.638761674313, 6111.449969502766, 6116.969415152896, 6131.785387511416, 6147.016477363601, 5998.190244317136, 6045.274567051806, 6046.818595442144, 6062.242219722535, 6081.604695694766], "mootools.html": [1576.4718819195568, 1703.7188863837468, 1865.524291305717, 2104.4633618427297, 2109.767925528193, 9354.953225233872, 10401.167906567476, 10606.734831629203, 10619.84070238947, 10631.255812093137, 10019.549120289586, 10094.242931780127, 10140.5436755346, 10151.644692435766, 10166.64416745414, 2090.540081182145, 2119.79861913118, 2350.7884290413904, 2359.9764002360016, 2414.95170096598, 2403.7476065013184, 2435.1233555919853, 2440.9389765255833, 2449.4856080223176, 2452.411421258903, 2336.2991102669216, 2381.559411508868, 2382.916597919073, 2385.2844146755992, 2386.5226954609147, 2129.105775574255, 2176.1513009926143, 2391.5456063347997, 2430.4409985703387, 2446.13162327373, 2417.093589903786, 2441.060191826142, 2442.658027876099, 2444.1567659157563, 2490.3525083478244, 10464.267501274913, 10550.894491055067, 10567.94716026415, 10576.206784491116, 10582.253928101854, 5803.361630220672, 5889.7644094236175, 5901.439363260483, 5901.645901245939, 5903.409659034105, 3588.5873124590485, 3617.475466057433, 3630.6550877666577, 3690.4833323334756, 3725.8137093145506, 1129.807932651443, 1135.818269076952, 1151.0906383956665, 1181.2085902445383, 1181.2794195540714, 16195.676086478323, 16368.918155409146, 16375.59061023472, 16380.754288685679, 16400.26198821056, 5278.97360513195, 5282.524572788468, 5343.412224655285, 5408.0535906216255, 5429.104197807317, 13577.86422135766, 13581.320933953262, 13586.0, 13586.86413135856, 13617.387217575233, 5984.910226346608, 5987.6108052976415, 5996.070609055603, 5998.760049597967, 6003.519718422515, 5371.409144994048, 5374.596905232123, 5393.352797664227, 5396.109641909041, 5434.64674796137, 4137.172565486914, 4146.647534959502, 4175.8956026099595, 4184.225918205142, 4196.538380778112, 1319.459021801057, 1350.6083235861686, 1355.986440135586, 1358.5041459867077, 1359.5377571625695, 1449.2608769527617, 1459.5402448228774, 1483.8961272711022, 1488.1368806092441, 1496.4463148634857, 9334.439933604006, 9338.252939764803, 9391.577379017961, 9409.294302927308, 9410.106039926197, 580.7270582826065, 585.1018686316484, 586.3813676571173, 589.0810335876047, 595.1429940885112, 7454.701811927463, 7506.587137707478, 7536.7362142324755, 7544.3210111089165, 7571.772846814494, 13400.195988240737, 13804.792928106086, 13827.51603693866, 13855.722885542233, 13878.0, 13368.33158342079, 13590.864091359157, 13660.316984150753, 13671.453141874214, 13685.657858553615, 9575.856362154573, 9778.217742580577, 9778.902210978084, 9781.657641982496, 9848.409095454295, 9263.305252106255, 9327.766805829908, 9342.53287335644, 9370.297227707813, 9394.67118650844, 11503.252288601214, 11623.1282653803, 11659.417029148679, 11701.2979221247, 11800.704982375166, 11829.171957963204, 11994.160408771302, 12117.27296362221, 12170.208936419105, 12179.208351457128, 8868.334874884538, 9066.50134242623, 9099.408538444979, 9103.817923641622, 9107.817843643223, 9714.562844671866, 9753.0, 9831.213502919893, 9841.163501102486, 10031.047050530187, 8321.251087402163, 8802.515861627671, 9456.290778191526, 9490.525473726148, 9553.570089345858, 9041.321900857594, 9051.773705657411, 9166.954165229132, 9186.448813071238, 9269.119433653792, 9550.37922535033, 9631.470269135265, 9664.9033509664, 9706.272029597949, 9735.756606084904, 8624.611892464729, 8666.869996950178, 8670.696525621574, 8672.349573781865, 8679.479231246145, 8476.321894248322, 8591.87112193305, 8614.22471977525, 8638.438501497383, 8647.135286471554], "ext.html": [605.2646035067394, 611.578011172291, 652.2531701202126, 652.3378770547891, 685.7771224352081, 45429.09141817166, 45980.54019459804, 46211.30683039753, 46230.0, 46296.30555541669, 48214.0, 48827.0, 48836.0, 48862.0, 48878.755606221916, 8300.626471808753, 8446.61990210442, 8884.600192991331, 10731.248812583122, 10942.398168100752, 10887.510062047188, 10999.560017599286, 11020.118390528738, 11026.724331891686, 11035.337879727202, 8537.060923298463, 10927.945360273226, 11057.170712196577, 11058.060064894493, 11058.391788451632, 8474.661013559451, 10954.726131846688, 11167.218294719372, 11189.384583847885, 11193.440327983568, 10741.087007604363, 10852.620158294421, 10864.185186110994, 10866.185036122244, 10866.348019118877, 45812.3128153078, 46207.0, 46278.53721462776, 46362.76818615885, 46372.0, 3872.2642697887313, 3948.8420463181437, 3983.5618082010956, 4057.8173982170874, 4610.654200934943, 34722.131946701535, 34790.652093478995, 35044.47433288477, 35069.64930350715, 36268.0, 3776.9055773605605, 3797.9430308545393, 3834.616538346171, 4018.7789671568053, 4028.0735430850777, 354231.0, 354676.22661886783, 356607.0, 357707.0, 360101.0, 60965.39034609686, 63327.68336158382, 68381.65809170922, 70460.64769676221, 70471.2952870475, 66182.0, 66465.33534664688, 66987.0, 67006.66496667583, 67069.32930670728, 18290.359837405627, 18810.905945470186, 19388.4183474496, 19540.804591954184, 19649.705254421195, 13758.65603359904, 13998.090124141898, 14017.229052402012, 14022.368993395321, 14028.649283767987, 23188.53622927532, 23454.413639658804, 23499.530009399718, 23526.176583819826, 23537.234707397012, 8958.10418958099, 8989.370744047854, 9079.273658107335, 9085.500297483703, 9149.660373963456, 1093.9288946218471, 1102.7077824376386, 1136.0003197186422, 1139.4132022008673, 1187.8833896137603, 29109.72588507928, 29272.414551708847, 29786.702132978826, 29939.700602994126, 29955.700442995727, 1124.1793490751797, 1125.7523344864117, 1183.9644810655693, 1192.4574318684977, 1272.9809052864214, 15560.92219538895, 15867.444639437796, 16189.0, 18811.3416030441, 18842.0, 591246.0, 596137.0, 600442.0, 600812.0, 601727.0, 60972.69513652403, 65432.67283663551, 65990.0, 66231.66884165548, 66292.33707662861, 1376.7521846067805, 1513.7199618070472, 1524.6798172383924, 1525.0925699208954, 1547.257316488092, 33830.569899447684, 33880.0, 34013.319733605684, 34032.31935361229, 34438.48342274818, 49627.75186124046, 50810.98378032345, 52375.21437178369, 52864.735676321376, 55811.0, 284812.0, 285343.0, 286038.0, 286581.0, 288622.0, 37534.249315013, 37664.62335376611, 38140.809295953346, 38162.618373817015, 38323.42514862335, 48940.510594893596, 49529.25706114339, 49835.0, 50070.749646251534, 50235.49764502308, 41399.7930010348, 42640.573594264904, 42811.7859410701, 43093.784531077144, 43585.56414435815, 41896.581034189265, 42402.78798605987, 42589.5741042598, 43080.138397231254, 43375.566244337155, 42048.579514204466, 42389.15221695611, 42741.0, 42814.57185428106, 42933.785331073144, 36859.63140368562, 37358.813205933795, 37675.81162094282, 38092.428613570264, 38257.80871095627, 28555.857220713762, 28637.0, 28656.713432865403, 28736.137915862557, 28761.42477150487], "prototype.html": [391.21366054230987, 392.9744566603171, 394.55809493367434, 396.7401352114365, 399.51658493223215, 6028.547858910577, 6038.516918646509, 6055.5761096723245, 6065.2418447694035, 6180.3510631383615, 5866.530677545797, 5998.100284957259, 6029.75880964762, 6038.637681739087, 6042.939570604292, 4639.559241872017, 4702.952970470285, 4721.480637129913, 4789.712617242976, 4791.065742180276, 4757.976210118944, 4762.428508578958, 4773.832915847946, 4784.282357646363, 4795.352627395309, 4714.057188562301, 4740.217864052427, 4742.596879265249, 4745.715257084568, 4748.8575342739605, 4716.080364328957, 4733.55031272032, 4741.099191153669, 4745.952540474603, 4746.0, 4117.07365842686, 4171.687123465722, 4180.456540649727, 4198.223328684173, 4247.256730072256, 5689.857753556153, 5703.800366987177, 5704.087346024658, 5706.657600543981, 5725.484706376446, 5252.107141785906, 5369.24830523727, 5479.0959491683825, 5483.150111732648, 5486.725663716838, 6311.589746666452, 6361.650109243989, 6379.0, 6388.744450221986, 6393.168888044571, 4738.265568836836, 4739.905201895943, 4740.407449068866, 4746.050789842046, 4747.548982846624, 6437.388448097423, 6497.805065848032, 6545.116409284781, 6574.342565743435, 6580.14458120446, 4879.463259041502, 4881.560659540587, 4882.658213925062, 4916.827911023097, 4931.802727890844, 4984.252362145635, 4991.0, 4998.875028124326, 5000.424951130666, 5001.699898006132, 5546.251256080377, 5592.021396255639, 5597.076482380443, 5602.411746766612, 5602.439756024446, 6362.363763623601, 6443.96778016107, 6458.031295305742, 6466.870662586816, 6484.221893372825, 1789.4810504953678, 1809.5657042309751, 1810.1401834128683, 1810.2306519729063, 1811.2664370929795, 1234.2717796499928, 1255.1841303153024, 1265.816456613786, 1268.695513076855, 1286.826278452397, 6132.233470816148, 6180.536459765535, 6183.134361189437, 6189.0, 6191.040388739662, 6616.4045235929, 6618.238902526271, 6625.304343043911, 6626.138601981712, 6636.966815165893, 6048.243969503812, 6163.445289923929, 6166.352532983972, 6168.691565421711, 6171.290301615282, 3652.4886515887797, 3669.743117981769, 3677.79772112531, 3685.8894233173046, 3687.649673281034, 6793.116894803743, 6799.422049125879, 6810.216825065082, 6844.452443804484, 6845.623490708059, 6677.298883617247, 6788.558743681645, 6799.660016999131, 6800.4219641330055, 6804.115464989619, 6679.432248258855, 6744.359285867835, 6785.050092986986, 6788.355106264897, 6812.352826481477, 6549.214094308713, 6563.0811686362995, 6565.606063636197, 6583.144191255297, 6636.867262654817, 6394.360563943568, 6467.773627923, 6489.772857949949, 6506.154199953976, 6506.316836732264, 6768.0, 6802.3537763912345, 6813.4889883257965, 6817.147856517935, 6821.420179284816, 4867.075255701406, 4868.3427737255015, 4870.099031679009, 4873.926891096708, 4878.756062196947, 6581.045748366364, 6590.538662293593, 6590.5716128451495, 6591.538592298493, 6596.0, 6398.296187419287, 6516.609003459618, 6518.641474718936, 6518.73925042993, 6518.804435866931, 6485.0, 6514.413702766774, 6520.673966301761, 6527.967360163168, 6532.869342613026, 6269.874602508015, 6407.455366293917, 6410.262819775786, 6412.0, 6425.614463132227, 6524.9673751630935, 6546.410823025951, 6547.148870646785, 6553.148090748363, 6558.770443034471, 6337.081123237012, 6341.0805433212845, 6388.265349484683, 6388.776392826228, 6396.808095757135], "yui.html": [845.7966995975488, 851.1658574596895, 907.6505545365037, 934.2245935873226, 955.8996305387934, 12794.680132996667, 13090.869091309083, 13107.410166542504, 13107.606771796838, 13147.73704525909, 13327.400266987985, 13445.394957226923, 13469.259190744506, 13488.258145801978, 13504.797428038588, 758.4084414156966, 763.8510490454364, 909.495230147268, 923.2521657457447, 938.0994245524271, 933.7992331648694, 938.8685584018243, 946.2902822882838, 947.0, 947.147567189528, 981.2738573455628, 990.3364745620452, 990.5988074829705, 991.0683957080357, 991.2367477042673, 795.4789612803623, 798.6166640012798, 973.493783232715, 989.8713167288206, 993.3195760903732, 736.2674139231445, 737.2553720742089, 737.5464089584921, 739.2939742545909, 740.5852722475431, 12803.0, 13143.802842957364, 13225.677432256698, 13266.66833329165, 13276.336183190802, 12279.877201227962, 12736.36318184087, 12945.0, 12990.415431305613, 13021.047979860665, 10218.131458826008, 10289.0, 10308.69073927776, 10322.122619577345, 10348.0, 3792.469054332396, 3797.886063418102, 3813.180166264239, 3841.750286231386, 3845.442410850411, 46334.76832615849, 46968.295475567895, 47201.763991179825, 47436.288455672846, 47467.0, 8001.199880011952, 8102.351811855037, 10525.0, 10594.470276486145, 10600.469976501145, 11863.525458981716, 11954.52181912731, 11976.46105925218, 12001.399930003465, 12022.398880055962, 7084.079069720903, 7294.234105418961, 7317.963410183022, 7394.5932973685885, 7538.698452061966, 4301.182775272689, 4344.087741574242, 4392.297232442794, 4600.056988317387, 4646.721196728207, 3108.098651391071, 3131.8120912745308, 3137.3882092992103, 3147.1345380020675, 3148.0870547541413, 542.4792199488535, 545.9836204913859, 552.2958228259002, 556.118552094926, 561.4189314059928, 628.0798630007062, 704.8555046215514, 708.8334241453255, 715.2382712411265, 730.3098571849551, 8205.0, 8264.545450000187, 8277.503349799032, 8349.457285276438, 8550.486970781772, 644.8968165093656, 688.686647575352, 702.4661257444277, 744.4751450227576, 747.768191860525, 4190.28765109932, 4206.032612499082, 4209.894752631209, 4212.157568486315, 4240.660747140221, 54826.0, 55243.0, 55307.44692553103, 55372.72313638406, 56026.43973560294, 46770.06459870784, 46926.296105558446, 47359.28961065587, 47520.0, 47750.76124619424, 39164.412533812014, 39456.80271598624, 39708.40437393441, 39721.40417893734, 39876.60123398845, 8362.832743345221, 8645.783855403664, 8836.646534138563, 8950.597223124845, 9098.90901091007, 27844.860775695994, 27926.02258920928, 28154.85922570374, 28369.716302837533, 28755.28111797222, 38537.292541492374, 38876.6112338873, 39006.80496597499, 39390.80304598458, 39435.0, 11567.0, 11792.469338879942, 11863.703407414883, 12382.071344649368, 12385.62843114708, 12284.754304914031, 12383.938080309541, 12701.93649031749, 12882.67793305175, 13213.273269970245, 11702.473388697359, 11826.0, 11920.76158476843, 12427.37863106823, 12587.559435419716, 11912.702182445162, 11921.10591705643, 11925.92298688692, 11973.0, 12214.26714397139, 11693.941530292293, 11958.521659133537, 11976.28142311464, 11977.461014254206, 12468.251904885736, 9399.530023498934, 9628.277879159232, 9707.223422126071, 9718.514074296116, 10090.527820683687, 9878.753031174278, 9886.159676427584, 10007.349522281029, 10016.39901605906, 10061.949690251502]}, "summary": {"suite": 7526.089178252262, "subtests": {"jquery.html": {"std": 109549.32546454467, "min": 418.41213095600693, "max": 703250.0, "median": 7921.405925345396, "filtered": 8343.170584544703, "mean": 33196.86805510548}, "dojo.html": {"std": 656.3329907471519, "min": 3367.124547617619, "max": 6525.412712855866, "median": 6020.638761674313, "filtered": 5731.652063550008, "mean": 5775.728121066914}, "mootools.html": {"std": 4248.6983482033265, "min": 580.7270582826065, "max": 16400.26198821056, "median": 8631.525196981056, "filtered": 5554.886913442818, "mean": 7243.213651775755}, "ext.html": {"std": 115064.61666996212, "min": 605.2646035067394, "max": 601727.0, "median": 31893.135171221707, "filtered": 21720.31085879683, "mean": 60028.342892378176}, "prototype.html": {"std": 1551.0485529442478, "min": 391.21366054230987, "max": 6845.623490708059, "median": 6098.737657792775, "filtered": 4964.989038212965, "mean": 5443.827868639147}, "yui.html": {"std": 14467.258991078685, "min": 542.4792199488535, "max": 56026.43973560294, "median": 10039.174353155282, "filtered": 6343.222795735744, "mean": 13017.284347501716}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-004"}, "testrun": {"date": 1446193248, "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": "20151029012446", "branch": "Mozilla-Aurora", "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 158.0, 160.0, 159.0, 158.0, 159.0, 161.0, 158.0, 160.0], "ai-astar": [102.0, 108.0, 109.0, 109.0, 110.0, 108.0, 115.0, 112.0, 109.0, 109.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "audio-beat-detection": [148.0, 128.0, 144.0, 152.0, 123.0, 150.0, 157.0, 130.0, 159.0, 123.0], "json-stringify-tinderbox": [61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0], "stanford-crypto-pbkdf2": [141.0, 137.0, 135.0, 135.0, 136.0, 134.0, 135.0, 135.0, 136.0, 134.0], "json-parse-financial": [52.0, 53.0, 53.0, 57.0, 55.0, 53.0, 53.0, 54.0, 67.0, 52.0], "stanford-crypto-sha256-iterative": [61.0, 65.0, 60.0, 59.0, 61.0, 61.0, 60.0, 62.0, 60.0, 59.0], "audio-fft": [72.0, 71.0, 71.0, 154.0, 71.0, 72.0, 72.0, 71.0, 154.0, 71.0], "imaging-darkroom": [145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 144.0, 145.0, 146.0], "stanford-crypto-ccm": [108.0, 109.0, 106.0, 110.0, 116.0, 114.0, 111.0, 106.0, 121.0, 113.0], "audio-oscillator": [87.0, 89.0, 135.0, 89.0, 89.0, 89.0, 137.0, 87.0, 88.0, 133.0], "stanford-crypto-aes": [76.0, 77.0, 78.0, 79.0, 80.0, 79.0, 79.0, 79.0, 78.0, 85.0], "imaging-desaturate": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0]}, "summary": {"suite": 1453.1, "subtests": {"audio-fft": {"std": 33.05283648947546, "min": 71.0, "max": 154.0, "median": 71.5, "filtered": 87.9, "mean": 87.9}, "stanford-crypto-pbkdf2": {"std": 1.9390719429665315, "min": 134.0, "max": 141.0, "median": 135.0, "filtered": 135.8, "mean": 135.8}, "audio-beat-detection": {"std": 13.328165665236908, "min": 123.0, "max": 159.0, "median": 146.0, "filtered": 141.4, "mean": 141.4}, "stanford-crypto-ccm": {"std": 4.476605857119878, "min": 106.0, "max": 121.0, "median": 110.5, "filtered": 111.4, "mean": 111.4}, "imaging-darkroom": {"std": 0.7810249675906655, "min": 144.0, "max": 147.0, "median": 145.0, "filtered": 145.3, "mean": 145.3}, "json-parse-financial": {"std": 4.27668095606862, "min": 52.0, "max": 67.0, "median": 53.0, "filtered": 54.9, "mean": 54.9}, "audio-oscillator": {"std": 21.43851673973738, "min": 87.0, "max": 137.0, "median": 89.0, "filtered": 102.3, "mean": 102.3}, "ai-astar": {"std": 3.1128764832546763, "min": 102.0, "max": 115.0, "median": 109.0, "filtered": 109.1, "mean": 109.1}, "audio-dft": {"std": 1.284523257866513, "min": 158.0, "max": 162.0, "median": 159.5, "filtered": 159.5, "mean": 159.5}, "stanford-crypto-sha256-iterative": {"std": 1.6613247725836155, "min": 59.0, "max": 65.0, "median": 60.5, "filtered": 60.8, "mean": 60.8}, "json-stringify-tinderbox": {"std": 0.45825756949558405, "min": 60.0, "max": 61.0, "median": 61.0, "filtered": 60.7, "mean": 60.7}, "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": 2.280350850198276, "min": 76.0, "max": 85.0, "median": 79.0, "filtered": 79.0, "mean": 79.0}, "imaging-desaturate": {"std": 0.5, "min": 95.0, "max": 96.0, "median": 95.5, "filtered": 95.5, "mean": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-004"}, "testrun": {"date": 1446193248, "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": "20151029012446", "branch": "Mozilla-Aurora", "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876"}}, {"talos_counters": {}, "results": {"DeltaBlue": [165.20733520568314], "Encrypt": [282.2466836014677], "NavierStokes": [4868.9320388349515], "Decrypt": [5076.1421319796955], "Splay": [531.632110579479], "Richards": [168.20857863751053], "RegExp": [25350.0], "Earley": [540.8328826392644], "Boyer": [10244.897959183674], "RayTrace": [957.8544061302682]}, "summary": {"suite": 23185.687338371547, "subtests": {"DeltaBlue": {"std": 0.0, "min": 165.20733520568314, "max": 165.20733520568314, "median": 165.20733520568314, "value": 400.2122539999999, "filtered": 400.2122539999999, "mean": 165.20733520568314}, "Encrypt": {"std": 0.0, "min": 282.2466836014677, "max": 282.2466836014677, "median": 282.2466836014677, "value": 943.0792829999996, "filtered": 943.0792829999996, "mean": 282.2466836014677}, "NavierStokes": {"std": 0.0, "min": 4868.9320388349515, "max": 4868.9320388349515, "median": 4868.9320388349515, "value": 304.7896311066801, "filtered": 304.7896311066801, "mean": 4868.9320388349515}, "Decrypt": {"std": 0.0, "min": 5076.1421319796955, "max": 5076.1421319796955, "median": 5076.1421319796955, "value": 52.43765699999998, "filtered": 52.43765699999998, "mean": 5076.1421319796955}, "Splay": {"std": 0.0, "min": 531.632110579479, "max": 531.632110579479, "median": 531.632110579479, "value": 153.28457100000003, "filtered": 153.28457100000003, "mean": 531.632110579479}, "RegExp": {"std": 0.0, "min": 25350.0, "max": 25350.0, "median": 25350.0, "value": 35.936291913214966, "filtered": 35.936291913214966, "mean": 25350.0}, "Richards": {"std": 0.0, "min": 168.20857863751053, "max": 168.20857863751053, "median": 168.20857863751053, "value": 209.87038999999996, "filtered": 209.87038999999996, "mean": 168.20857863751053}, "Earley": {"std": 0.0, "min": 540.8328826392644, "max": 540.8328826392644, "median": 540.8328826392644, "value": 1232.290087, "filtered": 1232.290087, "mean": 540.8328826392644}, "Boyer": {"std": 0.0, "min": 10244.897959183674, "max": 10244.897959183674, "median": 10244.897959183674, "value": 65.05316135458166, "filtered": 65.05316135458166, "mean": 10244.897959183674}, "RayTrace": {"std": 0.0, "min": 957.8544061302682, "max": 957.8544061302682, "median": 957.8544061302682, "value": 772.5485159999996, "filtered": 772.5485159999996, "mean": 957.8544061302682}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-004"}, "testrun": {"date": 1446193248, "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": "20151029012446", "branch": "Mozilla-Aurora", "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876"}}] 01:41:03 INFO - RETURN: dromaeo_css: 7526.09 01:41:03 INFO - RETURN: kraken: 1453.10 01:41:03 INFO - RETURN: v8_7: 23185.69 01:41:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23185.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1453.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7526.09"}}} 01:41:03 INFO - Return code: 0 01:41:03 INFO - # TBPL SUCCESS # 01:41:03 INFO - Running post-action listener: _resource_record_post_action 01:41:03 INFO - Running post-run listener: _resource_record_post_run 01:41:04 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 7184384; Write bytes: 433127424; Read time: 1332; Write time: 556076 01:41:04 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 46227456; Read time: 0; Write time: 98572 01:41:04 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 5062656; Write bytes: 386899968; Read time: 1136; Write time: 457504 01:41:04 INFO - Running post-run listener: _upload_blobber_files 01:41:04 INFO - Blob upload gear active. 01:41:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:41:04 INFO - Copying logs to upload dir... 01:41:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.940872 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-10-30 01:41:04.700589) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:41:04.704656) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008804 build_url: 'https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/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-30 01:41:04.755719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:41:04.756085) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1446189678.78704-1939350934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:41:04.806445) ========= ========= Started reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-30 01:41:04.806790) ========= ========= Finished reboot slave lost (results: 0, elapsed: 2 secs) (at 2015-10-30 01:41:07.786550) =========