builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1446193178.4 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.396474) ========= 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.396911) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.397286) ========= 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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007712 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.489222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.489504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.551535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.551818) ========= 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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.049959 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.621962) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.622263) ========= 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.622619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.622904) ========= 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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-10-30 01:19:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225537 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.860420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.860719) ========= 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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.198542 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.072002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.072373) ========= 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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-30 01:19:39,144 truncating revision to first 12 chars 2015-10-30 01:19:39,144 Setting DEBUG logging. 2015-10-30 01:19:39,144 attempt 1/10 2015-10-30 01:19:39,144 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,408 unpacking tar archive at: mozilla-aurora-5e1587041f9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550205 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.635388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.635734) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.644023) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.644453) ========= 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.645013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-10-30 01:19:39.645404) ========= /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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:19:39 INFO - MultiFileLogger online at 20151030 01:19:39 in /builds/slave/test-pgo 01:19:39 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:39 INFO - Guessing talos json url... 01:19:39 INFO - Using buildbot properties: 01:19:39 INFO - { 01:19:39 INFO - "properties": { 01:19:39 INFO - "buildnumber": 16, 01:19:39 INFO - "product": "firefox", 01:19:39 INFO - "script_repo_revision": "production", 01:19:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:19:39 INFO - "repository": "", 01:19:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:19:39 INFO - "buildid": "20151029012446", 01:19:39 INFO - "slavename": "talos-linux64-ix-050", 01:19:39 INFO - "pgo_build": "True", 01:19:39 INFO - "basedir": "/builds/slave/test-pgo", 01:19:39 INFO - "project": "", 01:19:39 INFO - "platform": "ubuntu64_hw", 01:19:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:19:39 INFO - "slavebuilddir": "test", 01:19:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:19:39 INFO - "branch": "mozilla-aurora", 01:19:39 INFO - "repo_path": "releases/mozilla-aurora", 01:19:39 INFO - "stage_platform": "linux64-pgo", 01:19:39 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 01:19:39 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:39 INFO - }, 01:19:39 INFO - "sourcestamp": { 01:19:39 INFO - "repository": "", 01:19:39 INFO - "hasPatch": false, 01:19:39 INFO - "project": "", 01:19:39 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:39 INFO - "changes": [ 01:19:39 INFO - { 01:19:39 INFO - "category": null, 01:19:39 INFO - "files": [ 01:19:39 INFO - { 01:19:39 INFO - "url": null, 01:19:39 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 01:19:39 INFO - } 01:19:39 INFO - ], 01:19:39 INFO - "repository": "", 01:19:39 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 01:19:39 INFO - "who": "bobowencode@gmail.com", 01:19:39 INFO - "when": 1446115088, 01:19:39 INFO - "number": 6592843, 01:19:39 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 01:19:39 INFO - "project": "", 01:19:39 INFO - "at": "Thu 29 Oct 2015 03:38:08", 01:19:39 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:39 INFO - "revlink": "", 01:19:39 INFO - "properties": [ 01:19:39 INFO - [ 01:19:39 INFO - "buildid", 01:19:39 INFO - "20151029012446", 01:19:39 INFO - "Change" 01:19:39 INFO - ], 01:19:39 INFO - [ 01:19:39 INFO - "builduid", 01:19:39 INFO - "3d43e8ca7be54163b739961a6150cca7", 01:19:39 INFO - "Change" 01:19:39 INFO - ], 01:19:39 INFO - [ 01:19:39 INFO - "pgo_build", 01:19:39 INFO - "True", 01:19:39 INFO - "Change" 01:19:39 INFO - ] 01:19:39 INFO - ], 01:19:39 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:39 INFO - } 01:19:39 INFO - ], 01:19:39 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:39 INFO - } 01:19:39 INFO - } 01:19:39 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:39 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:39 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:39 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:39 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:39 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:39 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:45 INFO - Downloaded 107 bytes. 01:19:45 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:45 INFO - Contents: 01:19:45 INFO - 20151029012446 01:19:45 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:19:45 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:45 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json 01:19:45 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:45 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:45 INFO - Downloaded 6818 bytes. 01:19:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:19:45 INFO - '../fennec_ids.txt'], 01:19:45 INFO - 'tests': ['tcheck2']}, 01:19:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:45 INFO - '--tppagecycles', 01:19:45 INFO - '7'], 01:19:45 INFO - 'tests': ['tsvgm']}}, 01:19:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:19:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:19:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:19:45 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:45 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:45 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:45 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:45 INFO - 'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:45 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'tests': ['damp', 'tps']}, 01:19:45 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['damp', 'tps']}, 01:19:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:19:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:45 INFO - 'other': {'tests': ['a11yr', 01:19:45 INFO - 'ts_paint', 01:19:45 INFO - 'tpaint', 01:19:45 INFO - 'sessionrestore', 01:19:45 INFO - 'sessionrestore_no_auto_restore']}, 01:19:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['a11yr', 01:19:45 INFO - 'ts_paint', 01:19:45 INFO - 'tpaint', 01:19:45 INFO - 'sessionrestore', 01:19:45 INFO - 'sessionrestore_no_auto_restore']}, 01:19:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['a11yr', 01:19:45 INFO - 'ts_paint', 01:19:45 INFO - 'tpaint', 01:19:45 INFO - 'sessionrestore', 01:19:45 INFO - 'sessionrestore_no_auto_restore']}, 01:19:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['a11yr', 01:19:45 INFO - 'ts_paint', 01:19:45 INFO - 'tpaint', 01:19:45 INFO - 'sessionrestore', 01:19:45 INFO - 'sessionrestore_no_auto_restore']}, 01:19:45 INFO - 'other_l64': {'tests': ['a11yr', 01:19:45 INFO - 'ts_paint', 01:19:45 INFO - 'tpaint', 01:19:45 INFO - 'sessionrestore', 01:19:45 INFO - 'sessionrestore_no_auto_restore']}, 01:19:45 INFO - 'other_nol64': {'tests': ['a11yr', 01:19:45 INFO - 'ts_paint', 01:19:45 INFO - 'tpaint', 01:19:45 INFO - 'sessionrestore', 01:19:45 INFO - 'sessionrestore_no_auto_restore']}, 01:19:45 INFO - 'svgr': {'tests': ['tsvgx', 01:19:45 INFO - 'tsvgr_opacity', 01:19:45 INFO - 'tart', 01:19:45 INFO - 'tscrollx', 01:19:45 INFO - 'cart']}, 01:19:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['tsvgx', 01:19:45 INFO - 'tsvgr_opacity', 01:19:45 INFO - 'tart', 01:19:45 INFO - 'tscrollx', 01:19:45 INFO - 'cart']}, 01:19:45 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:45 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:45 INFO - 'tests': ['tp5o']}, 01:19:45 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:45 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:45 INFO - 'talos_options': ['--e10s'], 01:19:45 INFO - 'tests': ['tp5o']}, 01:19:45 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:45 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:45 INFO - 'talos_options': ['--xperf_path', 01:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:45 INFO - 'tests': ['tp5n']}, 01:19:45 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 01:19:45 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:45 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:45 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:45 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:45 INFO - 'talos_options': ['--e10s', 01:19:45 INFO - '--xperf_path', 01:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 01:19:45 INFO - 'C:/slave/talos-data/talos/xperf.config'], 01:19:45 INFO - 'tests': ['tp5n']}}, 01:19:45 INFO - 'talos.zip': {'path': '', 01:19:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:45 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:19:45 INFO - {'append_to_log': False, 01:19:45 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:19:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:19:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:19:45 INFO - 'branch': 'Mozilla-Aurora', 01:19:45 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:45 INFO - 'config_files': ('talos/linux_config.py',), 01:19:45 INFO - 'default_actions': ('clobber', 01:19:45 INFO - 'read-buildbot-config', 01:19:45 INFO - 'download-and-extract', 01:19:45 INFO - 'populate-webroot', 01:19:45 INFO - 'create-virtualenv', 01:19:45 INFO - 'install', 01:19:45 INFO - 'run-tests'), 01:19:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:45 INFO - 'download_minidump_stackwalk': True, 01:19:45 INFO - 'download_symbols': 'ondemand', 01:19:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:45 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:45 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:45 INFO - 'installer_path': 'installer.exe', 01:19:45 INFO - 'log_level': 'info', 01:19:45 INFO - 'log_name': 'talos', 01:19:45 INFO - 'log_to_console': True, 01:19:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:19:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:19:45 INFO - 'opt_config_files': (), 01:19:45 INFO - 'pip_index': False, 01:19:45 INFO - 'python_webserver': False, 01:19:45 INFO - 'sps_profile': False, 01:19:45 INFO - 'sps_profile_interval': 0, 01:19:45 INFO - 'suite': 'dromaeojs', 01:19:45 INFO - 'system_bits': '64', 01:19:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:45 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 01:19:45 INFO - 'tests': (), 01:19:45 INFO - 'title': 'talos-linux64-ix-050', 01:19:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:45 INFO - 'use_talos_json': True, 01:19:45 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:19:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:45 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 01:19:45 INFO - 'work_dir': 'build'} 01:19:45 INFO - ##### 01:19:45 INFO - ##### Running clobber step. 01:19:45 INFO - ##### 01:19:45 INFO - Running pre-action listener: _resource_record_pre_action 01:19:45 INFO - Running main action method: clobber 01:19:45 INFO - rmtree: /builds/slave/test-pgo/build 01:19:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:19:46 INFO - Running post-action listener: _resource_record_post_action 01:19:46 INFO - ##### 01:19:46 INFO - ##### Running read-buildbot-config step. 01:19:46 INFO - ##### 01:19:46 INFO - Running pre-action listener: _resource_record_pre_action 01:19:46 INFO - Running main action method: read_buildbot_config 01:19:46 INFO - Using buildbot properties: 01:19:46 INFO - { 01:19:46 INFO - "properties": { 01:19:46 INFO - "buildnumber": 16, 01:19:46 INFO - "product": "firefox", 01:19:46 INFO - "script_repo_revision": "production", 01:19:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:19:46 INFO - "repository": "", 01:19:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:19:46 INFO - "buildid": "20151029012446", 01:19:46 INFO - "slavename": "talos-linux64-ix-050", 01:19:46 INFO - "pgo_build": "True", 01:19:46 INFO - "basedir": "/builds/slave/test-pgo", 01:19:46 INFO - "project": "", 01:19:46 INFO - "platform": "ubuntu64_hw", 01:19:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:19:46 INFO - "slavebuilddir": "test", 01:19:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:19:46 INFO - "branch": "mozilla-aurora", 01:19:46 INFO - "repo_path": "releases/mozilla-aurora", 01:19:46 INFO - "stage_platform": "linux64-pgo", 01:19:46 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 01:19:46 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:46 INFO - }, 01:19:46 INFO - "sourcestamp": { 01:19:46 INFO - "repository": "", 01:19:46 INFO - "hasPatch": false, 01:19:46 INFO - "project": "", 01:19:46 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:46 INFO - "changes": [ 01:19:46 INFO - { 01:19:46 INFO - "category": null, 01:19:46 INFO - "files": [ 01:19:46 INFO - { 01:19:46 INFO - "url": null, 01:19:46 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 01:19:46 INFO - } 01:19:46 INFO - ], 01:19:46 INFO - "repository": "", 01:19:46 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 01:19:46 INFO - "who": "bobowencode@gmail.com", 01:19:46 INFO - "when": 1446115088, 01:19:46 INFO - "number": 6592843, 01:19:46 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 01:19:46 INFO - "project": "", 01:19:46 INFO - "at": "Thu 29 Oct 2015 03:38:08", 01:19:46 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:46 INFO - "revlink": "", 01:19:46 INFO - "properties": [ 01:19:46 INFO - [ 01:19:46 INFO - "buildid", 01:19:46 INFO - "20151029012446", 01:19:46 INFO - "Change" 01:19:46 INFO - ], 01:19:46 INFO - [ 01:19:46 INFO - "builduid", 01:19:46 INFO - "3d43e8ca7be54163b739961a6150cca7", 01:19:46 INFO - "Change" 01:19:46 INFO - ], 01:19:46 INFO - [ 01:19:46 INFO - "pgo_build", 01:19:46 INFO - "True", 01:19:46 INFO - "Change" 01:19:46 INFO - ] 01:19:46 INFO - ], 01:19:46 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:46 INFO - } 01:19:46 INFO - ], 01:19:46 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:46 INFO - } 01:19:46 INFO - } 01:19:46 INFO - Running post-action listener: _resource_record_post_action 01:19:46 INFO - ##### 01:19:46 INFO - ##### Running download-and-extract step. 01:19:46 INFO - ##### 01:19:46 INFO - Running pre-action listener: _resource_record_pre_action 01:19:46 INFO - Running main action method: download_and_extract 01:19:46 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:46 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:19:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 01:19:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 01:19:46 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:46 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:47 INFO - Downloaded 1302 bytes. 01:19:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:19:47 INFO - Using the following test package requirements: 01:19:47 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:47 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:47 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:19:47 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:47 INFO - u'jsshell-linux-x86_64.zip'], 01:19:47 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:47 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:19:47 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:47 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:47 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:19:47 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:47 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:19:47 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:47 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:19:47 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:47 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:47 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:19:47 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:19:47 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:47 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:47 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:47 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:47 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:47 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:19:49 INFO - Downloaded 22906880 bytes. 01:19:49 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:19:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:49 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:19:50 INFO - Return code: 0 01:19:50 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: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/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 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/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:50 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:50 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:50 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:19:51 INFO - Downloaded 22906880 bytes. 01:19:51 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:19:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:51 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:19:53 INFO - Return code: 0 01:19:53 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:53 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:19:53 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:19:53 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:19:53 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:19:53 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:19:54 INFO - Downloaded 10881672 bytes. 01:19:54 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:19:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:19:54 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:19:54 INFO - Return code: 0 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.tar.bz2 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.tar.bz2 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.tar.bz2 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.tar.bz2 to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:19:54 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:19:56 INFO - Downloaded 56983114 bytes. 01:19:56 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:19:56 INFO - mkdir: /builds/slave/test-pgo/properties 01:19:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:19:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:19:56 INFO - Contents: 01:19:56 INFO - build_url:https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:19:56 INFO - Running post-action listener: _resource_record_post_action 01:19:56 INFO - Running post-action listener: _set_extra_try_arguments 01:19:56 INFO - ##### 01:19:56 INFO - ##### Running populate-webroot step. 01:19:56 INFO - ##### 01:19:56 INFO - Running pre-action listener: _resource_record_pre_action 01:19:56 INFO - Running main action method: populate_webroot 01:19:56 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 01:19:56 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 01:19:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 01:19:56 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 01:19:56 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 01:19:56 INFO - Running post-action listener: _resource_record_post_action 01:19:56 INFO - ##### 01:19:56 INFO - ##### Running create-virtualenv step. 01:19:56 INFO - ##### 01:19:56 INFO - Running pre-action listener: _resource_record_pre_action 01:19:56 INFO - Running main action method: create_virtualenv 01:19:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:19:56 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:19:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:19:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:19:56 INFO - Using real prefix '/usr' 01:19:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:19:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:59 INFO - Installing pip.................done. 01:19:59 INFO - Return code: 0 01:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:59 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 0x7fdf26e1eb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f967b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205b4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', '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:19:59 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:19:59 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:19:59 INFO - Using env: {'DISPLAY': ':0', 01:19:59 INFO - 'HOME': '/home/cltbld', 01:19:59 INFO - 'LANG': 'en_US.UTF-8', 01:19:59 INFO - 'LANGUAGE': 'en_US:en', 01:19:59 INFO - 'LOGNAME': 'cltbld', 01:19:59 INFO - 'MAIL': '/var/mail/cltbld', 01:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:59 INFO - 'MOZ_NO_REMOTE': '1', 01:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:59 INFO - 'NO_EM_RESTART': '1', 01:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:19:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:19:59 INFO - 'SHELL': '/bin/bash', 01:19:59 INFO - 'SHLVL': '1', 01:19:59 INFO - 'TERM': 'linux', 01:19:59 INFO - 'TMOUT': '86400', 01:19:59 INFO - 'USER': 'cltbld', 01:19:59 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:59 INFO - '_': '/tools/buildbot/bin/python'} 01:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:59 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:19:59 INFO - Cleaning up... 01:19:59 INFO - Return code: 0 01:19:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:59 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 0x7fdf26e1eb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f967b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205b4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', '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:19:59 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:19:59 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:19:59 INFO - Using env: {'DISPLAY': ':0', 01:19:59 INFO - 'HOME': '/home/cltbld', 01:19:59 INFO - 'LANG': 'en_US.UTF-8', 01:19:59 INFO - 'LANGUAGE': 'en_US:en', 01:19:59 INFO - 'LOGNAME': 'cltbld', 01:19:59 INFO - 'MAIL': '/var/mail/cltbld', 01:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:59 INFO - 'MOZ_NO_REMOTE': '1', 01:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:59 INFO - 'NO_EM_RESTART': '1', 01:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:19:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:19:59 INFO - 'SHELL': '/bin/bash', 01:19:59 INFO - 'SHLVL': '1', 01:19:59 INFO - 'TERM': 'linux', 01:19:59 INFO - 'TMOUT': '86400', 01:19:59 INFO - 'USER': 'cltbld', 01:19:59 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:59 INFO - '_': '/tools/buildbot/bin/python'} 01:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:59 INFO - Downloading/unpacking psutil>=0.7.1 01:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:19:59 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:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:20:01 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:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:20:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:01 INFO - Installing collected packages: psutil 01:20:01 INFO - Running setup.py install for psutil 01:20:01 INFO - building 'psutil._psutil_linux' extension 01:20:01 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:02 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:03 INFO - building 'psutil._psutil_posix' extension 01:20:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:20:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:20:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:03 INFO - Successfully installed psutil 01:20:03 INFO - Cleaning up... 01:20:03 INFO - Return code: 0 01:20:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf26e1eb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f967b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205b4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', '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:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:20:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:20:03 INFO - Using env: {'DISPLAY': ':0', 01:20:03 INFO - 'HOME': '/home/cltbld', 01:20:03 INFO - 'LANG': 'en_US.UTF-8', 01:20:03 INFO - 'LANGUAGE': 'en_US:en', 01:20:03 INFO - 'LOGNAME': 'cltbld', 01:20:03 INFO - 'MAIL': '/var/mail/cltbld', 01:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:03 INFO - 'MOZ_NO_REMOTE': '1', 01:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:03 INFO - 'NO_EM_RESTART': '1', 01:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:03 INFO - 'SHELL': '/bin/bash', 01:20:03 INFO - 'SHLVL': '1', 01:20:03 INFO - 'TERM': 'linux', 01:20:03 INFO - 'TMOUT': '86400', 01:20:03 INFO - 'USER': 'cltbld', 01:20:03 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:03 INFO - '_': '/tools/buildbot/bin/python'} 01:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:20:03 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:03 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:03 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:03 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:03 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:03 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:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:20:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:20:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:20:05 INFO - Installing collected packages: mozsystemmonitor 01:20:05 INFO - Running setup.py install for mozsystemmonitor 01:20:05 INFO - Successfully installed mozsystemmonitor 01:20:05 INFO - Cleaning up... 01:20:05 INFO - Return code: 0 01:20:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf26e1eb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f967b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205b4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', '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:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:20:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:20:05 INFO - Using env: {'DISPLAY': ':0', 01:20:05 INFO - 'HOME': '/home/cltbld', 01:20:05 INFO - 'LANG': 'en_US.UTF-8', 01:20:05 INFO - 'LANGUAGE': 'en_US:en', 01:20:05 INFO - 'LOGNAME': 'cltbld', 01:20:05 INFO - 'MAIL': '/var/mail/cltbld', 01:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:05 INFO - 'MOZ_NO_REMOTE': '1', 01:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:05 INFO - 'NO_EM_RESTART': '1', 01:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:05 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:05 INFO - 'SHELL': '/bin/bash', 01:20:05 INFO - 'SHLVL': '1', 01:20:05 INFO - 'TERM': 'linux', 01:20:05 INFO - 'TMOUT': '86400', 01:20:05 INFO - 'USER': 'cltbld', 01:20:05 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:05 INFO - '_': '/tools/buildbot/bin/python'} 01:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:05 INFO - Downloading/unpacking blobuploader==1.2.4 01:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:07 INFO - Downloading blobuploader-1.2.4.tar.gz 01:20:07 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:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:20:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:07 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:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:20:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:07 INFO - Downloading docopt-0.6.1.tar.gz 01:20:07 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:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:20:08 INFO - Installing collected packages: blobuploader, requests, docopt 01:20:08 INFO - Running setup.py install for blobuploader 01:20:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:20:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:20:08 INFO - Running setup.py install for requests 01:20:08 INFO - Running setup.py install for docopt 01:20:08 INFO - Successfully installed blobuploader requests docopt 01:20:08 INFO - Cleaning up... 01:20:08 INFO - Return code: 0 01:20:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:08 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 0x7fdf26e1eb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f967b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205b4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', '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:08 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:08 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:08 INFO - Using env: {'DISPLAY': ':0', 01:20:08 INFO - 'HOME': '/home/cltbld', 01:20:08 INFO - 'LANG': 'en_US.UTF-8', 01:20:08 INFO - 'LANGUAGE': 'en_US:en', 01:20:08 INFO - 'LOGNAME': 'cltbld', 01:20:08 INFO - 'MAIL': '/var/mail/cltbld', 01:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:08 INFO - 'MOZ_NO_REMOTE': '1', 01:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:08 INFO - 'NO_EM_RESTART': '1', 01:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:08 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:08 INFO - 'SHELL': '/bin/bash', 01:20:08 INFO - 'SHLVL': '1', 01:20:08 INFO - 'TERM': 'linux', 01:20:08 INFO - 'TMOUT': '86400', 01:20:08 INFO - 'USER': 'cltbld', 01:20:08 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:08 INFO - '_': '/tools/buildbot/bin/python'} 01:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:08 INFO - Running setup.py (path:/tmp/pip-hVryW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:08 INFO - Running setup.py (path:/tmp/pip-zoxwNu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:08 INFO - Running setup.py (path:/tmp/pip-w8J5gW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:09 INFO - Running setup.py (path:/tmp/pip-tDx38W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:09 INFO - Running setup.py (path:/tmp/pip-iliSjj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:09 INFO - Running setup.py (path:/tmp/pip-Pbc_uG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:09 INFO - Running setup.py (path:/tmp/pip-tfehcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:09 INFO - Running setup.py (path:/tmp/pip-UTs1s6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:09 INFO - Running setup.py (path:/tmp/pip-XMWKSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:09 INFO - Running setup.py (path:/tmp/pip-ejGOON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:09 INFO - Running setup.py (path:/tmp/pip-3M7b_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:09 INFO - Running setup.py (path:/tmp/pip-cvJSyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:09 INFO - Running setup.py (path:/tmp/pip-oJUL43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:09 INFO - Running setup.py (path:/tmp/pip-A4IUrk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:09 INFO - Running setup.py (path:/tmp/pip-VA_CNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:09 INFO - Running setup.py (path:/tmp/pip-YEJ_YG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:09 INFO - Running setup.py (path:/tmp/pip-lqOqkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:20:10 INFO - Running setup.py install for manifestparser 01:20:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Running setup.py install for mozcrash 01:20:10 INFO - Running setup.py install for mozdebug 01:20:10 INFO - Running setup.py install for mozdevice 01:20:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Running setup.py install for mozfile 01:20:10 INFO - Running setup.py install for mozhttpd 01:20:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Running setup.py install for mozinfo 01:20:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Running setup.py install for mozInstall 01:20:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:20:10 INFO - Running setup.py install for mozleak 01:20:10 INFO - Running setup.py install for mozlog 01:20:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:20:11 INFO - Running setup.py install for moznetwork 01:20:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:20:11 INFO - Running setup.py install for mozprocess 01:20:11 INFO - Running setup.py install for mozprofile 01:20:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:20:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:20:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:20:11 INFO - Running setup.py install for mozrunner 01:20:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:20:11 INFO - Running setup.py install for mozscreenshot 01:20:11 INFO - Running setup.py install for moztest 01:20:11 INFO - Running setup.py install for mozversion 01:20:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:20:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:20:11 INFO - Cleaning up... 01:20:11 INFO - Return code: 0 01:20:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:11 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 0x7fdf26e1eb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f967b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205b4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 01:20:11 INFO - 'HOME': '/home/cltbld', 01:20:11 INFO - 'LANG': 'en_US.UTF-8', 01:20:11 INFO - 'LANGUAGE': 'en_US:en', 01:20:11 INFO - 'LOGNAME': 'cltbld', 01:20:11 INFO - 'MAIL': '/var/mail/cltbld', 01:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:11 INFO - 'MOZ_NO_REMOTE': '1', 01:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:11 INFO - 'NO_EM_RESTART': '1', 01:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:11 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:11 INFO - 'SHELL': '/bin/bash', 01:20:11 INFO - 'SHLVL': '1', 01:20:11 INFO - 'TERM': 'linux', 01:20:11 INFO - 'TMOUT': '86400', 01:20:11 INFO - 'USER': 'cltbld', 01:20:11 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:11 INFO - '_': '/tools/buildbot/bin/python'} 01:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:12 INFO - Running setup.py (path:/tmp/pip-UTpn8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:12 INFO - Running setup.py (path:/tmp/pip-GZjgma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:12 INFO - Running setup.py (path:/tmp/pip-fM1Dt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:12 INFO - Running setup.py (path:/tmp/pip-of5oVn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:12 INFO - Running setup.py (path:/tmp/pip-NwJwGv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:12 INFO - Running setup.py (path:/tmp/pip-961BYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:12 INFO - Running setup.py (path:/tmp/pip-fDsYLN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:12 INFO - Running setup.py (path:/tmp/pip-r7sYIO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:12 INFO - Running setup.py (path:/tmp/pip-2k1Phs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:12 INFO - Running setup.py (path:/tmp/pip-_w9XBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:12 INFO - Running setup.py (path:/tmp/pip-oKEAS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:12 INFO - Running setup.py (path:/tmp/pip-HK2lic-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:12 INFO - Running setup.py (path:/tmp/pip-2gnWhT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:12 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:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:12 INFO - Running setup.py (path:/tmp/pip-nX3a45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:13 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:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:13 INFO - Running setup.py (path:/tmp/pip-ig9_7x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:13 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:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:13 INFO - Running setup.py (path:/tmp/pip-dbzW6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:13 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:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:13 INFO - Running setup.py (path:/tmp/pip-KUkoG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:14 INFO - Downloading blessings-1.5.1.tar.gz 01:20:14 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:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:20:15 INFO - Installing collected packages: blessings 01:20:15 INFO - Running setup.py install for blessings 01:20:15 INFO - Successfully installed blessings 01:20:15 INFO - Cleaning up... 01:20:15 INFO - Return code: 0 01:20:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:20:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:20:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:20:15 INFO - Reading from file tmpfile_stdout 01:20:15 INFO - Current package versions: 01:20:15 INFO - argparse == 1.2.1 01:20:15 INFO - blessings == 1.5.1 01:20:15 INFO - blobuploader == 1.2.4 01:20:15 INFO - docopt == 0.6.1 01:20:15 INFO - manifestparser == 1.1 01:20:15 INFO - mozInstall == 1.12 01:20:15 INFO - mozcrash == 0.16 01:20:15 INFO - mozdebug == 0.1 01:20:15 INFO - mozdevice == 0.46 01:20:15 INFO - mozfile == 1.2 01:20:15 INFO - mozhttpd == 0.7 01:20:15 INFO - mozinfo == 0.8 01:20:15 INFO - mozleak == 0.1 01:20:15 INFO - mozlog == 3.0 01:20:15 INFO - moznetwork == 0.27 01:20:15 INFO - mozprocess == 0.22 01:20:15 INFO - mozprofile == 0.27 01:20:15 INFO - mozrunner == 6.10 01:20:15 INFO - mozscreenshot == 0.1 01:20:15 INFO - mozsystemmonitor == 0.0 01:20:15 INFO - moztest == 0.7 01:20:15 INFO - mozversion == 1.4 01:20:15 INFO - psutil == 3.1.1 01:20:15 INFO - requests == 1.2.3 01:20:15 INFO - wsgiref == 0.1.2 01:20:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fdf26e1eb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f967b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205b4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, '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': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', '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:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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:15 INFO - Using env: {'DISPLAY': ':0', 01:20:15 INFO - 'HOME': '/home/cltbld', 01:20:15 INFO - 'LANG': 'en_US.UTF-8', 01:20:15 INFO - 'LANGUAGE': 'en_US:en', 01:20:15 INFO - 'LOGNAME': 'cltbld', 01:20:15 INFO - 'MAIL': '/var/mail/cltbld', 01:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:15 INFO - 'MOZ_NO_REMOTE': '1', 01:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:15 INFO - 'NO_EM_RESTART': '1', 01:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:15 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:15 INFO - 'SHELL': '/bin/bash', 01:20:15 INFO - 'SHLVL': '1', 01:20:15 INFO - 'TERM': 'linux', 01:20:15 INFO - 'TMOUT': '86400', 01:20:15 INFO - 'USER': 'cltbld', 01:20:15 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:15 INFO - '_': '/tools/buildbot/bin/python'} 01:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - Cleaning up... 01:20:15 INFO - Return code: 0 01:20:15 INFO - Running post-action listener: _resource_record_post_action 01:20:15 INFO - Running post-action listener: _start_resource_monitoring 01:20:15 INFO - Starting resource monitoring. 01:20:15 INFO - ##### 01:20:15 INFO - ##### Running install step. 01:20:15 INFO - ##### 01:20:15 INFO - Running pre-action listener: _resource_record_pre_action 01:20:15 INFO - Running main action method: install 01:20:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:20:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:20:15 INFO - Reading from file tmpfile_stdout 01:20:15 INFO - Detecting whether we're running mozinstall >=1.0... 01:20:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:20:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:20:15 INFO - Reading from file tmpfile_stdout 01:20:15 INFO - Output received: 01:20:15 INFO - Usage: mozinstall [options] installer 01:20:15 INFO - Options: 01:20:15 INFO - -h, --help show this help message and exit 01:20:15 INFO - -d DEST, --destination=DEST 01:20:15 INFO - Directory to install application into. [default: 01:20:15 INFO - "/builds/slave/test-pgo"] 01:20:15 INFO - --app=APP Application being installed. [default: firefox] 01:20:15 INFO - mkdir: /builds/slave/test-pgo/build/application 01:20:15 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:15 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:30 INFO - Reading from file tmpfile_stdout 01:20:30 INFO - Output received: 01:20:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:20:30 INFO - Running post-action listener: _resource_record_post_action 01:20:30 INFO - ##### 01:20:30 INFO - ##### Running run-tests step. 01:20:30 INFO - ##### 01:20:30 INFO - Running pre-action listener: _resource_record_pre_action 01:20:30 INFO - Running main action method: run_tests 01:20:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:20:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:20:30 INFO - Python 2.7.3 01:20:30 INFO - Return code: 0 01:20:30 INFO - grabbing minidump binary from tooltool 01:20:30 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:30 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 0x1dedbf0>, '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 0x20eb4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eb9a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:20:30 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:30 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:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:30 INFO - Return code: 0 01:20:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:20:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:20:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:20:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:20:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:20:30 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-050', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:20:30 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-050 --webServer localhost 01:20:30 INFO - Using env: {'DISPLAY': ':0', 01:20:30 INFO - 'HOME': '/home/cltbld', 01:20:30 INFO - 'LANG': 'en_US.UTF-8', 01:20:30 INFO - 'LANGUAGE': 'en_US:en', 01:20:30 INFO - 'LOGNAME': 'cltbld', 01:20:30 INFO - 'MAIL': '/var/mail/cltbld', 01:20:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:20:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:30 INFO - 'MOZ_NO_REMOTE': '1', 01:20:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:30 INFO - 'NO_EM_RESTART': '1', 01:20:30 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:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:20:30 INFO - 'SHELL': '/bin/bash', 01:20:30 INFO - 'SHLVL': '1', 01:20:30 INFO - 'TERM': 'linux', 01:20:30 INFO - 'TMOUT': '86400', 01:20:30 INFO - 'USER': 'cltbld', 01:20:30 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456', 01:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:30 INFO - '_': '/tools/buildbot/bin/python'} 01:20:30 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-050', '--webServer', 'localhost'] with output_timeout 3600 01:20:30 INFO - mozversion INFO | application_buildid: 20151029012446 01:20:30 INFO - mozversion INFO | application_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:20:30 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 01:20:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:30 INFO - mozversion INFO | application_name: Firefox 01:20:30 INFO - mozversion INFO | application_remotingname: firefox-dev 01:20:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:30 INFO - mozversion INFO | application_vendor: Mozilla 01:20:30 INFO - mozversion INFO | application_version: 43.0a2 01:20:30 INFO - mozversion INFO | platform_buildid: 20151029012446 01:20:30 INFO - mozversion INFO | platform_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:20:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:30 INFO - mozversion INFO | platform_version: 43.0a2 01:20:30 INFO - 2015-10-30 01:20:30,889 DEBUG : using testdate: 1446193230 01:20:30 INFO - 2015-10-30 01:20:30,889 DEBUG : actual date: 1446193230 01:20:30 INFO - 2015-10-30 01:20:30,969 INFO : Starting test suite talos-linux64-ix-050 01:20:30 INFO - 2015-10-30 01:20:30,969 INFO : Starting test dromaeo_css 01:20:30 INFO - 2015-10-30 01:20:30,969 DEBUG : operating with platform_type : linux_ 01:20:30 INFO - 2015-10-30 01:20:30,970 INFO : Initialising browser for dromaeo_css test... 01:20:31 INFO - 2015-10-30 01:20:31,001 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv3R1XH/profile http://localhost/getInfo.html 01:20:35 INFO - 2015-10-30 01:20:35,031 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:20:35 INFO - 2015-10-30 01:20:35,031 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:20:35 INFO - 2015-10-30 01:20:35,031 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:20:35 INFO - 2015-10-30 01:20:35,031 DEBUG : BROWSER_OUTPUT: __metrics 01:20:35 INFO - 2015-10-30 01:20:35,532 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:36 INFO - 2015-10-30 01:20:36,865 INFO : Browser initialized. 01:20:36 INFO - 2015-10-30 01:20:36,866 INFO : Running cycle 1/1 for dromaeo_css test... 01:20:36 INFO - 2015-10-30 01:20:36,866 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv3R1XH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:20:48 INFO - 2015-10-30 01:20:48,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 132804608 01:20:48 INFO - 2015-10-30 01:20:48,541 DEBUG : BROWSER_OUTPUT: 01:23:47 INFO - 2015-10-30 01:23:47,931 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:23:49 INFO - 2015-10-30 01:23:49,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 250073088 01:23:49 INFO - 2015-10-30 01:23:49,056 DEBUG : BROWSER_OUTPUT: 01:26:51 INFO - 2015-10-30 01:26:51,216 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:26:51 INFO - 2015-10-30 01:26:51,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 208637952 01:26:51 INFO - 2015-10-30 01:26:51,779 DEBUG : BROWSER_OUTPUT: 01:29:53 INFO - 2015-10-30 01:29:53,620 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:29:54 INFO - 2015-10-30 01:29:54,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 199888896 01:29:54 INFO - 2015-10-30 01:29:54,182 DEBUG : BROWSER_OUTPUT: 01:32:55 INFO - 2015-10-30 01:32:55,862 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:32:56 INFO - 2015-10-30 01:32:56,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 199729152 01:32:56 INFO - 2015-10-30 01:32:56,424 DEBUG : BROWSER_OUTPUT: 01:35:58 INFO - 2015-10-30 01:35:58,703 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:35:59 INFO - 2015-10-30 01:35:59,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 194060288 01:35:59 INFO - 2015-10-30 01:35:59,286 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,534 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:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 241299456 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3358.966410335897;3395.541601883745;3436;3438.5873695156583;3449.9817606700085;5690.4594063563945;5715.799947001856;5718.142278658198;5742.540596752266;5742.799002034919;5759.5968282220265;5766.509846663039;5777.1623114648355;5786.189933409326;5793.913091303634;5132.384113906336;5195.830938038949;5232.110541207994;5274.182501712241;5343.465653434664;5164.096283150452;5175.094358487268;5256.290400795901;5268.341457317835;5291.867703307429;5358.410574836785;5408.432114627966;5418.160185171305;5420.268263784378;5423.945760542403;5137.666051706665;5238.554722848562;5323.414424413311;5328.307320048369;5401.459854014606;5107.540321371094;5248.973755131238;5254.4220135785035;5260.395054568736;5281.07581173297;5599.944000560024;5609.439056094398;5613;5616.410276920906;5650.74571644277;6024.759009639609;6079.574429789916;6111.083337499366;6290.3709629037185;6300.054991751228;6275.372462753734;6312.210973628296;6327.683615819236;6331.55679102463;6338.112664227012;5865.677387743673;5879.529637629023;5884.264466941632;5886.70566471679;5888.087346461305;6126.969365153146;6192.473639740582;6267.71795269214;6336.746530138835;6343.238811342669;6109.144719739151;6139.693015349304;6145.324014358417;6158.414950579688;6182.350853160443;6293.96853015732;6295.024271237874;6305.14880491137;6307.148534947815;6308.243010838729;6003.849903752441;6067.696615169224;6080.422359875804;6179.011358182669;6186.628802271878;6198.81403557885;6248.4688801451475;6256.718447669866;6263.749450022039;6266.624002559861;4531.524189960072;4685.016146609182;4697.201475749131;4700.341952126705;4718.386609740712;4142.440770496005;4158.792060396968;4195.202911446876;4200.663946884242;4211.305134652748;5821.09772985188;5903.026000709835;5910.468057874812;5910.911336329958;5933.110033495011;6006.819795406145;6073.817785466443;6270.0908368287255;6323.715432805535;6346.365363463617;5750.338711048283;5802.274715660543;5819.88360232793;5823.330317013513;5850.385709500526;5323.840284791462;5349.732513374316;5352.0366334060245;5355.518003379637;5369.892602148013;6112.419320164578;6143.709820937564;6275.152854364603;6386.712597933104;6409.391107844747;6176.104464852481;6243.875122497616;6286.811395658137;6291.6539590321145;6294.433500984934;6404.039394090923;6410.8076757697345;6414.871702566016;6426.807195784134;6432.163818703539;5988.550858685703;6031.487323577369;6079.452849243589;6119;6132.877342453036;6182.258129024546;6191.597546159485;6199.628022318675;6274.090256912813;6299.275583307978;6131.294901086432;6133.294671112879;6136.29432615255;6137.84655383619;6141.815745527641;5855.707214639337;5965.433283838029;6074.240719910012;6164.47601953839;6174.475169610633;6024.042186289561;6043.939620385628;6093.9390606093375;6112.266528016667;6114.021756518936;5946.702664866826;6171.105189747551;6185.700808154552;6187.907181392193;6207.255129384503;5820.505257053198;5900.852478688067;5922.082077278029;5922.7334769936315;5947.613405128825 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: |1;ext.html;596.212998841529;640.8814369341673;642.2132887213164;673.0106743087659;680.2890978927021;44927;45552.31671524925;45669;45745.54254457454;45782.71086445677;50564.74717626407;51143;51230.48769512304;51246.48753512473;51449;8149.4702844315225;8579.399442039059;9229.953850230739;9393.436393816359;10745;10926.453677316142;11004.339739615649;11027;11036.779264414747;11041.83437248442;10934.890651093507;11053.723656908562;11068.723281917975;11079.612213572527;11107.888921110767;8593.398462107654;8823.161799629057;11042.613508527164;11281.153913456523;11288.774224515546;10910.781784364348;11014.44927753609;11033.944830275797;11066.336019838755;11067.944660276728;46504.069918601774;46573;46776.76611616954;46880;47130.764346178395;3919.392494163409;3939.330313846653;4110.753354798721;4112.074783173792;4155.896102597429;34807.4778878317;35223.64776352229;35523.28953420917;36800;36843.447348289796;3856.093817952779;3902.9609703902884;3916.1776027034357;3958.5447673517624;4016.979915100435;347737;348173;348530;482602;490555.99999999645;70782.64608676924;72244;72630.63684681543;72719;73109.63445182846;68441.31558684449;68678.65660671664;68884.3111568888;69198.65400673065;69417;18323.633527329377;18458.81541184598;18477.53806154857;18490.35283765062;18502.259909603734;14036.368363423671;14084.788728169086;14085.507007254697;14265.072770269899;14319.92840035814;23399.181028663916;23740.64389034166;23810.404739881295;23851.284461466184;23906;7864.606769661494;8041.3164880984605;8090.231428014447;8111.95944020288;8207.261346478726;1146.5814977533141;1171.1918776044502;1185.525789684116;1188.257339163023;1219.9024078073733;32109.197270068435;32286;32514.349713005606;32553.51169732456;33254;1148.1388958281289;1204.1209916760813;1243.8258643789877;1269.5683467621054;1271.4723389793132;14856.554303370916;15920.124393158487;16096.597585060234;16715.91642041782;17001.574960625836;442777;448103;448618;448762;449967;61354.38645613576;61580.69209653923;61697.69151154216;61850.69074654598;62024;1402.7404930087966;1415.402735979489;1444.6966137111324;1528.9694206116037;1544.8146222453154;29881.850590746908;30096;32266.35467290594;32562.02313930586;33241.16897077592;51410.74294628503;51812.222816658534;51897.22154167766;56009;58051.41948580629;557985;568496;570971;572906;574132;35434.29131417409;35950.820245898605;36078.8196059018;36187.63812361948;36236;49724.50275497344;49810.50189498059;50453.49546504488;50484.242736359716;50654;41421.79289103535;41732;42010;42300.36549451822;43102.78448607737;41851;42270.365944511475;42741.14517709691;42946.92632684208;43167.35248971205;42550.361744574475;42677.786611066746;43557.78221108874;43648.56351436445;43729.12541749084;35813.28373432464;37189.81405092957;37327.44008839924;37711;38336.80831595824;28282.43435131327;28609.713902860705;28773.568396473653;28815.279618009718;28852.422951540433 01:39:01 INFO - 2015-10-30 01:39:01,793 DEBUG : BROWSER_OUTPUT: |2;jquery.html;412.13040484577516;413.50173041484993;423.86436340371085;426.1370724283326;426.47543521468594;16101;16312.673746525063;19248.422547323586;19582.412527624176;20154.697679534784;19697.803021969776;19843.864015753545;20076.598468030632;20447.795522044813;21270.36188914335;5901.85245368866;6029.728662210189;6036.879262414749;6037.366076561963;6037.486813620848;4271.829126834923;4395.7362558246605;5966.612170208944;6495.902561461582;6735.5621884577595;6510.056041873949;6625.867482650344;6630.071789949411;6657.068010478537;6663.566868153554;5605.971970140164;6737.562058466208;6741.224759152711;6743.662816859187;6744.258131605519;6039.063945088518;6051;6063.787767428119;6678.732850685967;6878.312168783082;26842.328941776417;26929.32676683079;27233.319167020785;27285;27450.725492745016;2751.3534319434916;2789.5257806173;2811.7750579953554;2813.507636163684;2820.2244382794693;15541.14523701196;15609.141497217648;15801.60495987598;15878.444254451155;16070.919645401698;2127.2022991378235;2134.6264403729283;2194.8792816395094;2235.8099561537288;2270.65940108985;80636.59681701612;80641.59679201567;81616;83722.58138709268;84393.57803210945;17033.659326813642;17582.38461653836;17720.734188987175;17734.733978990327;17766.91116544409;28441.43117137646;28702.425951480855;28827.135185944455;28884.566731499046;29080.127596172148;10484.63303784379;10496.160307175407;10520.158387328995;10537.367757934395;10564.947175264075;8985.910140898639;9003.954980225057;9029.232515236146;9095;9095.045020272908;8650.745641881891;8754.518501482353;8768.386212965032;8809.295256379473;8819.603117859711;1310.4168644953095;1312.553731731216;1315.276597871167;1317.7298653775954;2151.6874706429066;538.1148011521104;558.4248224328948;559.4405594405595;569.6724383479516;582.9387914269025;13428.93285533566;13693.315334233448;14020.579382618538;14145.646358840906;14198.503052393324;566.8469513231487;580.6661169827366;587.2043381218473;599.4185639929261;602.4638072115821;7444.516106453063;7568.205338439495;7664;7918.762437126896;7933.325667318227;456520;557415;559049;640039;699935;82113.58943205245;82528.58735706283;89462;92268.53865730762;92514;605.8606520500222;612.8100288910363;614.1494030767419;614.4224429036691;615.9661218633019;11360.54557817678;11870.643880683594;12377.381130943237;12991.805122922975;13015.804762928374;38059.2388152241;38229.80885095557;38374;38495.03762405962;38780.61219387883;47544.286835698185;48580.51419485901;49727;50492.49507504878;53117;7916.08964969036;7950.761477155695;7952.36381089523;7969.920300796918;8030.638621262174;13436.865631343562;13516.189028658311;13703.794443083561;13926.164430134224;13961.441542338192;11988.880111198776;12007.639770806889;12151.756964860477;12389.62831115068;12405.937970310091;11767.352570639947;11965.102617303563;12071.637850864488;12363.134580579273;12643.747125057263;12405.75188496243;12619.36903154857;12775.744485110432;12794.616161515169;12957.870421295667;7573.886391704019;7834.255745704149;7861.842763144819;7864.056313242448;7943.24539168778;10421.9478902605;12046.75906481883;12079.69800754953;12369;12379.876201237872 01:39:01 INFO - 2015-10-30 01:39:01,794 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1552.2704328965397;1651.9256633451494;1827.2873579304073;2015.425603702945;2044.7444069491314;9351.81296374073;10199.388036717794;10309.53607087681;10317.53571089301;10328.328658637183;10052;10169.084782369586;10198.631196928933;10208.744781380468;10211.234157438203;2191.200211922645;2204.371754050096;2502.9874850625765;2509.6611957385794;2524.924252272435;2520.76052774987;2544.427503811637;2558.7057488388796;2565.076572433922;2566.8844901979364;2448.204333591581;2479.9832068851774;2491.302435318105;2491.352248415416;2495.5258500884775;2196.494806194576;2239.529698763262;2492.1651246832243;2567.255495906185;2575.0472325239593;2459.6187590923437;2483.714372847128;2491.6760821093144;2546.401595625027;2554.961675574868;10618.57525698971;10665.306755060974;10691.198160138021;10710.250282480229;10712.678619641423;5939.910901336483;6036.185115009462;6039.879202415971;6042.184305118841;6044.909326360108;3681.4661874028384;3719.7396182267253;3755.4179102239195;3761.28535578242;3779.9433008504893;1115.4590023838432;1120.3166068698088;1129.4183495499824;1136.6760473265163;1159.263867444179;16310.510684679479;16343.26455309514;16356.591085222846;16361.590960226089;16372.426965056286;5360;5379.6234263601955;5428.864278392993;5449.291592093003;5483.067878460672;12568.560100396442;12577.308248046445;12588.496460141492;12593;12599.244045357307;5985.191999080069;6010.849728756816;6063.302720187146;6065.514758819284;6079.422454866781;5352.357717073976;5354.518093371616;5374.247605335257;5376.220448035013;5378.031954248273;4565.086982603492;4586.059857729158;4605.148047611203;4631.8378856739855;4641.373414589055;1380.0891411668451;1400.208881981677;1405.058610730813;1411.2097225553723;1419.2548911821377;1461.4811741831497;1463.217178809332;1476.2397365356849;1492.0823693428463;1493.6116609681344;9749.951250243845;9756.804863902682;9778.75553111178;9790.51047447639;9809.362391444676;581.6887964938737;591.5149577346534;591.7425919724933;594.2275042444891;594.337313895004;7188.568685878864;7212.278772122746;7293.635318234067;7295.161056478573;7302.634868256566;13359.465621375231;13629.522966696317;13683.931580342034;13686.315684215948;13711;13242.139260948008;13611.11527750693;13621.727565448635;13655.863441365658;13657;9615.807683846284;9685.128338449433;9754.268429867647;9755.317127800985;9765.853512197322;9055.139761722627;9087.454752714859;9147.0852914708;9172.908270917205;9182.357234993486;11499.425028748696;11654.708632283922;11728;11750.58872939443;11783.705407364885;11829.70425739329;12046.578369757017;12074.758504829679;12114.21257618252;12127.211731237441;9089.409188402733;9324.11420915012;9402.059794020543;9417.811643766949;9423.293253005915;10069.244806639384;10212.387256764618;10330.276880618585;10341.121004714683;10363.32638378503;8249.422540422112;8773.122687731176;9516.762080948032;9543.618255269988;9592.472414017297;8748.518831464331;9089.181973622406;9266.907330926873;9283.11810378013;9448.763780905258;9269.67556135532;9281.303902207497;9301.395409298373;9309.674161404319;9313.720588382359;8595.87106193395;8683.609237584198;8685.91314086851;8687.782805429915;8706.1729135732;8403.159684031549;8416.15838416178;8450.957745211235;8461.238488535815;8603.655853765778 01:39:01 INFO - 2015-10-30 01:39:01,794 DEBUG : BROWSER_OUTPUT: |4;prototype.html;398.5790656310254;400.3394399241253;405.133015347157;405.3919121318023;406.15722376069647;5965;5984.581079324449;6052.576319657625;6064.969675151629;6066.454019138277;5880.647161170333;5922.466977971982;5942.970285148579;5971.253593300838;5971.611845230057;4781.856544303659;4787.688800227974;4787.8563643090765;4795.0889331027165;4796.448408433022;4756.9286460703115;4784.330193772875;4786.042791441708;4794.35276237707;4794.376731024962;4746.145693775119;4749.26386410107;4756.90486190276;4759.286107083948;4759.405074365704;4695.859124226278;4756.167670657621;4756.405449318835;4762.547557981986;4793.424789025305;4262.381954616563;4271.743695378287;4273.102648443831;4278.336857787048;4279.657627389833;5684.8294551163535;5712.1431785232135;5735.254416925773;5739.253896993364;5753.280839895013;5533.418991005967;5533.584981126432;5533.972330138364;5538.806141785019;5539.584531160139;6271.905921411182;6355.872882542323;6383.521235907326;6396.840078998016;6399.040143978394;4715.669903106784;4721.527847215285;4722.1028004679;4724.2205036169335;4724.480307166209;6280.371962803729;6380.234371875358;6490.513211509156;6589.571677840973;6609.405153536205;4844.297576851337;4878.365812444359;4885.169521181408;4890.290907818347;4894.339264199288;4943.604511639061;4944.752762361867;4950.356453661001;4953.504649535018;4954.950450495521;5298.258243845865;5352.0366334060245;5418.322709661293;5473.534749546254;5480.808171713971;6322.525810564226;6327.557071004985;6333.398327158912;6348.904766428507;6351.936480635227;1749.7112976358758;1769.8938063716218;1771.973420398695;1776.8134345893754;1776.840084392411;1246.6135497995651;1252.461441580111;1252.5052604221282;1264.3172686749053;1284.1845428153003;6080.391960803884;6126.816195514141;6128.540359473057;6142.6314421134875;6152.569320147547;6508;6535.150430444107;6576.375244351779;6593.40659340652;6595.637239951849;6030.969845150834;6111.663858487737;6122.387761223842;6137.662428566472;6141.723622436912;3612.6026137124895;3652.5251717277115;3656.067702735785;3656.926861462809;3657.451382292624;6771.72913083481;6776.11910451648;6784.423324017415;6784.728610855511;6800.455963522906;6586.967065164739;6725.159355080615;6761.121054263012;6769.05233267343;6776.966115169393;6774.559653622498;6776.186857577122;6791.93208067913;6798.150231221098;6800.65996700163;6566.737330506726;6599.670016499252;6605.372489613479;6605.867882642224;6606.768763093269;6413.262474815456;6490.7079181436;6494.4804415645685;6501.577397469338;6509.088727578048;6679.165104361955;6694.297098804555;6731.865362692621;6747.2915343890145;6747.595144291358;4828.058528587032;4849.345338379274;4853.369062021915;4860.1008813369635;4877.756112194447;6299.834530611852;6370.968145159244;6467.288598254282;6481.254655714653;6550.050242714875;6343.11196432509;6354.745810167541;6374.936250637435;6377.968110159605;6382.266039405527;6318.304986451579;6356.141920840812;6357.4278314950025;6368.554201205871;6368.936310636835;6135.263768347827;6227.532935029801;6248.937510625017;6253.405926436982;6276.686165691788;6405.647689377129;6494.772682956074;6495.285518593046;6496.577722448026;6500.674966251763;6283.3716628338625;6309.274433440213;6340.175777149126;6341.397567231105;6345.746170153327 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: |5;yui.html;830.8172202115533;862.7843039240189;888.0231745080408;936.9765755856107;956.2971216156126;12625.431855566498;13378.331083445826;14248.14511129333;14289.142651440921;14345.641358966019;12906.74186516269;12969.740605187913;12995.350232488361;13025.804612930813;13035.283059431727;760.5436737957236;767.9654415551314;928.5078908178676;948.0045951750669;949.5110018340561;927.972160835176;941.3034354577597;946.2855544064256;949.8052899155656;950.5484894675009;791.70311133325;797.4258533855615;965.2567523007281;984.921206303494;986.1469828598283;979.6913972098802;984.3847595252967;985.4973963278708;985.8225519406504;985.9507024648775;721.8303698630817;730.7186733107739;733.3546479098412;733.8092096055011;734.071399679406;13543.729125417436;13655.180689158682;13687.315634218348;13711.382987765575;13712.108712933627;10688.78622427555;12391.194572352768;12463.626091217187;12466.75066498665;13045.608631741063;10305.484725763681;10392.532336044897;10553;10581.31221470602;10753.569857205703;3456.9827150864085;3464.5149679044953;3467.826608669556;3469.2367679110557;3503.24680193757;43375.78312108419;43801;43933.340999885026;44363.33454998177;44432;7957.8408431832195;7969.521828690181;8000.199980001953;8013.15861834499;8058.033036035713;12745;12788.232706037668;12795.872041279654;12868.935655321664;12922.741545169043;7029.191642961125;7144;7218;7236.131664200329;7271.272872712792;4518.615917646971;4547.204239258117;4617.422822147231;4645.512221216791;4716.339712440261;2937.6621688506098;2969.1241083879877;2971.286891146109;2975.538791487323;2982.1053683894743;531.7155321902763;543.6411968101113;543.9401665816757;547.3213215612691;549.8762778374913;736.977890663281;739.5858319341186;741.4624397312014;744.0959234530072;765.2882818978403;8524.445911015764;8571.271441927382;8627.784305392415;8861.069587693328;9021.639134434681;609.2932198649545;643.829385212919;647.4334956912701;653.6013032050446;718.791550450374;3987.8404863805704;3988.282109220368;4032.697547683935;4070.8575199867864;4203.915921681611;56645;56801.715991420606;56833;57168.428315717145;57314.140287895716;43518.56481435208;43948.340774888406;44158.33762493565;44243;44276;37773;39491.210175796325;39673.20653586912;39853.60146398557;40274.99999999941;8716.869246961427;8805.119488051143;8975.640974360953;9049.230815380502;9153.17621414076;27913.162605121877;28118.2970425741;28385;28671.42657146887;28739.13782586526;37387;37407.43888841724;37452.812735936146;38483;38545.6145438542;11433.656990290305;11693.649190524298;11881.465334060162;11930.582429614922;12085.214461060003;12536.247825130522;12628.684282893002;12805.935970320088;12890.806637900627;12969.870301297244;12090;12095.758084838079;12101.576444824741;12335;12771.489140434278;11943.104267179822;12118.454669539715;12171.878281217429;12358.938205308916;12687.619371418872;10559.63041293551;10746.301490403099;11996.520139194683;12150.513979440724;12318.692032699255;9327.953360233156;10432.947835260775;10478.27421318896;10742.24804263694;10782.460876956278;9892.208623310262;10276.537555809857;10313.793724125626;10378;10623.575056997634 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,879 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194341788__endTimestamp 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,795 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5757.12 Median:5965.43 stddev:657.30 (11.0%) stddev-sans-first:631.81 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: Values: 3359.0 3395.5 3436.0 3438.6 3450.0 5690.5 5715.8 5718.1 5742.5 5742.8 5759.6 5766.5 5777.2 5786.2 5793.9 5132.4 5195.8 5232.1 5274.2 5343.5 5164.1 5175.1 5256.3 5268.3 5291.9 5358.4 5408.4 5418.2 5420.3 5423.9 5137.7 5238.6 5323.4 5328.3 5401.5 5107.5 5249.0 5254.4 5260.4 5281.1 5599.9 5609.4 5613.0 5616.4 5650.7 6024.8 6079.6 6111.1 6290.4 6300.1 6275.4 6312.2 6327.7 6331.6 6338.1 5865.7 5879.5 5884.3 5886.7 5888.1 6127.0 6192.5 6267.7 6336.7 6343.2 6109.1 6139.7 6145.3 6158.4 6182.4 6294.0 6295.0 6305.1 6307.1 6308.2 6003.8 6067.7 6080.4 6179.0 6186.6 6198.8 6248.5 6256.7 6263.7 6266.6 4531.5 4685.0 4697.2 4700.3 4718.4 4142.4 4158.8 4195.2 4200.7 4211.3 5821.1 5903.0 5910.5 5910.9 5933.1 6006.8 6073.8 6270.1 6323.7 6346.4 5750.3 5802.3 5819.9 5823.3 5850.4 5323.8 5349.7 5352.0 5355.5 5369.9 6112.4 6143.7 6275.2 6386.7 6409.4 6176.1 6243.9 6286.8 6291.7 6294.4 6404.0 6410.8 6414.9 6426.8 6432.2 5988.6 6031.5 6079.5 6119.0 6132.9 6182.3 6191.6 6199.6 6274.1 6299.3 6131.3 6133.3 6136.3 6137.8 6141.8 5855.7 5965.4 6074.2 6164.5 6174.5 6024.0 6043.9 6093.9 6112.3 6114.0 5946.7 6171.1 6185.7 6187.9 6207.3 5820.5 5900.9 5922.1 5922.7 5947.6 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65163.03 Median:3929.36 stddev:127180.73 (3236.7%) stddev-sans-first:127445.12 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: Values: 596.2 640.9 642.2 673.0 680.3 44927.0 45552.3 45669.0 45745.5 45782.7 50564.7 51143.0 51230.5 51246.5 51449.0 8149.5 8579.4 9230.0 9393.4 10745.0 10926.5 11004.3 11027.0 11036.8 11041.8 10934.9 11053.7 11068.7 11079.6 11107.9 8593.4 8823.2 11042.6 11281.2 11288.8 10910.8 11014.4 11033.9 11066.3 11067.9 46504.1 46573.0 46776.8 46880.0 47130.8 3919.4 3939.3 4110.8 4112.1 4155.9 34807.5 35223.6 35523.3 36800.0 36843.4 3856.1 3903.0 3916.2 3958.5 4017.0 347737.0 348173.0 348530.0 482602.0 490556.0 70782.6 72244.0 72630.6 72719.0 73109.6 68441.3 68678.7 68884.3 69198.7 69417.0 18323.6 18458.8 18477.5 18490.4 18502.3 14036.4 14084.8 14085.5 14265.1 14319.9 23399.2 23740.6 23810.4 23851.3 23906.0 7864.6 8041.3 8090.2 8112.0 8207.3 1146.6 1171.2 1185.5 1188.3 1219.9 32109.2 32286.0 32514.3 32553.5 33254.0 1148.1 1204.1 1243.8 1269.6 1271.5 14856.6 15920.1 16096.6 16715.9 17001.6 442777.0 448103.0 448618.0 448762.0 449967.0 61354.4 61580.7 61697.7 61850.7 62024.0 1402.7 1415.4 1444.7 1529.0 1544.8 29881.9 30096.0 32266.4 32562.0 33241.2 51410.7 51812.2 51897.2 56009.0 58051.4 557985.0 568496.0 570971.0 572906.0 574132.0 35434.3 35950.8 36078.8 36187.6 36236.0 49724.5 49810.5 50453.5 50484.2 50654.0 41421.8 41732.0 42010.0 42300.4 43102.8 41851.0 42270.4 42741.1 42946.9 43167.4 42550.4 42677.8 43557.8 43648.6 43729.1 35813.3 37189.8 37327.4 37711.0 38336.8 28282.4 28609.7 28773.6 28815.3 28852.4 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,796 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31918.04 Median:412.82 stddev:96400.14 (23351.8%) stddev-sans-first:96641.54 01:39:01 INFO - 2015-10-30 01:39:01,797 DEBUG : BROWSER_OUTPUT: Values: 412.1 413.5 423.9 426.1 426.5 16101.0 16312.7 19248.4 19582.4 20154.7 19697.8 19843.9 20076.6 20447.8 21270.4 5901.9 6029.7 6036.9 6037.4 6037.5 4271.8 4395.7 5966.6 6495.9 6735.6 6510.1 6625.9 6630.1 6657.1 6663.6 5606.0 6737.6 6741.2 6743.7 6744.3 6039.1 6051.0 6063.8 6678.7 6878.3 26842.3 26929.3 27233.3 27285.0 27450.7 2751.4 2789.5 2811.8 2813.5 2820.2 15541.1 15609.1 15801.6 15878.4 16070.9 2127.2 2134.6 2194.9 2235.8 2270.7 80636.6 80641.6 81616.0 83722.6 84393.6 17033.7 17582.4 17720.7 17734.7 17766.9 28441.4 28702.4 28827.1 28884.6 29080.1 10484.6 10496.2 10520.2 10537.4 10564.9 8985.9 9004.0 9029.2 9095.0 9095.0 8650.7 8754.5 8768.4 8809.3 8819.6 1310.4 1312.6 1315.3 1317.7 2151.7 538.1 558.4 559.4 569.7 582.9 13428.9 13693.3 14020.6 14145.6 14198.5 566.8 580.7 587.2 599.4 602.5 7444.5 7568.2 7664.0 7918.8 7933.3 456520.0 557415.0 559049.0 640039.0 699935.0 82113.6 82528.6 89462.0 92268.5 92514.0 605.9 612.8 614.1 614.4 616.0 11360.5 11870.6 12377.4 12991.8 13015.8 38059.2 38229.8 38374.0 38495.0 38780.6 47544.3 48580.5 49727.0 50492.5 53117.0 7916.1 7950.8 7952.4 7969.9 8030.6 13436.9 13516.2 13703.8 13926.2 13961.4 11988.9 12007.6 12151.8 12389.6 12405.9 11767.4 11965.1 12071.6 12363.1 12643.7 12405.8 12619.4 12775.7 12794.6 12957.9 7573.9 7834.3 7861.8 7864.1 7943.2 10421.9 12046.8 12079.7 12369.0 12379.9 01:39:01 INFO - 2015-10-30 01:39:01,798 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,798 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7248.44 Median:2565.98 stddev:4194.53 (163.5%) stddev-sans-first:4184.46 01:39:01 INFO - 2015-10-30 01:39:01,799 DEBUG : BROWSER_OUTPUT: Values: 1552.3 1651.9 1827.3 2015.4 2044.7 9351.8 10199.4 10309.5 10317.5 10328.3 10052.0 10169.1 10198.6 10208.7 10211.2 2191.2 2204.4 2503.0 2509.7 2524.9 2520.8 2544.4 2558.7 2565.1 2566.9 2448.2 2480.0 2491.3 2491.4 2495.5 2196.5 2239.5 2492.2 2567.3 2575.0 2459.6 2483.7 2491.7 2546.4 2555.0 10618.6 10665.3 10691.2 10710.3 10712.7 5939.9 6036.2 6039.9 6042.2 6044.9 3681.5 3719.7 3755.4 3761.3 3779.9 1115.5 1120.3 1129.4 1136.7 1159.3 16310.5 16343.3 16356.6 16361.6 16372.4 5360.0 5379.6 5428.9 5449.3 5483.1 12568.6 12577.3 12588.5 12593.0 12599.2 5985.2 6010.8 6063.3 6065.5 6079.4 5352.4 5354.5 5374.2 5376.2 5378.0 4565.1 4586.1 4605.1 4631.8 4641.4 1380.1 1400.2 1405.1 1411.2 1419.3 1461.5 1463.2 1476.2 1492.1 1493.6 9750.0 9756.8 9778.8 9790.5 9809.4 581.7 591.5 591.7 594.2 594.3 7188.6 7212.3 7293.6 7295.2 7302.6 13359.5 13629.5 13683.9 13686.3 13711.0 13242.1 13611.1 13621.7 13655.9 13657.0 9615.8 9685.1 9754.3 9755.3 9765.9 9055.1 9087.5 9147.1 9172.9 9182.4 11499.4 11654.7 11728.0 11750.6 11783.7 11829.7 12046.6 12074.8 12114.2 12127.2 9089.4 9324.1 9402.1 9417.8 9423.3 10069.2 10212.4 10330.3 10341.1 10363.3 8249.4 8773.1 9516.8 9543.6 9592.5 8748.5 9089.2 9266.9 9283.1 9448.8 9269.7 9281.3 9301.4 9309.7 9313.7 8595.9 8683.6 8685.9 8687.8 8706.2 8403.2 8416.2 8451.0 8461.2 8603.7 01:39:01 INFO - 2015-10-30 01:39:01,799 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,799 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5408.62 Median:6073.42 stddev:1533.57 (25.3%) stddev-sans-first:1491.05 01:39:01 INFO - 2015-10-30 01:39:01,800 DEBUG : BROWSER_OUTPUT: Values: 398.6 400.3 405.1 405.4 406.2 5965.0 5984.6 6052.6 6065.0 6066.5 5880.6 5922.5 5943.0 5971.3 5971.6 4781.9 4787.7 4787.9 4795.1 4796.4 4756.9 4784.3 4786.0 4794.4 4794.4 4746.1 4749.3 4756.9 4759.3 4759.4 4695.9 4756.2 4756.4 4762.5 4793.4 4262.4 4271.7 4273.1 4278.3 4279.7 5684.8 5712.1 5735.3 5739.3 5753.3 5533.4 5533.6 5534.0 5538.8 5539.6 6271.9 6355.9 6383.5 6396.8 6399.0 4715.7 4721.5 4722.1 4724.2 4724.5 6280.4 6380.2 6490.5 6589.6 6609.4 4844.3 4878.4 4885.2 4890.3 4894.3 4943.6 4944.8 4950.4 4953.5 4955.0 5298.3 5352.0 5418.3 5473.5 5480.8 6322.5 6327.6 6333.4 6348.9 6351.9 1749.7 1769.9 1772.0 1776.8 1776.8 1246.6 1252.5 1252.5 1264.3 1284.2 6080.4 6126.8 6128.5 6142.6 6152.6 6508.0 6535.2 6576.4 6593.4 6595.6 6031.0 6111.7 6122.4 6137.7 6141.7 3612.6 3652.5 3656.1 3656.9 3657.5 6771.7 6776.1 6784.4 6784.7 6800.5 6587.0 6725.2 6761.1 6769.1 6777.0 6774.6 6776.2 6791.9 6798.2 6800.7 6566.7 6599.7 6605.4 6605.9 6606.8 6413.3 6490.7 6494.5 6501.6 6509.1 6679.2 6694.3 6731.9 6747.3 6747.6 4828.1 4849.3 4853.4 4860.1 4877.8 6299.8 6371.0 6467.3 6481.3 6550.1 6343.1 6354.7 6374.9 6378.0 6382.3 6318.3 6356.1 6357.4 6368.6 6368.9 6135.3 6227.5 6248.9 6253.4 6276.7 6405.6 6494.8 6495.3 6496.6 6500.7 6283.4 6309.3 6340.2 6341.4 6345.7 01:39:01 INFO - 2015-10-30 01:39:01,800 DEBUG : BROWSER_OUTPUT: 01:39:01 INFO - 2015-10-30 01:39:01,800 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12863.97 Median:4051.78 stddev:14190.77 (350.2%) stddev-sans-first:14201.81 01:39:01 INFO - 2015-10-30 01:39:01,801 DEBUG : BROWSER_OUTPUT: Values: 830.8 862.8 888.0 937.0 956.3 12625.4 13378.3 14248.1 14289.1 14345.6 12906.7 12969.7 12995.4 13025.8 13035.3 760.5 768.0 928.5 948.0 949.5 928.0 941.3 946.3 949.8 950.5 791.7 797.4 965.3 984.9 986.1 979.7 984.4 985.5 985.8 986.0 721.8 730.7 733.4 733.8 734.1 13543.7 13655.2 13687.3 13711.4 13712.1 10688.8 12391.2 12463.6 12466.8 13045.6 10305.5 10392.5 10553.0 10581.3 10753.6 3457.0 3464.5 3467.8 3469.2 3503.2 43375.8 43801.0 43933.3 44363.3 44432.0 7957.8 7969.5 8000.2 8013.2 8058.0 12745.0 12788.2 12795.9 12868.9 12922.7 7029.2 7144.0 7218.0 7236.1 7271.3 4518.6 4547.2 4617.4 4645.5 4716.3 2937.7 2969.1 2971.3 2975.5 2982.1 531.7 543.6 543.9 547.3 549.9 737.0 739.6 741.5 744.1 765.3 8524.4 8571.3 8627.8 8861.1 9021.6 609.3 643.8 647.4 653.6 718.8 3987.8 3988.3 4032.7 4070.9 4203.9 56645.0 56801.7 56833.0 57168.4 57314.1 43518.6 43948.3 44158.3 44243.0 44276.0 37773.0 39491.2 39673.2 39853.6 40275.0 8716.9 8805.1 8975.6 9049.2 9153.2 27913.2 28118.3 28385.0 28671.4 28739.1 37387.0 37407.4 37452.8 38483.0 38545.6 11433.7 11693.6 11881.5 11930.6 12085.2 12536.2 12628.7 12805.9 12890.8 12969.9 12090.0 12095.8 12101.6 12335.0 12771.5 11943.1 12118.5 12171.9 12358.9 12687.6 10559.6 10746.3 11996.5 12150.5 12318.7 9328.0 10432.9 10478.3 10742.2 10782.5 9892.2 10276.5 10313.8 10378.0 10623.6 01:39:01 INFO - 2015-10-30 01:39:01,801 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:39:01 INFO - 2015-10-30 01:39:01,801 DEBUG : BROWSER_OUTPUT: 01:39:02 INFO - 2015-10-30 01:39:02,381 INFO : Browser exited with error code: 0 01:39:02 INFO - 2015-10-30 01:39:02,405 INFO : Completed test dromaeo_css (00:18:31) 01:39:02 INFO - 2015-10-30 01:39:02,405 INFO : Starting test kraken 01:39:02 INFO - 2015-10-30 01:39:02,405 DEBUG : operating with platform_type : linux_ 01:39:02 INFO - 2015-10-30 01:39:02,405 INFO : Initialising browser for kraken test... 01:39:02 INFO - 2015-10-30 01:39:02,411 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3cclvX/profile http://localhost/getInfo.html 01:39:06 INFO - 2015-10-30 01:39:06,032 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:39:06 INFO - 2015-10-30 01:39:06,032 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:39:06 INFO - 2015-10-30 01:39:06,032 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:39:06 INFO - 2015-10-30 01:39:06,032 DEBUG : BROWSER_OUTPUT: __metrics 01:39:06 INFO - 2015-10-30 01:39:06,190 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:07 INFO - 2015-10-30 01:39:07,431 INFO : Browser initialized. 01:39:07 INFO - 2015-10-30 01:39:07,431 INFO : Running cycle 1/1 for kraken test... 01:39:07 INFO - 2015-10-30 01:39:07,431 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3cclvX/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:19 INFO - 2015-10-30 01:39:19,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 132587520 01:39:19 INFO - 2015-10-30 01:39:19,163 DEBUG : BROWSER_OUTPUT: 01:39:22 INFO - 2015-10-30 01:39:22,041 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:22 INFO - 2015-10-30 01:39:22,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 164773888 01:39:22 INFO - 2015-10-30 01:39:22,613 DEBUG : BROWSER_OUTPUT: 01:39:25 INFO - 2015-10-30 01:39:25,142 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:25 INFO - 2015-10-30 01:39:25,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 162914304 01:39:25 INFO - 2015-10-30 01:39:25,703 DEBUG : BROWSER_OUTPUT: 01:39:28 INFO - 2015-10-30 01:39:28,460 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:29 INFO - 2015-10-30 01:39:29,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 162992128 01:39:29 INFO - 2015-10-30 01:39:29,024 DEBUG : BROWSER_OUTPUT: 01:39:30 INFO - 2015-10-30 01:39:30,957 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:31 INFO - 2015-10-30 01:39:31,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 160133120 01:39:31 INFO - 2015-10-30 01:39:31,518 DEBUG : BROWSER_OUTPUT: 01:39:33 INFO - 2015-10-30 01:39:33,604 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:34 INFO - 2015-10-30 01:39:34,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 154722304 01:39:34 INFO - 2015-10-30 01:39:34,158 DEBUG : BROWSER_OUTPUT: 01:39:36 INFO - 2015-10-30 01:39:36,980 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:39:37 INFO - 2015-10-30 01:39:37,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 156446720 01:39:37 INFO - 2015-10-30 01:39:37,546 DEBUG : BROWSER_OUTPUT: 01:39:40 INFO - 2015-10-30 01:39:40,861 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:39:41 INFO - 2015-10-30 01:39:41,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 155967488 01:39:41 INFO - 2015-10-30 01:39:41,423 DEBUG : BROWSER_OUTPUT: 01:39:44 INFO - 2015-10-30 01:39:44,065 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:39:44 INFO - 2015-10-30 01:39:44,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 156614656 01:39:44 INFO - 2015-10-30 01:39:44,634 DEBUG : BROWSER_OUTPUT: 01:39:46 INFO - 2015-10-30 01:39:46,155 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:39:46 INFO - 2015-10-30 01:39:46,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 162422784 01:39:46 INFO - 2015-10-30 01:39:46,717 DEBUG : BROWSER_OUTPUT: 01:39:48 INFO - 2015-10-30 01:39:48,406 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:39:48 INFO - 2015-10-30 01:39:48,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 161955840 01:39:48 INFO - 2015-10-30 01:39:48,996 DEBUG : BROWSER_OUTPUT: 01:39:50 INFO - 2015-10-30 01:39:50,959 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:39:51 INFO - 2015-10-30 01:39:51,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 170405888 01:39:51 INFO - 2015-10-30 01:39:51,527 DEBUG : BROWSER_OUTPUT: 01:39:54 INFO - 2015-10-30 01:39:54,027 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:39:54 INFO - 2015-10-30 01:39:54,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 174325760 01:39:54 INFO - 2015-10-30 01:39:54,609 DEBUG : BROWSER_OUTPUT: 01:39:56 INFO - 2015-10-30 01:39:56,995 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:39:57 INFO - 2015-10-30 01:39:57,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 171020288 01:39:57 INFO - 2015-10-30 01:39:57,557 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,138 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:39:59 INFO - 2015-10-30 01:39:59,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 230260736 01:39:59 INFO - 2015-10-30 01:39:59,388 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,391 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:39:59 INFO - 2015-10-30 01:39:59,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:39:59 INFO - 2015-10-30 01:39:59,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:39:59 INFO - 2015-10-30 01:39:59,392 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:39:59 INFO - 2015-10-30 01:39:59,392 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;109;109;109;108;110;116;110;109;107 01:39:59 INFO - 2015-10-30 01:39:59,392 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;142;123;149;156;129;152;145;123;167;120 01:39:59 INFO - 2015-10-30 01:39:59,392 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;158;159;157;161;162;160;158;159 01:39:59 INFO - 2015-10-30 01:39:59,392 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;71;160;69;70;71;72;151;70 01:39:59 INFO - 2015-10-30 01:39:59,392 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;88;133;88;88;89;128;88;88;130 01:39:59 INFO - 2015-10-30 01:39:59,393 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;110;110;110;111;110 01:39:59 INFO - 2015-10-30 01:39:59,393 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;146;145;146;145;145;145;147 01:39:59 INFO - 2015-10-30 01:39:59,393 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;95 01:39:59 INFO - 2015-10-30 01:39:59,393 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;55;55;54;56;53;55;56;78;53 01:39:59 INFO - 2015-10-30 01:39:59,393 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;61;62;61;62;62;61;61;61;60 01:39:59 INFO - 2015-10-30 01:39:59,393 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;81;78;79;79;78;77;80;78;78 01:39:59 INFO - 2015-10-30 01:39:59,393 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;112;124;105;107;108;108;113;105;113 01:39:59 INFO - 2015-10-30 01:39:59,394 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;138;135;137;135;135;135;127;138;137 01:39:59 INFO - 2015-10-30 01:39:59,394 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;61;60;61;61;60;59;60;60;60 01:39:59 INFO - 2015-10-30 01:39:59,394 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:39:59 INFO - 2015-10-30 01:39:59,394 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:39:59 INFO - 2015-10-30 01:39:59,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,859 01:39:59 INFO - 2015-10-30 01:39:59,394 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:39:59 INFO - 2015-10-30 01:39:59,394 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194399390__endTimestamp 01:39:59 INFO - 2015-10-30 01:39:59,395 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,398 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:39:59 INFO - 2015-10-30 01:39:59,398 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:39:59 INFO - 2015-10-30 01:39:59,398 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,399 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:109.00 stddev:2.82 (2.6%) stddev-sans-first:2.55 01:39:59 INFO - 2015-10-30 01:39:59,399 DEBUG : BROWSER_OUTPUT: Values: 105.0 109.0 109.0 109.0 108.0 110.0 116.0 110.0 109.0 107.0 01:39:59 INFO - 2015-10-30 01:39:59,399 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,399 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.60 Median:147.00 stddev:16.11 (11.0%) stddev-sans-first:17.07 01:39:59 INFO - 2015-10-30 01:39:59,399 DEBUG : BROWSER_OUTPUT: Values: 142.0 123.0 149.0 156.0 129.0 152.0 145.0 123.0 167.0 120.0 01:39:59 INFO - 2015-10-30 01:39:59,399 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,400 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.40 Median:160.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 01:39:59 INFO - 2015-10-30 01:39:59,400 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 158.0 159.0 157.0 161.0 162.0 160.0 158.0 159.0 01:39:59 INFO - 2015-10-30 01:39:59,400 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,400 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.40 Median:70.00 stddev:35.96 (51.4%) stddev-sans-first:37.59 01:39:59 INFO - 2015-10-30 01:39:59,400 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 160.0 69.0 70.0 71.0 72.0 151.0 70.0 01:39:59 INFO - 2015-10-30 01:39:59,400 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.90 Median:88.00 stddev:20.35 (23.1%) stddev-sans-first:21.12 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: Values: 89.0 88.0 133.0 88.0 88.0 89.0 128.0 88.0 88.0 130.0 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 147.0 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:39:59 INFO - 2015-10-30 01:39:59,401 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:7.42 (13.4%) stddev-sans-first:7.87 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: Values: 57.0 55.0 55.0 54.0 56.0 53.0 55.0 56.0 78.0 53.0 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 60.0 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:1.27 (1.6%) stddev-sans-first:1.22 01:39:59 INFO - 2015-10-30 01:39:59,402 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 78.0 79.0 79.0 78.0 77.0 80.0 78.0 78.0 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:110.60 Median:111.50 stddev:5.60 (5.0%) stddev-sans-first:5.94 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 124.0 105.0 107.0 108.0 108.0 113.0 105.0 113.0 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:137.00 stddev:3.20 (2.3%) stddev-sans-first:3.35 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: Values: 137.0 138.0 135.0 137.0 135.0 135.0 135.0 127.0 138.0 137.0 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 60.0 61.0 61.0 60.0 59.0 60.0 60.0 60.0 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:39:59 INFO - 2015-10-30 01:39:59,403 DEBUG : BROWSER_OUTPUT: 01:40:00 INFO - 2015-10-30 01:40:00,193 INFO : Browser exited with error code: 0 01:40:00 INFO - 2015-10-30 01:40:00,244 INFO : Completed test kraken (00:00:57) 01:40:00 INFO - 2015-10-30 01:40:00,244 INFO : Starting test v8_7 01:40:00 INFO - 2015-10-30 01:40:00,244 DEBUG : operating with platform_type : linux_ 01:40:00 INFO - 2015-10-30 01:40:00,244 INFO : Initialising browser for v8_7 test... 01:40:00 INFO - 2015-10-30 01:40:00,251 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWvccxL/profile http://localhost/getInfo.html 01:40:03 INFO - 2015-10-30 01:40:03,953 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:40:03 INFO - 2015-10-30 01:40:03,953 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:40:03 INFO - 2015-10-30 01:40:03,953 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:40:03 INFO - 2015-10-30 01:40:03,953 DEBUG : BROWSER_OUTPUT: __metrics 01:40:04 INFO - 2015-10-30 01:40:04,017 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:05 INFO - 2015-10-30 01:40:05,255 INFO : Browser initialized. 01:40:05 INFO - 2015-10-30 01:40:05,256 INFO : Running cycle 1/1 for v8_7 test... 01:40:05 INFO - 2015-10-30 01:40:05,256 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWvccxL/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:16 INFO - 2015-10-30 01:40:16,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 132624384 01:40:16 INFO - 2015-10-30 01:40:16,927 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,349 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:40:38 INFO - 2015-10-30 01:40:38,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 432177152 01:40:38 INFO - 2015-10-30 01:40:38,607 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,607 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:40:38 INFO - 2015-10-30 01:40:38,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:40:38 INFO - 2015-10-30 01:40:38,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |0;Richards;168.9189189189189 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.6090534979424 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.5315315315315 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5096.446700507614 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |4;RayTrace;956.9377990430622 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |5;Earley;543.4782608695652 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |6;Boyer;10255.102040816326 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |7;RegExp;23045.454545454544 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |8;Splay;537.6344086021505 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194438600__endTimestamp 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:40:38 INFO - 2015-10-30 01:40:38,608 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.92 Median:168.92 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: Values: 168.9 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.61 Median:164.61 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: Values: 164.6 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: Values: 281.5 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5096.45 Median:5096.45 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: Values: 5096.4 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:956.94 Median:956.94 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: Values: 956.9 01:40:38 INFO - 2015-10-30 01:40:38,609 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.48 Median:543.48 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: Values: 543.5 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10255.10 Median:10255.10 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: Values: 10255.1 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23045.45 Median:23045.45 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: Values: 23045.5 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:537.63 Median:537.63 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: Values: 537.6 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: 01:40:38 INFO - 2015-10-30 01:40:38,610 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 01:40:38 INFO - 2015-10-30 01:40:38,611 DEBUG : BROWSER_OUTPUT: Values: 4817.3 01:40:38 INFO - 2015-10-30 01:40:38,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:40:38 INFO - 2015-10-30 01:40:38,611 DEBUG : BROWSER_OUTPUT: 01:40:39 INFO - 2015-10-30 01:40:39,461 INFO : Browser exited with error code: 0 01:40:39 INFO - 2015-10-30 01:40:39,479 INFO : Completed test v8_7 (00:00:39) 01:40:39 INFO - 2015-10-30 01:40:39,480 INFO : Completed test suite (00:20:08) 01:40:39 INFO - 2015-10-30 01:40:39,480 DEBUG : Working with test: dromaeo_css 01:40:39 INFO - 2015-10-30 01:40:39,480 DEBUG : Generating results file: dromaeo_css 01:40:39 INFO - 2015-10-30 01:40:39,481 DEBUG : Working with test: kraken 01:40:39 INFO - 2015-10-30 01:40:39,482 DEBUG : Generating results file: kraken 01:40:39 INFO - 2015-10-30 01:40:39,482 INFO : javascript benchmark 01:40:39 INFO - 2015-10-30 01:40:39,482 DEBUG : Working with test: v8_7 01:40:39 INFO - 2015-10-30 01:40:39,482 DEBUG : Generating results file: v8_7 01:40:39 INFO - 2015-10-30 01:40:39,482 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:40:39 INFO - 2015-10-30 01:40:39,537 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 01:40:39 INFO - 2015-10-30 01:40:39,537 DEBUG : process_Request line: dromaeo_css 7681.35 graph.html#tests=[[72,52,35]] 01:40:39 INFO - 2015-10-30 01:40:39,537 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:40:39 INFO - 2015-10-30 01:40:39,641 DEBUG : process_Request line: kraken 1451.60 graph.html#tests=[[232,52,35]] 01:40:39 INFO - 2015-10-30 01:40:39,641 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:40:39 INFO - 2015-10-30 01:40:39,749 DEBUG : process_Request line: v8_7 23385.54 graph.html#tests=[[230,52,35]] 01:40:39 INFO - 2015-10-30 01:40:39,752 INFO : javascript benchmark 01:40:39 INFO - 2015-10-30 01:40:39,756 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [412.13040484577516, 413.50173041484993, 423.86436340371085, 426.1370724283326, 426.47543521468594, 16101.0, 16312.673746525063, 19248.422547323586, 19582.412527624176, 20154.697679534784, 19697.803021969776, 19843.864015753545, 20076.598468030632, 20447.795522044813, 21270.36188914335, 5901.85245368866, 6029.728662210189, 6036.879262414749, 6037.366076561963, 6037.486813620848, 4271.829126834923, 4395.7362558246605, 5966.612170208944, 6495.902561461582, 6735.5621884577595, 6510.056041873949, 6625.867482650344, 6630.071789949411, 6657.068010478537, 6663.566868153554, 5605.971970140164, 6737.562058466208, 6741.224759152711, 6743.662816859187, 6744.258131605519, 6039.063945088518, 6051.0, 6063.787767428119, 6678.732850685967, 6878.312168783082, 26842.328941776417, 26929.32676683079, 27233.319167020785, 27285.0, 27450.725492745016, 2751.3534319434916, 2789.5257806173, 2811.7750579953554, 2813.507636163684, 2820.2244382794693, 15541.14523701196, 15609.141497217648, 15801.60495987598, 15878.444254451155, 16070.919645401698, 2127.2022991378235, 2134.6264403729283, 2194.8792816395094, 2235.8099561537288, 2270.65940108985, 80636.59681701612, 80641.59679201567, 81616.0, 83722.58138709268, 84393.57803210945, 17033.659326813642, 17582.38461653836, 17720.734188987175, 17734.733978990327, 17766.91116544409, 28441.43117137646, 28702.425951480855, 28827.135185944455, 28884.566731499046, 29080.127596172148, 10484.63303784379, 10496.160307175407, 10520.158387328995, 10537.367757934395, 10564.947175264075, 8985.910140898639, 9003.954980225057, 9029.232515236146, 9095.0, 9095.045020272908, 8650.745641881891, 8754.518501482353, 8768.386212965032, 8809.295256379473, 8819.603117859711, 1310.4168644953095, 1312.553731731216, 1315.276597871167, 1317.7298653775954, 2151.6874706429066, 538.1148011521104, 558.4248224328948, 559.4405594405595, 569.6724383479516, 582.9387914269025, 13428.93285533566, 13693.315334233448, 14020.579382618538, 14145.646358840906, 14198.503052393324, 566.8469513231487, 580.6661169827366, 587.2043381218473, 599.4185639929261, 602.4638072115821, 7444.516106453063, 7568.205338439495, 7664.0, 7918.762437126896, 7933.325667318227, 456520.0, 557415.0, 559049.0, 640039.0, 699935.0, 82113.58943205245, 82528.58735706283, 89462.0, 92268.53865730762, 92514.0, 605.8606520500222, 612.8100288910363, 614.1494030767419, 614.4224429036691, 615.9661218633019, 11360.54557817678, 11870.643880683594, 12377.381130943237, 12991.805122922975, 13015.804762928374, 38059.2388152241, 38229.80885095557, 38374.0, 38495.03762405962, 38780.61219387883, 47544.286835698185, 48580.51419485901, 49727.0, 50492.49507504878, 53117.0, 7916.08964969036, 7950.761477155695, 7952.36381089523, 7969.920300796918, 8030.638621262174, 13436.865631343562, 13516.189028658311, 13703.794443083561, 13926.164430134224, 13961.441542338192, 11988.880111198776, 12007.639770806889, 12151.756964860477, 12389.62831115068, 12405.937970310091, 11767.352570639947, 11965.102617303563, 12071.637850864488, 12363.134580579273, 12643.747125057263, 12405.75188496243, 12619.36903154857, 12775.744485110432, 12794.616161515169, 12957.870421295667, 7573.886391704019, 7834.255745704149, 7861.842763144819, 7864.056313242448, 7943.24539168778, 10421.9478902605, 12046.75906481883, 12079.69800754953, 12369.0, 12379.876201237872], "dojo.html": [3358.966410335897, 3395.541601883745, 3436.0, 3438.5873695156583, 3449.9817606700085, 5690.4594063563945, 5715.799947001856, 5718.142278658198, 5742.540596752266, 5742.799002034919, 5759.5968282220265, 5766.509846663039, 5777.1623114648355, 5786.189933409326, 5793.913091303634, 5132.384113906336, 5195.830938038949, 5232.110541207994, 5274.182501712241, 5343.465653434664, 5164.096283150452, 5175.094358487268, 5256.290400795901, 5268.341457317835, 5291.867703307429, 5358.410574836785, 5408.432114627966, 5418.160185171305, 5420.268263784378, 5423.945760542403, 5137.666051706665, 5238.554722848562, 5323.414424413311, 5328.307320048369, 5401.459854014606, 5107.540321371094, 5248.973755131238, 5254.4220135785035, 5260.395054568736, 5281.07581173297, 5599.944000560024, 5609.439056094398, 5613.0, 5616.410276920906, 5650.74571644277, 6024.759009639609, 6079.574429789916, 6111.083337499366, 6290.3709629037185, 6300.054991751228, 6275.372462753734, 6312.210973628296, 6327.683615819236, 6331.55679102463, 6338.112664227012, 5865.677387743673, 5879.529637629023, 5884.264466941632, 5886.70566471679, 5888.087346461305, 6126.969365153146, 6192.473639740582, 6267.71795269214, 6336.746530138835, 6343.238811342669, 6109.144719739151, 6139.693015349304, 6145.324014358417, 6158.414950579688, 6182.350853160443, 6293.96853015732, 6295.024271237874, 6305.14880491137, 6307.148534947815, 6308.243010838729, 6003.849903752441, 6067.696615169224, 6080.422359875804, 6179.011358182669, 6186.628802271878, 6198.81403557885, 6248.4688801451475, 6256.718447669866, 6263.749450022039, 6266.624002559861, 4531.524189960072, 4685.016146609182, 4697.201475749131, 4700.341952126705, 4718.386609740712, 4142.440770496005, 4158.792060396968, 4195.202911446876, 4200.663946884242, 4211.305134652748, 5821.09772985188, 5903.026000709835, 5910.468057874812, 5910.911336329958, 5933.110033495011, 6006.819795406145, 6073.817785466443, 6270.0908368287255, 6323.715432805535, 6346.365363463617, 5750.338711048283, 5802.274715660543, 5819.88360232793, 5823.330317013513, 5850.385709500526, 5323.840284791462, 5349.732513374316, 5352.0366334060245, 5355.518003379637, 5369.892602148013, 6112.419320164578, 6143.709820937564, 6275.152854364603, 6386.712597933104, 6409.391107844747, 6176.104464852481, 6243.875122497616, 6286.811395658137, 6291.6539590321145, 6294.433500984934, 6404.039394090923, 6410.8076757697345, 6414.871702566016, 6426.807195784134, 6432.163818703539, 5988.550858685703, 6031.487323577369, 6079.452849243589, 6119.0, 6132.877342453036, 6182.258129024546, 6191.597546159485, 6199.628022318675, 6274.090256912813, 6299.275583307978, 6131.294901086432, 6133.294671112879, 6136.29432615255, 6137.84655383619, 6141.815745527641, 5855.707214639337, 5965.433283838029, 6074.240719910012, 6164.47601953839, 6174.475169610633, 6024.042186289561, 6043.939620385628, 6093.9390606093375, 6112.266528016667, 6114.021756518936, 5946.702664866826, 6171.105189747551, 6185.700808154552, 6187.907181392193, 6207.255129384503, 5820.505257053198, 5900.852478688067, 5922.082077278029, 5922.7334769936315, 5947.613405128825], "mootools.html": [1552.2704328965397, 1651.9256633451494, 1827.2873579304073, 2015.425603702945, 2044.7444069491314, 9351.81296374073, 10199.388036717794, 10309.53607087681, 10317.53571089301, 10328.328658637183, 10052.0, 10169.084782369586, 10198.631196928933, 10208.744781380468, 10211.234157438203, 2191.200211922645, 2204.371754050096, 2502.9874850625765, 2509.6611957385794, 2524.924252272435, 2520.76052774987, 2544.427503811637, 2558.7057488388796, 2565.076572433922, 2566.8844901979364, 2448.204333591581, 2479.9832068851774, 2491.302435318105, 2491.352248415416, 2495.5258500884775, 2196.494806194576, 2239.529698763262, 2492.1651246832243, 2567.255495906185, 2575.0472325239593, 2459.6187590923437, 2483.714372847128, 2491.6760821093144, 2546.401595625027, 2554.961675574868, 10618.57525698971, 10665.306755060974, 10691.198160138021, 10710.250282480229, 10712.678619641423, 5939.910901336483, 6036.185115009462, 6039.879202415971, 6042.184305118841, 6044.909326360108, 3681.4661874028384, 3719.7396182267253, 3755.4179102239195, 3761.28535578242, 3779.9433008504893, 1115.4590023838432, 1120.3166068698088, 1129.4183495499824, 1136.6760473265163, 1159.263867444179, 16310.510684679479, 16343.26455309514, 16356.591085222846, 16361.590960226089, 16372.426965056286, 5360.0, 5379.6234263601955, 5428.864278392993, 5449.291592093003, 5483.067878460672, 12568.560100396442, 12577.308248046445, 12588.496460141492, 12593.0, 12599.244045357307, 5985.191999080069, 6010.849728756816, 6063.302720187146, 6065.514758819284, 6079.422454866781, 5352.357717073976, 5354.518093371616, 5374.247605335257, 5376.220448035013, 5378.031954248273, 4565.086982603492, 4586.059857729158, 4605.148047611203, 4631.8378856739855, 4641.373414589055, 1380.0891411668451, 1400.208881981677, 1405.058610730813, 1411.2097225553723, 1419.2548911821377, 1461.4811741831497, 1463.217178809332, 1476.2397365356849, 1492.0823693428463, 1493.6116609681344, 9749.951250243845, 9756.804863902682, 9778.75553111178, 9790.51047447639, 9809.362391444676, 581.6887964938737, 591.5149577346534, 591.7425919724933, 594.2275042444891, 594.337313895004, 7188.568685878864, 7212.278772122746, 7293.635318234067, 7295.161056478573, 7302.634868256566, 13359.465621375231, 13629.522966696317, 13683.931580342034, 13686.315684215948, 13711.0, 13242.139260948008, 13611.11527750693, 13621.727565448635, 13655.863441365658, 13657.0, 9615.807683846284, 9685.128338449433, 9754.268429867647, 9755.317127800985, 9765.853512197322, 9055.139761722627, 9087.454752714859, 9147.0852914708, 9172.908270917205, 9182.357234993486, 11499.425028748696, 11654.708632283922, 11728.0, 11750.58872939443, 11783.705407364885, 11829.70425739329, 12046.578369757017, 12074.758504829679, 12114.21257618252, 12127.211731237441, 9089.409188402733, 9324.11420915012, 9402.059794020543, 9417.811643766949, 9423.293253005915, 10069.244806639384, 10212.387256764618, 10330.276880618585, 10341.121004714683, 10363.32638378503, 8249.422540422112, 8773.122687731176, 9516.762080948032, 9543.618255269988, 9592.472414017297, 8748.518831464331, 9089.181973622406, 9266.907330926873, 9283.11810378013, 9448.763780905258, 9269.67556135532, 9281.303902207497, 9301.395409298373, 9309.674161404319, 9313.720588382359, 8595.87106193395, 8683.609237584198, 8685.91314086851, 8687.782805429915, 8706.1729135732, 8403.159684031549, 8416.15838416178, 8450.957745211235, 8461.238488535815, 8603.655853765778], "ext.html": [596.212998841529, 640.8814369341673, 642.2132887213164, 673.0106743087659, 680.2890978927021, 44927.0, 45552.31671524925, 45669.0, 45745.54254457454, 45782.71086445677, 50564.74717626407, 51143.0, 51230.48769512304, 51246.48753512473, 51449.0, 8149.4702844315225, 8579.399442039059, 9229.953850230739, 9393.436393816359, 10745.0, 10926.453677316142, 11004.339739615649, 11027.0, 11036.779264414747, 11041.83437248442, 10934.890651093507, 11053.723656908562, 11068.723281917975, 11079.612213572527, 11107.888921110767, 8593.398462107654, 8823.161799629057, 11042.613508527164, 11281.153913456523, 11288.774224515546, 10910.781784364348, 11014.44927753609, 11033.944830275797, 11066.336019838755, 11067.944660276728, 46504.069918601774, 46573.0, 46776.76611616954, 46880.0, 47130.764346178395, 3919.392494163409, 3939.330313846653, 4110.753354798721, 4112.074783173792, 4155.896102597429, 34807.4778878317, 35223.64776352229, 35523.28953420917, 36800.0, 36843.447348289796, 3856.093817952779, 3902.9609703902884, 3916.1776027034357, 3958.5447673517624, 4016.979915100435, 347737.0, 348173.0, 348530.0, 482602.0, 490555.99999999645, 70782.64608676924, 72244.0, 72630.63684681543, 72719.0, 73109.63445182846, 68441.31558684449, 68678.65660671664, 68884.3111568888, 69198.65400673065, 69417.0, 18323.633527329377, 18458.81541184598, 18477.53806154857, 18490.35283765062, 18502.259909603734, 14036.368363423671, 14084.788728169086, 14085.507007254697, 14265.072770269899, 14319.92840035814, 23399.181028663916, 23740.64389034166, 23810.404739881295, 23851.284461466184, 23906.0, 7864.606769661494, 8041.3164880984605, 8090.231428014447, 8111.95944020288, 8207.261346478726, 1146.5814977533141, 1171.1918776044502, 1185.525789684116, 1188.257339163023, 1219.9024078073733, 32109.197270068435, 32286.0, 32514.349713005606, 32553.51169732456, 33254.0, 1148.1388958281289, 1204.1209916760813, 1243.8258643789877, 1269.5683467621054, 1271.4723389793132, 14856.554303370916, 15920.124393158487, 16096.597585060234, 16715.91642041782, 17001.574960625836, 442777.0, 448103.0, 448618.0, 448762.0, 449967.0, 61354.38645613576, 61580.69209653923, 61697.69151154216, 61850.69074654598, 62024.0, 1402.7404930087966, 1415.402735979489, 1444.6966137111324, 1528.9694206116037, 1544.8146222453154, 29881.850590746908, 30096.0, 32266.35467290594, 32562.02313930586, 33241.16897077592, 51410.74294628503, 51812.222816658534, 51897.22154167766, 56009.0, 58051.41948580629, 557985.0, 568496.0, 570971.0, 572906.0, 574132.0, 35434.29131417409, 35950.820245898605, 36078.8196059018, 36187.63812361948, 36236.0, 49724.50275497344, 49810.50189498059, 50453.49546504488, 50484.242736359716, 50654.0, 41421.79289103535, 41732.0, 42010.0, 42300.36549451822, 43102.78448607737, 41851.0, 42270.365944511475, 42741.14517709691, 42946.92632684208, 43167.35248971205, 42550.361744574475, 42677.786611066746, 43557.78221108874, 43648.56351436445, 43729.12541749084, 35813.28373432464, 37189.81405092957, 37327.44008839924, 37711.0, 38336.80831595824, 28282.43435131327, 28609.713902860705, 28773.568396473653, 28815.279618009718, 28852.422951540433], "prototype.html": [398.5790656310254, 400.3394399241253, 405.133015347157, 405.3919121318023, 406.15722376069647, 5965.0, 5984.581079324449, 6052.576319657625, 6064.969675151629, 6066.454019138277, 5880.647161170333, 5922.466977971982, 5942.970285148579, 5971.253593300838, 5971.611845230057, 4781.856544303659, 4787.688800227974, 4787.8563643090765, 4795.0889331027165, 4796.448408433022, 4756.9286460703115, 4784.330193772875, 4786.042791441708, 4794.35276237707, 4794.376731024962, 4746.145693775119, 4749.26386410107, 4756.90486190276, 4759.286107083948, 4759.405074365704, 4695.859124226278, 4756.167670657621, 4756.405449318835, 4762.547557981986, 4793.424789025305, 4262.381954616563, 4271.743695378287, 4273.102648443831, 4278.336857787048, 4279.657627389833, 5684.8294551163535, 5712.1431785232135, 5735.254416925773, 5739.253896993364, 5753.280839895013, 5533.418991005967, 5533.584981126432, 5533.972330138364, 5538.806141785019, 5539.584531160139, 6271.905921411182, 6355.872882542323, 6383.521235907326, 6396.840078998016, 6399.040143978394, 4715.669903106784, 4721.527847215285, 4722.1028004679, 4724.2205036169335, 4724.480307166209, 6280.371962803729, 6380.234371875358, 6490.513211509156, 6589.571677840973, 6609.405153536205, 4844.297576851337, 4878.365812444359, 4885.169521181408, 4890.290907818347, 4894.339264199288, 4943.604511639061, 4944.752762361867, 4950.356453661001, 4953.504649535018, 4954.950450495521, 5298.258243845865, 5352.0366334060245, 5418.322709661293, 5473.534749546254, 5480.808171713971, 6322.525810564226, 6327.557071004985, 6333.398327158912, 6348.904766428507, 6351.936480635227, 1749.7112976358758, 1769.8938063716218, 1771.973420398695, 1776.8134345893754, 1776.840084392411, 1246.6135497995651, 1252.461441580111, 1252.5052604221282, 1264.3172686749053, 1284.1845428153003, 6080.391960803884, 6126.816195514141, 6128.540359473057, 6142.6314421134875, 6152.569320147547, 6508.0, 6535.150430444107, 6576.375244351779, 6593.40659340652, 6595.637239951849, 6030.969845150834, 6111.663858487737, 6122.387761223842, 6137.662428566472, 6141.723622436912, 3612.6026137124895, 3652.5251717277115, 3656.067702735785, 3656.926861462809, 3657.451382292624, 6771.72913083481, 6776.11910451648, 6784.423324017415, 6784.728610855511, 6800.455963522906, 6586.967065164739, 6725.159355080615, 6761.121054263012, 6769.05233267343, 6776.966115169393, 6774.559653622498, 6776.186857577122, 6791.93208067913, 6798.150231221098, 6800.65996700163, 6566.737330506726, 6599.670016499252, 6605.372489613479, 6605.867882642224, 6606.768763093269, 6413.262474815456, 6490.7079181436, 6494.4804415645685, 6501.577397469338, 6509.088727578048, 6679.165104361955, 6694.297098804555, 6731.865362692621, 6747.2915343890145, 6747.595144291358, 4828.058528587032, 4849.345338379274, 4853.369062021915, 4860.1008813369635, 4877.756112194447, 6299.834530611852, 6370.968145159244, 6467.288598254282, 6481.254655714653, 6550.050242714875, 6343.11196432509, 6354.745810167541, 6374.936250637435, 6377.968110159605, 6382.266039405527, 6318.304986451579, 6356.141920840812, 6357.4278314950025, 6368.554201205871, 6368.936310636835, 6135.263768347827, 6227.532935029801, 6248.937510625017, 6253.405926436982, 6276.686165691788, 6405.647689377129, 6494.772682956074, 6495.285518593046, 6496.577722448026, 6500.674966251763, 6283.3716628338625, 6309.274433440213, 6340.175777149126, 6341.397567231105, 6345.746170153327], "yui.html": [830.8172202115533, 862.7843039240189, 888.0231745080408, 936.9765755856107, 956.2971216156126, 12625.431855566498, 13378.331083445826, 14248.14511129333, 14289.142651440921, 14345.641358966019, 12906.74186516269, 12969.740605187913, 12995.350232488361, 13025.804612930813, 13035.283059431727, 760.5436737957236, 767.9654415551314, 928.5078908178676, 948.0045951750669, 949.5110018340561, 927.972160835176, 941.3034354577597, 946.2855544064256, 949.8052899155656, 950.5484894675009, 791.70311133325, 797.4258533855615, 965.2567523007281, 984.921206303494, 986.1469828598283, 979.6913972098802, 984.3847595252967, 985.4973963278708, 985.8225519406504, 985.9507024648775, 721.8303698630817, 730.7186733107739, 733.3546479098412, 733.8092096055011, 734.071399679406, 13543.729125417436, 13655.180689158682, 13687.315634218348, 13711.382987765575, 13712.108712933627, 10688.78622427555, 12391.194572352768, 12463.626091217187, 12466.75066498665, 13045.608631741063, 10305.484725763681, 10392.532336044897, 10553.0, 10581.31221470602, 10753.569857205703, 3456.9827150864085, 3464.5149679044953, 3467.826608669556, 3469.2367679110557, 3503.24680193757, 43375.78312108419, 43801.0, 43933.340999885026, 44363.33454998177, 44432.0, 7957.8408431832195, 7969.521828690181, 8000.199980001953, 8013.15861834499, 8058.033036035713, 12745.0, 12788.232706037668, 12795.872041279654, 12868.935655321664, 12922.741545169043, 7029.191642961125, 7144.0, 7218.0, 7236.131664200329, 7271.272872712792, 4518.615917646971, 4547.204239258117, 4617.422822147231, 4645.512221216791, 4716.339712440261, 2937.6621688506098, 2969.1241083879877, 2971.286891146109, 2975.538791487323, 2982.1053683894743, 531.7155321902763, 543.6411968101113, 543.9401665816757, 547.3213215612691, 549.8762778374913, 736.977890663281, 739.5858319341186, 741.4624397312014, 744.0959234530072, 765.2882818978403, 8524.445911015764, 8571.271441927382, 8627.784305392415, 8861.069587693328, 9021.639134434681, 609.2932198649545, 643.829385212919, 647.4334956912701, 653.6013032050446, 718.791550450374, 3987.8404863805704, 3988.282109220368, 4032.697547683935, 4070.8575199867864, 4203.915921681611, 56645.0, 56801.715991420606, 56833.0, 57168.428315717145, 57314.140287895716, 43518.56481435208, 43948.340774888406, 44158.33762493565, 44243.0, 44276.0, 37773.0, 39491.210175796325, 39673.20653586912, 39853.60146398557, 40274.99999999941, 8716.869246961427, 8805.119488051143, 8975.640974360953, 9049.230815380502, 9153.17621414076, 27913.162605121877, 28118.2970425741, 28385.0, 28671.42657146887, 28739.13782586526, 37387.0, 37407.43888841724, 37452.812735936146, 38483.0, 38545.6145438542, 11433.656990290305, 11693.649190524298, 11881.465334060162, 11930.582429614922, 12085.214461060003, 12536.247825130522, 12628.684282893002, 12805.935970320088, 12890.806637900627, 12969.870301297244, 12090.0, 12095.758084838079, 12101.576444824741, 12335.0, 12771.489140434278, 11943.104267179822, 12118.454669539715, 12171.878281217429, 12358.938205308916, 12687.619371418872, 10559.63041293551, 10746.301490403099, 11996.520139194683, 12150.513979440724, 12318.692032699255, 9327.953360233156, 10432.947835260775, 10478.27421318896, 10742.24804263694, 10782.460876956278, 9892.208623310262, 10276.537555809857, 10313.793724125626, 10378.0, 10623.575056997634]}, "summary": {"suite": 7681.346386324143, "subtests": {"jquery.html": {"std": 96131.98815169671, "min": 412.13040484577516, "max": 699935.0, "median": 10551.157466599234, "filtered": 9371.212323022139, "mean": 31918.0419350701}, "dojo.html": {"std": 655.3007928673131, "min": 3358.966410335897, "max": 6432.163818703539, "median": 5965.433283838029, "filtered": 5712.947231022561, "mean": 5757.12304331941}, "mootools.html": {"std": 4182.8671524464435, "min": 581.6887964938737, "max": 16372.426965056286, "median": 8528.554775234883, "filtered": 5598.219712568514, "mean": 7248.435526335244}, "ext.html": {"std": 126826.9626255903, "min": 596.212998841529, "max": 574132.0, "median": 32400.174856502803, "filtered": 22044.581398915398, "mean": 65163.025394772245}, "prototype.html": {"std": 1529.2994351774425, "min": 398.5790656310254, "max": 6800.65996700163, "median": 6065.711847144953, "filtered": 4938.61437665647, "mean": 5408.62221718343}, "yui.html": {"std": 14151.300139972316, "min": 531.7155321902763, "max": 57314.140287895716, "median": 10345.896862062813, "filtered": 6294.683020433075, "mean": 12863.972538915199}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-050"}, "testrun": {"date": 1446193230, "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": [160.0, 160.0, 158.0, 159.0, 157.0, 161.0, 162.0, 160.0, 158.0, 159.0], "ai-astar": [105.0, 109.0, 109.0, 109.0, 108.0, 110.0, 116.0, 110.0, 109.0, 107.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "audio-beat-detection": [142.0, 123.0, 149.0, 156.0, 129.0, 152.0, 145.0, 123.0, 167.0, 120.0], "json-stringify-tinderbox": [62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 60.0], "stanford-crypto-pbkdf2": [137.0, 138.0, 135.0, 137.0, 135.0, 135.0, 135.0, 127.0, 138.0, 137.0], "json-parse-financial": [57.0, 55.0, 55.0, 54.0, 56.0, 53.0, 55.0, 56.0, 78.0, 53.0], "stanford-crypto-sha256-iterative": [62.0, 61.0, 60.0, 61.0, 61.0, 60.0, 59.0, 60.0, 60.0, 60.0], "audio-fft": [70.0, 70.0, 71.0, 160.0, 69.0, 70.0, 71.0, 72.0, 151.0, 70.0], "imaging-darkroom": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0], "stanford-crypto-ccm": [111.0, 112.0, 124.0, 105.0, 107.0, 108.0, 108.0, 113.0, 105.0, 113.0], "audio-oscillator": [89.0, 88.0, 133.0, 88.0, 88.0, 89.0, 128.0, 88.0, 88.0, 130.0], "stanford-crypto-aes": [77.0, 81.0, 78.0, 79.0, 79.0, 78.0, 77.0, 80.0, 78.0, 78.0], "imaging-desaturate": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0]}, "summary": {"suite": 1451.6000000000001, "subtests": {"audio-fft": {"std": 34.118030423809635, "min": 69.0, "max": 160.0, "median": 70.5, "filtered": 87.4, "mean": 87.4}, "stanford-crypto-pbkdf2": {"std": 3.039736830714133, "min": 127.0, "max": 138.0, "median": 136.0, "filtered": 135.4, "mean": 135.4}, "audio-beat-detection": {"std": 15.278743403827423, "min": 120.0, "max": 167.0, "median": 143.5, "filtered": 140.6, "mean": 140.6}, "stanford-crypto-ccm": {"std": 5.314132102234569, "min": 105.0, "max": 124.0, "median": 109.5, "filtered": 110.6, "mean": 110.6}, "imaging-darkroom": {"std": 0.66332495807108, "min": 145.0, "max": 147.0, "median": 145.0, "filtered": 145.4, "mean": 145.4}, "json-parse-financial": {"std": 7.0398863627192165, "min": 53.0, "max": 78.0, "median": 55.0, "filtered": 57.2, "mean": 57.2}, "audio-oscillator": {"std": 19.305180651835403, "min": 88.0, "max": 133.0, "median": 88.5, "filtered": 100.9, "mean": 100.9}, "ai-astar": {"std": 2.6758176320519307, "min": 105.0, "max": 116.0, "median": 109.0, "filtered": 109.2, "mean": 109.2}, "audio-dft": {"std": 1.42828568570857, "min": 157.0, "max": 162.0, "median": 159.5, "filtered": 159.4, "mean": 159.4}, "stanford-crypto-sha256-iterative": {"std": 0.8, "min": 59.0, "max": 62.0, "median": 60.0, "filtered": 60.4, "mean": 60.4}, "json-stringify-tinderbox": {"std": 0.6403124237432849, "min": 60.0, "max": 62.0, "median": 61.0, "filtered": 61.3, "mean": 61.3}, "imaging-gaussian-blur": {"std": 0.4472135954999579, "min": 109.0, "max": 111.0, "median": 110.0, "filtered": 110.0, "mean": 110.0}, "stanford-crypto-aes": {"std": 1.2041594578792296, "min": 77.0, "max": 81.0, "median": 78.0, "filtered": 78.5, "mean": 78.5}, "imaging-desaturate": {"std": 0.45825756949558394, "min": 95.0, "max": 96.0, "median": 95.0, "filtered": 95.3, "mean": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-050"}, "testrun": {"date": 1446193230, "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": [164.6090534979424], "Encrypt": [281.5315315315315], "NavierStokes": [4817.307692307692], "Decrypt": [5096.446700507614], "Splay": [537.6344086021505], "Richards": [168.9189189189189], "RegExp": [23045.454545454544], "Earley": [543.4782608695652], "Boyer": [10255.102040816326], "RayTrace": [956.9377990430622]}, "summary": {"suite": 23385.537462813325, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.6090534979424, "max": 164.6090534979424, "median": 164.6090534979424, "value": 401.66685000000007, "filtered": 401.66685000000007, "mean": 164.6090534979424}, "Encrypt": {"std": 0.0, "min": 281.5315315315315, "max": 281.5315315315315, "median": 281.5315315315315, "value": 945.4749119999998, "filtered": 945.4749119999998, "mean": 281.5315315315315}, "NavierStokes": {"std": 0.0, "min": 4817.307692307692, "max": 4817.307692307692, "median": 4817.307692307692, "value": 308.055888223553, "filtered": 308.055888223553, "mean": 4817.307692307692}, "Decrypt": {"std": 0.0, "min": 5096.446700507614, "max": 5096.446700507614, "median": 5096.446700507614, "value": 52.22874203187249, "filtered": 52.22874203187249, "mean": 5096.446700507614}, "Splay": {"std": 0.0, "min": 537.6344086021505, "max": 537.6344086021505, "median": 537.6344086021505, "value": 151.57326, "filtered": 151.57326, "mean": 537.6344086021505}, "RegExp": {"std": 0.0, "min": 23045.454545454544, "max": 23045.454545454544, "median": 23045.454545454544, "value": 39.529921104536506, "filtered": 39.529921104536506, "mean": 23045.454545454544}, "Richards": {"std": 0.0, "min": 168.9189189189189, "max": 168.9189189189189, "median": 168.9189189189189, "value": 208.98783999999998, "filtered": 208.98783999999998, "mean": 168.9189189189189}, "Earley": {"std": 0.0, "min": 543.4782608695652, "max": 543.4782608695652, "median": 543.4782608695652, "value": 1226.2919200000001, "filtered": 1226.2919200000001, "mean": 543.4782608695652}, "Boyer": {"std": 0.0, "min": 10255.102040816326, "max": 10255.102040816326, "median": 10255.102040816326, "value": 64.98843184079605, "filtered": 64.98843184079605, "mean": 10255.102040816326}, "RayTrace": {"std": 0.0, "min": 956.9377990430622, "max": 956.9377990430622, "median": 956.9377990430622, "value": 773.2885049999996, "filtered": 773.2885049999996, "mean": 956.9377990430622}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-050"}, "testrun": {"date": 1446193230, "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:40:39 INFO - RETURN: dromaeo_css: 7681.35 01:40:39 INFO - RETURN: kraken: 1451.60 01:40:39 INFO - RETURN: v8_7: 23385.54 01:40:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23385.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1451.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7681.35"}}} 01:40:39 INFO - Return code: 0 01:40:39 INFO - # TBPL SUCCESS # 01:40:39 INFO - Running post-action listener: _resource_record_post_action 01:40:39 INFO - Running post-run listener: _resource_record_post_run 01:40:40 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 7675904; Write bytes: 385081344; Read time: 2280; Write time: 268892 01:40:40 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 12275712; Read time: 0; Write time: 1496 01:40:40 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 5435392; Write bytes: 282693632; Read time: 1360; Write time: 192984 01:40:40 INFO - Running post-run listener: _upload_blobber_files 01:40:40 INFO - Blob upload gear active. 01:40:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:40:40 INFO - Copying logs to upload dir... 01:40:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.290448 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-10-30 01:40:40.946021) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:40:40.949604) ========= 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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 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.010722 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:40:41.001479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:40:41.001823) ========= 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=d3f2be9b0713ec03b22325b2000001be-1446188510.620083-1338247456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:40:41.052157) ========= ========= Started reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-30 01:40:41.052478) ========= ========= Finished reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-30 01:40:44.952901) =========