builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1446115142.58 results: success (0) buildid: 20151029012446 builduid: 3d43e8ca7be54163b739961a6150cca7 revision: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.577613) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.578121) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.578532) ========= 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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006578 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.648560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.649252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.683548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.683917) ========= 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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.028896 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.742348) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.742651) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.743058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.743331) ========= 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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-29 03:39:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-10-29 03:39:02 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211093 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.973221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:02.973542) ========= 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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.075414 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:03.060649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:03.061030) ========= 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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-29 03:39:03,088 truncating revision to first 12 chars 2015-10-29 03:39:03,088 Setting DEBUG logging. 2015-10-29 03:39:03,088 attempt 1/10 2015-10-29 03:39:03,088 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-29 03:39:03,358 unpacking tar archive at: mozilla-aurora-5e1587041f9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540174 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:03.613453) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:03.613779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:03.623971) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:03.624270) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 03:39:03.624671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-10-29 03:39:03.624973) ========= /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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:03 INFO - MultiFileLogger online at 20151029 03:39:03 in /builds/slave/test-pgo 03:39:03 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 03:39:03 INFO - Guessing talos json url... 03:39:03 INFO - Using buildbot properties: 03:39:03 INFO - { 03:39:03 INFO - "properties": { 03:39:03 INFO - "buildnumber": 4, 03:39:03 INFO - "product": "firefox", 03:39:03 INFO - "script_repo_revision": "production", 03:39:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:39:03 INFO - "repository": "", 03:39:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:39:03 INFO - "buildid": "20151029012446", 03:39:03 INFO - "slavename": "talos-linux64-ix-012", 03:39:03 INFO - "pgo_build": "True", 03:39:03 INFO - "basedir": "/builds/slave/test-pgo", 03:39:03 INFO - "project": "", 03:39:03 INFO - "platform": "ubuntu64_hw", 03:39:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:39:03 INFO - "slavebuilddir": "test", 03:39:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:03 INFO - "branch": "mozilla-aurora", 03:39:03 INFO - "repo_path": "releases/mozilla-aurora", 03:39:03 INFO - "stage_platform": "linux64-pgo", 03:39:03 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 03:39:03 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 03:39:03 INFO - }, 03:39:03 INFO - "sourcestamp": { 03:39:03 INFO - "repository": "", 03:39:03 INFO - "hasPatch": false, 03:39:03 INFO - "project": "", 03:39:03 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:39:03 INFO - "changes": [ 03:39:03 INFO - { 03:39:03 INFO - "category": null, 03:39:03 INFO - "files": [ 03:39:03 INFO - { 03:39:03 INFO - "url": null, 03:39:03 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:39:03 INFO - } 03:39:03 INFO - ], 03:39:03 INFO - "repository": "", 03:39:03 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 03:39:03 INFO - "who": "bobowencode@gmail.com", 03:39:03 INFO - "when": 1446115088, 03:39:03 INFO - "number": 6592843, 03:39:03 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 03:39:03 INFO - "project": "", 03:39:03 INFO - "at": "Thu 29 Oct 2015 03:38:08", 03:39:03 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:39:03 INFO - "revlink": "", 03:39:03 INFO - "properties": [ 03:39:03 INFO - [ 03:39:03 INFO - "buildid", 03:39:03 INFO - "20151029012446", 03:39:03 INFO - "Change" 03:39:03 INFO - ], 03:39:03 INFO - [ 03:39:03 INFO - "builduid", 03:39:03 INFO - "3d43e8ca7be54163b739961a6150cca7", 03:39:03 INFO - "Change" 03:39:03 INFO - ], 03:39:03 INFO - [ 03:39:03 INFO - "pgo_build", 03:39:03 INFO - "True", 03:39:03 INFO - "Change" 03:39:03 INFO - ] 03:39:03 INFO - ], 03:39:03 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 03:39:03 INFO - } 03:39:03 INFO - ], 03:39:03 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 03:39:03 INFO - } 03:39:03 INFO - } 03:39:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 03:39: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')]} 03:39:03 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 03:39:03 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 03:39:03 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 03:39:03 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 03:39:03 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 03:39:04 INFO - Downloaded 107 bytes. 03:39:04 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:39:04 INFO - Contents: 03:39:04 INFO - 20151029012446 03:39:04 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/5e1587041f9a9724055f62c0c5a9f7e9c9c54876 03:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:04 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json 03:39:04 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 03:39:04 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 03:39:05 INFO - Downloaded 6818 bytes. 03:39:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:39:05 INFO - '../fennec_ids.txt'], 03:39:05 INFO - 'tests': ['tcheck2']}, 03:39:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:05 INFO - '--tppagecycles', 03:39:05 INFO - '7'], 03:39:05 INFO - 'tests': ['tsvgm']}}, 03:39:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:39:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:39:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:39:05 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:39:05 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:05 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:39:05 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:39:05 INFO - 'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:05 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'tests': ['damp', 'tps']}, 03:39:05 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['damp', 'tps']}, 03:39:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:39:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:05 INFO - 'other': {'tests': ['a11yr', 03:39:05 INFO - 'ts_paint', 03:39:05 INFO - 'tpaint', 03:39:05 INFO - 'sessionrestore', 03:39:05 INFO - 'sessionrestore_no_auto_restore']}, 03:39:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['a11yr', 03:39:05 INFO - 'ts_paint', 03:39:05 INFO - 'tpaint', 03:39:05 INFO - 'sessionrestore', 03:39:05 INFO - 'sessionrestore_no_auto_restore']}, 03:39:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['a11yr', 03:39:05 INFO - 'ts_paint', 03:39:05 INFO - 'tpaint', 03:39:05 INFO - 'sessionrestore', 03:39:05 INFO - 'sessionrestore_no_auto_restore']}, 03:39:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['a11yr', 03:39:05 INFO - 'ts_paint', 03:39:05 INFO - 'tpaint', 03:39:05 INFO - 'sessionrestore', 03:39:05 INFO - 'sessionrestore_no_auto_restore']}, 03:39:05 INFO - 'other_l64': {'tests': ['a11yr', 03:39:05 INFO - 'ts_paint', 03:39:05 INFO - 'tpaint', 03:39:05 INFO - 'sessionrestore', 03:39:05 INFO - 'sessionrestore_no_auto_restore']}, 03:39:05 INFO - 'other_nol64': {'tests': ['a11yr', 03:39:05 INFO - 'ts_paint', 03:39:05 INFO - 'tpaint', 03:39:05 INFO - 'sessionrestore', 03:39:05 INFO - 'sessionrestore_no_auto_restore']}, 03:39:05 INFO - 'svgr': {'tests': ['tsvgx', 03:39:05 INFO - 'tsvgr_opacity', 03:39:05 INFO - 'tart', 03:39:05 INFO - 'tscrollx', 03:39:05 INFO - 'cart']}, 03:39:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['tsvgx', 03:39:05 INFO - 'tsvgr_opacity', 03:39:05 INFO - 'tart', 03:39:05 INFO - 'tscrollx', 03:39:05 INFO - 'cart']}, 03:39:05 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:39:05 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:39:05 INFO - 'tests': ['tp5o']}, 03:39:05 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:39:05 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:39:05 INFO - 'talos_options': ['--e10s'], 03:39:05 INFO - 'tests': ['tp5o']}, 03:39:05 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:39:05 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:39:05 INFO - 'talos_options': ['--xperf_path', 03:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:05 INFO - 'tests': ['tp5n']}, 03:39:05 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:39:05 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:39:05 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:05 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:39:05 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:39:05 INFO - 'talos_options': ['--e10s', 03:39:05 INFO - '--xperf_path', 03:39:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 03:39:05 INFO - 'C:/slave/talos-data/talos/xperf.config'], 03:39:05 INFO - 'tests': ['tp5n']}}, 03:39:05 INFO - 'talos.zip': {'path': '', 03:39:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:39:05 INFO - {'append_to_log': False, 03:39:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:39:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:39:05 INFO - 'branch': 'Mozilla-Aurora', 03:39:05 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:05 INFO - 'config_files': ('talos/linux_config.py',), 03:39:05 INFO - 'default_actions': ('clobber', 03:39:05 INFO - 'read-buildbot-config', 03:39:05 INFO - 'download-and-extract', 03:39:05 INFO - 'populate-webroot', 03:39:05 INFO - 'create-virtualenv', 03:39:05 INFO - 'install', 03:39:05 INFO - 'run-tests'), 03:39:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:05 INFO - 'download_minidump_stackwalk': True, 03:39:05 INFO - 'download_symbols': 'ondemand', 03:39:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:05 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:05 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:05 INFO - 'installer_path': 'installer.exe', 03:39:05 INFO - 'log_level': 'info', 03:39:05 INFO - 'log_name': 'talos', 03:39:05 INFO - 'log_to_console': True, 03:39:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:05 INFO - 'opt_config_files': (), 03:39:05 INFO - 'pip_index': False, 03:39:05 INFO - 'python_webserver': False, 03:39:05 INFO - 'sps_profile': False, 03:39:05 INFO - 'sps_profile_interval': 0, 03:39:05 INFO - 'suite': 'dromaeojs', 03:39:05 INFO - 'system_bits': '64', 03:39:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:05 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 03:39:05 INFO - 'tests': (), 03:39:05 INFO - 'title': 'talos-linux64-ix-012', 03:39:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:05 INFO - 'use_talos_json': True, 03:39:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:39:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:05 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 03:39:05 INFO - 'work_dir': 'build'} 03:39:05 INFO - ##### 03:39:05 INFO - ##### Running clobber step. 03:39:05 INFO - ##### 03:39:05 INFO - Running pre-action listener: _resource_record_pre_action 03:39:05 INFO - Running main action method: clobber 03:39:05 INFO - rmtree: /builds/slave/test-pgo/build 03:39:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:39:06 INFO - Running post-action listener: _resource_record_post_action 03:39:06 INFO - ##### 03:39:06 INFO - ##### Running read-buildbot-config step. 03:39:06 INFO - ##### 03:39:06 INFO - Running pre-action listener: _resource_record_pre_action 03:39:06 INFO - Running main action method: read_buildbot_config 03:39:06 INFO - Using buildbot properties: 03:39:06 INFO - { 03:39:06 INFO - "properties": { 03:39:06 INFO - "buildnumber": 4, 03:39:06 INFO - "product": "firefox", 03:39:06 INFO - "script_repo_revision": "production", 03:39:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:39:06 INFO - "repository": "", 03:39:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:39:06 INFO - "buildid": "20151029012446", 03:39:06 INFO - "slavename": "talos-linux64-ix-012", 03:39:06 INFO - "pgo_build": "True", 03:39:06 INFO - "basedir": "/builds/slave/test-pgo", 03:39:06 INFO - "project": "", 03:39:06 INFO - "platform": "ubuntu64_hw", 03:39:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:39:06 INFO - "slavebuilddir": "test", 03:39:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:06 INFO - "branch": "mozilla-aurora", 03:39:06 INFO - "repo_path": "releases/mozilla-aurora", 03:39:06 INFO - "stage_platform": "linux64-pgo", 03:39:06 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 03:39:06 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 03:39:06 INFO - }, 03:39:06 INFO - "sourcestamp": { 03:39:06 INFO - "repository": "", 03:39:06 INFO - "hasPatch": false, 03:39:06 INFO - "project": "", 03:39:06 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:39:06 INFO - "changes": [ 03:39:06 INFO - { 03:39:06 INFO - "category": null, 03:39:06 INFO - "files": [ 03:39:06 INFO - { 03:39:06 INFO - "url": null, 03:39:06 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:39:06 INFO - } 03:39:06 INFO - ], 03:39:06 INFO - "repository": "", 03:39:06 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 03:39:06 INFO - "who": "bobowencode@gmail.com", 03:39:06 INFO - "when": 1446115088, 03:39:06 INFO - "number": 6592843, 03:39:06 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 03:39:06 INFO - "project": "", 03:39:06 INFO - "at": "Thu 29 Oct 2015 03:38:08", 03:39:06 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:39:06 INFO - "revlink": "", 03:39:06 INFO - "properties": [ 03:39:06 INFO - [ 03:39:06 INFO - "buildid", 03:39:06 INFO - "20151029012446", 03:39:06 INFO - "Change" 03:39:06 INFO - ], 03:39:06 INFO - [ 03:39:06 INFO - "builduid", 03:39:06 INFO - "3d43e8ca7be54163b739961a6150cca7", 03:39:06 INFO - "Change" 03:39:06 INFO - ], 03:39:06 INFO - [ 03:39:06 INFO - "pgo_build", 03:39:06 INFO - "True", 03:39:06 INFO - "Change" 03:39:06 INFO - ] 03:39:06 INFO - ], 03:39:06 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 03:39:06 INFO - } 03:39:06 INFO - ], 03:39:06 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 03:39:06 INFO - } 03:39:06 INFO - } 03:39:06 INFO - Running post-action listener: _resource_record_post_action 03:39:06 INFO - ##### 03:39:06 INFO - ##### Running download-and-extract step. 03:39:06 INFO - ##### 03:39:06 INFO - Running pre-action listener: _resource_record_pre_action 03:39:06 INFO - Running main action method: download_and_extract 03:39:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:06 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:39:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 03:39:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 03:39:06 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 03:39:06 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 03:39:06 INFO - Downloaded 1302 bytes. 03:39:06 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:39:06 INFO - Using the following test package requirements: 03:39:06 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:06 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:06 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:06 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:06 INFO - u'jsshell-linux-x86_64.zip'], 03:39:06 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:06 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:06 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:06 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:06 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:06 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:06 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:06 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:06 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:06 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:06 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:06 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:06 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:06 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 03:39:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:06 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 03:39:07 INFO - Downloaded 22906880 bytes. 03:39:07 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 03:39:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:07 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 03:39:08 INFO - Return code: 0 03:39:08 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 03:39: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')]} 03:39:08 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 03:39:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:08 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 03:39:10 INFO - Downloaded 22906880 bytes. 03:39:10 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 03:39:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:39:10 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 03:39:12 INFO - Return code: 0 03:39:12 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')]} 03:39:12 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 03:39:12 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 03:39:12 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 03:39:12 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 03:39:12 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 03:39:13 INFO - Downloaded 10881672 bytes. 03:39:13 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 03:39:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:13 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 03:39:13 INFO - Return code: 0 03:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:13 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 03:39:13 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 03:39:13 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 03:39:13 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 03:39:13 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 03:39:15 INFO - Downloaded 56983114 bytes. 03:39:15 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 03:39:15 INFO - mkdir: /builds/slave/test-pgo/properties 03:39:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:39:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:39:15 INFO - Contents: 03:39:15 INFO - build_url:https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:39:15 INFO - Running post-action listener: _resource_record_post_action 03:39:15 INFO - Running post-action listener: _set_extra_try_arguments 03:39:15 INFO - ##### 03:39:15 INFO - ##### Running populate-webroot step. 03:39:15 INFO - ##### 03:39:15 INFO - Running pre-action listener: _resource_record_pre_action 03:39:15 INFO - Running main action method: populate_webroot 03:39:15 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 03:39:15 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:39:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 03:39:15 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 03:39:15 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:39:15 INFO - Running post-action listener: _resource_record_post_action 03:39:15 INFO - ##### 03:39:15 INFO - ##### Running create-virtualenv step. 03:39:15 INFO - ##### 03:39:15 INFO - Running pre-action listener: _resource_record_pre_action 03:39:15 INFO - Running main action method: create_virtualenv 03:39:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:39:15 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 03:39:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:39:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:16 INFO - Using real prefix '/usr' 03:39:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:39:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:19 INFO - Installing pip.................done. 03:39:19 INFO - Return code: 0 03:39:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:39:19 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')]} 03:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:19 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')]} 03:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:19 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 0x7fd6ba090b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21017b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c64a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, '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': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', '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 03:39:19 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 03:39:19 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 03:39:19 INFO - Using env: {'DISPLAY': ':0', 03:39:19 INFO - 'HOME': '/home/cltbld', 03:39:19 INFO - 'LANG': 'en_US.UTF-8', 03:39:19 INFO - 'LANGUAGE': 'en_US:en', 03:39:19 INFO - 'LOGNAME': 'cltbld', 03:39:19 INFO - 'MAIL': '/var/mail/cltbld', 03:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:19 INFO - 'MOZ_NO_REMOTE': '1', 03:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:19 INFO - 'NO_EM_RESTART': '1', 03:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:19 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:19 INFO - 'SHELL': '/bin/bash', 03:39:19 INFO - 'SHLVL': '1', 03:39:19 INFO - 'TERM': 'linux', 03:39:19 INFO - 'TMOUT': '86400', 03:39:19 INFO - 'USER': 'cltbld', 03:39:19 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:19 INFO - '_': '/tools/buildbot/bin/python'} 03:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:39:20 INFO - Cleaning up... 03:39:20 INFO - Return code: 0 03:39:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ba090b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21017b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c64a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, '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': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', '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 03:39:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:39:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:39:20 INFO - Using env: {'DISPLAY': ':0', 03:39:20 INFO - 'HOME': '/home/cltbld', 03:39:20 INFO - 'LANG': 'en_US.UTF-8', 03:39:20 INFO - 'LANGUAGE': 'en_US:en', 03:39:20 INFO - 'LOGNAME': 'cltbld', 03:39:20 INFO - 'MAIL': '/var/mail/cltbld', 03:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:20 INFO - 'MOZ_NO_REMOTE': '1', 03:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:20 INFO - 'NO_EM_RESTART': '1', 03:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:20 INFO - 'SHELL': '/bin/bash', 03:39:20 INFO - 'SHLVL': '1', 03:39:20 INFO - 'TERM': 'linux', 03:39:20 INFO - 'TMOUT': '86400', 03:39:20 INFO - 'USER': 'cltbld', 03:39:20 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:20 INFO - '_': '/tools/buildbot/bin/python'} 03:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:20 INFO - Downloading/unpacking psutil>=0.7.1 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:21 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:39:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:39:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:22 INFO - Installing collected packages: psutil 03:39:22 INFO - Running setup.py install for psutil 03:39:22 INFO - building 'psutil._psutil_linux' extension 03:39:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:39:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:39:23 INFO - building 'psutil._psutil_posix' extension 03:39:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:39:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:39:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:23 INFO - Successfully installed psutil 03:39:23 INFO - Cleaning up... 03:39:23 INFO - Return code: 0 03:39:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd6ba090b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21017b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c64a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, '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': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', '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 03:39:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:39:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:39:23 INFO - Using env: {'DISPLAY': ':0', 03:39:23 INFO - 'HOME': '/home/cltbld', 03:39:23 INFO - 'LANG': 'en_US.UTF-8', 03:39:23 INFO - 'LANGUAGE': 'en_US:en', 03:39:23 INFO - 'LOGNAME': 'cltbld', 03:39:23 INFO - 'MAIL': '/var/mail/cltbld', 03:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:23 INFO - 'MOZ_NO_REMOTE': '1', 03:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:23 INFO - 'NO_EM_RESTART': '1', 03:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:23 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:23 INFO - 'SHELL': '/bin/bash', 03:39:23 INFO - 'SHLVL': '1', 03:39:23 INFO - 'TERM': 'linux', 03:39:23 INFO - 'TMOUT': '86400', 03:39:23 INFO - 'USER': 'cltbld', 03:39:23 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:23 INFO - '_': '/tools/buildbot/bin/python'} 03:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:39:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:39:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:39:25 INFO - Installing collected packages: mozsystemmonitor 03:39:25 INFO - Running setup.py install for mozsystemmonitor 03:39:25 INFO - Successfully installed mozsystemmonitor 03:39:25 INFO - Cleaning up... 03:39:25 INFO - Return code: 0 03:39:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:39:25 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')]} 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:25 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')]} 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:25 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 0x7fd6ba090b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21017b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c64a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, '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': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', '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 03:39:25 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 03:39:25 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 03:39:25 INFO - Using env: {'DISPLAY': ':0', 03:39:25 INFO - 'HOME': '/home/cltbld', 03:39:25 INFO - 'LANG': 'en_US.UTF-8', 03:39:25 INFO - 'LANGUAGE': 'en_US:en', 03:39:25 INFO - 'LOGNAME': 'cltbld', 03:39:25 INFO - 'MAIL': '/var/mail/cltbld', 03:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:25 INFO - 'MOZ_NO_REMOTE': '1', 03:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:25 INFO - 'NO_EM_RESTART': '1', 03:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:25 INFO - 'SHELL': '/bin/bash', 03:39:25 INFO - 'SHLVL': '1', 03:39:25 INFO - 'TERM': 'linux', 03:39:25 INFO - 'TMOUT': '86400', 03:39:25 INFO - 'USER': 'cltbld', 03:39:25 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:25 INFO - '_': '/tools/buildbot/bin/python'} 03:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:39:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:39:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39:27 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 03:39:27 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 03:39:27 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 03:39:27 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 03:39:27 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 03:39:27 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 03:39:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:39:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:39:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:27 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 03:39:27 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 03:39:27 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 03:39:27 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 03:39:27 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 03:39:27 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 03:39:28 INFO - Downloading docopt-0.6.1.tar.gz 03:39:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:39:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:39:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:39:28 INFO - Running setup.py install for blobuploader 03:39:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:39:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:39:28 INFO - Running setup.py install for requests 03:39:28 INFO - Running setup.py install for docopt 03:39:28 INFO - Successfully installed blobuploader requests docopt 03:39:28 INFO - Cleaning up... 03:39:28 INFO - Return code: 0 03:39:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:39:28 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')]} 03:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:28 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')]} 03:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:28 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 0x7fd6ba090b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21017b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c64a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, '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': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', '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 03:39:28 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 03:39:28 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 03:39:28 INFO - Using env: {'DISPLAY': ':0', 03:39:28 INFO - 'HOME': '/home/cltbld', 03:39:28 INFO - 'LANG': 'en_US.UTF-8', 03:39:28 INFO - 'LANGUAGE': 'en_US:en', 03:39:28 INFO - 'LOGNAME': 'cltbld', 03:39:28 INFO - 'MAIL': '/var/mail/cltbld', 03:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:28 INFO - 'MOZ_NO_REMOTE': '1', 03:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:28 INFO - 'NO_EM_RESTART': '1', 03:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:28 INFO - 'SHELL': '/bin/bash', 03:39:28 INFO - 'SHLVL': '1', 03:39:28 INFO - 'TERM': 'linux', 03:39:28 INFO - 'TMOUT': '86400', 03:39:28 INFO - 'USER': 'cltbld', 03:39:28 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:28 INFO - '_': '/tools/buildbot/bin/python'} 03:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:39:28 INFO - Running setup.py (path:/tmp/pip-sepxlU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:39:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:39:28 INFO - Running setup.py (path:/tmp/pip-cTDWk4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:39:29 INFO - Running setup.py (path:/tmp/pip-LzBKFr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:39:29 INFO - Running setup.py (path:/tmp/pip-5vhPOs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:39:29 INFO - Running setup.py (path:/tmp/pip-NQa8KE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:39:29 INFO - Running setup.py (path:/tmp/pip-0mkc4B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:39:29 INFO - Running setup.py (path:/tmp/pip-_jt1mU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:39:29 INFO - Running setup.py (path:/tmp/pip-PNhtfO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:39:29 INFO - Running setup.py (path:/tmp/pip-x1_hlq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:39:29 INFO - Running setup.py (path:/tmp/pip-uIjVjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:39:29 INFO - Running setup.py (path:/tmp/pip-yqpjQu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:39:29 INFO - Running setup.py (path:/tmp/pip-16VdA4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:39:29 INFO - Running setup.py (path:/tmp/pip-M_lkMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:39:29 INFO - Running setup.py (path:/tmp/pip-MgvJZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:39:29 INFO - Running setup.py (path:/tmp/pip-ulsTx7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:39:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:39:29 INFO - Running setup.py (path:/tmp/pip-qLL9yu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:39:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:39:30 INFO - Running setup.py (path:/tmp/pip-14WIKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:39:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:39:30 INFO - Running setup.py install for manifestparser 03:39:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Running setup.py install for mozcrash 03:39:30 INFO - Running setup.py install for mozdebug 03:39:30 INFO - Running setup.py install for mozdevice 03:39:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Running setup.py install for mozfile 03:39:30 INFO - Running setup.py install for mozhttpd 03:39:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Running setup.py install for mozinfo 03:39:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Running setup.py install for mozInstall 03:39:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:39:30 INFO - Running setup.py install for mozleak 03:39:31 INFO - Running setup.py install for mozlog 03:39:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:39:31 INFO - Running setup.py install for moznetwork 03:39:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:39:31 INFO - Running setup.py install for mozprocess 03:39:31 INFO - Running setup.py install for mozprofile 03:39:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:39:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:39:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:39:31 INFO - Running setup.py install for mozrunner 03:39:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:39:31 INFO - Running setup.py install for mozscreenshot 03:39:31 INFO - Running setup.py install for moztest 03:39:31 INFO - Running setup.py install for mozversion 03:39:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:39:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:31 INFO - Cleaning up... 03:39:31 INFO - Return code: 0 03:39:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:39:31 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')]} 03:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:31 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')]} 03:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:31 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 0x7fd6ba090b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21017b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c64a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, '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': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', '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 03:39:31 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 03:39:31 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 03:39:31 INFO - Using env: {'DISPLAY': ':0', 03:39:31 INFO - 'HOME': '/home/cltbld', 03:39:31 INFO - 'LANG': 'en_US.UTF-8', 03:39:31 INFO - 'LANGUAGE': 'en_US:en', 03:39:31 INFO - 'LOGNAME': 'cltbld', 03:39:31 INFO - 'MAIL': '/var/mail/cltbld', 03:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:31 INFO - 'MOZ_NO_REMOTE': '1', 03:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:31 INFO - 'NO_EM_RESTART': '1', 03:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:31 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:31 INFO - 'SHELL': '/bin/bash', 03:39:31 INFO - 'SHLVL': '1', 03:39:31 INFO - 'TERM': 'linux', 03:39:31 INFO - 'TMOUT': '86400', 03:39:31 INFO - 'USER': 'cltbld', 03:39:31 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:31 INFO - '_': '/tools/buildbot/bin/python'} 03:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:39:32 INFO - Running setup.py (path:/tmp/pip-H95wDR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:39:32 INFO - Running setup.py (path:/tmp/pip-5Sunvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:39:32 INFO - Running setup.py (path:/tmp/pip-XcH1vQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:39:32 INFO - Running setup.py (path:/tmp/pip-tIf_8p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:39:32 INFO - Running setup.py (path:/tmp/pip-m2oD28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:39:32 INFO - Running setup.py (path:/tmp/pip-RzhtOY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:39:32 INFO - Running setup.py (path:/tmp/pip-VWk3f6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:39:32 INFO - Running setup.py (path:/tmp/pip-daOkGK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:39:32 INFO - Running setup.py (path:/tmp/pip-1UYgnA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:39:32 INFO - Running setup.py (path:/tmp/pip-Tm_L9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:39:32 INFO - Running setup.py (path:/tmp/pip-oos10a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:39:32 INFO - Running setup.py (path:/tmp/pip-sQxZhB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:39:32 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)) 03:39:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:39:32 INFO - Running setup.py (path:/tmp/pip-_Z5dbR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:39:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:39:33 INFO - Running setup.py (path:/tmp/pip-4syGeA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:39:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:39:33 INFO - Running setup.py (path:/tmp/pip-slFxoF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:39:33 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)) 03:39:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:39:33 INFO - Running setup.py (path:/tmp/pip-eyjEFG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:39:33 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)) 03:39:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:39:33 INFO - Running setup.py (path:/tmp/pip-XyoLbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:39:33 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)) 03:39:33 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)) 03:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:33 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)) 03:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:39:33 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)) 03:39:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:33 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 03:39:33 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 03:39:33 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 03:39:33 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 03:39:33 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 03:39:33 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 03:39:34 INFO - Downloading blessings-1.5.1.tar.gz 03:39:34 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 03:39:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:35 INFO - Installing collected packages: blessings 03:39:35 INFO - Running setup.py install for blessings 03:39:35 INFO - Successfully installed blessings 03:39:35 INFO - Cleaning up... 03:39:35 INFO - Return code: 0 03:39:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:39:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:39:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:39:35 INFO - Reading from file tmpfile_stdout 03:39:35 INFO - Current package versions: 03:39:35 INFO - argparse == 1.2.1 03:39:35 INFO - blessings == 1.5.1 03:39:35 INFO - blobuploader == 1.2.4 03:39:35 INFO - docopt == 0.6.1 03:39:35 INFO - manifestparser == 1.1 03:39:35 INFO - mozInstall == 1.12 03:39:35 INFO - mozcrash == 0.16 03:39:35 INFO - mozdebug == 0.1 03:39:35 INFO - mozdevice == 0.46 03:39:35 INFO - mozfile == 1.2 03:39:35 INFO - mozhttpd == 0.7 03:39:35 INFO - mozinfo == 0.8 03:39:35 INFO - mozleak == 0.1 03:39:35 INFO - mozlog == 3.0 03:39:35 INFO - moznetwork == 0.27 03:39:35 INFO - mozprocess == 0.22 03:39:35 INFO - mozprofile == 0.27 03:39:35 INFO - mozrunner == 6.10 03:39:35 INFO - mozscreenshot == 0.1 03:39:35 INFO - mozsystemmonitor == 0.0 03:39:35 INFO - moztest == 0.7 03:39:35 INFO - mozversion == 1.4 03:39:35 INFO - psutil == 3.1.1 03:39:35 INFO - requests == 1.2.3 03:39:35 INFO - wsgiref == 0.1.2 03:39:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:39:35 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')]} 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:35 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')]} 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:35 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 0x7fd6ba090b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21017b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c64a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, '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': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', '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 03:39:35 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 03:39:35 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 03:39:35 INFO - Using env: {'DISPLAY': ':0', 03:39:35 INFO - 'HOME': '/home/cltbld', 03:39:35 INFO - 'LANG': 'en_US.UTF-8', 03:39:35 INFO - 'LANGUAGE': 'en_US:en', 03:39:35 INFO - 'LOGNAME': 'cltbld', 03:39:35 INFO - 'MAIL': '/var/mail/cltbld', 03:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:35 INFO - 'MOZ_NO_REMOTE': '1', 03:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:35 INFO - 'NO_EM_RESTART': '1', 03:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:35 INFO - 'SHELL': '/bin/bash', 03:39:35 INFO - 'SHLVL': '1', 03:39:35 INFO - 'TERM': 'linux', 03:39:35 INFO - 'TMOUT': '86400', 03:39:35 INFO - 'USER': 'cltbld', 03:39:35 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:35 INFO - '_': '/tools/buildbot/bin/python'} 03:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 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)) 03:39:35 INFO - Cleaning up... 03:39:35 INFO - Return code: 0 03:39:35 INFO - Running post-action listener: _resource_record_post_action 03:39:35 INFO - Running post-action listener: _start_resource_monitoring 03:39:35 INFO - Starting resource monitoring. 03:39:35 INFO - ##### 03:39:35 INFO - ##### Running install step. 03:39:35 INFO - ##### 03:39:35 INFO - Running pre-action listener: _resource_record_pre_action 03:39:35 INFO - Running main action method: install 03:39:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:39:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:39:35 INFO - Reading from file tmpfile_stdout 03:39:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:39:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:39:36 INFO - Reading from file tmpfile_stdout 03:39:36 INFO - Output received: 03:39:36 INFO - Usage: mozinstall [options] installer 03:39:36 INFO - Options: 03:39:36 INFO - -h, --help show this help message and exit 03:39:36 INFO - -d DEST, --destination=DEST 03:39:36 INFO - Directory to install application into. [default: 03:39:36 INFO - "/builds/slave/test-pgo"] 03:39:36 INFO - --app=APP Application being installed. [default: firefox] 03:39:36 INFO - mkdir: /builds/slave/test-pgo/build/application 03:39:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:39:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:39:50 INFO - Reading from file tmpfile_stdout 03:39:50 INFO - Output received: 03:39:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:39:50 INFO - Running post-action listener: _resource_record_post_action 03:39:50 INFO - ##### 03:39:50 INFO - ##### Running run-tests step. 03:39:50 INFO - ##### 03:39:50 INFO - Running pre-action listener: _resource_record_pre_action 03:39:50 INFO - Running main action method: run_tests 03:39:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:39:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:39:50 INFO - Python 2.7.3 03:39:50 INFO - Return code: 0 03:39:50 INFO - grabbing minidump binary from tooltool 03:39: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')]} 03:39:50 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 0x1f58bf0>, '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 0x22564f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22569a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:39:50 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 03:39:50 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 03:39:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:50 INFO - Return code: 0 03:39:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:39:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:39:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:39:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:39:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:39:50 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-012', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:39:50 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-012 --webServer localhost 03:39:50 INFO - Using env: {'DISPLAY': ':0', 03:39:50 INFO - 'HOME': '/home/cltbld', 03:39:50 INFO - 'LANG': 'en_US.UTF-8', 03:39:50 INFO - 'LANGUAGE': 'en_US:en', 03:39:50 INFO - 'LOGNAME': 'cltbld', 03:39:50 INFO - 'MAIL': '/var/mail/cltbld', 03:39:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:39:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:50 INFO - 'MOZ_NO_REMOTE': '1', 03:39:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:50 INFO - 'NO_EM_RESTART': '1', 03:39:50 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:39:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:39:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:39:50 INFO - 'SHELL': '/bin/bash', 03:39:50 INFO - 'SHLVL': '1', 03:39:50 INFO - 'TERM': 'linux', 03:39:50 INFO - 'TMOUT': '86400', 03:39:50 INFO - 'USER': 'cltbld', 03:39:50 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380', 03:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:50 INFO - '_': '/tools/buildbot/bin/python'} 03:39:50 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-012', '--webServer', 'localhost'] with output_timeout 3600 03:39:50 INFO - mozversion INFO | application_buildid: 20151029012446 03:39:50 INFO - mozversion INFO | application_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 03:39:50 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:39:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:50 INFO - mozversion INFO | application_name: Firefox 03:39:50 INFO - mozversion INFO | application_remotingname: firefox-dev 03:39:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:39:50 INFO - mozversion INFO | application_vendor: Mozilla 03:39:50 INFO - mozversion INFO | application_version: 43.0a2 03:39:50 INFO - mozversion INFO | platform_buildid: 20151029012446 03:39:50 INFO - mozversion INFO | platform_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 03:39:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:39:50 INFO - mozversion INFO | platform_version: 43.0a2 03:39:50 INFO - 2015-10-29 03:39:50,588 DEBUG : using testdate: 1446115190 03:39:50 INFO - 2015-10-29 03:39:50,588 DEBUG : actual date: 1446115190 03:39:50 INFO - 2015-10-29 03:39:50,598 INFO : Starting test suite talos-linux64-ix-012 03:39:50 INFO - 2015-10-29 03:39:50,598 INFO : Starting test dromaeo_css 03:39:50 INFO - 2015-10-29 03:39:50,598 DEBUG : operating with platform_type : linux_ 03:39:50 INFO - 2015-10-29 03:39:50,598 INFO : Initialising browser for dromaeo_css test... 03:39:50 INFO - 2015-10-29 03:39:50,617 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7eXBjY/profile http://localhost/getInfo.html 03:39:54 INFO - 2015-10-29 03:39:54,962 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:39:54 INFO - 2015-10-29 03:39:54,963 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:39:54 INFO - 2015-10-29 03:39:54,963 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:39:54 INFO - 2015-10-29 03:39:54,963 DEBUG : BROWSER_OUTPUT: __metrics 03:39:55 INFO - 2015-10-29 03:39:55,100 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:56 INFO - 2015-10-29 03:39:56,137 INFO : Browser initialized. 03:39:56 INFO - 2015-10-29 03:39:56,138 INFO : Running cycle 1/1 for dromaeo_css test... 03:39:56 INFO - 2015-10-29 03:39:56,138 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7eXBjY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:40:07 INFO - 2015-10-29 03:40:07,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 132562944 03:40:07 INFO - 2015-10-29 03:40:07,847 DEBUG : BROWSER_OUTPUT: 03:43:07 INFO - 2015-10-29 03:43:06,999 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) 03:43:08 INFO - 2015-10-29 03:43:08,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 250757120 03:43:08 INFO - 2015-10-29 03:43:08,145 DEBUG : BROWSER_OUTPUT: 03:46:10 INFO - 2015-10-29 03:46:10,274 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) 03:46:10 INFO - 2015-10-29 03:46:10,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 210997248 03:46:10 INFO - 2015-10-29 03:46:10,836 DEBUG : BROWSER_OUTPUT: 03:49:12 INFO - 2015-10-29 03:49:12,532 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) 03:49:13 INFO - 2015-10-29 03:49:13,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 215683072 03:49:13 INFO - 2015-10-29 03:49:13,100 DEBUG : BROWSER_OUTPUT: 03:52:14 INFO - 2015-10-29 03:52:14,830 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) 03:52:15 INFO - 2015-10-29 03:52:15,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 207847424 03:52:15 INFO - 2015-10-29 03:52:15,391 DEBUG : BROWSER_OUTPUT: 03:55:17 INFO - 2015-10-29 03:55:17,697 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) 03:55:18 INFO - 2015-10-29 03:55:18,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 196898816 03:55:18 INFO - 2015-10-29 03:55:18,287 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,437 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) 03:58:20 INFO - 2015-10-29 03:58:20,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 235524096 03:58:20 INFO - 2015-10-29 03:58:20,688 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,688 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:58:20 INFO - 2015-10-29 03:58:20,688 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:58:20 INFO - 2015-10-29 03:58:20,688 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:58:20 INFO - 2015-10-29 03:58:20,688 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:58:20 INFO - 2015-10-29 03:58:20,689 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3361.680640339168;3386.542816719742;3428.262923471453;3433.038749150239;3451.8101504417264;5689.914651280229;5712.086066229404;5738.713064346787;5746.626469279499;5749.166370876221;5715.9997000524945;5756.712164391784;5774.931637647038;5779.739911703973;5810.651360918348;5134;5196.532312091901;5215.765290561915;5215.895682086356;5282.841514754564;5168.095583272931;5228.163493840986;5261.815836445725;5298.496642818926;5332.946670533283;5315.7873685052555;5367.302250707403;5371.5165635092835;5374.516293533581;5400.702961337125;5131.948680513222;5257.263983042377;5325.174597937287;5326.440723723992;5397.325334333208;5091.821786237464;5188.040212560688;5188.740562971836;5189.42916279209;5221.347331583552;5605.887882242332;5663.122216056518;5678.205051292823;5683.630564013326;5691.573132015115;5990.580659353847;6072.210612620331;6102.6948652567635;6242.375762423767;6252.3747625237565;6250.624962502265;6312.274088479838;6312.968435157794;6313.463355614778;6320.652364119972;5846.883062338729;5848.152017957457;5849.532037436995;5855.795047173371;5862.120681897707;6041.395860414012;6141.508679305645;6223.937760622336;6357.237131544244;6389.6805159741825;6042.546808989343;6108.969455152785;6111.174991376196;6115.663638499926;6119.173911521888;6138.14066030756;6158.04550294696;6167.537434692416;6180.351063138396;6181.907271390843;6006.069059295816;6060.969695151496;6128.01427809372;6131.478824299896;6133.355997620275;6157.168782214344;6199.256089269316;6216.502679785606;6235.3452887446165;6256.468200203034;4561.2245918193985;4729.243321068612;4732.408448943882;4747.928781068286;4748.572628463455;4096.754194748325;4134.834606615762;4152.91694166121;4188.162367526507;4199.118185181146;5836.212111364996;5888.352281249059;5895.145203945404;5899.587028908021;5900.675462849498;6030.065339872327;6087.36082711309;6242.344553821874;6295.18162638854;6298.559100862895;5690.943090569124;5768.961586914395;5780.5953583248765;5780.855478613068;5800.88398232033;5409.675419474844;5416.593755468277;5447.128459446549;5447.972760136253;5456.127019676833;6132.724027418777;6172.290186628506;6238.095476156022;6516.674166291667;6522.478201743849;6285.528585356025;6310.400511951358;6310.7791227306825;6321.905171422524;6327.493800496041;6391.9772836345965;6428.903566446601;6432.2281326241155;6445.323241059621;6455.193100862392;5886.882262354815;6011.068284415923;6022.6386416813375;6098.265895953616;6176.629402235881;6265.122882796321;6320.5575609706875;6327.715252813542;6332.461740751904;6337.144485494399;6149.139120523041;6163.660998645118;6170.9074363885475;6171.722272497658;6186.072089186658;5868.354481007171;5972.193753843176;5997.820065398045;6134.834601026089;6139.478144357601;6012.398760123952;6041.214642096499;6041.456268935817;6043.607165534402;6059.030555111161;5987.970060149672;6166.537509686702;6166.845828854135;6182.474489668429;6188.597741146811;5897.9115313271195;5948.702564871825;6020.849478763066;6055.72749226277;6075.878482430415 03:58:20 INFO - 2015-10-29 03:58:20,690 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.8544321198096;612.5987478201778;621.1490258346065;635.7838334966114;640.836586670399;45535;45990.540094599084;46019.30971035437;46034;46052.53947460533;49525.50474495254;50171.74914125433;50295.49704502954;50312;50331.24503132456;8505.404621676485;8638.617821148617;9353.906460935388;9525.95237023814;10852.565897364097;11216.943915280412;11354.659360219166;11368.37473938933;11381.032612227971;11386.772264554704;11223.719407014849;11254.943725281402;11354.26197297173;11362.034227090666;11371.601993930213;8690.391672582922;8854.335924805633;11030.834537481944;11163.888361116447;11230.55077796887;10661.573537058508;10782.73043173919;10784.245102842804;10785.406802625852;10787.137029037658;43544.564554354685;43837.56162438398;43950.78024609888;43978.780106099264;44073.77963110164;3786.2238241160494;3856.1323702166787;3902.7268091233627;3932.233214523169;3937.409388591734;33538.49692254618;33829.66170338314;33858.15354616154;33985;34030.65969340324;3363.1592101974506;3385.339858727549;3422.0760394693543;3436;3441.9949117475335;339966;341935;342633.9999999975;342722;342740.71777846455;63064;63655.36344636587;72352;73949.26050739532;74300.62849685717;70405.64797175981;70414;70476;70561.29438705649;70736.64631676911;19458.31895883637;19597.608047838963;19608.509787255432;19678.606427871648;19682.409527713906;14829.555113346616;14856.702865942621;14989.250537473083;15025.173615451255;15146.318415671321;22533.211337603105;23484.295471135894;23496.647550286758;23528.882355588114;23726;8725.694600689072;8828.51443170619;8931.955340223387;8945.686900958435;8984.685536006209;1142.2974870454611;1163.139276935062;1165.7260543772206;1171.226990186473;1195.1514424758518;32259.35481290408;32320.676793231767;32344.35311293761;32949.83525082407;33032.83483582567;1159.6173262823247;1187.8455800745849;1230.9015278777676;1275.4961790092862;1332.580237225271;16150.67698646044;17059.976401415955;18023.639527209383;18280.81719182791;19168.424947251606;542389;547799;548239;548772;549233;61733.69133154306;62261.68869155716;65103.34896650973;72295;73000.63499682574;1503.9323230454656;1507.6683129711446;1517.544736579022;1530.540837748671;1534.63935975048;30389.848050759603;33249.833750831094;33450.66549334476;33921.49117763285;33944;51797.741011294704;58710.7064464692;58806;58840.70579647074;58850;424450;424507;426018;427796;428371;37600.2479950394;37877.81061094677;38143.61856381401;38676.41985370166;38755;49383.506164939325;49668.25497617466;49858.25212621886;50079.74960125176;50346.244806328665;40681.59318406778;41895;41915.7904210477;42194.57805422029;46579.301310481045;41771.16457670891;42863.78568107139;43186.56813431825;43944.121117578106;44011.55988440075;43709.78145109381;44028.33957490704;44207.55792442035;44251.114977699624;44747.10505789931;36996.44505332368;38710.80644596759;38711.806440967615;38932.22135557216;39709.60290397059;29460.55809162907;29722.554161688025;30398.54402184013;30565.847170764006;31753.20616984594 03:58:20 INFO - 2015-10-29 03:58:20,692 DEBUG : BROWSER_OUTPUT: |2;jquery.html;427.7390791617113;428.62067070642473;431.484376170476;432.27378004951686;435.63624373648;15984.84015159848;16444;17018.5745356366;18834.43496695098;18976.240950361986;17276.568085797862;20170.899145504252;20472.078756455958;20810.791892081073;20824.89587552064;5889.941100589003;6014.458698717114;6022.457978781908;6025.0661147522205;6033.487153591928;4266.381374700666;4383.824647014131;5969.850753731148;6008.849778755544;6477.870442591146;6536.705848236841;6562.146920900276;6608.2070151581875;6611.735530578771;6620.470362371023;6419.422251997319;6557.5081868860025;6564.343565643421;6571.3757193066585;6572.835679108012;4593.977030114861;5859.912101318484;5875.206847075633;5876.853078673024;5893.469587737124;15638.843611563967;15687;15755.684886302324;15870.20648967547;15886.126263055527;2269.8751568663715;2270.9091636334692;2286.119843860109;2306.1006207579057;2360.5986982213067;10839.349639021684;10967.341959482377;10975.945120274348;10996.615118470816;11158.497867595977;1696.0925904640958;1705.7185564381862;1814.0294942205855;1851.907404629763;1863.5527473406285;66572.3342766571;67907.66046169738;71137.64431177812;73366;74356.62821685911;8012.599370031475;8039.477433966774;8175.754727358189;8230.588470576447;8248.257656810796;10098.343607665478;10103.19174466041;10113.848292275474;10114.898851011396;10132.138768204637;6620;6628.933710662928;6656.966715166393;6658.83352916181;6674.399304062657;6867.793966181022;6897.3447522485285;7254.310840470147;7276.599787011765;7304.3426091650945;3806.600306967784;3828.980855095707;3829.5213098362706;3832.6550610445192;3844.7308688392104;1290.7353992431529;1324.788033914569;1341.1952828303135;1350.6825895914453;1361.700425906299;539.9595030372737;548.9972550137223;549.5027000564495;573.5927491481095;575.5740751843689;12247.571335003233;13821.79267310991;13917.095388799695;14163.575092747235;14285.285735713172;580.2167074449544;594.3551246897078;598.9580729348991;599.286848650105;602.1810337940398;7416.629168541552;7456.627168641547;7470.103587569418;7618.4667073305445;7632.236776322324;654590;670669;684385;690985;696441;90524;91879.54060229656;91964.54017730002;92470.53764731133;93622.0637793627;602.3374288282854;603.2338929559435;604.6009633641776;606.1453350775386;609.0346800321452;12805.103642744918;12924.547640832525;12982.480700772241;13147.868521314664;13226;42076.78961605173;42169.1566168681;42463;42839.35740963826;43337;56521.71739141278;56804.14793778014;56861.14708279462;57962;58507.70746146242;7858.135605083322;7890.329322007694;7900.802479938047;7925.28672419485;8001.479903806467;10649.627263046066;13991.23048232357;14269.785953210503;14361.784573231618;14471.78292325637;11998.160128790902;12141.69645758863;12235.93882030584;12469.127161098637;12485.250884946932;11623.6512904613;11911.106667000184;11935.104867134825;12097.516099355928;12183.634490965285;11796.174267801514;12153.751555962175;12287.201331913397;12449.502019919464;12472.625821225378;7794.181610930771;7903.644336005009;8001.519908805491;8004.199580041949;8017.639206235617;12028.819567706316;12165.75668486643;12328.81506777381;12632.873671263169;12655.303958282382 03:58:20 INFO - 2015-10-29 03:58:20,695 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1553.2389129326634;1670.707626165421;1868.402111324376;2053.6919462080687;2079.1787244038605;9294.488803115826;10215.642452514163;10496.842547361795;10511.789764204712;10528.684139475808;9892.50537473127;10028.899711002889;10031.849522257155;10056.547455364507;10065.899341006587;2225.3657707553352;2260.073369918334;2444.4622183119686;2475.7400472950353;2511.8618475983812;2439.231642032754;2459.1270099114827;2466.371075375777;2471.258622413278;2480.131953816159;2497.126005897939;2516.723160452358;2523.4448421347365;2527.064985955199;2530.3800568860656;2252.605793986054;2300.620397634388;2491.9252422427267;2533.3919859233833;2540.326813394452;2427.2232885476656;2434.6104623260194;2443.2914454808083;2553.5786595211766;2572.2926195296254;10543.420111893844;10597.629082982136;10621.362718236931;10626.574937002511;10628.149748020218;5984.311804142536;5997.610155339932;6057;6062.96968515159;6067.484263837579;3605.5132557104716;3636.7636103653176;3674.2651469706166;3686.3364594373;3698.7780733156096;1062.6227689170387;1067.114295135036;1084.6854412220446;1088.2219213262556;1107.6676996900978;15993.760093598605;16002;16004.919975400166;16010.119443430607;16073.598160046093;5210.296609957683;5256.632035757537;5270.314859068297;5427.240186373911;5427.348718153768;12572.748545029232;12586;12609;12619.305938173306;12624.684382890502;5861.267341582302;5862.794802181903;5864.794732184353;5872.119182122716;5884.852878677982;5303.098473259555;5304.124819404832;5309;5311.362636483569;5374.328208973879;4339.34909763538;4339.63113135387;4344.782760861945;4363.738175709467;4378.036831896978;1138.9544418223345;1139.7321629417247;1142.114860982745;1150.160382920456;1164.6738913104343;1185.0993245133761;1196.682879037056;1204.27141579345;1474.2186641080245;1478.334749362791;9875.456849873326;9980.301378903552;10076.647317344004;10085.546150423103;10100.595976161017;544.9564034877201;556.9387367389584;558.8267637032533;560.1234068682498;562.5893098038373;7503.174650788409;7515.586642734593;7578.658960346797;7587;7615.276548727862;13538.729225415436;13737.725245495034;13753.449862005607;13760.587182384545;13785.310734463237;13438.664033399244;13768.036237463282;13867.375968081258;13881.652958676113;13893.652658683613;9712.125908668253;9852.704418867446;9903;9933.900660993442;9936.304458687968;9247.167754902091;9421.481818500048;9466.390713578847;9467.526623668928;9486.098820612031;11649.825252621047;11750.177487575787;11760;11808.35054072;11854.11094167958;11950.223235489666;12077.818832717692;12130.514779408724;12164.39178041112;12214.14500984958;8405.621747021522;8632.568371581521;8644.308455323433;8645.135486451305;8655.567221638767;10270.794584108426;10307.94846025765;10356.741081473023;10385.844212336971;10423.583056677648;8476;9674.75813104678;9711.439435950284;9714.95142524311;9719.85420218683;8242.423030387816;9211.953940230256;9442.48066356357;9493.145616894513;9573.090556397132;9313.534323283944;9331.906680933374;9350.064993500868;9405.871295444591;9443.386179898285;8356.623951922056;8455.02767181782;8456.32349412058;8463.74608761738;8470.57647117654;8542.530160841214;8545.871811922701;8616.48301101936;8695.478271303742;8719.258862996716 03:58:20 INFO - 2015-10-29 03:58:20,696 DEBUG : BROWSER_OUTPUT: |4;prototype.html;395.8001209389258;402.91538776856856;403.96970227232964;407.1043703851527;411.0463724159948;5967.850803729909;5978.701064946752;5987.371326010772;6027.578069535134;6056.454919057284;5913.526917846572;5918.556108291885;5932.703364831752;5949.8215053548465;5968.7314070866805;4603.631709463251;4717.174494463472;4786.114568804782;4790.449098353682;4793.688410253322;4683.414573178353;4698;4707.435107787071;4715.056988602276;4716.386869706933;4654.976725116369;4665.696729712575;4669.859904202879;4673.158831410345;4679.60223381013;4529.886752831189;4574.817007319703;4624.352590637313;4668.696534725266;4674.298855171717;4123.814428350732;4136.896577585554;4141.337386018223;4146.543880173179;4165.791710414497;5433.293671822637;5485.067538518461;5623.9437605623825;5645.294338207724;5648.237487939158;5365.865853353658;5437.918431223535;5447.891042179174;5456.127019676872;5463.289772329612;6277.968610156966;6299.496040316763;6301.590396624205;6302.338254483259;6304.054391841215;4596.632269418438;4596.678232523725;4597.103564804865;4598.839040633562;4599.494055653875;6273.1531243282025;6509.9023514647315;6521.250056243498;6596.472282217411;6602.141721576164;4687.554682305175;4694.178518759203;4694.718316900997;4694.929576056362;4696;4725.9527404726205;4749.525047495223;4749.952500474951;4755;4766.547178018082;5368;5410.026195284808;5424.891502169935;5426.593005524602;5428.212909128154;6356.586821856565;6359.459445947146;6364.172657554488;6364.6181229126405;6372.458341041063;1728.3086765293983;1751.0894334945756;1751.299480207927;1752.0451354011839;1752.0451354012093;1186.5609724402027;1193.0694058634278;1204.6205445284706;1206.638008597435;1226.7791797476361;6100.359462256488;6103.755849766048;6171.228596425447;6181.381861813873;6182.752689892444;6596.274409814917;6597.604143751294;6598.736050557924;6601.2738598754095;6604.405603495708;6081.665508397081;6143.447089761943;6165.568410211242;6170.81487555374;6179.660118693425;3624.7643903146213;3654.068212605822;3659.359612067931;3660.5973342932257;3664.908377290589;6797.966010169917;6800.353966373285;6810.455163586901;6811.182658081062;6822.658867056627;6541.542092053605;6626.966865165643;6681.966590167018;6751.223609284995;6773;6710.899336509956;6743.898841517381;6759.898601520883;6782.050512928194;6783;6519.902201466887;6550.901736474052;6559.311272316338;6564;6567.868642627216;6339.112524246517;6480;6491.285958544462;6492.0261960706275;6497.382748638872;6833.897491537531;6855.5886646801355;6874.346937040973;6875.449964002768;6882.03651488782;4821.108095002436;4825.734584597881;4828.275758636232;4828.589569886459;4830.806767729251;6502.252240992158;6646.169228846395;6649.335066493312;6653.9667301663185;6656.7004484797335;6487.967560162169;6493.188351456068;6495.350464953467;6505.73977040932;6508.414242718178;6420.2937676856445;6429.164208652845;6442.516811239269;6474.643894585843;6483.2544257411;6244.063390491281;6389.712462939272;6396.552241343062;6397.6481293529305;6408.61548307103;6500.089987401862;6501.512386570931;6520.217573891164;6525.151730275224;6540.018997150275;6359.523035772243;6363.904541431974;6372.394622510854;6375.872482550416;6377.808665740035 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: |5;yui.html;874.8162885793982;896.3904544909461;937.3579098317657;954.4273435938436;1007.2395341517154;13579.728405431886;13839.238841863693;14823.851761482381;14824.184669843167;14840.703185936274;13736.656583585416;13789.931050344734;13874.791878121836;13878.653033674163;13882.167069975809;762.2491845532146;773.3851587987564;930.7998780262226;934.3926447808944;957.248559880494;950.064186776025;951.9666811661593;959.2374062620233;960.011188475871;960.0975083421596;804.7907544038534;988.9653862114827;1002.5187909803299;1003.3528374198637;1005.03516624041;817.166490180016;977.130353984954;1010.3079390617414;1011.7976404719012;1015.1422048369117;712.9500934934557;720.8594324106801;721.462510429728;722.6495149852317;722.9385502232317;12946;13064.085514014023;13067;13095.083344165912;13108.410121544553;12236.449359778742;12357.32034738089;12573.11988160829;12991.935040324832;13159.736805263841;10438.217133714927;10531.52608132636;10546.261761676686;10783.352998820095;10913.781724365468;3821.445890345912;3850.306944749944;3902.6292502212245;3917.040325120364;3932.5870783567884;41367.793161034;41760.37359439611;41877.581224187976;46124;46498;10774.461276936121;11018.779624407627;11274.774504509864;11285.153613478858;11330.433478326215;19947.202111915652;20136.19455221775;20151.49621259451;20159.798402016084;20181;8073.555954422446;8324.209200125979;8333.8333233335;8363.874541881876;8494.957525212334;4397.31841564558;4459.308807134899;4633.2818413146015;4665.673402861835;4688.695234809727;3361.3949489092197;3386.5766779152605;3391.8643254270046;3392.4402473592077;3396.6093899201414;561.4750208555014;570.9086546152596;574.1273264637811;574.7930744931821;584.0392554248323;722.1045903080143;733.8238822682624;738.4308344767369;739.8631253218172;756.43267549338;8704.34717396185;8882;9011.864822027675;9119.04250053748;9264.351495395393;646.6314200905533;652.7062821730241;706.7879636109146;714.2785786355818;759.734093067422;4338.566143385636;4372.060007098489;4416.933745993749;4450.532694067141;4532.682712210114;54037.45962540403;55789.44210557923;55914;55924.720376397854;55962;45863;46451;46979.29531057037;47028;47078;40034.799826000686;40102;40292;40464.39303410451;41767.582324176976;8711.564421779012;8952;9067.863982040406;9174.357794954556;9310.674126405544;27765.444691105662;27975.160745177676;28743.281417964718;28818;28832;37879;37904.810475947445;40039.79980100081;40537.79731101326;40580.18839623132;8293.875591866248;8540.572971351532;8602.78493037679;8737.825243494968;8763.474191548528;12402.875971240172;12681.985441164868;13106.934465327613;13222.272774997467;13355.98980458817;11100.888991110309;11685.474153662935;11946.701332466759;12266.325352105363;12459.314737689514;11568.88431115678;11745.530178792753;11990.880091198977;11993.1005174614;12074.27554346742;10394.752629684486;11587.304761714324;11795.469203885674;12081.75836483283;12137.453814578541;10292.176625869763;10373.740656483647;10466.319689220176;10473.109785668303;10706.143508519455;9992.550335235077;10065.24510661718;10160.898391015995;10162.39025658463;10173.745656358651 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,906 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: __startTimestamp1446116300685__endTimestamp 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,698 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5753.65 Median:5997.82 stddev:656.88 (11.0%) stddev-sans-first:631.52 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: Values: 3361.7 3386.5 3428.3 3433.0 3451.8 5689.9 5712.1 5738.7 5746.6 5749.2 5716.0 5756.7 5774.9 5779.7 5810.7 5134.0 5196.5 5215.8 5215.9 5282.8 5168.1 5228.2 5261.8 5298.5 5332.9 5315.8 5367.3 5371.5 5374.5 5400.7 5131.9 5257.3 5325.2 5326.4 5397.3 5091.8 5188.0 5188.7 5189.4 5221.3 5605.9 5663.1 5678.2 5683.6 5691.6 5990.6 6072.2 6102.7 6242.4 6252.4 6250.6 6312.3 6313.0 6313.5 6320.7 5846.9 5848.2 5849.5 5855.8 5862.1 6041.4 6141.5 6223.9 6357.2 6389.7 6042.5 6109.0 6111.2 6115.7 6119.2 6138.1 6158.0 6167.5 6180.4 6181.9 6006.1 6061.0 6128.0 6131.5 6133.4 6157.2 6199.3 6216.5 6235.3 6256.5 4561.2 4729.2 4732.4 4747.9 4748.6 4096.8 4134.8 4152.9 4188.2 4199.1 5836.2 5888.4 5895.1 5899.6 5900.7 6030.1 6087.4 6242.3 6295.2 6298.6 5690.9 5769.0 5780.6 5780.9 5800.9 5409.7 5416.6 5447.1 5448.0 5456.1 6132.7 6172.3 6238.1 6516.7 6522.5 6285.5 6310.4 6310.8 6321.9 6327.5 6392.0 6428.9 6432.2 6445.3 6455.2 5886.9 6011.1 6022.6 6098.3 6176.6 6265.1 6320.6 6327.7 6332.5 6337.1 6149.1 6163.7 6170.9 6171.7 6186.1 5868.4 5972.2 5997.8 6134.8 6139.5 6012.4 6041.2 6041.5 6043.6 6059.0 5988.0 6166.5 6166.8 6182.5 6188.6 5897.9 5948.7 6020.8 6055.7 6075.9 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62654.49 Median:38693.61 stddev:117997.96 (305.0%) stddev-sans-first:118236.91 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: Values: 570.9 612.6 621.1 635.8 640.8 45535.0 45990.5 46019.3 46034.0 46052.5 49525.5 50171.7 50295.5 50312.0 50331.2 8505.4 8638.6 9353.9 9526.0 10852.6 11216.9 11354.7 11368.4 11381.0 11386.8 11223.7 11254.9 11354.3 11362.0 11371.6 8690.4 8854.3 11030.8 11163.9 11230.6 10661.6 10782.7 10784.2 10785.4 10787.1 43544.6 43837.6 43950.8 43978.8 44073.8 3786.2 3856.1 3902.7 3932.2 3937.4 33538.5 33829.7 33858.2 33985.0 34030.7 3363.2 3385.3 3422.1 3436.0 3442.0 339966.0 341935.0 342634.0 342722.0 342740.7 63064.0 63655.4 72352.0 73949.3 74300.6 70405.6 70414.0 70476.0 70561.3 70736.6 19458.3 19597.6 19608.5 19678.6 19682.4 14829.6 14856.7 14989.3 15025.2 15146.3 22533.2 23484.3 23496.6 23528.9 23726.0 8725.7 8828.5 8932.0 8945.7 8984.7 1142.3 1163.1 1165.7 1171.2 1195.2 32259.4 32320.7 32344.4 32949.8 33032.8 1159.6 1187.8 1230.9 1275.5 1332.6 16150.7 17060.0 18023.6 18280.8 19168.4 542389.0 547799.0 548239.0 548772.0 549233.0 61733.7 62261.7 65103.3 72295.0 73000.6 1503.9 1507.7 1517.5 1530.5 1534.6 30389.8 33249.8 33450.7 33921.5 33944.0 51797.7 58710.7 58806.0 58840.7 58850.0 424450.0 424507.0 426018.0 427796.0 428371.0 37600.2 37877.8 38143.6 38676.4 38755.0 49383.5 49668.3 49858.3 50079.7 50346.2 40681.6 41895.0 41915.8 42194.6 46579.3 41771.2 42863.8 43186.6 43944.1 44011.6 43709.8 44028.3 44207.6 44251.1 44747.1 36996.4 38710.8 38711.8 38932.2 39709.6 29460.6 29722.6 30398.5 30565.8 31753.2 03:58:20 INFO - 2015-10-29 03:58:20,699 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,700 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33118.42 Median:2409.73 stddev:111340.24 (4620.4%) stddev-sans-first:111625.51 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: Values: 427.7 428.6 431.5 432.3 435.6 15984.8 16444.0 17018.6 18834.4 18976.2 17276.6 20170.9 20472.1 20810.8 20824.9 5889.9 6014.5 6022.5 6025.1 6033.5 4266.4 4383.8 5969.9 6008.8 6477.9 6536.7 6562.1 6608.2 6611.7 6620.5 6419.4 6557.5 6564.3 6571.4 6572.8 4594.0 5859.9 5875.2 5876.9 5893.5 15638.8 15687.0 15755.7 15870.2 15886.1 2269.9 2270.9 2286.1 2306.1 2360.6 10839.3 10967.3 10975.9 10996.6 11158.5 1696.1 1705.7 1814.0 1851.9 1863.6 66572.3 67907.7 71137.6 73366.0 74356.6 8012.6 8039.5 8175.8 8230.6 8248.3 10098.3 10103.2 10113.8 10114.9 10132.1 6620.0 6628.9 6657.0 6658.8 6674.4 6867.8 6897.3 7254.3 7276.6 7304.3 3806.6 3829.0 3829.5 3832.7 3844.7 1290.7 1324.8 1341.2 1350.7 1361.7 540.0 549.0 549.5 573.6 575.6 12247.6 13821.8 13917.1 14163.6 14285.3 580.2 594.4 599.0 599.3 602.2 7416.6 7456.6 7470.1 7618.5 7632.2 654590.0 670669.0 684385.0 690985.0 696441.0 90524.0 91879.5 91964.5 92470.5 93622.1 602.3 603.2 604.6 606.1 609.0 12805.1 12924.5 12982.5 13147.9 13226.0 42076.8 42169.2 42463.0 42839.4 43337.0 56521.7 56804.1 56861.1 57962.0 58507.7 7858.1 7890.3 7900.8 7925.3 8001.5 10649.6 13991.2 14269.8 14361.8 14471.8 11998.2 12141.7 12235.9 12469.1 12485.3 11623.7 11911.1 11935.1 12097.5 12183.6 11796.2 12153.8 12287.2 12449.5 12472.6 7794.2 7903.6 8001.5 8004.2 8017.6 12028.8 12165.8 12328.8 12632.9 12655.3 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7235.38 Median:2528.72 stddev:4232.25 (167.4%) stddev-sans-first:4222.58 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: Values: 1553.2 1670.7 1868.4 2053.7 2079.2 9294.5 10215.6 10496.8 10511.8 10528.7 9892.5 10028.9 10031.8 10056.5 10065.9 2225.4 2260.1 2444.5 2475.7 2511.9 2439.2 2459.1 2466.4 2471.3 2480.1 2497.1 2516.7 2523.4 2527.1 2530.4 2252.6 2300.6 2491.9 2533.4 2540.3 2427.2 2434.6 2443.3 2553.6 2572.3 10543.4 10597.6 10621.4 10626.6 10628.1 5984.3 5997.6 6057.0 6063.0 6067.5 3605.5 3636.8 3674.3 3686.3 3698.8 1062.6 1067.1 1084.7 1088.2 1107.7 15993.8 16002.0 16004.9 16010.1 16073.6 5210.3 5256.6 5270.3 5427.2 5427.3 12572.7 12586.0 12609.0 12619.3 12624.7 5861.3 5862.8 5864.8 5872.1 5884.9 5303.1 5304.1 5309.0 5311.4 5374.3 4339.3 4339.6 4344.8 4363.7 4378.0 1139.0 1139.7 1142.1 1150.2 1164.7 1185.1 1196.7 1204.3 1474.2 1478.3 9875.5 9980.3 10076.6 10085.5 10100.6 545.0 556.9 558.8 560.1 562.6 7503.2 7515.6 7578.7 7587.0 7615.3 13538.7 13737.7 13753.4 13760.6 13785.3 13438.7 13768.0 13867.4 13881.7 13893.7 9712.1 9852.7 9903.0 9933.9 9936.3 9247.2 9421.5 9466.4 9467.5 9486.1 11649.8 11750.2 11760.0 11808.4 11854.1 11950.2 12077.8 12130.5 12164.4 12214.1 8405.6 8632.6 8644.3 8645.1 8655.6 10270.8 10307.9 10356.7 10385.8 10423.6 8476.0 9674.8 9711.4 9715.0 9719.9 8242.4 9212.0 9442.5 9493.1 9573.1 9313.5 9331.9 9350.1 9405.9 9443.4 8356.6 8455.0 8456.3 8463.7 8470.6 8542.5 8545.9 8616.5 8695.5 8719.3 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5391.49 Median:6091.01 stddev:1565.38 (25.7%) stddev-sans-first:1524.21 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: Values: 395.8 402.9 404.0 407.1 411.0 5967.9 5978.7 5987.4 6027.6 6056.5 5913.5 5918.6 5932.7 5949.8 5968.7 4603.6 4717.2 4786.1 4790.4 4793.7 4683.4 4698.0 4707.4 4715.1 4716.4 4655.0 4665.7 4669.9 4673.2 4679.6 4529.9 4574.8 4624.4 4668.7 4674.3 4123.8 4136.9 4141.3 4146.5 4165.8 5433.3 5485.1 5623.9 5645.3 5648.2 5365.9 5437.9 5447.9 5456.1 5463.3 6278.0 6299.5 6301.6 6302.3 6304.1 4596.6 4596.7 4597.1 4598.8 4599.5 6273.2 6509.9 6521.3 6596.5 6602.1 4687.6 4694.2 4694.7 4694.9 4696.0 4726.0 4749.5 4750.0 4755.0 4766.5 5368.0 5410.0 5424.9 5426.6 5428.2 6356.6 6359.5 6364.2 6364.6 6372.5 1728.3 1751.1 1751.3 1752.0 1752.0 1186.6 1193.1 1204.6 1206.6 1226.8 6100.4 6103.8 6171.2 6181.4 6182.8 6596.3 6597.6 6598.7 6601.3 6604.4 6081.7 6143.4 6165.6 6170.8 6179.7 3624.8 3654.1 3659.4 3660.6 3664.9 6798.0 6800.4 6810.5 6811.2 6822.7 6541.5 6627.0 6682.0 6751.2 6773.0 6710.9 6743.9 6759.9 6782.1 6783.0 6519.9 6550.9 6559.3 6564.0 6567.9 6339.1 6480.0 6491.3 6492.0 6497.4 6833.9 6855.6 6874.3 6875.4 6882.0 4821.1 4825.7 4828.3 4828.6 4830.8 6502.3 6646.2 6649.3 6654.0 6656.7 6488.0 6493.2 6495.4 6505.7 6508.4 6420.3 6429.2 6442.5 6474.6 6483.3 6244.1 6389.7 6396.6 6397.6 6408.6 6500.1 6501.5 6520.2 6525.2 6540.0 6359.5 6363.9 6372.4 6375.9 6377.8 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: 03:58:20 INFO - 2015-10-29 03:58:20,701 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13261.75 Median:40197.00 stddev:14361.08 (35.7%) stddev-sans-first:14371.24 03:58:20 INFO - 2015-10-29 03:58:20,703 DEBUG : BROWSER_OUTPUT: Values: 874.8 896.4 937.4 954.4 1007.2 13579.7 13839.2 14823.9 14824.2 14840.7 13736.7 13789.9 13874.8 13878.7 13882.2 762.2 773.4 930.8 934.4 957.2 950.1 952.0 959.2 960.0 960.1 804.8 989.0 1002.5 1003.4 1005.0 817.2 977.1 1010.3 1011.8 1015.1 713.0 720.9 721.5 722.6 722.9 12946.0 13064.1 13067.0 13095.1 13108.4 12236.4 12357.3 12573.1 12991.9 13159.7 10438.2 10531.5 10546.3 10783.4 10913.8 3821.4 3850.3 3902.6 3917.0 3932.6 41367.8 41760.4 41877.6 46124.0 46498.0 10774.5 11018.8 11274.8 11285.2 11330.4 19947.2 20136.2 20151.5 20159.8 20181.0 8073.6 8324.2 8333.8 8363.9 8495.0 4397.3 4459.3 4633.3 4665.7 4688.7 3361.4 3386.6 3391.9 3392.4 3396.6 561.5 570.9 574.1 574.8 584.0 722.1 733.8 738.4 739.9 756.4 8704.3 8882.0 9011.9 9119.0 9264.4 646.6 652.7 706.8 714.3 759.7 4338.6 4372.1 4416.9 4450.5 4532.7 54037.5 55789.4 55914.0 55924.7 55962.0 45863.0 46451.0 46979.3 47028.0 47078.0 40034.8 40102.0 40292.0 40464.4 41767.6 8711.6 8952.0 9067.9 9174.4 9310.7 27765.4 27975.2 28743.3 28818.0 28832.0 37879.0 37904.8 40039.8 40537.8 40580.2 8293.9 8540.6 8602.8 8737.8 8763.5 12402.9 12682.0 13106.9 13222.3 13356.0 11100.9 11685.5 11946.7 12266.3 12459.3 11568.9 11745.5 11990.9 11993.1 12074.3 10394.8 11587.3 11795.5 12081.8 12137.5 10292.2 10373.7 10466.3 10473.1 10706.1 9992.6 10065.2 10160.9 10162.4 10173.7 03:58:20 INFO - 2015-10-29 03:58:20,703 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:58:20 INFO - 2015-10-29 03:58:20,703 DEBUG : BROWSER_OUTPUT: 03:58:21 INFO - 2015-10-29 03:58:21,278 INFO : Browser exited with error code: 0 03:58:21 INFO - 2015-10-29 03:58:21,293 INFO : Completed test dromaeo_css (00:18:30) 03:58:21 INFO - 2015-10-29 03:58:21,294 INFO : Starting test kraken 03:58:21 INFO - 2015-10-29 03:58:21,294 DEBUG : operating with platform_type : linux_ 03:58:21 INFO - 2015-10-29 03:58:21,294 INFO : Initialising browser for kraken test... 03:58:21 INFO - 2015-10-29 03:58:21,299 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU_bH0W/profile http://localhost/getInfo.html 03:58:24 INFO - 2015-10-29 03:58:24,496 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:58:24 INFO - 2015-10-29 03:58:24,497 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:58:24 INFO - 2015-10-29 03:58:24,497 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:58:24 INFO - 2015-10-29 03:58:24,497 DEBUG : BROWSER_OUTPUT: __metrics 03:58:24 INFO - 2015-10-29 03:58:24,634 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:58:25 INFO - 2015-10-29 03:58:25,668 INFO : Browser initialized. 03:58:25 INFO - 2015-10-29 03:58:25,669 INFO : Running cycle 1/1 for kraken test... 03:58:25 INFO - 2015-10-29 03:58:25,669 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU_bH0W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:58:37 INFO - 2015-10-29 03:58:37,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 132628480 03:58:37 INFO - 2015-10-29 03:58:37,321 DEBUG : BROWSER_OUTPUT: 03:58:40 INFO - 2015-10-29 03:58:40,203 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) 03:58:40 INFO - 2015-10-29 03:58:40,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 166223872 03:58:40 INFO - 2015-10-29 03:58:40,786 DEBUG : BROWSER_OUTPUT: 03:58:43 INFO - 2015-10-29 03:58:43,307 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) 03:58:43 INFO - 2015-10-29 03:58:43,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 162279424 03:58:43 INFO - 2015-10-29 03:58:43,873 DEBUG : BROWSER_OUTPUT: 03:58:46 INFO - 2015-10-29 03:58:46,635 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) 03:58:47 INFO - 2015-10-29 03:58:47,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 162758656 03:58:47 INFO - 2015-10-29 03:58:47,199 DEBUG : BROWSER_OUTPUT: 03:58:49 INFO - 2015-10-29 03:58:49,143 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) 03:58:49 INFO - 2015-10-29 03:58:49,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 159682560 03:58:49 INFO - 2015-10-29 03:58:49,704 DEBUG : BROWSER_OUTPUT: 03:58:51 INFO - 2015-10-29 03:58:51,817 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) 03:58:52 INFO - 2015-10-29 03:58:52,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 156590080 03:58:52 INFO - 2015-10-29 03:58:52,379 DEBUG : BROWSER_OUTPUT: 03:58:55 INFO - 2015-10-29 03:58:55,218 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) 03:58:55 INFO - 2015-10-29 03:58:55,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 157483008 03:58:55 INFO - 2015-10-29 03:58:55,784 DEBUG : BROWSER_OUTPUT: 03:58:59 INFO - 2015-10-29 03:58:59,072 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) 03:58:59 INFO - 2015-10-29 03:58:59,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 157806592 03:58:59 INFO - 2015-10-29 03:58:59,641 DEBUG : BROWSER_OUTPUT: 03:59:02 INFO - 2015-10-29 03:59:02,360 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) 03:59:02 INFO - 2015-10-29 03:59:02,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 155566080 03:59:02 INFO - 2015-10-29 03:59:02,930 DEBUG : BROWSER_OUTPUT: 03:59:04 INFO - 2015-10-29 03:59:04,423 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) 03:59:04 INFO - 2015-10-29 03:59:04,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 165519360 03:59:04 INFO - 2015-10-29 03:59:04,973 DEBUG : BROWSER_OUTPUT: 03:59:06 INFO - 2015-10-29 03:59:06,663 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) 03:59:07 INFO - 2015-10-29 03:59:07,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 166326272 03:59:07 INFO - 2015-10-29 03:59:07,253 DEBUG : BROWSER_OUTPUT: 03:59:09 INFO - 2015-10-29 03:59:09,169 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) 03:59:09 INFO - 2015-10-29 03:59:09,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 171548672 03:59:09 INFO - 2015-10-29 03:59:09,758 DEBUG : BROWSER_OUTPUT: 03:59:12 INFO - 2015-10-29 03:59:12,019 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) 03:59:12 INFO - 2015-10-29 03:59:12,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 177463296 03:59:12 INFO - 2015-10-29 03:59:12,601 DEBUG : BROWSER_OUTPUT: 03:59:14 INFO - 2015-10-29 03:59:14,982 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) 03:59:15 INFO - 2015-10-29 03:59:15,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 175591424 03:59:15 INFO - 2015-10-29 03:59:15,547 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,120 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) 03:59:17 INFO - 2015-10-29 03:59:17,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 232980480 03:59:17 INFO - 2015-10-29 03:59:17,367 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,371 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:59:17 INFO - 2015-10-29 03:59:17,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:59:17 INFO - 2015-10-29 03:59:17,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:59:17 INFO - 2015-10-29 03:59:17,371 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:59:17 INFO - 2015-10-29 03:59:17,371 DEBUG : BROWSER_OUTPUT: |0;ai-astar;104;108;110;109;109;109;116;109;108;107 03:59:17 INFO - 2015-10-29 03:59:17,371 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;121;143;159;124;146;149;124;164;124 03:59:17 INFO - 2015-10-29 03:59:17,371 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;163;162;160;160;160;159;159;161 03:59:17 INFO - 2015-10-29 03:59:17,372 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;72;70;137;70;71;72;70;164;72 03:59:17 INFO - 2015-10-29 03:59:17,372 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;88;143;87;88;88;142;88;89;130 03:59:17 INFO - 2015-10-29 03:59:17,372 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;109;109;109;109;110 03:59:17 INFO - 2015-10-29 03:59:17,372 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;146;146;145;145;145;144 03:59:17 INFO - 2015-10-29 03:59:17,372 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;97;96;110;95;96;97 03:59:17 INFO - 2015-10-29 03:59:17,372 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;53;53;54;54;54;54;71;53 03:59:17 INFO - 2015-10-29 03:59:17,372 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;60;61;61;61;61;67;61;61;60 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;78;77;79;78;77;77;79;79;79 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;107;105;111;115;120;109;115;107;103 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;135;133;138;135;133;143;135;133;128 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;60;59;59;62;61;60;61;59;59;59 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,875 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: __startTimestamp1446116357369__endTimestamp 03:59:17 INFO - 2015-10-29 03:59:17,373 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:3.00 (2.8%) stddev-sans-first:2.60 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: Values: 104.0 108.0 110.0 109.0 109.0 109.0 116.0 109.0 108.0 107.0 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.10 Median:146.50 stddev:15.78 (10.8%) stddev-sans-first:16.54 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: Values: 147.0 121.0 143.0 159.0 124.0 146.0 149.0 124.0 164.0 124.0 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,375 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 163.0 162.0 160.0 160.0 160.0 159.0 159.0 161.0 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.80 Median:70.50 stddev:34.18 (48.5%) stddev-sans-first:35.71 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 70.0 137.0 70.0 71.0 72.0 70.0 164.0 72.0 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:88.00 stddev:24.56 (27.9%) stddev-sans-first:25.43 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: Values: 88.0 88.0 143.0 87.0 88.0 88.0 142.0 88.0 89.0 130.0 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,376 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:59:17 INFO - 2015-10-29 03:59:17,377 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 03:59:17 INFO - 2015-10-29 03:59:17,377 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,377 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 03:59:17 INFO - 2015-10-29 03:59:17,377 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 144.0 03:59:17 INFO - 2015-10-29 03:59:17,377 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,377 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.40 Median:96.00 stddev:4.48 (4.7%) stddev-sans-first:4.72 03:59:17 INFO - 2015-10-29 03:59:17,378 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 97.0 96.0 110.0 95.0 96.0 97.0 03:59:17 INFO - 2015-10-29 03:59:17,378 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.00 stddev:5.46 (10.1%) stddev-sans-first:5.79 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 53.0 53.0 54.0 54.0 54.0 54.0 71.0 53.0 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:2.01 (3.3%) stddev-sans-first:2.13 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 61.0 61.0 61.0 61.0 67.0 61.0 61.0 60.0 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.50 stddev:1.10 (1.4%) stddev-sans-first:0.93 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: Values: 76.0 78.0 77.0 79.0 78.0 77.0 77.0 79.0 79.0 79.0 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:110.50 Median:112.00 stddev:5.28 (4.7%) stddev-sans-first:5.52 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 105.0 111.0 115.0 120.0 109.0 115.0 107.0 103.0 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,379 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.90 Median:135.00 stddev:3.87 (2.9%) stddev-sans-first:4.09 03:59:17 INFO - 2015-10-29 03:59:17,380 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 133.0 138.0 135.0 133.0 143.0 135.0 133.0 128.0 03:59:17 INFO - 2015-10-29 03:59:17,380 DEBUG : BROWSER_OUTPUT: 03:59:17 INFO - 2015-10-29 03:59:17,380 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 03:59:17 INFO - 2015-10-29 03:59:17,380 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 59.0 62.0 61.0 60.0 61.0 59.0 59.0 59.0 03:59:17 INFO - 2015-10-29 03:59:17,380 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:59:17 INFO - 2015-10-29 03:59:17,380 DEBUG : BROWSER_OUTPUT: 03:59:18 INFO - 2015-10-29 03:59:18,125 INFO : Browser exited with error code: 0 03:59:18 INFO - 2015-10-29 03:59:18,175 INFO : Completed test kraken (00:00:56) 03:59:18 INFO - 2015-10-29 03:59:18,175 INFO : Starting test v8_7 03:59:18 INFO - 2015-10-29 03:59:18,175 DEBUG : operating with platform_type : linux_ 03:59:18 INFO - 2015-10-29 03:59:18,176 INFO : Initialising browser for v8_7 test... 03:59:18 INFO - 2015-10-29 03:59:18,182 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsXgWV2/profile http://localhost/getInfo.html 03:59:21 INFO - 2015-10-29 03:59:21,400 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:59:21 INFO - 2015-10-29 03:59:21,400 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:59:21 INFO - 2015-10-29 03:59:21,400 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:59:21 INFO - 2015-10-29 03:59:21,400 DEBUG : BROWSER_OUTPUT: __metrics 03:59:21 INFO - 2015-10-29 03:59:21,529 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:22 INFO - 2015-10-29 03:59:22,500 INFO : Browser initialized. 03:59:22 INFO - 2015-10-29 03:59:22,501 INFO : Running cycle 1/1 for v8_7 test... 03:59:22 INFO - 2015-10-29 03:59:22,501 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsXgWV2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:59:34 INFO - 2015-10-29 03:59:34,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 132689920 03:59:34 INFO - 2015-10-29 03:59:34,156 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,566 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) 03:59:55 INFO - 2015-10-29 03:59:55,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 432070656 03:59:55 INFO - 2015-10-29 03:59:55,816 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,817 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:59:55 INFO - 2015-10-29 03:59:55,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:59:55 INFO - 2015-10-29 03:59:55,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:59:55 INFO - 2015-10-29 03:59:55,818 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:59:55 INFO - 2015-10-29 03:59:55,818 DEBUG : BROWSER_OUTPUT: |0;Richards;168.37851490149856 03:59:55 INFO - 2015-10-29 03:59:55,818 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.66326362588507 03:59:55 INFO - 2015-10-29 03:59:55,818 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.0567734682406 03:59:55 INFO - 2015-10-29 03:59:55,818 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5070.707070707071 03:59:55 INFO - 2015-10-29 03:59:55,819 DEBUG : BROWSER_OUTPUT: |4;RayTrace;954.1984732824427 03:59:55 INFO - 2015-10-29 03:59:55,819 DEBUG : BROWSER_OUTPUT: |5;Earley;539.6654074473827 03:59:55 INFO - 2015-10-29 03:59:55,819 DEBUG : BROWSER_OUTPUT: |6;Boyer;10244.897959183674 03:59:55 INFO - 2015-10-29 03:59:55,819 DEBUG : BROWSER_OUTPUT: |7;RegExp;23113.636363636364 03:59:55 INFO - 2015-10-29 03:59:55,819 DEBUG : BROWSER_OUTPUT: |8;Splay;551.5719801434087 03:59:55 INFO - 2015-10-29 03:59:55,819 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 03:59:55 INFO - 2015-10-29 03:59:55,819 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:59:55 INFO - 2015-10-29 03:59:55,820 DEBUG : BROWSER_OUTPUT: __startTimestamp1446116395816__endTimestamp 03:59:55 INFO - 2015-10-29 03:59:55,820 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,820 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:59:55 INFO - 2015-10-29 03:59:55,820 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:59:55 INFO - 2015-10-29 03:59:55,820 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.38 Median:168.38 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: Values: 168.4 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.66 Median:164.66 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: Values: 164.7 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: Values: 281.1 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5070.71 Median:5070.71 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: Values: 5070.7 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:954.20 Median:954.20 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: Values: 954.2 03:59:55 INFO - 2015-10-29 03:59:55,822 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:539.67 Median:539.67 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: Values: 539.7 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10244.90 Median:10244.90 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: Values: 10244.9 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23113.64 Median:23113.64 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: Values: 23113.6 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,823 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:551.57 Median:551.57 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,824 DEBUG : BROWSER_OUTPUT: Values: 551.6 03:59:55 INFO - 2015-10-29 03:59:55,824 DEBUG : BROWSER_OUTPUT: 03:59:55 INFO - 2015-10-29 03:59:55,824 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 03:59:55 INFO - 2015-10-29 03:59:55,824 DEBUG : BROWSER_OUTPUT: Values: 4817.3 03:59:55 INFO - 2015-10-29 03:59:55,824 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:59:55 INFO - 2015-10-29 03:59:55,824 DEBUG : BROWSER_OUTPUT: 03:59:56 INFO - 2015-10-29 03:59:56,585 INFO : Browser exited with error code: 0 03:59:56 INFO - 2015-10-29 03:59:56,604 INFO : Completed test v8_7 (00:00:38) 03:59:56 INFO - 2015-10-29 03:59:56,604 INFO : Completed test suite (00:20:06) 03:59:56 INFO - 2015-10-29 03:59:56,604 DEBUG : Working with test: dromaeo_css 03:59:56 INFO - 2015-10-29 03:59:56,604 DEBUG : Generating results file: dromaeo_css 03:59:56 INFO - 2015-10-29 03:59:56,606 DEBUG : Working with test: kraken 03:59:56 INFO - 2015-10-29 03:59:56,606 DEBUG : Generating results file: kraken 03:59:56 INFO - 2015-10-29 03:59:56,606 INFO : javascript benchmark 03:59:56 INFO - 2015-10-29 03:59:56,606 DEBUG : Working with test: v8_7 03:59:56 INFO - 2015-10-29 03:59:56,606 DEBUG : Generating results file: v8_7 03:59:56 INFO - 2015-10-29 03:59:56,606 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:59:56 INFO - 2015-10-29 03:59:56,667 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:59:56 INFO - 2015-10-29 03:59:56,667 DEBUG : process_Request line: dromaeo_css 7542.47 graph.html#tests=[[72,52,35]] 03:59:56 INFO - 2015-10-29 03:59:56,667 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:59:56 INFO - 2015-10-29 03:59:56,704 DEBUG : process_Request line: kraken 1452.00 graph.html#tests=[[232,52,35]] 03:59:56 INFO - 2015-10-29 03:59:56,704 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:59:56 INFO - 2015-10-29 03:59:56,742 DEBUG : process_Request line: v8_7 23366.96 graph.html#tests=[[230,52,35]] 03:59:56 INFO - 2015-10-29 03:59:56,745 INFO : javascript benchmark 03:59:56 INFO - 2015-10-29 03:59:56,749 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [427.7390791617113, 428.62067070642473, 431.484376170476, 432.27378004951686, 435.63624373648, 15984.84015159848, 16444.0, 17018.5745356366, 18834.43496695098, 18976.240950361986, 17276.568085797862, 20170.899145504252, 20472.078756455958, 20810.791892081073, 20824.89587552064, 5889.941100589003, 6014.458698717114, 6022.457978781908, 6025.0661147522205, 6033.487153591928, 4266.381374700666, 4383.824647014131, 5969.850753731148, 6008.849778755544, 6477.870442591146, 6536.705848236841, 6562.146920900276, 6608.2070151581875, 6611.735530578771, 6620.470362371023, 6419.422251997319, 6557.5081868860025, 6564.343565643421, 6571.3757193066585, 6572.835679108012, 4593.977030114861, 5859.912101318484, 5875.206847075633, 5876.853078673024, 5893.469587737124, 15638.843611563967, 15687.0, 15755.684886302324, 15870.20648967547, 15886.126263055527, 2269.8751568663715, 2270.9091636334692, 2286.119843860109, 2306.1006207579057, 2360.5986982213067, 10839.349639021684, 10967.341959482377, 10975.945120274348, 10996.615118470816, 11158.497867595977, 1696.0925904640958, 1705.7185564381862, 1814.0294942205855, 1851.907404629763, 1863.5527473406285, 66572.3342766571, 67907.66046169738, 71137.64431177812, 73366.0, 74356.62821685911, 8012.599370031475, 8039.477433966774, 8175.754727358189, 8230.588470576447, 8248.257656810796, 10098.343607665478, 10103.19174466041, 10113.848292275474, 10114.898851011396, 10132.138768204637, 6620.0, 6628.933710662928, 6656.966715166393, 6658.83352916181, 6674.399304062657, 6867.793966181022, 6897.3447522485285, 7254.310840470147, 7276.599787011765, 7304.3426091650945, 3806.600306967784, 3828.980855095707, 3829.5213098362706, 3832.6550610445192, 3844.7308688392104, 1290.7353992431529, 1324.788033914569, 1341.1952828303135, 1350.6825895914453, 1361.700425906299, 539.9595030372737, 548.9972550137223, 549.5027000564495, 573.5927491481095, 575.5740751843689, 12247.571335003233, 13821.79267310991, 13917.095388799695, 14163.575092747235, 14285.285735713172, 580.2167074449544, 594.3551246897078, 598.9580729348991, 599.286848650105, 602.1810337940398, 7416.629168541552, 7456.627168641547, 7470.103587569418, 7618.4667073305445, 7632.236776322324, 654590.0, 670669.0, 684385.0, 690985.0, 696441.0, 90524.0, 91879.54060229656, 91964.54017730002, 92470.53764731133, 93622.0637793627, 602.3374288282854, 603.2338929559435, 604.6009633641776, 606.1453350775386, 609.0346800321452, 12805.103642744918, 12924.547640832525, 12982.480700772241, 13147.868521314664, 13226.0, 42076.78961605173, 42169.1566168681, 42463.0, 42839.35740963826, 43337.0, 56521.71739141278, 56804.14793778014, 56861.14708279462, 57962.0, 58507.70746146242, 7858.135605083322, 7890.329322007694, 7900.802479938047, 7925.28672419485, 8001.479903806467, 10649.627263046066, 13991.23048232357, 14269.785953210503, 14361.784573231618, 14471.78292325637, 11998.160128790902, 12141.69645758863, 12235.93882030584, 12469.127161098637, 12485.250884946932, 11623.6512904613, 11911.106667000184, 11935.104867134825, 12097.516099355928, 12183.634490965285, 11796.174267801514, 12153.751555962175, 12287.201331913397, 12449.502019919464, 12472.625821225378, 7794.181610930771, 7903.644336005009, 8001.519908805491, 8004.199580041949, 8017.639206235617, 12028.819567706316, 12165.75668486643, 12328.81506777381, 12632.873671263169, 12655.303958282382], "dojo.html": [3361.680640339168, 3386.542816719742, 3428.262923471453, 3433.038749150239, 3451.8101504417264, 5689.914651280229, 5712.086066229404, 5738.713064346787, 5746.626469279499, 5749.166370876221, 5715.9997000524945, 5756.712164391784, 5774.931637647038, 5779.739911703973, 5810.651360918348, 5134.0, 5196.532312091901, 5215.765290561915, 5215.895682086356, 5282.841514754564, 5168.095583272931, 5228.163493840986, 5261.815836445725, 5298.496642818926, 5332.946670533283, 5315.7873685052555, 5367.302250707403, 5371.5165635092835, 5374.516293533581, 5400.702961337125, 5131.948680513222, 5257.263983042377, 5325.174597937287, 5326.440723723992, 5397.325334333208, 5091.821786237464, 5188.040212560688, 5188.740562971836, 5189.42916279209, 5221.347331583552, 5605.887882242332, 5663.122216056518, 5678.205051292823, 5683.630564013326, 5691.573132015115, 5990.580659353847, 6072.210612620331, 6102.6948652567635, 6242.375762423767, 6252.3747625237565, 6250.624962502265, 6312.274088479838, 6312.968435157794, 6313.463355614778, 6320.652364119972, 5846.883062338729, 5848.152017957457, 5849.532037436995, 5855.795047173371, 5862.120681897707, 6041.395860414012, 6141.508679305645, 6223.937760622336, 6357.237131544244, 6389.6805159741825, 6042.546808989343, 6108.969455152785, 6111.174991376196, 6115.663638499926, 6119.173911521888, 6138.14066030756, 6158.04550294696, 6167.537434692416, 6180.351063138396, 6181.907271390843, 6006.069059295816, 6060.969695151496, 6128.01427809372, 6131.478824299896, 6133.355997620275, 6157.168782214344, 6199.256089269316, 6216.502679785606, 6235.3452887446165, 6256.468200203034, 4561.2245918193985, 4729.243321068612, 4732.408448943882, 4747.928781068286, 4748.572628463455, 4096.754194748325, 4134.834606615762, 4152.91694166121, 4188.162367526507, 4199.118185181146, 5836.212111364996, 5888.352281249059, 5895.145203945404, 5899.587028908021, 5900.675462849498, 6030.065339872327, 6087.36082711309, 6242.344553821874, 6295.18162638854, 6298.559100862895, 5690.943090569124, 5768.961586914395, 5780.5953583248765, 5780.855478613068, 5800.88398232033, 5409.675419474844, 5416.593755468277, 5447.128459446549, 5447.972760136253, 5456.127019676833, 6132.724027418777, 6172.290186628506, 6238.095476156022, 6516.674166291667, 6522.478201743849, 6285.528585356025, 6310.400511951358, 6310.7791227306825, 6321.905171422524, 6327.493800496041, 6391.9772836345965, 6428.903566446601, 6432.2281326241155, 6445.323241059621, 6455.193100862392, 5886.882262354815, 6011.068284415923, 6022.6386416813375, 6098.265895953616, 6176.629402235881, 6265.122882796321, 6320.5575609706875, 6327.715252813542, 6332.461740751904, 6337.144485494399, 6149.139120523041, 6163.660998645118, 6170.9074363885475, 6171.722272497658, 6186.072089186658, 5868.354481007171, 5972.193753843176, 5997.820065398045, 6134.834601026089, 6139.478144357601, 6012.398760123952, 6041.214642096499, 6041.456268935817, 6043.607165534402, 6059.030555111161, 5987.970060149672, 6166.537509686702, 6166.845828854135, 6182.474489668429, 6188.597741146811, 5897.9115313271195, 5948.702564871825, 6020.849478763066, 6055.72749226277, 6075.878482430415], "mootools.html": [1553.2389129326634, 1670.707626165421, 1868.402111324376, 2053.6919462080687, 2079.1787244038605, 9294.488803115826, 10215.642452514163, 10496.842547361795, 10511.789764204712, 10528.684139475808, 9892.50537473127, 10028.899711002889, 10031.849522257155, 10056.547455364507, 10065.899341006587, 2225.3657707553352, 2260.073369918334, 2444.4622183119686, 2475.7400472950353, 2511.8618475983812, 2439.231642032754, 2459.1270099114827, 2466.371075375777, 2471.258622413278, 2480.131953816159, 2497.126005897939, 2516.723160452358, 2523.4448421347365, 2527.064985955199, 2530.3800568860656, 2252.605793986054, 2300.620397634388, 2491.9252422427267, 2533.3919859233833, 2540.326813394452, 2427.2232885476656, 2434.6104623260194, 2443.2914454808083, 2553.5786595211766, 2572.2926195296254, 10543.420111893844, 10597.629082982136, 10621.362718236931, 10626.574937002511, 10628.149748020218, 5984.311804142536, 5997.610155339932, 6057.0, 6062.96968515159, 6067.484263837579, 3605.5132557104716, 3636.7636103653176, 3674.2651469706166, 3686.3364594373, 3698.7780733156096, 1062.6227689170387, 1067.114295135036, 1084.6854412220446, 1088.2219213262556, 1107.6676996900978, 15993.760093598605, 16002.0, 16004.919975400166, 16010.119443430607, 16073.598160046093, 5210.296609957683, 5256.632035757537, 5270.314859068297, 5427.240186373911, 5427.348718153768, 12572.748545029232, 12586.0, 12609.0, 12619.305938173306, 12624.684382890502, 5861.267341582302, 5862.794802181903, 5864.794732184353, 5872.119182122716, 5884.852878677982, 5303.098473259555, 5304.124819404832, 5309.0, 5311.362636483569, 5374.328208973879, 4339.34909763538, 4339.63113135387, 4344.782760861945, 4363.738175709467, 4378.036831896978, 1138.9544418223345, 1139.7321629417247, 1142.114860982745, 1150.160382920456, 1164.6738913104343, 1185.0993245133761, 1196.682879037056, 1204.27141579345, 1474.2186641080245, 1478.334749362791, 9875.456849873326, 9980.301378903552, 10076.647317344004, 10085.546150423103, 10100.595976161017, 544.9564034877201, 556.9387367389584, 558.8267637032533, 560.1234068682498, 562.5893098038373, 7503.174650788409, 7515.586642734593, 7578.658960346797, 7587.0, 7615.276548727862, 13538.729225415436, 13737.725245495034, 13753.449862005607, 13760.587182384545, 13785.310734463237, 13438.664033399244, 13768.036237463282, 13867.375968081258, 13881.652958676113, 13893.652658683613, 9712.125908668253, 9852.704418867446, 9903.0, 9933.900660993442, 9936.304458687968, 9247.167754902091, 9421.481818500048, 9466.390713578847, 9467.526623668928, 9486.098820612031, 11649.825252621047, 11750.177487575787, 11760.0, 11808.35054072, 11854.11094167958, 11950.223235489666, 12077.818832717692, 12130.514779408724, 12164.39178041112, 12214.14500984958, 8405.621747021522, 8632.568371581521, 8644.308455323433, 8645.135486451305, 8655.567221638767, 10270.794584108426, 10307.94846025765, 10356.741081473023, 10385.844212336971, 10423.583056677648, 8476.0, 9674.75813104678, 9711.439435950284, 9714.95142524311, 9719.85420218683, 8242.423030387816, 9211.953940230256, 9442.48066356357, 9493.145616894513, 9573.090556397132, 9313.534323283944, 9331.906680933374, 9350.064993500868, 9405.871295444591, 9443.386179898285, 8356.623951922056, 8455.02767181782, 8456.32349412058, 8463.74608761738, 8470.57647117654, 8542.530160841214, 8545.871811922701, 8616.48301101936, 8695.478271303742, 8719.258862996716], "ext.html": [570.8544321198096, 612.5987478201778, 621.1490258346065, 635.7838334966114, 640.836586670399, 45535.0, 45990.540094599084, 46019.30971035437, 46034.0, 46052.53947460533, 49525.50474495254, 50171.74914125433, 50295.49704502954, 50312.0, 50331.24503132456, 8505.404621676485, 8638.617821148617, 9353.906460935388, 9525.95237023814, 10852.565897364097, 11216.943915280412, 11354.659360219166, 11368.37473938933, 11381.032612227971, 11386.772264554704, 11223.719407014849, 11254.943725281402, 11354.26197297173, 11362.034227090666, 11371.601993930213, 8690.391672582922, 8854.335924805633, 11030.834537481944, 11163.888361116447, 11230.55077796887, 10661.573537058508, 10782.73043173919, 10784.245102842804, 10785.406802625852, 10787.137029037658, 43544.564554354685, 43837.56162438398, 43950.78024609888, 43978.780106099264, 44073.77963110164, 3786.2238241160494, 3856.1323702166787, 3902.7268091233627, 3932.233214523169, 3937.409388591734, 33538.49692254618, 33829.66170338314, 33858.15354616154, 33985.0, 34030.65969340324, 3363.1592101974506, 3385.339858727549, 3422.0760394693543, 3436.0, 3441.9949117475335, 339966.0, 341935.0, 342633.9999999975, 342722.0, 342740.71777846455, 63064.0, 63655.36344636587, 72352.0, 73949.26050739532, 74300.62849685717, 70405.64797175981, 70414.0, 70476.0, 70561.29438705649, 70736.64631676911, 19458.31895883637, 19597.608047838963, 19608.509787255432, 19678.606427871648, 19682.409527713906, 14829.555113346616, 14856.702865942621, 14989.250537473083, 15025.173615451255, 15146.318415671321, 22533.211337603105, 23484.295471135894, 23496.647550286758, 23528.882355588114, 23726.0, 8725.694600689072, 8828.51443170619, 8931.955340223387, 8945.686900958435, 8984.685536006209, 1142.2974870454611, 1163.139276935062, 1165.7260543772206, 1171.226990186473, 1195.1514424758518, 32259.35481290408, 32320.676793231767, 32344.35311293761, 32949.83525082407, 33032.83483582567, 1159.6173262823247, 1187.8455800745849, 1230.9015278777676, 1275.4961790092862, 1332.580237225271, 16150.67698646044, 17059.976401415955, 18023.639527209383, 18280.81719182791, 19168.424947251606, 542389.0, 547799.0, 548239.0, 548772.0, 549233.0, 61733.69133154306, 62261.68869155716, 65103.34896650973, 72295.0, 73000.63499682574, 1503.9323230454656, 1507.6683129711446, 1517.544736579022, 1530.540837748671, 1534.63935975048, 30389.848050759603, 33249.833750831094, 33450.66549334476, 33921.49117763285, 33944.0, 51797.741011294704, 58710.7064464692, 58806.0, 58840.70579647074, 58850.0, 424450.0, 424507.0, 426018.0, 427796.0, 428371.0, 37600.2479950394, 37877.81061094677, 38143.61856381401, 38676.41985370166, 38755.0, 49383.506164939325, 49668.25497617466, 49858.25212621886, 50079.74960125176, 50346.244806328665, 40681.59318406778, 41895.0, 41915.7904210477, 42194.57805422029, 46579.301310481045, 41771.16457670891, 42863.78568107139, 43186.56813431825, 43944.121117578106, 44011.55988440075, 43709.78145109381, 44028.33957490704, 44207.55792442035, 44251.114977699624, 44747.10505789931, 36996.44505332368, 38710.80644596759, 38711.806440967615, 38932.22135557216, 39709.60290397059, 29460.55809162907, 29722.554161688025, 30398.54402184013, 30565.847170764006, 31753.20616984594], "prototype.html": [395.8001209389258, 402.91538776856856, 403.96970227232964, 407.1043703851527, 411.0463724159948, 5967.850803729909, 5978.701064946752, 5987.371326010772, 6027.578069535134, 6056.454919057284, 5913.526917846572, 5918.556108291885, 5932.703364831752, 5949.8215053548465, 5968.7314070866805, 4603.631709463251, 4717.174494463472, 4786.114568804782, 4790.449098353682, 4793.688410253322, 4683.414573178353, 4698.0, 4707.435107787071, 4715.056988602276, 4716.386869706933, 4654.976725116369, 4665.696729712575, 4669.859904202879, 4673.158831410345, 4679.60223381013, 4529.886752831189, 4574.817007319703, 4624.352590637313, 4668.696534725266, 4674.298855171717, 4123.814428350732, 4136.896577585554, 4141.337386018223, 4146.543880173179, 4165.791710414497, 5433.293671822637, 5485.067538518461, 5623.9437605623825, 5645.294338207724, 5648.237487939158, 5365.865853353658, 5437.918431223535, 5447.891042179174, 5456.127019676872, 5463.289772329612, 6277.968610156966, 6299.496040316763, 6301.590396624205, 6302.338254483259, 6304.054391841215, 4596.632269418438, 4596.678232523725, 4597.103564804865, 4598.839040633562, 4599.494055653875, 6273.1531243282025, 6509.9023514647315, 6521.250056243498, 6596.472282217411, 6602.141721576164, 4687.554682305175, 4694.178518759203, 4694.718316900997, 4694.929576056362, 4696.0, 4725.9527404726205, 4749.525047495223, 4749.952500474951, 4755.0, 4766.547178018082, 5368.0, 5410.026195284808, 5424.891502169935, 5426.593005524602, 5428.212909128154, 6356.586821856565, 6359.459445947146, 6364.172657554488, 6364.6181229126405, 6372.458341041063, 1728.3086765293983, 1751.0894334945756, 1751.299480207927, 1752.0451354011839, 1752.0451354012093, 1186.5609724402027, 1193.0694058634278, 1204.6205445284706, 1206.638008597435, 1226.7791797476361, 6100.359462256488, 6103.755849766048, 6171.228596425447, 6181.381861813873, 6182.752689892444, 6596.274409814917, 6597.604143751294, 6598.736050557924, 6601.2738598754095, 6604.405603495708, 6081.665508397081, 6143.447089761943, 6165.568410211242, 6170.81487555374, 6179.660118693425, 3624.7643903146213, 3654.068212605822, 3659.359612067931, 3660.5973342932257, 3664.908377290589, 6797.966010169917, 6800.353966373285, 6810.455163586901, 6811.182658081062, 6822.658867056627, 6541.542092053605, 6626.966865165643, 6681.966590167018, 6751.223609284995, 6773.0, 6710.899336509956, 6743.898841517381, 6759.898601520883, 6782.050512928194, 6783.0, 6519.902201466887, 6550.901736474052, 6559.311272316338, 6564.0, 6567.868642627216, 6339.112524246517, 6480.0, 6491.285958544462, 6492.0261960706275, 6497.382748638872, 6833.897491537531, 6855.5886646801355, 6874.346937040973, 6875.449964002768, 6882.03651488782, 4821.108095002436, 4825.734584597881, 4828.275758636232, 4828.589569886459, 4830.806767729251, 6502.252240992158, 6646.169228846395, 6649.335066493312, 6653.9667301663185, 6656.7004484797335, 6487.967560162169, 6493.188351456068, 6495.350464953467, 6505.73977040932, 6508.414242718178, 6420.2937676856445, 6429.164208652845, 6442.516811239269, 6474.643894585843, 6483.2544257411, 6244.063390491281, 6389.712462939272, 6396.552241343062, 6397.6481293529305, 6408.61548307103, 6500.089987401862, 6501.512386570931, 6520.217573891164, 6525.151730275224, 6540.018997150275, 6359.523035772243, 6363.904541431974, 6372.394622510854, 6375.872482550416, 6377.808665740035], "yui.html": [874.8162885793982, 896.3904544909461, 937.3579098317657, 954.4273435938436, 1007.2395341517154, 13579.728405431886, 13839.238841863693, 14823.851761482381, 14824.184669843167, 14840.703185936274, 13736.656583585416, 13789.931050344734, 13874.791878121836, 13878.653033674163, 13882.167069975809, 762.2491845532146, 773.3851587987564, 930.7998780262226, 934.3926447808944, 957.248559880494, 950.064186776025, 951.9666811661593, 959.2374062620233, 960.011188475871, 960.0975083421596, 804.7907544038534, 988.9653862114827, 1002.5187909803299, 1003.3528374198637, 1005.03516624041, 817.166490180016, 977.130353984954, 1010.3079390617414, 1011.7976404719012, 1015.1422048369117, 712.9500934934557, 720.8594324106801, 721.462510429728, 722.6495149852317, 722.9385502232317, 12946.0, 13064.085514014023, 13067.0, 13095.083344165912, 13108.410121544553, 12236.449359778742, 12357.32034738089, 12573.11988160829, 12991.935040324832, 13159.736805263841, 10438.217133714927, 10531.52608132636, 10546.261761676686, 10783.352998820095, 10913.781724365468, 3821.445890345912, 3850.306944749944, 3902.6292502212245, 3917.040325120364, 3932.5870783567884, 41367.793161034, 41760.37359439611, 41877.581224187976, 46124.0, 46498.0, 10774.461276936121, 11018.779624407627, 11274.774504509864, 11285.153613478858, 11330.433478326215, 19947.202111915652, 20136.19455221775, 20151.49621259451, 20159.798402016084, 20181.0, 8073.555954422446, 8324.209200125979, 8333.8333233335, 8363.874541881876, 8494.957525212334, 4397.31841564558, 4459.308807134899, 4633.2818413146015, 4665.673402861835, 4688.695234809727, 3361.3949489092197, 3386.5766779152605, 3391.8643254270046, 3392.4402473592077, 3396.6093899201414, 561.4750208555014, 570.9086546152596, 574.1273264637811, 574.7930744931821, 584.0392554248323, 722.1045903080143, 733.8238822682624, 738.4308344767369, 739.8631253218172, 756.43267549338, 8704.34717396185, 8882.0, 9011.864822027675, 9119.04250053748, 9264.351495395393, 646.6314200905533, 652.7062821730241, 706.7879636109146, 714.2785786355818, 759.734093067422, 4338.566143385636, 4372.060007098489, 4416.933745993749, 4450.532694067141, 4532.682712210114, 54037.45962540403, 55789.44210557923, 55914.0, 55924.720376397854, 55962.0, 45863.0, 46451.0, 46979.29531057037, 47028.0, 47078.0, 40034.799826000686, 40102.0, 40292.0, 40464.39303410451, 41767.582324176976, 8711.564421779012, 8952.0, 9067.863982040406, 9174.357794954556, 9310.674126405544, 27765.444691105662, 27975.160745177676, 28743.281417964718, 28818.0, 28832.0, 37879.0, 37904.810475947445, 40039.79980100081, 40537.79731101326, 40580.18839623132, 8293.875591866248, 8540.572971351532, 8602.78493037679, 8737.825243494968, 8763.474191548528, 12402.875971240172, 12681.985441164868, 13106.934465327613, 13222.272774997467, 13355.98980458817, 11100.888991110309, 11685.474153662935, 11946.701332466759, 12266.325352105363, 12459.314737689514, 11568.88431115678, 11745.530178792753, 11990.880091198977, 11993.1005174614, 12074.27554346742, 10394.752629684486, 11587.304761714324, 11795.469203885674, 12081.75836483283, 12137.453814578541, 10292.176625869763, 10373.740656483647, 10466.319689220176, 10473.109785668303, 10706.143508519455, 9992.550335235077, 10065.24510661718, 10160.898391015995, 10162.39025658463, 10173.745656358651]}, "summary": {"suite": 7542.466879108443, "subtests": {"jquery.html": {"std": 111030.52909319247, "min": 427.7390791617113, "max": 696441.0, "median": 8015.119288133546, "filtered": 8235.343365835244, "mean": 33118.42188869614}, "dojo.html": {"std": 654.8843955782081, "min": 3361.680640339168, "max": 6522.478201743849, "median": 5997.820065398045, "filtered": 5709.491384191543, "mean": 5753.654907212843}, "mootools.html": {"std": 4220.479814473289, "min": 544.9564034877201, "max": 16073.598160046093, "median": 8460.03479086898, "filtered": 5522.406882469456, "mean": 7235.381038381127}, "ext.html": {"std": 117669.73387119328, "min": 570.8544321198096, "max": 549233.0, "median": 32991.33504332487, "filtered": 22116.072864867227, "mean": 62654.48957735427}, "prototype.html": {"std": 1561.0291502979135, "min": 395.8001209389258, "max": 6882.03651488782, "median": 6069.060213727183, "filtered": 4910.565265784117, "mean": 5391.491379963858}, "yui.html": {"std": 14321.132104547529, "min": 561.4750208555014, "max": 55962.0, "median": 10232.961141114207, "filtered": 6528.251504897391, "mean": 13261.74868048635}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1446115190, "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, 162.0, 163.0, 162.0, 160.0, 160.0, 160.0, 159.0, 159.0, 161.0], "ai-astar": [104.0, 108.0, 110.0, 109.0, 109.0, 109.0, 116.0, 109.0, 108.0, 107.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "audio-beat-detection": [147.0, 121.0, 143.0, 159.0, 124.0, 146.0, 149.0, 124.0, 164.0, 124.0], "json-stringify-tinderbox": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 67.0, 61.0, 61.0, 60.0], "stanford-crypto-pbkdf2": [136.0, 135.0, 133.0, 138.0, 135.0, 133.0, 143.0, 135.0, 133.0, 128.0], "json-parse-financial": [55.0, 55.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 71.0, 53.0], "stanford-crypto-sha256-iterative": [60.0, 59.0, 59.0, 62.0, 61.0, 60.0, 61.0, 59.0, 59.0, 59.0], "audio-fft": [70.0, 72.0, 70.0, 137.0, 70.0, 71.0, 72.0, 70.0, 164.0, 72.0], "imaging-darkroom": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 144.0], "stanford-crypto-ccm": [113.0, 107.0, 105.0, 111.0, 115.0, 120.0, 109.0, 115.0, 107.0, 103.0], "audio-oscillator": [88.0, 88.0, 143.0, 87.0, 88.0, 88.0, 142.0, 88.0, 89.0, 130.0], "stanford-crypto-aes": [76.0, 78.0, 77.0, 79.0, 78.0, 77.0, 77.0, 79.0, 79.0, 79.0], "imaging-desaturate": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 110.0, 95.0, 96.0, 97.0]}, "summary": {"suite": 1452.0000000000005, "subtests": {"audio-fft": {"std": 32.42776588049198, "min": 70.0, "max": 164.0, "median": 71.5, "filtered": 86.8, "mean": 86.8}, "stanford-crypto-pbkdf2": {"std": 3.6728735344413916, "min": 128.0, "max": 143.0, "median": 135.0, "filtered": 134.9, "mean": 134.9}, "audio-beat-detection": {"std": 14.969635934116768, "min": 121.0, "max": 164.0, "median": 144.5, "filtered": 140.1, "mean": 140.1}, "stanford-crypto-ccm": {"std": 5.004997502496879, "min": 103.0, "max": 120.0, "median": 110.0, "filtered": 110.5, "mean": 110.5}, "imaging-darkroom": {"std": 0.6403124237432849, "min": 144.0, "max": 146.0, "median": 145.0, "filtered": 145.3, "mean": 145.3}, "json-parse-financial": {"std": 5.180733538795447, "min": 53.0, "max": 71.0, "median": 54.0, "filtered": 55.6, "mean": 55.6}, "audio-oscillator": {"std": 23.295707759155977, "min": 87.0, "max": 143.0, "median": 88.0, "filtered": 103.1, "mean": 103.1}, "ai-astar": {"std": 2.844292530665579, "min": 104.0, "max": 116.0, "median": 109.0, "filtered": 108.9, "mean": 108.9}, "audio-dft": {"std": 1.2806248474865696, "min": 159.0, "max": 163.0, "median": 160.0, "filtered": 160.6, "mean": 160.6}, "stanford-crypto-sha256-iterative": {"std": 1.0440306508910548, "min": 59.0, "max": 62.0, "median": 59.5, "filtered": 59.9, "mean": 59.9}, "json-stringify-tinderbox": {"std": 1.907878402833891, "min": 60.0, "max": 67.0, "median": 61.0, "filtered": 61.4, "mean": 61.4}, "imaging-gaussian-blur": {"std": 0.4898979485566356, "min": 109.0, "max": 110.0, "median": 110.0, "filtered": 109.6, "mean": 109.6}, "stanford-crypto-aes": {"std": 1.0440306508910548, "min": 76.0, "max": 79.0, "median": 78.0, "filtered": 77.9, "mean": 77.9}, "imaging-desaturate": {"std": 4.24735211631906, "min": 95.0, "max": 110.0, "median": 96.0, "filtered": 97.4, "mean": 97.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1446115190, "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.66326362588507], "Encrypt": [281.0567734682406], "NavierStokes": [4817.307692307692], "Decrypt": [5070.707070707071], "Splay": [551.5719801434087], "Richards": [168.37851490149856], "RegExp": [23113.636363636364], "Earley": [539.6654074473827], "Boyer": [10244.897959183674], "RayTrace": [954.1984732824427]}, "summary": {"suite": 23366.96365263535, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.66326362588507, "max": 164.66326362588507, "median": 164.66326362588507, "value": 401.5346139999999, "filtered": 401.5346139999999, "mean": 164.66326362588507}, "Encrypt": {"std": 0.0, "min": 281.0567734682406, "max": 281.0567734682406, "median": 281.0567734682406, "value": 947.0719979999998, "filtered": 947.0719979999998, "mean": 281.0567734682406}, "NavierStokes": {"std": 0.0, "min": 4817.307692307692, "max": 4817.307692307692, "median": 4817.307692307692, "value": 308.055888223553, "filtered": 308.055888223553, "mean": 4817.307692307692}, "Decrypt": {"std": 0.0, "min": 5070.707070707071, "max": 5070.707070707071, "median": 5070.707070707071, "value": 52.493862549800795, "filtered": 52.493862549800795, "mean": 5070.707070707071}, "Splay": {"std": 0.0, "min": 551.5719801434087, "max": 551.5719801434087, "median": 551.5719801434087, "value": 147.74318300000004, "filtered": 147.74318300000004, "mean": 551.5719801434087}, "RegExp": {"std": 0.0, "min": 23113.636363636364, "max": 23113.636363636364, "median": 23113.636363636364, "value": 39.41331366764998, "filtered": 39.41331366764998, "mean": 23113.636363636364}, "Richards": {"std": 0.0, "min": 168.37851490149856, "max": 168.37851490149856, "median": 168.37851490149856, "value": 209.65857799999998, "filtered": 209.65857799999998, "mean": 168.37851490149856}, "Earley": {"std": 0.0, "min": 539.6654074473827, "max": 539.6654074473827, "median": 539.6654074473827, "value": 1234.9559390000002, "filtered": 1234.9559390000002, "mean": 539.6654074473827}, "Boyer": {"std": 0.0, "min": 10244.897959183674, "max": 10244.897959183674, "median": 10244.897959183674, "value": 65.05316135458166, "filtered": 65.05316135458166, "mean": 10244.897959183674}, "RayTrace": {"std": 0.0, "min": 954.1984732824427, "max": 954.1984732824427, "median": 954.1984732824427, "value": 775.5084720000002, "filtered": 775.5084720000002, "mean": 954.1984732824427}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-012"}, "testrun": {"date": 1446115190, "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"}}] 03:59:56 INFO - RETURN: dromaeo_css: 7542.47 03:59:56 INFO - RETURN: kraken: 1452.00 03:59:56 INFO - RETURN: v8_7: 23366.96 03:59:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23366.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1452.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7542.47"}}} 03:59:56 INFO - Return code: 0 03:59:56 INFO - # TBPL SUCCESS # 03:59:56 INFO - Running post-action listener: _resource_record_post_action 03:59:56 INFO - Running post-run listener: _resource_record_post_run 03:59:57 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 7577600; Write bytes: 384274432; Read time: 1828; Write time: 213036 03:59:57 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 83505152; Read time: 0; Write time: 56564 03:59:57 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 5226496; Write bytes: 279420928; Read time: 1396; Write time: 127476 03:59:57 INFO - Running post-run listener: _upload_blobber_files 03:59:57 INFO - Blob upload gear active. 03:59:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:59:57 INFO - Copying logs to upload dir... 03:59:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.361749 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-10-29 03:59:58.005045) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:59:58.008170) ========= 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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 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.009836 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-29 03:59:58.059079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:59:58.059447) ========= 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=928fd09416829678a2f67a56000001ac-1446114646.308354-1943575380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:59:58.110017) ========= ========= Started reboot slave lost (results: 0, elapsed: 5 secs) (at 2015-10-29 03:59:58.110362) ========= ========= Finished reboot slave lost (results: 0, elapsed: 5 secs) (at 2015-10-29 04:00:03.386292) =========