builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1446193178.38 results: success (0) buildid: 20151029012446 builduid: 3d43e8ca7be54163b739961a6150cca7 revision: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.380331) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.380808) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.381137) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005623 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.493537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.493822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.594637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.594914) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.028920 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.644033) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.644351) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.644731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.645013) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-30 01:19:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-10-30 01:19:38 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.206050 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.864687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.865027) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.118689 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.995029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:38.995527) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-30 01:19:39,165 truncating revision to first 12 chars 2015-10-30 01:19:39,166 Setting DEBUG logging. 2015-10-30 01:19:39,166 attempt 1/10 2015-10-30 01:19:39,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5e1587041f9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-30 01:19:39,419 unpacking tar archive at: mozilla-aurora-5e1587041f9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576184 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.584268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.584615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.593440) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.593773) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-30 01:19:39.594278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-10-30 01:19:39.594596) ========= /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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:19:40 INFO - MultiFileLogger online at 20151030 01:19:40 in /builds/slave/test-pgo 01:19:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:19:40 INFO - Guessing talos json url... 01:19:40 INFO - Using buildbot properties: 01:19:40 INFO - { 01:19:40 INFO - "properties": { 01:19:40 INFO - "buildnumber": 14, 01:19:40 INFO - "product": "firefox", 01:19:40 INFO - "script_repo_revision": "production", 01:19:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:19:40 INFO - "repository": "", 01:19:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:19:40 INFO - "buildid": "20151029012446", 01:19:40 INFO - "slavename": "talos-linux64-ix-032", 01:19:40 INFO - "pgo_build": "True", 01:19:40 INFO - "basedir": "/builds/slave/test-pgo", 01:19:40 INFO - "project": "", 01:19:40 INFO - "platform": "ubuntu64_hw", 01:19:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:19:40 INFO - "slavebuilddir": "test", 01:19:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:19:40 INFO - "branch": "mozilla-aurora", 01:19:40 INFO - "repo_path": "releases/mozilla-aurora", 01:19:40 INFO - "stage_platform": "linux64-pgo", 01:19:40 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 01:19:40 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:40 INFO - }, 01:19:40 INFO - "sourcestamp": { 01:19:40 INFO - "repository": "", 01:19:40 INFO - "hasPatch": false, 01:19:40 INFO - "project": "", 01:19:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:40 INFO - "changes": [ 01:19:40 INFO - { 01:19:40 INFO - "category": null, 01:19:40 INFO - "files": [ 01:19:40 INFO - { 01:19:40 INFO - "url": null, 01:19:40 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 01:19:40 INFO - } 01:19:40 INFO - ], 01:19:40 INFO - "repository": "", 01:19:40 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 01:19:40 INFO - "who": "bobowencode@gmail.com", 01:19:40 INFO - "when": 1446115088, 01:19:40 INFO - "number": 6592843, 01:19:40 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 01:19:40 INFO - "project": "", 01:19:40 INFO - "at": "Thu 29 Oct 2015 03:38:08", 01:19:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:40 INFO - "revlink": "", 01:19:40 INFO - "properties": [ 01:19:40 INFO - [ 01:19:40 INFO - "buildid", 01:19:40 INFO - "20151029012446", 01:19:40 INFO - "Change" 01:19:40 INFO - ], 01:19:40 INFO - [ 01:19:40 INFO - "builduid", 01:19:40 INFO - "3d43e8ca7be54163b739961a6150cca7", 01:19:40 INFO - "Change" 01:19:40 INFO - ], 01:19:40 INFO - [ 01:19:40 INFO - "pgo_build", 01:19:40 INFO - "True", 01:19:40 INFO - "Change" 01:19:40 INFO - ] 01:19:40 INFO - ], 01:19:40 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:40 INFO - } 01:19:40 INFO - ], 01:19:40 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:40 INFO - } 01:19:40 INFO - } 01:19:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 01:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:40 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 01:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:40 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt'), kwargs: {}, attempt #1 01:19:41 INFO - Downloaded 107 bytes. 01:19:41 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 01:19:41 INFO - Contents: 01:19:41 INFO - 20151029012446 01:19:41 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:41 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json 01:19:41 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 01:19:41 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/5e1587041f/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 01:19:42 INFO - Downloaded 6818 bytes. 01:19:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:19:42 INFO - '../fennec_ids.txt'], 01:19:42 INFO - 'tests': ['tcheck2']}, 01:19:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:42 INFO - '--tppagecycles', 01:19:42 INFO - '7'], 01:19:42 INFO - 'tests': ['tsvgm']}}, 01:19:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:19:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:19:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:19:42 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:42 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:42 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:42 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:42 INFO - 'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:42 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'tests': ['damp', 'tps']}, 01:19:42 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['damp', 'tps']}, 01:19:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:19:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:42 INFO - 'other': {'tests': ['a11yr', 01:19:42 INFO - 'ts_paint', 01:19:42 INFO - 'tpaint', 01:19:42 INFO - 'sessionrestore', 01:19:42 INFO - 'sessionrestore_no_auto_restore']}, 01:19:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['a11yr', 01:19:42 INFO - 'ts_paint', 01:19:42 INFO - 'tpaint', 01:19:42 INFO - 'sessionrestore', 01:19:42 INFO - 'sessionrestore_no_auto_restore']}, 01:19:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['a11yr', 01:19:42 INFO - 'ts_paint', 01:19:42 INFO - 'tpaint', 01:19:42 INFO - 'sessionrestore', 01:19:42 INFO - 'sessionrestore_no_auto_restore']}, 01:19:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['a11yr', 01:19:42 INFO - 'ts_paint', 01:19:42 INFO - 'tpaint', 01:19:42 INFO - 'sessionrestore', 01:19:42 INFO - 'sessionrestore_no_auto_restore']}, 01:19:42 INFO - 'other_l64': {'tests': ['a11yr', 01:19:42 INFO - 'ts_paint', 01:19:42 INFO - 'tpaint', 01:19:42 INFO - 'sessionrestore', 01:19:42 INFO - 'sessionrestore_no_auto_restore']}, 01:19:42 INFO - 'other_nol64': {'tests': ['a11yr', 01:19:42 INFO - 'ts_paint', 01:19:42 INFO - 'tpaint', 01:19:42 INFO - 'sessionrestore', 01:19:42 INFO - 'sessionrestore_no_auto_restore']}, 01:19:42 INFO - 'svgr': {'tests': ['tsvgx', 01:19:42 INFO - 'tsvgr_opacity', 01:19:42 INFO - 'tart', 01:19:42 INFO - 'tscrollx', 01:19:42 INFO - 'cart']}, 01:19:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['tsvgx', 01:19:42 INFO - 'tsvgr_opacity', 01:19:42 INFO - 'tart', 01:19:42 INFO - 'tscrollx', 01:19:42 INFO - 'cart']}, 01:19:42 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:42 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:42 INFO - 'tests': ['tp5o']}, 01:19:42 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:42 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:42 INFO - 'talos_options': ['--e10s'], 01:19:42 INFO - 'tests': ['tp5o']}, 01:19:42 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:42 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:42 INFO - 'talos_options': ['--xperf_path', 01:19:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:42 INFO - 'tests': ['tp5n']}, 01:19:42 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 01:19:42 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 01:19:42 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:42 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 01:19:42 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 01:19:42 INFO - 'talos_options': ['--e10s', 01:19:42 INFO - '--xperf_path', 01:19:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 01:19:42 INFO - 'C:/slave/talos-data/talos/xperf.config'], 01:19:42 INFO - 'tests': ['tp5n']}}, 01:19:42 INFO - 'talos.zip': {'path': '', 01:19:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:19:42 INFO - {'append_to_log': False, 01:19:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:19:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:19:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:19:42 INFO - 'branch': 'Mozilla-Aurora', 01:19:42 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:42 INFO - 'config_files': ('talos/linux_config.py',), 01:19:42 INFO - 'default_actions': ('clobber', 01:19:42 INFO - 'read-buildbot-config', 01:19:42 INFO - 'download-and-extract', 01:19:42 INFO - 'populate-webroot', 01:19:42 INFO - 'create-virtualenv', 01:19:42 INFO - 'install', 01:19:42 INFO - 'run-tests'), 01:19:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:42 INFO - 'download_minidump_stackwalk': True, 01:19:42 INFO - 'download_symbols': 'ondemand', 01:19:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:42 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:42 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:42 INFO - 'installer_path': 'installer.exe', 01:19:42 INFO - 'log_level': 'info', 01:19:42 INFO - 'log_name': 'talos', 01:19:42 INFO - 'log_to_console': True, 01:19:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:19:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:19:42 INFO - 'opt_config_files': (), 01:19:42 INFO - 'pip_index': False, 01:19:42 INFO - 'python_webserver': False, 01:19:42 INFO - 'sps_profile': False, 01:19:42 INFO - 'sps_profile_interval': 0, 01:19:42 INFO - 'suite': 'dromaeojs', 01:19:42 INFO - 'system_bits': '64', 01:19:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:42 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 01:19:42 INFO - 'tests': (), 01:19:42 INFO - 'title': 'talos-linux64-ix-032', 01:19:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:42 INFO - 'use_talos_json': True, 01:19:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:19:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:42 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 01:19:42 INFO - 'work_dir': 'build'} 01:19:42 INFO - ##### 01:19:42 INFO - ##### Running clobber step. 01:19:42 INFO - ##### 01:19:42 INFO - Running pre-action listener: _resource_record_pre_action 01:19:42 INFO - Running main action method: clobber 01:19:42 INFO - rmtree: /builds/slave/test-pgo/build 01:19:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:19:48 INFO - Running post-action listener: _resource_record_post_action 01:19:48 INFO - ##### 01:19:48 INFO - ##### Running read-buildbot-config step. 01:19:48 INFO - ##### 01:19:48 INFO - Running pre-action listener: _resource_record_pre_action 01:19:48 INFO - Running main action method: read_buildbot_config 01:19:48 INFO - Using buildbot properties: 01:19:48 INFO - { 01:19:48 INFO - "properties": { 01:19:48 INFO - "buildnumber": 14, 01:19:48 INFO - "product": "firefox", 01:19:48 INFO - "script_repo_revision": "production", 01:19:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:19:48 INFO - "repository": "", 01:19:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:19:48 INFO - "buildid": "20151029012446", 01:19:48 INFO - "slavename": "talos-linux64-ix-032", 01:19:48 INFO - "pgo_build": "True", 01:19:48 INFO - "basedir": "/builds/slave/test-pgo", 01:19:48 INFO - "project": "", 01:19:48 INFO - "platform": "ubuntu64_hw", 01:19:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:19:48 INFO - "slavebuilddir": "test", 01:19:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:19:48 INFO - "branch": "mozilla-aurora", 01:19:48 INFO - "repo_path": "releases/mozilla-aurora", 01:19:48 INFO - "stage_platform": "linux64-pgo", 01:19:48 INFO - "builduid": "3d43e8ca7be54163b739961a6150cca7", 01:19:48 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:48 INFO - }, 01:19:48 INFO - "sourcestamp": { 01:19:48 INFO - "repository": "", 01:19:48 INFO - "hasPatch": false, 01:19:48 INFO - "project": "", 01:19:48 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:48 INFO - "changes": [ 01:19:48 INFO - { 01:19:48 INFO - "category": null, 01:19:48 INFO - "files": [ 01:19:48 INFO - { 01:19:48 INFO - "url": null, 01:19:48 INFO - "name": "https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 01:19:48 INFO - } 01:19:48 INFO - ], 01:19:48 INFO - "repository": "", 01:19:48 INFO - "rev": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876", 01:19:48 INFO - "who": "bobowencode@gmail.com", 01:19:48 INFO - "when": 1446115088, 01:19:48 INFO - "number": 6592843, 01:19:48 INFO - "comments": "Bug 1218473: Back out 45ab7cdffbb4 on suspicion of causing spike in CreateWindowEx crashes; r=backout a=lizzard CLOSED TREE", 01:19:48 INFO - "project": "", 01:19:48 INFO - "at": "Thu 29 Oct 2015 03:38:08", 01:19:48 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 01:19:48 INFO - "revlink": "", 01:19:48 INFO - "properties": [ 01:19:48 INFO - [ 01:19:48 INFO - "buildid", 01:19:48 INFO - "20151029012446", 01:19:48 INFO - "Change" 01:19:48 INFO - ], 01:19:48 INFO - [ 01:19:48 INFO - "builduid", 01:19:48 INFO - "3d43e8ca7be54163b739961a6150cca7", 01:19:48 INFO - "Change" 01:19:48 INFO - ], 01:19:48 INFO - [ 01:19:48 INFO - "pgo_build", 01:19:48 INFO - "True", 01:19:48 INFO - "Change" 01:19:48 INFO - ] 01:19:48 INFO - ], 01:19:48 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:48 INFO - } 01:19:48 INFO - ], 01:19:48 INFO - "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876" 01:19:48 INFO - } 01:19:48 INFO - } 01:19:48 INFO - Running post-action listener: _resource_record_post_action 01:19:48 INFO - ##### 01:19:48 INFO - ##### Running download-and-extract step. 01:19:48 INFO - ##### 01:19:48 INFO - Running pre-action listener: _resource_record_pre_action 01:19:48 INFO - Running main action method: download_and_extract 01:19:48 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:48 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:19:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 01:19:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json 01:19:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:19:48 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 01:19:49 INFO - Downloaded 1302 bytes. 01:19:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:19:49 INFO - Using the following test package requirements: 01:19:49 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:49 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:49 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:19:49 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:49 INFO - u'jsshell-linux-x86_64.zip'], 01:19:49 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:49 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:19:49 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:49 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:49 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:19:49 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:49 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:19:49 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:49 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:19:49 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 01:19:49 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 01:19:49 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:19:49 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:49 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:19:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:49 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 01:19:56 INFO - Downloaded 22906880 bytes. 01:19:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:19:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:19:57 INFO - Return code: 0 01:19:57 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:57 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:19:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:19:57 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 01:20:00 INFO - Downloaded 22906880 bytes. 01:20:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:20:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 01:20:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:20:02 INFO - Return code: 0 01:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:02 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:20:02 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'), kwargs: {}, attempt #1 01:20:03 INFO - Downloaded 10881672 bytes. 01:20:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 01:20:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 01:20:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:20:03 INFO - Return code: 0 01:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:03 INFO - https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:20: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.tar.bz2 01:20: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.tar.bz2 01:20: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.tar.bz2 to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:20: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.tar.bz2', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2'), kwargs: {}, attempt #1 01:20:06 INFO - Downloaded 56983114 bytes. 01:20:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:20:06 INFO - mkdir: /builds/slave/test-pgo/properties 01:20:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:20:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:20:06 INFO - Contents: 01:20:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 01:20:06 INFO - Running post-action listener: _resource_record_post_action 01:20:06 INFO - Running post-action listener: _set_extra_try_arguments 01:20:06 INFO - ##### 01:20:06 INFO - ##### Running populate-webroot step. 01:20:06 INFO - ##### 01:20:06 INFO - Running pre-action listener: _resource_record_pre_action 01:20:06 INFO - Running main action method: populate_webroot 01:20:06 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 01:20:06 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 01:20:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 01:20:07 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 01:20:07 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 01:20:07 INFO - Running post-action listener: _resource_record_post_action 01:20:07 INFO - ##### 01:20:07 INFO - ##### Running create-virtualenv step. 01:20:07 INFO - ##### 01:20:07 INFO - Running pre-action listener: _resource_record_pre_action 01:20:07 INFO - Running main action method: create_virtualenv 01:20:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:20:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:20:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:20:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:20:07 INFO - Using real prefix '/usr' 01:20:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:20:11 INFO - Installing distribute.............................................................................................................................................................................................done. 01:20:13 INFO - Installing pip.................done. 01:20:13 INFO - Return code: 0 01:20:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:20: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')]} 01:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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')]} 01:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fdf308e5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:20:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:20:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:20:13 INFO - Using env: {'DISPLAY': ':0', 01:20:13 INFO - 'HOME': '/home/cltbld', 01:20:13 INFO - 'LANG': 'en_US.UTF-8', 01:20:13 INFO - 'LANGUAGE': 'en_US:en', 01:20:13 INFO - 'LOGNAME': 'cltbld', 01:20:13 INFO - 'MAIL': '/var/mail/cltbld', 01:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:13 INFO - 'MOZ_NO_REMOTE': '1', 01:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:13 INFO - 'NO_EM_RESTART': '1', 01:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:13 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:13 INFO - 'SHELL': '/bin/bash', 01:20:13 INFO - 'SHLVL': '1', 01:20:13 INFO - 'TERM': 'linux', 01:20:13 INFO - 'TMOUT': '86400', 01:20:13 INFO - 'USER': 'cltbld', 01:20:13 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:13 INFO - '_': '/tools/buildbot/bin/python'} 01:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:20:13 INFO - Cleaning up... 01:20:13 INFO - Return code: 0 01:20:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:20: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')]} 01:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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')]} 01:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fdf308e5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:20:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:20:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:20:13 INFO - Using env: {'DISPLAY': ':0', 01:20:13 INFO - 'HOME': '/home/cltbld', 01:20:13 INFO - 'LANG': 'en_US.UTF-8', 01:20:13 INFO - 'LANGUAGE': 'en_US:en', 01:20:13 INFO - 'LOGNAME': 'cltbld', 01:20:13 INFO - 'MAIL': '/var/mail/cltbld', 01:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:13 INFO - 'MOZ_NO_REMOTE': '1', 01:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:13 INFO - 'NO_EM_RESTART': '1', 01:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:13 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:13 INFO - 'SHELL': '/bin/bash', 01:20:13 INFO - 'SHLVL': '1', 01:20:13 INFO - 'TERM': 'linux', 01:20:13 INFO - 'TMOUT': '86400', 01:20:13 INFO - 'USER': 'cltbld', 01:20:13 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:13 INFO - '_': '/tools/buildbot/bin/python'} 01:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:13 INFO - Downloading/unpacking psutil>=0.7.1 01:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:15 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:20:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:20:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:15 INFO - Installing collected packages: psutil 01:20:15 INFO - Running setup.py install for psutil 01:20:15 INFO - building 'psutil._psutil_linux' extension 01:20:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:20:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:20:17 INFO - building 'psutil._psutil_posix' extension 01:20:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:20:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:20:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:20:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:20:17 INFO - Successfully installed psutil 01:20:17 INFO - Cleaning up... 01:20:17 INFO - Return code: 0 01:20:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf308e5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:20:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:20:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:20:17 INFO - Using env: {'DISPLAY': ':0', 01:20:17 INFO - 'HOME': '/home/cltbld', 01:20:17 INFO - 'LANG': 'en_US.UTF-8', 01:20:17 INFO - 'LANGUAGE': 'en_US:en', 01:20:17 INFO - 'LOGNAME': 'cltbld', 01:20:17 INFO - 'MAIL': '/var/mail/cltbld', 01:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:17 INFO - 'MOZ_NO_REMOTE': '1', 01:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:17 INFO - 'NO_EM_RESTART': '1', 01:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:17 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:17 INFO - 'SHELL': '/bin/bash', 01:20:17 INFO - 'SHLVL': '1', 01:20:17 INFO - 'TERM': 'linux', 01:20:17 INFO - 'TMOUT': '86400', 01:20:17 INFO - 'USER': 'cltbld', 01:20:17 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:17 INFO - '_': '/tools/buildbot/bin/python'} 01:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:20:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:20:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:20:19 INFO - Installing collected packages: mozsystemmonitor 01:20:19 INFO - Running setup.py install for mozsystemmonitor 01:20:19 INFO - Successfully installed mozsystemmonitor 01:20:19 INFO - Cleaning up... 01:20:19 INFO - Return code: 0 01:20:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:20: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')]} 01:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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')]} 01:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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', '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 0x7fdf308e5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:20: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:20: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 blobuploader==1.2.4 01:20:19 INFO - Using env: {'DISPLAY': ':0', 01:20:19 INFO - 'HOME': '/home/cltbld', 01:20:19 INFO - 'LANG': 'en_US.UTF-8', 01:20:19 INFO - 'LANGUAGE': 'en_US:en', 01:20:19 INFO - 'LOGNAME': 'cltbld', 01:20:19 INFO - 'MAIL': '/var/mail/cltbld', 01:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:19 INFO - 'MOZ_NO_REMOTE': '1', 01:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:19 INFO - 'NO_EM_RESTART': '1', 01:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:19 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:19 INFO - 'SHELL': '/bin/bash', 01:20:19 INFO - 'SHLVL': '1', 01:20:19 INFO - 'TERM': 'linux', 01:20:19 INFO - 'TMOUT': '86400', 01:20:19 INFO - 'USER': 'cltbld', 01:20:19 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:19 INFO - '_': '/tools/buildbot/bin/python'} 01:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:19 INFO - Downloading/unpacking blobuploader==1.2.4 01:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:21 INFO - Downloading blobuploader-1.2.4.tar.gz 01:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:20:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:20:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:20:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:20:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:20:22 INFO - Downloading docopt-0.6.1.tar.gz 01:20:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:20:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:20:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:20:22 INFO - Running setup.py install for blobuploader 01:20:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:20:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:20:22 INFO - Running setup.py install for requests 01:20:22 INFO - Running setup.py install for docopt 01:20:22 INFO - Successfully installed blobuploader requests docopt 01:20:22 INFO - Cleaning up... 01:20:22 INFO - Return code: 0 01:20:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:22 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 0x7fdf308e5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:20:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:20:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:20:22 INFO - Using env: {'DISPLAY': ':0', 01:20:22 INFO - 'HOME': '/home/cltbld', 01:20:22 INFO - 'LANG': 'en_US.UTF-8', 01:20:22 INFO - 'LANGUAGE': 'en_US:en', 01:20:22 INFO - 'LOGNAME': 'cltbld', 01:20:22 INFO - 'MAIL': '/var/mail/cltbld', 01:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:22 INFO - 'MOZ_NO_REMOTE': '1', 01:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:22 INFO - 'NO_EM_RESTART': '1', 01:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:22 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:22 INFO - 'SHELL': '/bin/bash', 01:20:22 INFO - 'SHLVL': '1', 01:20:22 INFO - 'TERM': 'linux', 01:20:22 INFO - 'TMOUT': '86400', 01:20:22 INFO - 'USER': 'cltbld', 01:20:22 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:22 INFO - '_': '/tools/buildbot/bin/python'} 01:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:22 INFO - Running setup.py (path:/tmp/pip-R5xB3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:23 INFO - Running setup.py (path:/tmp/pip-1YuL6X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:23 INFO - Running setup.py (path:/tmp/pip-QG748c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:23 INFO - Running setup.py (path:/tmp/pip-t1ZmGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:23 INFO - Running setup.py (path:/tmp/pip-9oD4Sc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:23 INFO - Running setup.py (path:/tmp/pip-u3ca3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:23 INFO - Running setup.py (path:/tmp/pip-on788Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:23 INFO - Running setup.py (path:/tmp/pip-AGk4O4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:23 INFO - Running setup.py (path:/tmp/pip-OZOet8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:23 INFO - Running setup.py (path:/tmp/pip-4bzg7i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:23 INFO - Running setup.py (path:/tmp/pip-b8N6Aj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:23 INFO - Running setup.py (path:/tmp/pip-QAQXf_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:23 INFO - Running setup.py (path:/tmp/pip-5N8xPs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:23 INFO - Running setup.py (path:/tmp/pip-vdYI5T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:23 INFO - Running setup.py (path:/tmp/pip-em_nDB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:23 INFO - Running setup.py (path:/tmp/pip-ZjM28Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:24 INFO - Running setup.py (path:/tmp/pip-_w9WbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:20:24 INFO - Running setup.py install for manifestparser 01:20:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Running setup.py install for mozcrash 01:20:24 INFO - Running setup.py install for mozdebug 01:20:24 INFO - Running setup.py install for mozdevice 01:20:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Running setup.py install for mozfile 01:20:24 INFO - Running setup.py install for mozhttpd 01:20:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Running setup.py install for mozinfo 01:20:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Running setup.py install for mozInstall 01:20:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:20:24 INFO - Running setup.py install for mozleak 01:20:25 INFO - Running setup.py install for mozlog 01:20:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:20:25 INFO - Running setup.py install for moznetwork 01:20:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:20:25 INFO - Running setup.py install for mozprocess 01:20:25 INFO - Running setup.py install for mozprofile 01:20:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:20:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:20:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:20:25 INFO - Running setup.py install for mozrunner 01:20:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:20:25 INFO - Running setup.py install for mozscreenshot 01:20:25 INFO - Running setup.py install for moztest 01:20:25 INFO - Running setup.py install for mozversion 01:20:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:20:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:20:25 INFO - Cleaning up... 01:20:25 INFO - Return code: 0 01:20:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20: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')]} 01:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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')]} 01:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20: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', '-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 0x7fdf308e5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:20:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:20:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:20:25 INFO - Using env: {'DISPLAY': ':0', 01:20:25 INFO - 'HOME': '/home/cltbld', 01:20:25 INFO - 'LANG': 'en_US.UTF-8', 01:20:25 INFO - 'LANGUAGE': 'en_US:en', 01:20:25 INFO - 'LOGNAME': 'cltbld', 01:20:25 INFO - 'MAIL': '/var/mail/cltbld', 01:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:25 INFO - 'MOZ_NO_REMOTE': '1', 01:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:25 INFO - 'NO_EM_RESTART': '1', 01:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:25 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:25 INFO - 'SHELL': '/bin/bash', 01:20:25 INFO - 'SHLVL': '1', 01:20:25 INFO - 'TERM': 'linux', 01:20:25 INFO - 'TMOUT': '86400', 01:20:25 INFO - 'USER': 'cltbld', 01:20:25 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:25 INFO - '_': '/tools/buildbot/bin/python'} 01:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:26 INFO - Running setup.py (path:/tmp/pip-J_kB7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:26 INFO - Running setup.py (path:/tmp/pip-GFbWY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:26 INFO - Running setup.py (path:/tmp/pip-vgdd2G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:26 INFO - Running setup.py (path:/tmp/pip-bfCD9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:26 INFO - Running setup.py (path:/tmp/pip-NT2LYL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:26 INFO - Running setup.py (path:/tmp/pip-FU0XrG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:26 INFO - Running setup.py (path:/tmp/pip-USIh_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:26 INFO - Running setup.py (path:/tmp/pip-4W2p_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:26 INFO - Running setup.py (path:/tmp/pip-C0D9KF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:26 INFO - Running setup.py (path:/tmp/pip-ht86yA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:26 INFO - Running setup.py (path:/tmp/pip-1rz9ch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:26 INFO - Running setup.py (path:/tmp/pip-L2_hB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 01:20:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:27 INFO - Running setup.py (path:/tmp/pip-c2sVny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:27 INFO - Running setup.py (path:/tmp/pip-Vy6Vny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:27 INFO - Running setup.py (path:/tmp/pip-H471yN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:27 INFO - Running setup.py (path:/tmp/pip-A_8sIc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 01:20:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:27 INFO - Running setup.py (path:/tmp/pip-y1TquM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:20: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 01:20: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 01:20: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 01:20: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 01:20: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 01:20: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 01:20:28 INFO - Downloading blessings-1.5.1.tar.gz 01:20:29 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:20:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:20:29 INFO - Installing collected packages: blessings 01:20:29 INFO - Running setup.py install for blessings 01:20:29 INFO - Successfully installed blessings 01:20:29 INFO - Cleaning up... 01:20:29 INFO - Return code: 0 01:20:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:20:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:20:29 INFO - Reading from file tmpfile_stdout 01:20:29 INFO - Current package versions: 01:20:29 INFO - argparse == 1.2.1 01:20:29 INFO - blessings == 1.5.1 01:20:29 INFO - blobuploader == 1.2.4 01:20:29 INFO - docopt == 0.6.1 01:20:29 INFO - manifestparser == 1.1 01:20:29 INFO - mozInstall == 1.12 01:20:29 INFO - mozcrash == 0.16 01:20:29 INFO - mozdebug == 0.1 01:20:29 INFO - mozdevice == 0.46 01:20:29 INFO - mozfile == 1.2 01:20:29 INFO - mozhttpd == 0.7 01:20:29 INFO - mozinfo == 0.8 01:20:29 INFO - mozleak == 0.1 01:20:29 INFO - mozlog == 3.0 01:20:29 INFO - moznetwork == 0.27 01:20:29 INFO - mozprocess == 0.22 01:20:29 INFO - mozprofile == 0.27 01:20:29 INFO - mozrunner == 6.10 01:20:29 INFO - mozscreenshot == 0.1 01:20:29 INFO - mozsystemmonitor == 0.0 01:20:29 INFO - moztest == 0.7 01:20:29 INFO - mozversion == 1.4 01:20:29 INFO - psutil == 3.1.1 01:20:29 INFO - requests == 1.2.3 01:20:29 INFO - wsgiref == 0.1.2 01:20:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:20:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fdf308e5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbe4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:20:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 01:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:20:29 INFO - Using env: {'DISPLAY': ':0', 01:20:29 INFO - 'HOME': '/home/cltbld', 01:20:29 INFO - 'LANG': 'en_US.UTF-8', 01:20:29 INFO - 'LANGUAGE': 'en_US:en', 01:20:29 INFO - 'LOGNAME': 'cltbld', 01:20:29 INFO - 'MAIL': '/var/mail/cltbld', 01:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:29 INFO - 'MOZ_NO_REMOTE': '1', 01:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:29 INFO - 'NO_EM_RESTART': '1', 01:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:29 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:29 INFO - 'SHELL': '/bin/bash', 01:20:29 INFO - 'SHLVL': '1', 01:20:29 INFO - 'TERM': 'linux', 01:20:29 INFO - 'TMOUT': '86400', 01:20:29 INFO - 'USER': 'cltbld', 01:20:29 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:29 INFO - '_': '/tools/buildbot/bin/python'} 01:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 01:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:20:29 INFO - Cleaning up... 01:20:29 INFO - Return code: 0 01:20:29 INFO - Running post-action listener: _resource_record_post_action 01:20:29 INFO - Running post-action listener: _start_resource_monitoring 01:20:29 INFO - Starting resource monitoring. 01:20:29 INFO - ##### 01:20:29 INFO - ##### Running install step. 01:20:29 INFO - ##### 01:20:29 INFO - Running pre-action listener: _resource_record_pre_action 01:20:29 INFO - Running main action method: install 01:20:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:20:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:20:30 INFO - Reading from file tmpfile_stdout 01:20:30 INFO - Detecting whether we're running mozinstall >=1.0... 01:20:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:20:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:20:30 INFO - Reading from file tmpfile_stdout 01:20:30 INFO - Output received: 01:20:30 INFO - Usage: mozinstall [options] installer 01:20:30 INFO - Options: 01:20:30 INFO - -h, --help show this help message and exit 01:20:30 INFO - -d DEST, --destination=DEST 01:20:30 INFO - Directory to install application into. [default: 01:20:30 INFO - "/builds/slave/test-pgo"] 01:20:30 INFO - --app=APP Application being installed. [default: firefox] 01:20:30 INFO - mkdir: /builds/slave/test-pgo/build/application 01:20:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:20:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:20:44 INFO - Reading from file tmpfile_stdout 01:20:44 INFO - Output received: 01:20:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:20:44 INFO - Running post-action listener: _resource_record_post_action 01:20:44 INFO - ##### 01:20:44 INFO - ##### Running run-tests step. 01:20:44 INFO - ##### 01:20:44 INFO - Running pre-action listener: _resource_record_pre_action 01:20:44 INFO - Running main action method: run_tests 01:20:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:20:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:20:44 INFO - Python 2.7.3 01:20:44 INFO - Return code: 0 01:20:44 INFO - grabbing minidump binary from tooltool 01:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:20:44 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 0x1d50bf0>, '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 0x204e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204e9a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:20:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 01:20:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:20:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:20:44 INFO - Return code: 0 01:20:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:20:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:20:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:20:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:20:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:20:44 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-032', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:20:44 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-032 --webServer localhost 01:20:44 INFO - Using env: {'DISPLAY': ':0', 01:20:44 INFO - 'HOME': '/home/cltbld', 01:20:44 INFO - 'LANG': 'en_US.UTF-8', 01:20:44 INFO - 'LANGUAGE': 'en_US:en', 01:20:44 INFO - 'LOGNAME': 'cltbld', 01:20:44 INFO - 'MAIL': '/var/mail/cltbld', 01:20:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:20:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:20:44 INFO - 'MOZ_NO_REMOTE': '1', 01:20:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:20:44 INFO - 'NO_EM_RESTART': '1', 01:20:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:20:44 INFO - 'PWD': '/builds/slave/test-pgo', 01:20:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:20:44 INFO - 'SHELL': '/bin/bash', 01:20:44 INFO - 'SHLVL': '1', 01:20:44 INFO - 'TERM': 'linux', 01:20:44 INFO - 'TMOUT': '86400', 01:20:44 INFO - 'USER': 'cltbld', 01:20:44 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271', 01:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:20:44 INFO - '_': '/tools/buildbot/bin/python'} 01:20:44 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-032', '--webServer', 'localhost'] with output_timeout 3600 01:20:45 INFO - mozversion INFO | application_buildid: 20151029012446 01:20:45 INFO - mozversion INFO | application_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:20:45 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 01:20:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:20:45 INFO - mozversion INFO | application_name: Firefox 01:20:45 INFO - mozversion INFO | application_remotingname: firefox-dev 01:20:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:45 INFO - mozversion INFO | application_vendor: Mozilla 01:20:45 INFO - mozversion INFO | application_version: 43.0a2 01:20:45 INFO - mozversion INFO | platform_buildid: 20151029012446 01:20:45 INFO - mozversion INFO | platform_changeset: 5e1587041f9a9724055f62c0c5a9f7e9c9c54876 01:20:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:20:45 INFO - mozversion INFO | platform_version: 43.0a2 01:20:45 INFO - 2015-10-30 01:20:45,032 DEBUG : using testdate: 1446193245 01:20:45 INFO - 2015-10-30 01:20:45,032 DEBUG : actual date: 1446193245 01:20:45 INFO - 2015-10-30 01:20:45,041 INFO : Starting test suite talos-linux64-ix-032 01:20:45 INFO - 2015-10-30 01:20:45,041 INFO : Starting test dromaeo_css 01:20:45 INFO - 2015-10-30 01:20:45,041 DEBUG : operating with platform_type : linux_ 01:20:45 INFO - 2015-10-30 01:20:45,041 INFO : Initialising browser for dromaeo_css test... 01:20:45 INFO - 2015-10-30 01:20:45,149 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUpb0tF/profile http://localhost/getInfo.html 01:20:50 INFO - 2015-10-30 01:20:50,460 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:20:50 INFO - 2015-10-30 01:20:50,460 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:20:50 INFO - 2015-10-30 01:20:50,460 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:20:50 INFO - 2015-10-30 01:20:50,460 DEBUG : BROWSER_OUTPUT: __metrics 01:20:50 INFO - 2015-10-30 01:20:50,577 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:51 INFO - 2015-10-30 01:20:51,919 INFO : Browser initialized. 01:20:51 INFO - 2015-10-30 01:20:51,920 INFO : Running cycle 1/1 for dromaeo_css test... 01:20:51 INFO - 2015-10-30 01:20:51,920 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUpb0tF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:21:03 INFO - 2015-10-30 01:21:03,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 132427776 01:21:03 INFO - 2015-10-30 01:21:03,613 DEBUG : BROWSER_OUTPUT: 01:24:03 INFO - 2015-10-30 01:24:03,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-dojo.html (next: http://localhost/page_load_test/dromaeo/cssquery-ext.html) 01:24:04 INFO - 2015-10-30 01:24:04,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 224673792 01:24:04 INFO - 2015-10-30 01:24:04,170 DEBUG : BROWSER_OUTPUT: 01:27:06 INFO - 2015-10-30 01:27:06,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-ext.html (next: http://localhost/page_load_test/dromaeo/cssquery-jquery.html) 01:27:06 INFO - 2015-10-30 01:27:06,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 214368256 01:27:06 INFO - 2015-10-30 01:27:06,715 DEBUG : BROWSER_OUTPUT: 01:30:08 INFO - 2015-10-30 01:30:08,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-jquery.html (next: http://localhost/page_load_test/dromaeo/cssquery-mootools.html) 01:30:09 INFO - 2015-10-30 01:30:09,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 212049920 01:30:09 INFO - 2015-10-30 01:30:09,143 DEBUG : BROWSER_OUTPUT: 01:33:10 INFO - 2015-10-30 01:33:10,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-mootools.html (next: http://localhost/page_load_test/dromaeo/cssquery-prototype.html) 01:33:11 INFO - 2015-10-30 01:33:11,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 200822784 01:33:11 INFO - 2015-10-30 01:33:11,403 DEBUG : BROWSER_OUTPUT: 01:36:13 INFO - 2015-10-30 01:36:13,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-prototype.html (next: http://localhost/page_load_test/dromaeo/cssquery-yui.html) 01:36:14 INFO - 2015-10-30 01:36:14,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 193662976 01:36:14 INFO - 2015-10-30 01:36:14,336 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-yui.html (next: http://localhost/page_load_test/dromaeo/cssquery-dojo.html) 01:39:16 INFO - 2015-10-30 01:39:16,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 238399488 01:39:16 INFO - 2015-10-30 01:39:16,676 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,677 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:39:16 INFO - 2015-10-30 01:39:16,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:39:16 INFO - 2015-10-30 01:39:16,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:39:16 INFO - 2015-10-30 01:39:16,677 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:39:16 INFO - 2015-10-30 01:39:16,679 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3352.832358382081;3394.7453940954433;3421.794692318462;3429.0055883793684;3434.8454319555617;5754.71226438678;5758.510526605243;5768.077107662775;5771.567132465061;5784;5774.797882074128;5784.884302313952;5800.651960882339;5810.941890581093;5817.040188368914;5213.9478605214035;5258.737063146837;5287.762050707708;5287.841364759063;5351.063563876306;5278.049951008817;5284.365876094874;5292;5296.496832800897;5300.125479295912;5062.417821950486;5182.196759502283;5190.688558686472;5213.530782229617;5287.339082614673;5277.947220527803;5319.973400132994;5325.174597937326;5325.360956685184;5331.866703332447;5103.260027296022;5218.817341393033;5219.869503262411;5266.34170728659;5267.525922666979;5399.865003374908;5522.723863806834;5545.944540554583;5550.417206193332;5556.86107847303;6219.502439804804;6243.875122497525;6261.749530018794;6265.122882796412;6265.436110750009;6042.184305118797;6093.6039157454625;6270.435660790551;6301.936980630181;6306.054091886208;5669.036263835158;5762.567807414461;5762.942370576283;5767.134929760486;5791.247137872049;6277.403646653561;6289.213848268966;6307.400796924285;6309.179806625201;6311.053341998737;5984.640921544721;6071.241094863142;6088.665123418255;6164.753409863555;6208.782692605737;6242.625442473466;6247.625142491465;6275.090111933744;6280.214973128359;6296.212973378328;6227.1282020517165;6229.1590635264565;6233.563650544418;6234.2830574484515;6235.376462353819;6045.516358691382;6069.575129740964;6136.028952951454;6143.372006418303;6232.345603711636;4684.906301873943;4685.789139488731;4694.037722266927;4694.95305046952;4713.835015774432;4195.202911446815;4199.118185181085;4199.328107502785;4201.663866890642;4205.2640787862;5667.263255776723;5741.598088133791;5776.5089967352405;5807.157962095473;5872.0898260769645;6242.344553821874;6246.875062498815;6298.937010629927;6307.211598550181;6317.368263173646;5903.645781253139;5918.556108291896;5932.110183472428;5937.079752638348;5941.197938278277;5225.973870130625;5274.525292723673;5335.626506144533;5382.138857782814;5391.973040134774;6365.458935990493;6391.169148010729;6393.552451328455;6393.7122829471855;6394.680265986682;6108.409796619265;6204.09220925484;6230.875382492415;6234.688265586793;6238.563300568917;6290.465310448663;6407;6417.326180750954;6419.807405777834;6421.743130274736;6200.658963756856;6212.192414986023;6220.409061139185;6222.973209420395;6227.657478838707;6116.204893364013;6224.937750622617;6320.905186422299;6330.430261276507;6337.9366206337345;6060.939390606038;6171.6297022178815;6174.8147555573405;6183.288921774054;6186.907196391968;6117.571769976237;6144.109104179958;6145.477634401126;6148.139260503623;6170.938290617037;5865.765369385177;5890.204822348928;5958.851028724316;6071.119687645355;6077.179580756718;6168.167297414791;6169.84575385601;6177.81466556004;6180.0111982084445;6187.041008643668;5994.55040871945;6008.399160083956;6043.214382130295;6076.270847498328;6078.908816367846 01:39:16 INFO - 2015-10-30 01:39:16,682 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.7106446776609;604.0395770724548;620.624522164091;620.9939897366266;626.7743612299569;35548.822255888714;44628.3305750414;45327.32009019859;45332.09335813282;45392.09215815682;48580.757096214555;48870.755646221805;49297;49319.50680493194;49388.50611493884;8141.877871831927;8249.546274954875;9151.130642588943;9325.673601423918;10702.197335199891;10860.34837909724;11067.335959842436;11069.889301106967;11074.335539867594;11088.94655007773;10904.563817447293;11069.778604427947;11080.833787493195;11083.889161108365;11084.501197446134;10909;10929.344239345584;10931.070858976997;10942.23404361695;11032;10765.623203187852;10873.619423320224;10876.075533579655;10895;10898.618548350769;45960.54039459596;46337;46380.536194637956;46409;46451.30323045157;3789.3558095123894;3862.575116737157;3874.0508575398926;4408.823647054146;4448.021435284265;33766.83116584426;34332.14169645754;34390;34417;34485.82757086224;3312.817795021273;3350.6816852398983;3377.814220217887;3461.498082778008;3542.0436482149676;346900;347455.9999999975;348469;348515;348679;57343.71328143332;58352.41647583555;65595;66317.66841165764;66425.33574664191;61321.38678613246;61570;61732.69133654303;61800.69099654473;61805.69097154486;18043.458696239133;18071.367502137364;18599.25602975893;18785.906070469835;18794.154263058193;14132.717345653029;14176.291185440892;14200.644983875485;14212.573622791126;14307;21021.89489052545;21331.573368532852;21333.78666213318;21335.146594136062;21357.78642213589;8481.830363392697;8747.956260218658;8775.868361974575;8893.28853691703;8919.152680495343;1117.474786850179;1195.0439648281515;1199.9820002699967;1200.7118291610125;1245.688577855536;31076.223094422367;31135.706451290986;31249.687503125133;31860.840695796836;31976.36047279088;1245.2777389114292;1253.8808813162734;1272.3256673962815;1365.5015919189425;1381.9930900345435;15306.234688265542;16716.916415417843;16752.162391880356;16784.328626855033;16931.492055238363;429098;434418;435068;437017;438007;57593.424065759646;57911.420885790605;58120.128198077065;58146.70926645424;58158;1474.3512854344053;1504.090025534536;1515.3559737111684;1518.5140754958306;1521.8325984141957;32308.192295191868;32543.674563254066;32738.181545461553;33201.66798331986;33630.3273934515;50126;50195.996080077464;50286.245706313704;50504.49495504998;50523.24215136703;225827;227391;352670;400520;402211;33166.17084572905;33239;33391.49912751262;33422.16444588808;33703.3259334807;47550.76224618855;48734.26898596595;49091;49173.26240106473;49270.75364623154;40513.59486405216;40955;41056.79471602623;41629.58370416257;42086.78956605197;41734.58265417307;41951;42008.78995605002;42119.57880421157;42380.36429453499;41967.790161049;42776.78611606922;42915.785421073946;42925;42977.3553396693;36062.45906311355;37184.81407592945;37493.81253093717;37900.48398064046;38130;28107;28312.451879330958;28410;28442.288942776595;28481.857590711912 01:39:16 INFO - 2015-10-30 01:39:16,682 DEBUG : BROWSER_OUTPUT: |2;jquery.html;423.39031794216305;424.134765079238;429.8688899885536;430.3738061121068;439.1831193979198;15843.92078039611;16368.672626547463;19093.904530477346;19489.317873874417;19621.31325403611;19371.709424358647;19636.41090767279;19787.703184452246;19789.20843166275;20702.585948281027;6330.366963303667;6416.262129855079;6419.358064193567;6440.162778838744;6483.189601299838;4428.247197976336;4551.112533056055;6980.092587963558;7065.858682826341;7309.597972111532;7128.85742285154;7224.2414546472655;7241.094863142107;7290.343869051784;7297.124345078598;7254.27457254273;7269.454790890704;7287.125544934642;7288.3804876585555;7289.5261807982315;6457.257415397243;6457.418832305115;6460.903086453707;6536.477081833489;7007.684654190573;27104.59343109855;27267.590986135026;27425.17724468269;27541.86229068842;27707;2514.0572285392977;2559.3089865736333;2616.856072915989;2622.252657992482;2644.4975454663554;15629.609259768484;15783.921080394639;16083.597910052342;16209.270582823683;16368.427105051265;2066.183857376328;2136.060133541237;2136.743590769102;2182.923597674074;2203.5923354179527;81363;81823.5908820458;82652.58673706654;83061.58469207675;83145;17233.913830431018;17732.822671773374;17750.28998840058;17870.46388608344;17894.55263618394;28316.8584157082;28437.431251374855;28687.85656071748;28730.132541384744;28858.567121493194;6662.86674266512;6768.323167683291;6807.965960170168;6812.829679258059;9861.309708320348;7197.064381630355;7203.89194162088;7232.349088582053;7248.420126389876;7254.637268136572;3671.045528162697;3846.5576458707046;3850.4609354690365;3855.248226595843;3891.3190191716335;1317.617890811673;1332.4869925078915;1351.6823546466574;1360.088740543838;1371.4240019191964;541.2692864632714;553.3498139685853;556.7605929450375;575.1171951055111;596.2457491273542;11577.942110289563;13062.281574513303;13323.313808531033;13848.268966379203;14177.929110354382;568.1591244957486;572.9111987641922;586.7887560478224;589.5607772209731;601.5097695378253;7550.6602202901;7655.693772249159;7680.462367634212;7809;7875.488093274033;621343;637129;641514;647125;655609;83145;84021;84189;85032;92836;610.0330975403946;615.6644628677382;630.9905351419733;634.0679201573679;635.3741564558906;12719.236845789283;12884.806727899277;13095.214287142802;13137.277449740355;13173.802392964304;41767.53813616509;42515.7874210627;43581;45192;48475;60689;61030.69484652548;61318.69340653447;61428.385716142264;62533.374666254575;16584.839061265597;16624.83375166233;16650;16998.74501882448;17001.574960626083;19865;20312.59374812466;20405.897970510647;21070.26254081161;21359.89320053452;17440;17463.825361746727;17767.555811104827;17790.37733679315;17866.374676886247;10201.489925503547;11498.13763967689;11636.185467017227;11993.160478766751;12186.634400967985;10447.425391603534;10597.735056623338;12157.513699451923;12258.816117758419;12494.187877787916;16779.58051048685;17023.148842558072;17353.30586776515;17504.474865754048;17549.298028078734;17776.733348999518;17802.5549361267;18025.369112081014;18030.36893708714;18344.08279586042 01:39:16 INFO - 2015-10-30 01:39:16,686 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1552.7981362422884;1684.663067386523;1790.8209179082091;2034.847386446016;2068.7724350321464;9507.904920950798;10198.694039178827;10399.116075133605;10412.947935260314;10414.323069000518;9907;10195.847062294071;10212.2851400402;10219.540120694568;10240.487975601209;2111.7360329958756;2134.1890081768906;2469.086438017936;2474.1093206445667;2483.5902076157413;2523.3817714659936;2550.1074623881677;2552.910648127316;2553;2556.2203527923975;2512.1207577347964;2535.467551814121;2538.6445897574354;2540.3014171103;2542.4406630541253;2188.7482939461925;2232.520008198237;2468.9753102468926;2524.532961402128;2525.1162093267394;2502;2530.1776922500076;2539.9746002539923;2582.1478911959007;2586.3792689754323;10749.355038697704;10792.352458852494;10835.67492975212;10859.18556108295;10862.837057444145;5755.942440575583;5825.679587622679;5829.067349224146;5833.591648584601;5836.649801011953;3747.756395834262;3803.182315802088;3828.617138286177;3832.405977073558;3841.116543195081;1121;1149.8735139134687;1163.2264544078178;1176.476467971753;1185.1230089733622;16508.33966641333;16539.50381488557;16554.917225413916;16556.42052528168;16571.91714041422;5351.973240133852;5377.489138531833;5389.326334208224;5434.076207044812;5434.8913021739345;12474;12495.375231238402;12545.12184147101;12564.308963006939;12567.685807854694;5879.088741245114;5909.143174239797;5909.202257695242;5911.349751527328;5924.881502369928;5332.120200166929;5345.171498417673;5348.866278343073;5349.491798279158;5350.652207606493;4615.16926953145;4631.235846085426;4642.837500687459;4647.744374059392;4705.6470764692785;1354.1671871798774;1378.5244090788663;1384.8753612174953;1392.5474220878052;1414.1444426122048;1198.9100817438728;1253.924764514132;1268.7462507498537;1488.3971991343524;1491.7240310542584;9669.129778319984;9940.353876997971;9959.253056020827;9969.750756231153;9970.501474926225;571.8227349521661;577.9364269930304;581.776016233753;582.3681305783188;586.4165155670136;7487.352782387866;7490.101187857492;7573.46985710995;7576.01511803462;7614.048243969504;13530.864691353157;13756.862431375559;13764.724705505834;13789.655258618615;13814.102083364549;13331;13710.588682339545;13711.725765484834;13712.725745485035;13720.451181952809;9754.707358779247;9879.950600246953;9955.55200016001;10020.09819116283;10030.147437467896;9317.72046838596;9376.249900008119;9439.48082855422;9454.858177127211;9456.385334953206;11671.59149429766;11788.823167652321;11823.290602563873;11845.111616628616;11938;11908.34504102248;12060.75878482443;12181.39093045362;12186.329751863732;12207.938960305142;8753.956230218808;8829.11708829112;8887.244584210155;8887.866681999905;8897.2882169425;10169.694909152737;10322.845157322496;10356.171506279328;10374.325668831501;10384.480775961323;8314;9497.43015419077;9527.761805954906;9666.468344241135;9690.37012594179;8708.869366959374;9379.577918993798;9465.526723663652;9504.477253750834;9626.807463850824;9194.724158275263;9233.538323083685;9366.718998430058;9379.81240375175;9406.200472959876;8033.799155021171;8058.959705201437;8069.59652017385;8086.1913808618665;8088.757337279891;8615.22462978335;8636.697715579925;8703.738887833375;8824.029356770621;8838.381313308008 01:39:16 INFO - 2015-10-30 01:39:16,686 DEBUG : BROWSER_OUTPUT: |4;prototype.html;397.2332702725517;403.44929171680644;407.82259717023095;408.5138684964892;412.1180673359014;5858.472737453629;5984.311804142525;6025.066114752215;6034.547408944325;6108.022716365383;5900.911486327708;5949.6727679977585;5969.611975221618;5991.940080599193;5993.310769261536;4623.214053610877;4654.115718013567;4705.882352941187;4740.2889566564945;4762.595179409737;4748.240281554952;4761.047790441909;4764.666473346867;4765.880852978686;4773.594244489223;4718.127146477896;4721.504242054586;4726.976365118169;4728.290756386536;4730.385049943503;4681.321208424793;4715.269133284346;4723.055388922212;4736.905261894777;4740.075685241397;4126.112885729583;4192.763134875188;4209.852655157055;4238.17355615652;4282.721623094489;5696.401877802812;5702.572307076985;5708.600397972144;5710.114932185518;5720.485156335908;5263.815766448156;5460.071787796084;5461.836144915659;5462.126059830448;5462.945370546284;6183.319834818167;6240.0327949167495;6280.309165991737;6320.241571011462;6326.367363263683;4593.63250939924;4612.123696497688;4616.376789133491;4617.191991401525;4618.307253911907;6458.160439142928;6523.902141467882;6527;6527.086207930894;6530.869382612369;4650.18621741194;4716.29255611661;4742;4751.216049351888;4760.880977975578;4854.417469903634;4861.076395484846;4861.392325959255;4861.586765125004;4861.659683822169;5482.122860342326;5487.917681234785;5491.28613280271;5492.5605951523785;5493.533049690741;6300.9684951574945;6427.967860160669;6429.58207716497;6433.903491447632;6439.098526206335;1740.1560243282;1757;1759.568905618106;1760.6918789212093;1761.6652835961127;1193.1290158184574;1197.9341136237417;1213.3326670331282;1226.466487078124;1236.4806781151938;6087.178230938766;6112.113743507255;6113.480354169946;6119.694015299307;6126.479249263773;6546.803595892131;6547.443467305237;6624.105745724362;6625.17185351831;6635.2037755469655;6015.0977353396465;6159.599626024294;6161.938380616226;6166.876662466815;6168.8766224675255;3629.872954446582;3636.30910127075;3653.232821107544;3674.0447483654443;3674.779513229215;6766.5263431559315;6813.727450901908;6816.0457535944015;6817.863642727118;6827.2831352708245;6672.833179170462;6777.695003724844;6781.559198652072;6781.694823732944;6785.219699734495;6599.307072757388;6661.067450556926;6722.932770672329;6824.488163387766;6832.521723479408;6575.704093315717;6575.868482630225;6597.109390232449;6598.274189839018;6612.735490580323;6491.35086491366;6503.089567460654;6504.837379065561;6508.8047358579315;6511.055896895018;6648.468122550281;6790.117284752951;6791.0832037676255;6794;6795.116634837439;4822.662413631012;4824.396950381202;4827.975860120677;4828.275758636232;4831.710097394168;6631.204255489372;6661.633610151488;6668.6665666717445;6671.366220209073;6671.966640166768;6343.143675603735;6444.420002199825;6445.677716114269;6445.70994305248;6483.805485835433;6387.361263873576;6417.2299324081405;6423.614583125028;6427.068075129174;6439.871202575829;6298.874022519615;6318.27339855904;6320.652364120017;6322.399372059647;6328.0824280478155;6328.588641738273;6500.934990650033;6539.411452969255;6542.084108224947;6544.411003009562;6380.585261958144;6381.585196962183;6394.71223794921;6395.584287021329;6395.6802159890885 01:39:16 INFO - 2015-10-30 01:39:16,690 DEBUG : BROWSER_OUTPUT: |5;yui.html;851.3614788908319;892.3619611977435;899.7885496908225;968.6416026070355;976.462945380041;11130.49912753926;11448.999999999989;11450.312981221132;11451.656450306484;11464.541418343266;13377.732445351086;13464.461421543127;13477.932610336959;13479.730405391887;13490.662733431669;776.3944123583585;788.3850596534712;922.9077092290768;929.730378190324;952.1478276942132;937.1191080384451;937.3625934364629;944.8866136063682;945.1399226703701;947.3889341374809;813.4143416739938;1000.104906109032;1003.8042581696573;1005.316384858296;1007.0885848307257;823.0082750285922;987.2151639446621;1001.1740314240708;1001.754570130319;1002.7292630989665;736.5911918885016;741.0107506478857;741.6736635880195;741.6996116572797;742.3726950726627;13114;13281.335933203301;13324.267165305904;13328.800067998987;13434.261115638636;11683.7079073023;12237.898589127022;12401.317927513983;12411.689707757288;12653.240805551604;10704.839427408595;10759.892401076046;10853.565857365775;10859.18556108295;10934.398608076554;3617.94573081404;3673.9081522961874;3675.5773086095173;3675.6691897729065;3720.776753394805;40756;40914;41251.38122928129;44945.550544494465;44949;7990.280874721303;8063.19368063189;8064.879026814602;8072;8072.919270807334;12709;12717.046221533423;12736.617901462785;12745.10784245094;12760.29818359999;7185.6766445510075;7292.8176795579475;7397.334239918433;7430;7519.661615227328;4381.6494680425485;4500.099980004013;4501.257292546758;4656.4877863434995;4704.153252414599;3055.724984751383;3078.5536097266217;3083.537469379566;3087.243625311813;3088.5521599367967;517.0279873837162;521.8121476268541;522.6681057528497;523.8454655876526;528.3211073770187;545.7871430142247;677.9220389655154;742.7251916790714;767.6890859202032;782.5461232485145;8433.156684331518;8636.956815215884;8680.913190868137;8845.159709827556;8940.15068568485;548.0600769680018;587.2072701852464;622.8816524860262;625.7309356976543;657.5824351536809;4265.701400901907;4327.459067616548;4375.387445757597;4421.248387774086;4510.323451482304;55193;55975.72012139994;56056.15915761267;56265.43734562684;56290.718546407006;48914.26628600574;49474;49557.752211238716;49603.25595116076;49824;40792.98017549526;41019.38470922939;41427.7928610355;41672;41773.58226417697;8470.576471176293;8617.267532259828;8677.088905664814;8694.869576956477;8722.781930451789;28073.859630701714;28329.71670283271;28355.716442836132;28493.715062849107;28643.118124247103;37493.625063749016;39407.60592394039;39644.801775990934;39747.60252397439;40220.58676479421;8236.423450358658;8244.958775206325;8245.587720614065;8293.58532073406;8489.533075680896;11272.3800190987;11562;11707.531698731955;12112.394380280775;12389.008879289455;10512.894871051192;10554;10843.403612801372;11099.889001109885;11131.443427828739;11020.338779673246;11327.352745407803;11391.601293954673;11461.369624670722;11636.36000020007;10256.58973641046;10325.019123183285;10579.36523808574;10855.023047925724;11513.13651476126;10015.799684006424;10015.799684006424;10432.582696692047;10567.735806604896;10964.890351096386;10014.64948726791;10033.44816035125;10049.949750251202;10214.336068155546;10253.58985640566 01:39:16 INFO - 2015-10-30 01:39:16,690 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:39:16 INFO - 2015-10-30 01:39:16,690 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:39:16 INFO - 2015-10-30 01:39:16,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,728 01:39:16 INFO - 2015-10-30 01:39:16,691 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:39:16 INFO - 2015-10-30 01:39:16,691 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194356675__endTimestamp 01:39:16 INFO - 2015-10-30 01:39:16,691 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,691 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:39:16 INFO - 2015-10-30 01:39:16,692 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:39:16 INFO - 2015-10-30 01:39:16,692 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,692 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5762.49 Median:6043.21 stddev:665.47 (11.0%) stddev-sans-first:640.10 01:39:16 INFO - 2015-10-30 01:39:16,693 DEBUG : BROWSER_OUTPUT: Values: 3352.8 3394.7 3421.8 3429.0 3434.8 5754.7 5758.5 5768.1 5771.6 5784.0 5774.8 5784.9 5800.7 5810.9 5817.0 5213.9 5258.7 5287.8 5287.8 5351.1 5278.0 5284.4 5292.0 5296.5 5300.1 5062.4 5182.2 5190.7 5213.5 5287.3 5277.9 5320.0 5325.2 5325.4 5331.9 5103.3 5218.8 5219.9 5266.3 5267.5 5399.9 5522.7 5545.9 5550.4 5556.9 6219.5 6243.9 6261.7 6265.1 6265.4 6042.2 6093.6 6270.4 6301.9 6306.1 5669.0 5762.6 5762.9 5767.1 5791.2 6277.4 6289.2 6307.4 6309.2 6311.1 5984.6 6071.2 6088.7 6164.8 6208.8 6242.6 6247.6 6275.1 6280.2 6296.2 6227.1 6229.2 6233.6 6234.3 6235.4 6045.5 6069.6 6136.0 6143.4 6232.3 4684.9 4685.8 4694.0 4695.0 4713.8 4195.2 4199.1 4199.3 4201.7 4205.3 5667.3 5741.6 5776.5 5807.2 5872.1 6242.3 6246.9 6298.9 6307.2 6317.4 5903.6 5918.6 5932.1 5937.1 5941.2 5226.0 5274.5 5335.6 5382.1 5392.0 6365.5 6391.2 6393.6 6393.7 6394.7 6108.4 6204.1 6230.9 6234.7 6238.6 6290.5 6407.0 6417.3 6419.8 6421.7 6200.7 6212.2 6220.4 6223.0 6227.7 6116.2 6224.9 6320.9 6330.4 6337.9 6060.9 6171.6 6174.8 6183.3 6186.9 6117.6 6144.1 6145.5 6148.1 6170.9 5865.8 5890.2 5958.9 6071.1 6077.2 6168.2 6169.8 6177.8 6180.0 6187.0 5994.6 6008.4 6043.2 6076.3 6078.9 01:39:16 INFO - 2015-10-30 01:39:16,693 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,693 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55351.05 Median:348597.00 stddev:98300.13 (28.2%) stddev-sans-first:98489.87 01:39:16 INFO - 2015-10-30 01:39:16,693 DEBUG : BROWSER_OUTPUT: Values: 578.7 604.0 620.6 621.0 626.8 35548.8 44628.3 45327.3 45332.1 45392.1 48580.8 48870.8 49297.0 49319.5 49388.5 8141.9 8249.5 9151.1 9325.7 10702.2 10860.3 11067.3 11069.9 11074.3 11088.9 10904.6 11069.8 11080.8 11083.9 11084.5 10909.0 10929.3 10931.1 10942.2 11032.0 10765.6 10873.6 10876.1 10895.0 10898.6 45960.5 46337.0 46380.5 46409.0 46451.3 3789.4 3862.6 3874.1 4408.8 4448.0 33766.8 34332.1 34390.0 34417.0 34485.8 3312.8 3350.7 3377.8 3461.5 3542.0 346900.0 347456.0 348469.0 348515.0 348679.0 57343.7 58352.4 65595.0 66317.7 66425.3 61321.4 61570.0 61732.7 61800.7 61805.7 18043.5 18071.4 18599.3 18785.9 18794.2 14132.7 14176.3 14200.6 14212.6 14307.0 21021.9 21331.6 21333.8 21335.1 21357.8 8481.8 8748.0 8775.9 8893.3 8919.2 1117.5 1195.0 1200.0 1200.7 1245.7 31076.2 31135.7 31249.7 31860.8 31976.4 1245.3 1253.9 1272.3 1365.5 1382.0 15306.2 16716.9 16752.2 16784.3 16931.5 429098.0 434418.0 435068.0 437017.0 438007.0 57593.4 57911.4 58120.1 58146.7 58158.0 1474.4 1504.1 1515.4 1518.5 1521.8 32308.2 32543.7 32738.2 33201.7 33630.3 50126.0 50196.0 50286.2 50504.5 50523.2 225827.0 227391.0 352670.0 400520.0 402211.0 33166.2 33239.0 33391.5 33422.2 33703.3 47550.8 48734.3 49091.0 49173.3 49270.8 40513.6 40955.0 41056.8 41629.6 42086.8 41734.6 41951.0 42008.8 42119.6 42380.4 41967.8 42776.8 42915.8 42925.0 42977.4 36062.5 37184.8 37493.8 37900.5 38130.0 28107.0 28312.5 28410.0 28442.3 28481.9 01:39:16 INFO - 2015-10-30 01:39:16,693 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,694 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34715.56 Median:3758.80 stddev:104706.80 (2785.6%) stddev-sans-first:104968.87 01:39:16 INFO - 2015-10-30 01:39:16,695 DEBUG : BROWSER_OUTPUT: Values: 423.4 424.1 429.9 430.4 439.2 15843.9 16368.7 19093.9 19489.3 19621.3 19371.7 19636.4 19787.7 19789.2 20702.6 6330.4 6416.3 6419.4 6440.2 6483.2 4428.2 4551.1 6980.1 7065.9 7309.6 7128.9 7224.2 7241.1 7290.3 7297.1 7254.3 7269.5 7287.1 7288.4 7289.5 6457.3 6457.4 6460.9 6536.5 7007.7 27104.6 27267.6 27425.2 27541.9 27707.0 2514.1 2559.3 2616.9 2622.3 2644.5 15629.6 15783.9 16083.6 16209.3 16368.4 2066.2 2136.1 2136.7 2182.9 2203.6 81363.0 81823.6 82652.6 83061.6 83145.0 17233.9 17732.8 17750.3 17870.5 17894.6 28316.9 28437.4 28687.9 28730.1 28858.6 6662.9 6768.3 6808.0 6812.8 9861.3 7197.1 7203.9 7232.3 7248.4 7254.6 3671.0 3846.6 3850.5 3855.2 3891.3 1317.6 1332.5 1351.7 1360.1 1371.4 541.3 553.3 556.8 575.1 596.2 11577.9 13062.3 13323.3 13848.3 14177.9 568.2 572.9 586.8 589.6 601.5 7550.7 7655.7 7680.5 7809.0 7875.5 621343.0 637129.0 641514.0 647125.0 655609.0 83145.0 84021.0 84189.0 85032.0 92836.0 610.0 615.7 631.0 634.1 635.4 12719.2 12884.8 13095.2 13137.3 13173.8 41767.5 42515.8 43581.0 45192.0 48475.0 60689.0 61030.7 61318.7 61428.4 62533.4 16584.8 16624.8 16650.0 16998.7 17001.6 19865.0 20312.6 20405.9 21070.3 21359.9 17440.0 17463.8 17767.6 17790.4 17866.4 10201.5 11498.1 11636.2 11993.2 12186.6 10447.4 10597.7 12157.5 12258.8 12494.2 16779.6 17023.1 17353.3 17504.5 17549.3 17776.7 17802.6 18025.4 18030.4 18344.1 01:39:16 INFO - 2015-10-30 01:39:16,695 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,695 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7273.29 Median:2552.96 stddev:4237.85 (166.0%) stddev-sans-first:4227.93 01:39:16 INFO - 2015-10-30 01:39:16,696 DEBUG : BROWSER_OUTPUT: Values: 1552.8 1684.7 1790.8 2034.8 2068.8 9507.9 10198.7 10399.1 10412.9 10414.3 9907.0 10195.8 10212.3 10219.5 10240.5 2111.7 2134.2 2469.1 2474.1 2483.6 2523.4 2550.1 2552.9 2553.0 2556.2 2512.1 2535.5 2538.6 2540.3 2542.4 2188.7 2232.5 2469.0 2524.5 2525.1 2502.0 2530.2 2540.0 2582.1 2586.4 10749.4 10792.4 10835.7 10859.2 10862.8 5755.9 5825.7 5829.1 5833.6 5836.6 3747.8 3803.2 3828.6 3832.4 3841.1 1121.0 1149.9 1163.2 1176.5 1185.1 16508.3 16539.5 16554.9 16556.4 16571.9 5352.0 5377.5 5389.3 5434.1 5434.9 12474.0 12495.4 12545.1 12564.3 12567.7 5879.1 5909.1 5909.2 5911.3 5924.9 5332.1 5345.2 5348.9 5349.5 5350.7 4615.2 4631.2 4642.8 4647.7 4705.6 1354.2 1378.5 1384.9 1392.5 1414.1 1198.9 1253.9 1268.7 1488.4 1491.7 9669.1 9940.4 9959.3 9969.8 9970.5 571.8 577.9 581.8 582.4 586.4 7487.4 7490.1 7573.5 7576.0 7614.0 13530.9 13756.9 13764.7 13789.7 13814.1 13331.0 13710.6 13711.7 13712.7 13720.5 9754.7 9880.0 9955.6 10020.1 10030.1 9317.7 9376.2 9439.5 9454.9 9456.4 11671.6 11788.8 11823.3 11845.1 11938.0 11908.3 12060.8 12181.4 12186.3 12207.9 8754.0 8829.1 8887.2 8887.9 8897.3 10169.7 10322.8 10356.2 10374.3 10384.5 8314.0 9497.4 9527.8 9666.5 9690.4 8708.9 9379.6 9465.5 9504.5 9626.8 9194.7 9233.5 9366.7 9379.8 9406.2 8033.8 8059.0 8069.6 8086.2 8088.8 8615.2 8636.7 8703.7 8824.0 8838.4 01:39:16 INFO - 2015-10-30 01:39:16,696 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,696 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5406.85 Median:6097.60 stddev:1557.61 (25.5%) stddev-sans-first:1515.92 01:39:16 INFO - 2015-10-30 01:39:16,697 DEBUG : BROWSER_OUTPUT: Values: 397.2 403.4 407.8 408.5 412.1 5858.5 5984.3 6025.1 6034.5 6108.0 5900.9 5949.7 5969.6 5991.9 5993.3 4623.2 4654.1 4705.9 4740.3 4762.6 4748.2 4761.0 4764.7 4765.9 4773.6 4718.1 4721.5 4727.0 4728.3 4730.4 4681.3 4715.3 4723.1 4736.9 4740.1 4126.1 4192.8 4209.9 4238.2 4282.7 5696.4 5702.6 5708.6 5710.1 5720.5 5263.8 5460.1 5461.8 5462.1 5462.9 6183.3 6240.0 6280.3 6320.2 6326.4 4593.6 4612.1 4616.4 4617.2 4618.3 6458.2 6523.9 6527.0 6527.1 6530.9 4650.2 4716.3 4742.0 4751.2 4760.9 4854.4 4861.1 4861.4 4861.6 4861.7 5482.1 5487.9 5491.3 5492.6 5493.5 6301.0 6428.0 6429.6 6433.9 6439.1 1740.2 1757.0 1759.6 1760.7 1761.7 1193.1 1197.9 1213.3 1226.5 1236.5 6087.2 6112.1 6113.5 6119.7 6126.5 6546.8 6547.4 6624.1 6625.2 6635.2 6015.1 6159.6 6161.9 6166.9 6168.9 3629.9 3636.3 3653.2 3674.0 3674.8 6766.5 6813.7 6816.0 6817.9 6827.3 6672.8 6777.7 6781.6 6781.7 6785.2 6599.3 6661.1 6722.9 6824.5 6832.5 6575.7 6575.9 6597.1 6598.3 6612.7 6491.4 6503.1 6504.8 6508.8 6511.1 6648.5 6790.1 6791.1 6794.0 6795.1 4822.7 4824.4 4828.0 4828.3 4831.7 6631.2 6661.6 6668.7 6671.4 6672.0 6343.1 6444.4 6445.7 6445.7 6483.8 6387.4 6417.2 6423.6 6427.1 6439.9 6298.9 6318.3 6320.7 6322.4 6328.1 6328.6 6500.9 6539.4 6542.1 6544.4 6380.6 6381.6 6394.7 6395.6 6395.7 01:39:16 INFO - 2015-10-30 01:39:16,697 DEBUG : BROWSER_OUTPUT: 01:39:16 INFO - 2015-10-30 01:39:16,697 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12783.21 Median:41135.38 stddev:14578.28 (35.4%) stddev-sans-first:14591.64 01:39:16 INFO - 2015-10-30 01:39:16,697 DEBUG : BROWSER_OUTPUT: Values: 851.4 892.4 899.8 968.6 976.5 11130.5 11449.0 11450.3 11451.7 11464.5 13377.7 13464.5 13477.9 13479.7 13490.7 776.4 788.4 922.9 929.7 952.1 937.1 937.4 944.9 945.1 947.4 813.4 1000.1 1003.8 1005.3 1007.1 823.0 987.2 1001.2 1001.8 1002.7 736.6 741.0 741.7 741.7 742.4 13114.0 13281.3 13324.3 13328.8 13434.3 11683.7 12237.9 12401.3 12411.7 12653.2 10704.8 10759.9 10853.6 10859.2 10934.4 3617.9 3673.9 3675.6 3675.7 3720.8 40756.0 40914.0 41251.4 44945.6 44949.0 7990.3 8063.2 8064.9 8072.0 8072.9 12709.0 12717.0 12736.6 12745.1 12760.3 7185.7 7292.8 7397.3 7430.0 7519.7 4381.6 4500.1 4501.3 4656.5 4704.2 3055.7 3078.6 3083.5 3087.2 3088.6 517.0 521.8 522.7 523.8 528.3 545.8 677.9 742.7 767.7 782.5 8433.2 8637.0 8680.9 8845.2 8940.2 548.1 587.2 622.9 625.7 657.6 4265.7 4327.5 4375.4 4421.2 4510.3 55193.0 55975.7 56056.2 56265.4 56290.7 48914.3 49474.0 49557.8 49603.3 49824.0 40793.0 41019.4 41427.8 41672.0 41773.6 8470.6 8617.3 8677.1 8694.9 8722.8 28073.9 28329.7 28355.7 28493.7 28643.1 37493.6 39407.6 39644.8 39747.6 40220.6 8236.4 8245.0 8245.6 8293.6 8489.5 11272.4 11562.0 11707.5 12112.4 12389.0 10512.9 10554.0 10843.4 11099.9 11131.4 11020.3 11327.4 11391.6 11461.4 11636.4 10256.6 10325.0 10579.4 10855.0 11513.1 10015.8 10015.8 10432.6 10567.7 10964.9 10014.6 10033.4 10049.9 10214.3 10253.6 01:39:16 INFO - 2015-10-30 01:39:16,697 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:39:16 INFO - 2015-10-30 01:39:16,697 DEBUG : BROWSER_OUTPUT: 01:39:17 INFO - 2015-10-30 01:39:17,277 INFO : Browser exited with error code: 0 01:39:17 INFO - 2015-10-30 01:39:17,298 INFO : Completed test dromaeo_css (00:18:32) 01:39:17 INFO - 2015-10-30 01:39:17,298 INFO : Starting test kraken 01:39:17 INFO - 2015-10-30 01:39:17,298 DEBUG : operating with platform_type : linux_ 01:39:17 INFO - 2015-10-30 01:39:17,298 INFO : Initialising browser for kraken test... 01:39:17 INFO - 2015-10-30 01:39:17,304 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYSeptD/profile http://localhost/getInfo.html 01:39:21 INFO - 2015-10-30 01:39:21,090 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:39:21 INFO - 2015-10-30 01:39:21,091 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:39:21 INFO - 2015-10-30 01:39:21,091 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:39:21 INFO - 2015-10-30 01:39:21,091 DEBUG : BROWSER_OUTPUT: __metrics 01:39:21 INFO - 2015-10-30 01:39:21,253 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:39:22 INFO - 2015-10-30 01:39:22,573 INFO : Browser initialized. 01:39:22 INFO - 2015-10-30 01:39:22,574 INFO : Running cycle 1/1 for kraken test... 01:39:22 INFO - 2015-10-30 01:39:22,574 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYSeptD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:39:34 INFO - 2015-10-30 01:39:34,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 132558848 01:39:34 INFO - 2015-10-30 01:39:34,258 DEBUG : BROWSER_OUTPUT: 01:39:37 INFO - 2015-10-30 01:39:37,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=ai-astar (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection) 01:39:37 INFO - 2015-10-30 01:39:37,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 166891520 01:39:37 INFO - 2015-10-30 01:39:37,717 DEBUG : BROWSER_OUTPUT: 01:39:40 INFO - 2015-10-30 01:39:40,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-dft) 01:39:40 INFO - 2015-10-30 01:39:40,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 162398208 01:39:40 INFO - 2015-10-30 01:39:40,776 DEBUG : BROWSER_OUTPUT: 01:39:43 INFO - 2015-10-30 01:39:43,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-dft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-fft) 01:39:44 INFO - 2015-10-30 01:39:44,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 163688448 01:39:44 INFO - 2015-10-30 01:39:44,123 DEBUG : BROWSER_OUTPUT: 01:39:46 INFO - 2015-10-30 01:39:46,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-fft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator) 01:39:46 INFO - 2015-10-30 01:39:46,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 161185792 01:39:46 INFO - 2015-10-30 01:39:46,621 DEBUG : BROWSER_OUTPUT: 01:39:48 INFO - 2015-10-30 01:39:48,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur) 01:39:49 INFO - 2015-10-30 01:39:49,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 155455488 01:39:49 INFO - 2015-10-30 01:39:49,274 DEBUG : BROWSER_OUTPUT: 01:39:52 INFO - 2015-10-30 01:39:52,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom) 01:39:52 INFO - 2015-10-30 01:39:52,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 155971584 01:39:52 INFO - 2015-10-30 01:39:52,643 DEBUG : BROWSER_OUTPUT: 01:39:55 INFO - 2015-10-30 01:39:55,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate) 01:39:56 INFO - 2015-10-30 01:39:56,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 157585408 01:39:56 INFO - 2015-10-30 01:39:56,483 DEBUG : BROWSER_OUTPUT: 01:39:59 INFO - 2015-10-30 01:39:59,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate (next: http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial) 01:39:59 INFO - 2015-10-30 01:39:59,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 155856896 01:39:59 INFO - 2015-10-30 01:39:59,721 DEBUG : BROWSER_OUTPUT: 01:40:01 INFO - 2015-10-30 01:40:01,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial (next: http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox) 01:40:01 INFO - 2015-10-30 01:40:01,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 166293504 01:40:02 INFO - 2015-10-30 01:40:01,775 DEBUG : BROWSER_OUTPUT: 01:40:03 INFO - 2015-10-30 01:40:03,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes) 01:40:04 INFO - 2015-10-30 01:40:04,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 165552128 01:40:04 INFO - 2015-10-30 01:40:04,052 DEBUG : BROWSER_OUTPUT: 01:40:05 INFO - 2015-10-30 01:40:05,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm) 01:40:06 INFO - 2015-10-30 01:40:06,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 171339776 01:40:06 INFO - 2015-10-30 01:40:06,545 DEBUG : BROWSER_OUTPUT: 01:40:08 INFO - 2015-10-30 01:40:08,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:40:09 INFO - 2015-10-30 01:40:09,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 179355648 01:40:09 INFO - 2015-10-30 01:40:09,377 DEBUG : BROWSER_OUTPUT: 01:40:11 INFO - 2015-10-30 01:40:11,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:40:12 INFO - 2015-10-30 01:40:12,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 173322240 01:40:12 INFO - 2015-10-30 01:40:12,356 DEBUG : BROWSER_OUTPUT: 01:40:13 INFO - 2015-10-30 01:40:13,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost/page_load_test/kraken/driver.html?testName=ai-astar) 01:40:14 INFO - 2015-10-30 01:40:14,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 233189376 01:40:14 INFO - 2015-10-30 01:40:14,179 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,182 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:40:14 INFO - 2015-10-30 01:40:14,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: |0;ai-astar;102;108;109;110;109;108;116;107;110;109 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;142;119;145;155;123;142;146;122;162;121 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;160;160;161;159;160;159;162;160 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;69;71;154;70;71;69;70;151;70 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;87;89;130;88;88;88;135;88;88;133 01:40:14 INFO - 2015-10-30 01:40:14,183 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;110;109;110;109;109 01:40:14 INFO - 2015-10-30 01:40:14,184 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;145;146;146;145;144;146 01:40:14 INFO - 2015-10-30 01:40:14,184 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;96;96;96;96;96;96 01:40:14 INFO - 2015-10-30 01:40:14,184 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;55;54;55;54;54;55;56;68;53 01:40:14 INFO - 2015-10-30 01:40:14,184 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;62;62;61;61;61;61;62;61;60 01:40:14 INFO - 2015-10-30 01:40:14,184 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;77;77;79;77;80;80;78;79 01:40:14 INFO - 2015-10-30 01:40:14,184 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;106;109;106;124;117;108;113;108;107;106 01:40:14 INFO - 2015-10-30 01:40:14,184 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;137;135;127;137;136;136;135;135;133 01:40:14 INFO - 2015-10-30 01:40:14,185 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;60;59;62;60;60;60;62;59;59 01:40:14 INFO - 2015-10-30 01:40:14,185 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:40:14 INFO - 2015-10-30 01:40:14,185 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:40:14 INFO - 2015-10-30 01:40:14,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,881 01:40:14 INFO - 2015-10-30 01:40:14,185 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:40:14 INFO - 2015-10-30 01:40:14,185 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194414180__endTimestamp 01:40:14 INFO - 2015-10-30 01:40:14,185 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,186 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:40:14 INFO - 2015-10-30 01:40:14,186 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:40:14 INFO - 2015-10-30 01:40:14,186 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:3.43 (3.1%) stddev-sans-first:2.60 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: Values: 102.0 108.0 109.0 110.0 109.0 108.0 116.0 107.0 110.0 109.0 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:137.70 Median:143.50 stddev:15.42 (10.7%) stddev-sans-first:16.28 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: Values: 142.0 119.0 145.0 155.0 123.0 142.0 146.0 122.0 162.0 121.0 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 160.0 160.0 161.0 159.0 160.0 159.0 162.0 160.0 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,187 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.50 Median:70.00 stddev:34.80 (49.7%) stddev-sans-first:36.39 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 154.0 70.0 71.0 69.0 70.0 151.0 70.0 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.40 Median:88.00 stddev:21.61 (24.6%) stddev-sans-first:22.29 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: Values: 87.0 89.0 130.0 88.0 88.0 88.0 135.0 88.0 88.0 133.0 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 01:40:14 INFO - 2015-10-30 01:40:14,188 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,189 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 01:40:14 INFO - 2015-10-30 01:40:14,189 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 144.0 146.0 01:40:14 INFO - 2015-10-30 01:40:14,189 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:4.37 (7.9%) stddev-sans-first:4.58 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: Values: 58.0 55.0 54.0 55.0 54.0 54.0 55.0 56.0 68.0 53.0 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 62.0 61.0 61.0 61.0 61.0 62.0 61.0 60.0 01:40:14 INFO - 2015-10-30 01:40:14,190 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.50 stddev:1.29 (1.6%) stddev-sans-first:1.30 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 77.0 77.0 79.0 77.0 80.0 80.0 78.0 79.0 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:108.50 stddev:5.95 (5.5%) stddev-sans-first:6.09 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: Values: 106.0 109.0 106.0 124.0 117.0 108.0 113.0 108.0 107.0 106.0 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:136.00 stddev:6.80 (5.0%) stddev-sans-first:3.09 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: Values: 154.0 137.0 135.0 127.0 137.0 136.0 136.0 135.0 135.0 133.0 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:60.00 stddev:1.14 (1.9%) stddev-sans-first:1.17 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 59.0 62.0 60.0 60.0 60.0 62.0 59.0 59.0 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:40:14 INFO - 2015-10-30 01:40:14,191 DEBUG : BROWSER_OUTPUT: 01:40:15 INFO - 2015-10-30 01:40:15,009 INFO : Browser exited with error code: 0 01:40:15 INFO - 2015-10-30 01:40:15,059 INFO : Completed test kraken (00:00:57) 01:40:15 INFO - 2015-10-30 01:40:15,059 INFO : Starting test v8_7 01:40:15 INFO - 2015-10-30 01:40:15,059 DEBUG : operating with platform_type : linux_ 01:40:15 INFO - 2015-10-30 01:40:15,059 INFO : Initialising browser for v8_7 test... 01:40:15 INFO - 2015-10-30 01:40:15,065 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHMjrxe/profile http://localhost/getInfo.html 01:40:18 INFO - 2015-10-30 01:40:18,875 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:40:18 INFO - 2015-10-30 01:40:18,876 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:40:18 INFO - 2015-10-30 01:40:18,876 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:40:18 INFO - 2015-10-30 01:40:18,876 DEBUG : BROWSER_OUTPUT: __metrics 01:40:18 INFO - 2015-10-30 01:40:18,993 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:40:20 INFO - 2015-10-30 01:40:20,434 INFO : Browser initialized. 01:40:20 INFO - 2015-10-30 01:40:20,435 INFO : Running cycle 1/1 for v8_7 test... 01:40:20 INFO - 2015-10-30 01:40:20,435 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHMjrxe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:40:32 INFO - 2015-10-30 01:40:32,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 132173824 01:40:32 INFO - 2015-10-30 01:40:32,126 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/v8_7/run.html (next: http://localhost/page_load_test/v8_7/run.html) 01:40:53 INFO - 2015-10-30 01:40:53,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 426860544 01:40:53 INFO - 2015-10-30 01:40:53,767 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:40:53 INFO - 2015-10-30 01:40:53,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:40:53 INFO - 2015-10-30 01:40:53,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:40:53 INFO - 2015-10-30 01:40:53,768 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:40:53 INFO - 2015-10-30 01:40:53,768 DEBUG : BROWSER_OUTPUT: |0;Richards;168.26518593303047 01:40:53 INFO - 2015-10-30 01:40:53,768 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.72224074691565 01:40:53 INFO - 2015-10-30 01:40:53,768 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 01:40:53 INFO - 2015-10-30 01:40:53,768 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 01:40:53 INFO - 2015-10-30 01:40:53,769 DEBUG : BROWSER_OUTPUT: |4;RayTrace;958.7727708533077 01:40:53 INFO - 2015-10-30 01:40:53,769 DEBUG : BROWSER_OUTPUT: |5;Earley;541.7118093174431 01:40:53 INFO - 2015-10-30 01:40:53,769 DEBUG : BROWSER_OUTPUT: |6;Boyer;10329.896907216495 01:40:53 INFO - 2015-10-30 01:40:53,769 DEBUG : BROWSER_OUTPUT: |7;RegExp;22977.272727272728 01:40:53 INFO - 2015-10-30 01:40:53,769 DEBUG : BROWSER_OUTPUT: |8;Splay;546.1496450027307 01:40:53 INFO - 2015-10-30 01:40:53,769 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 01:40:53 INFO - 2015-10-30 01:40:53,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:40:53 INFO - 2015-10-30 01:40:53,770 DEBUG : BROWSER_OUTPUT: __startTimestamp1446194453766__endTimestamp 01:40:53 INFO - 2015-10-30 01:40:53,770 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,770 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:40:53 INFO - 2015-10-30 01:40:53,770 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:40:53 INFO - 2015-10-30 01:40:53,771 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,771 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.27 Median:168.27 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,771 DEBUG : BROWSER_OUTPUT: Values: 168.3 01:40:53 INFO - 2015-10-30 01:40:53,771 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,771 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,771 DEBUG : BROWSER_OUTPUT: Values: 166.7 01:40:53 INFO - 2015-10-30 01:40:53,772 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,772 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,772 DEBUG : BROWSER_OUTPUT: Values: 281.3 01:40:53 INFO - 2015-10-30 01:40:53,772 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,773 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,773 DEBUG : BROWSER_OUTPUT: Values: 5112.2 01:40:53 INFO - 2015-10-30 01:40:53,773 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,773 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: Values: 958.8 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:541.71 Median:541.71 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: Values: 541.7 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10329.90 Median:10329.90 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: Values: 10329.9 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:22977.27 Median:22977.27 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: Values: 22977.3 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:546.15 Median:546.15 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: Values: 546.1 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: 01:40:53 INFO - 2015-10-30 01:40:53,774 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 01:40:53 INFO - 2015-10-30 01:40:53,775 DEBUG : BROWSER_OUTPUT: Values: 4817.3 01:40:53 INFO - 2015-10-30 01:40:53,775 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:40:53 INFO - 2015-10-30 01:40:53,775 DEBUG : BROWSER_OUTPUT: 01:40:54 INFO - 2015-10-30 01:40:54,561 INFO : Browser exited with error code: 0 01:40:54 INFO - 2015-10-30 01:40:54,578 INFO : Completed test v8_7 (00:00:39) 01:40:54 INFO - 2015-10-30 01:40:54,578 INFO : Completed test suite (00:20:09) 01:40:54 INFO - 2015-10-30 01:40:54,578 DEBUG : Working with test: dromaeo_css 01:40:54 INFO - 2015-10-30 01:40:54,578 DEBUG : Generating results file: dromaeo_css 01:40:54 INFO - 2015-10-30 01:40:54,579 DEBUG : Working with test: kraken 01:40:54 INFO - 2015-10-30 01:40:54,579 DEBUG : Generating results file: kraken 01:40:54 INFO - 2015-10-30 01:40:54,579 INFO : javascript benchmark 01:40:54 INFO - 2015-10-30 01:40:54,579 DEBUG : Working with test: v8_7 01:40:54 INFO - 2015-10-30 01:40:54,580 DEBUG : Generating results file: v8_7 01:40:54 INFO - 2015-10-30 01:40:54,580 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:40:54 INFO - 2015-10-30 01:40:54,636 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 01:40:54 INFO - 2015-10-30 01:40:54,636 DEBUG : process_Request line: dromaeo_css 7668.19 graph.html#tests=[[72,52,35]] 01:40:54 INFO - 2015-10-30 01:40:54,636 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:40:54 INFO - 2015-10-30 01:40:54,665 DEBUG : process_Request line: kraken 1447.50 graph.html#tests=[[232,52,35]] 01:40:54 INFO - 2015-10-30 01:40:54,665 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:40:54 INFO - 2015-10-30 01:40:54,696 DEBUG : process_Request line: v8_7 23316.13 graph.html#tests=[[230,52,35]] 01:40:54 INFO - 2015-10-30 01:40:54,699 INFO : javascript benchmark 01:40:54 INFO - 2015-10-30 01:40:54,703 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [423.39031794216305, 424.134765079238, 429.8688899885536, 430.3738061121068, 439.1831193979198, 15843.92078039611, 16368.672626547463, 19093.904530477346, 19489.317873874417, 19621.31325403611, 19371.709424358647, 19636.41090767279, 19787.703184452246, 19789.20843166275, 20702.585948281027, 6330.366963303667, 6416.262129855079, 6419.358064193567, 6440.162778838744, 6483.189601299838, 4428.247197976336, 4551.112533056055, 6980.092587963558, 7065.858682826341, 7309.597972111532, 7128.85742285154, 7224.2414546472655, 7241.094863142107, 7290.343869051784, 7297.124345078598, 7254.27457254273, 7269.454790890704, 7287.125544934642, 7288.3804876585555, 7289.5261807982315, 6457.257415397243, 6457.418832305115, 6460.903086453707, 6536.477081833489, 7007.684654190573, 27104.59343109855, 27267.590986135026, 27425.17724468269, 27541.86229068842, 27707.0, 2514.0572285392977, 2559.3089865736333, 2616.856072915989, 2622.252657992482, 2644.4975454663554, 15629.609259768484, 15783.921080394639, 16083.597910052342, 16209.270582823683, 16368.427105051265, 2066.183857376328, 2136.060133541237, 2136.743590769102, 2182.923597674074, 2203.5923354179527, 81363.0, 81823.5908820458, 82652.58673706654, 83061.58469207675, 83145.0, 17233.913830431018, 17732.822671773374, 17750.28998840058, 17870.46388608344, 17894.55263618394, 28316.8584157082, 28437.431251374855, 28687.85656071748, 28730.132541384744, 28858.567121493194, 6662.86674266512, 6768.323167683291, 6807.965960170168, 6812.829679258059, 9861.309708320348, 7197.064381630355, 7203.89194162088, 7232.349088582053, 7248.420126389876, 7254.637268136572, 3671.045528162697, 3846.5576458707046, 3850.4609354690365, 3855.248226595843, 3891.3190191716335, 1317.617890811673, 1332.4869925078915, 1351.6823546466574, 1360.088740543838, 1371.4240019191964, 541.2692864632714, 553.3498139685853, 556.7605929450375, 575.1171951055111, 596.2457491273542, 11577.942110289563, 13062.281574513303, 13323.313808531033, 13848.268966379203, 14177.929110354382, 568.1591244957486, 572.9111987641922, 586.7887560478224, 589.5607772209731, 601.5097695378253, 7550.6602202901, 7655.693772249159, 7680.462367634212, 7809.0, 7875.488093274033, 621343.0, 637129.0, 641514.0, 647125.0, 655609.0, 83145.0, 84021.0, 84189.0, 85032.0, 92836.0, 610.0330975403946, 615.6644628677382, 630.9905351419733, 634.0679201573679, 635.3741564558906, 12719.236845789283, 12884.806727899277, 13095.214287142802, 13137.277449740355, 13173.802392964304, 41767.53813616509, 42515.7874210627, 43581.0, 45192.0, 48475.0, 60689.0, 61030.69484652548, 61318.69340653447, 61428.385716142264, 62533.374666254575, 16584.839061265597, 16624.83375166233, 16650.0, 16998.74501882448, 17001.574960626083, 19865.0, 20312.59374812466, 20405.897970510647, 21070.26254081161, 21359.89320053452, 17440.0, 17463.825361746727, 17767.555811104827, 17790.37733679315, 17866.374676886247, 10201.489925503547, 11498.13763967689, 11636.185467017227, 11993.160478766751, 12186.634400967985, 10447.425391603534, 10597.735056623338, 12157.513699451923, 12258.816117758419, 12494.187877787916, 16779.58051048685, 17023.148842558072, 17353.30586776515, 17504.474865754048, 17549.298028078734, 17776.733348999518, 17802.5549361267, 18025.369112081014, 18030.36893708714, 18344.08279586042], "dojo.html": [3352.832358382081, 3394.7453940954433, 3421.794692318462, 3429.0055883793684, 3434.8454319555617, 5754.71226438678, 5758.510526605243, 5768.077107662775, 5771.567132465061, 5784.0, 5774.797882074128, 5784.884302313952, 5800.651960882339, 5810.941890581093, 5817.040188368914, 5213.9478605214035, 5258.737063146837, 5287.762050707708, 5287.841364759063, 5351.063563876306, 5278.049951008817, 5284.365876094874, 5292.0, 5296.496832800897, 5300.125479295912, 5062.417821950486, 5182.196759502283, 5190.688558686472, 5213.530782229617, 5287.339082614673, 5277.947220527803, 5319.973400132994, 5325.174597937326, 5325.360956685184, 5331.866703332447, 5103.260027296022, 5218.817341393033, 5219.869503262411, 5266.34170728659, 5267.525922666979, 5399.865003374908, 5522.723863806834, 5545.944540554583, 5550.417206193332, 5556.86107847303, 6219.502439804804, 6243.875122497525, 6261.749530018794, 6265.122882796412, 6265.436110750009, 6042.184305118797, 6093.6039157454625, 6270.435660790551, 6301.936980630181, 6306.054091886208, 5669.036263835158, 5762.567807414461, 5762.942370576283, 5767.134929760486, 5791.247137872049, 6277.403646653561, 6289.213848268966, 6307.400796924285, 6309.179806625201, 6311.053341998737, 5984.640921544721, 6071.241094863142, 6088.665123418255, 6164.753409863555, 6208.782692605737, 6242.625442473466, 6247.625142491465, 6275.090111933744, 6280.214973128359, 6296.212973378328, 6227.1282020517165, 6229.1590635264565, 6233.563650544418, 6234.2830574484515, 6235.376462353819, 6045.516358691382, 6069.575129740964, 6136.028952951454, 6143.372006418303, 6232.345603711636, 4684.906301873943, 4685.789139488731, 4694.037722266927, 4694.95305046952, 4713.835015774432, 4195.202911446815, 4199.118185181085, 4199.328107502785, 4201.663866890642, 4205.2640787862, 5667.263255776723, 5741.598088133791, 5776.5089967352405, 5807.157962095473, 5872.0898260769645, 6242.344553821874, 6246.875062498815, 6298.937010629927, 6307.211598550181, 6317.368263173646, 5903.645781253139, 5918.556108291896, 5932.110183472428, 5937.079752638348, 5941.197938278277, 5225.973870130625, 5274.525292723673, 5335.626506144533, 5382.138857782814, 5391.973040134774, 6365.458935990493, 6391.169148010729, 6393.552451328455, 6393.7122829471855, 6394.680265986682, 6108.409796619265, 6204.09220925484, 6230.875382492415, 6234.688265586793, 6238.563300568917, 6290.465310448663, 6407.0, 6417.326180750954, 6419.807405777834, 6421.743130274736, 6200.658963756856, 6212.192414986023, 6220.409061139185, 6222.973209420395, 6227.657478838707, 6116.204893364013, 6224.937750622617, 6320.905186422299, 6330.430261276507, 6337.9366206337345, 6060.939390606038, 6171.6297022178815, 6174.8147555573405, 6183.288921774054, 6186.907196391968, 6117.571769976237, 6144.109104179958, 6145.477634401126, 6148.139260503623, 6170.938290617037, 5865.765369385177, 5890.204822348928, 5958.851028724316, 6071.119687645355, 6077.179580756718, 6168.167297414791, 6169.84575385601, 6177.81466556004, 6180.0111982084445, 6187.041008643668, 5994.55040871945, 6008.399160083956, 6043.214382130295, 6076.270847498328, 6078.908816367846], "mootools.html": [1552.7981362422884, 1684.663067386523, 1790.8209179082091, 2034.847386446016, 2068.7724350321464, 9507.904920950798, 10198.694039178827, 10399.116075133605, 10412.947935260314, 10414.323069000518, 9907.0, 10195.847062294071, 10212.2851400402, 10219.540120694568, 10240.487975601209, 2111.7360329958756, 2134.1890081768906, 2469.086438017936, 2474.1093206445667, 2483.5902076157413, 2523.3817714659936, 2550.1074623881677, 2552.910648127316, 2553.0, 2556.2203527923975, 2512.1207577347964, 2535.467551814121, 2538.6445897574354, 2540.3014171103, 2542.4406630541253, 2188.7482939461925, 2232.520008198237, 2468.9753102468926, 2524.532961402128, 2525.1162093267394, 2502.0, 2530.1776922500076, 2539.9746002539923, 2582.1478911959007, 2586.3792689754323, 10749.355038697704, 10792.352458852494, 10835.67492975212, 10859.18556108295, 10862.837057444145, 5755.942440575583, 5825.679587622679, 5829.067349224146, 5833.591648584601, 5836.649801011953, 3747.756395834262, 3803.182315802088, 3828.617138286177, 3832.405977073558, 3841.116543195081, 1121.0, 1149.8735139134687, 1163.2264544078178, 1176.476467971753, 1185.1230089733622, 16508.33966641333, 16539.50381488557, 16554.917225413916, 16556.42052528168, 16571.91714041422, 5351.973240133852, 5377.489138531833, 5389.326334208224, 5434.076207044812, 5434.8913021739345, 12474.0, 12495.375231238402, 12545.12184147101, 12564.308963006939, 12567.685807854694, 5879.088741245114, 5909.143174239797, 5909.202257695242, 5911.349751527328, 5924.881502369928, 5332.120200166929, 5345.171498417673, 5348.866278343073, 5349.491798279158, 5350.652207606493, 4615.16926953145, 4631.235846085426, 4642.837500687459, 4647.744374059392, 4705.6470764692785, 1354.1671871798774, 1378.5244090788663, 1384.8753612174953, 1392.5474220878052, 1414.1444426122048, 1198.9100817438728, 1253.924764514132, 1268.7462507498537, 1488.3971991343524, 1491.7240310542584, 9669.129778319984, 9940.353876997971, 9959.253056020827, 9969.750756231153, 9970.501474926225, 571.8227349521661, 577.9364269930304, 581.776016233753, 582.3681305783188, 586.4165155670136, 7487.352782387866, 7490.101187857492, 7573.46985710995, 7576.01511803462, 7614.048243969504, 13530.864691353157, 13756.862431375559, 13764.724705505834, 13789.655258618615, 13814.102083364549, 13331.0, 13710.588682339545, 13711.725765484834, 13712.725745485035, 13720.451181952809, 9754.707358779247, 9879.950600246953, 9955.55200016001, 10020.09819116283, 10030.147437467896, 9317.72046838596, 9376.249900008119, 9439.48082855422, 9454.858177127211, 9456.385334953206, 11671.59149429766, 11788.823167652321, 11823.290602563873, 11845.111616628616, 11938.0, 11908.34504102248, 12060.75878482443, 12181.39093045362, 12186.329751863732, 12207.938960305142, 8753.956230218808, 8829.11708829112, 8887.244584210155, 8887.866681999905, 8897.2882169425, 10169.694909152737, 10322.845157322496, 10356.171506279328, 10374.325668831501, 10384.480775961323, 8314.0, 9497.43015419077, 9527.761805954906, 9666.468344241135, 9690.37012594179, 8708.869366959374, 9379.577918993798, 9465.526723663652, 9504.477253750834, 9626.807463850824, 9194.724158275263, 9233.538323083685, 9366.718998430058, 9379.81240375175, 9406.200472959876, 8033.799155021171, 8058.959705201437, 8069.59652017385, 8086.1913808618665, 8088.757337279891, 8615.22462978335, 8636.697715579925, 8703.738887833375, 8824.029356770621, 8838.381313308008], "ext.html": [578.7106446776609, 604.0395770724548, 620.624522164091, 620.9939897366266, 626.7743612299569, 35548.822255888714, 44628.3305750414, 45327.32009019859, 45332.09335813282, 45392.09215815682, 48580.757096214555, 48870.755646221805, 49297.0, 49319.50680493194, 49388.50611493884, 8141.877871831927, 8249.546274954875, 9151.130642588943, 9325.673601423918, 10702.197335199891, 10860.34837909724, 11067.335959842436, 11069.889301106967, 11074.335539867594, 11088.94655007773, 10904.563817447293, 11069.778604427947, 11080.833787493195, 11083.889161108365, 11084.501197446134, 10909.0, 10929.344239345584, 10931.070858976997, 10942.23404361695, 11032.0, 10765.623203187852, 10873.619423320224, 10876.075533579655, 10895.0, 10898.618548350769, 45960.54039459596, 46337.0, 46380.536194637956, 46409.0, 46451.30323045157, 3789.3558095123894, 3862.575116737157, 3874.0508575398926, 4408.823647054146, 4448.021435284265, 33766.83116584426, 34332.14169645754, 34390.0, 34417.0, 34485.82757086224, 3312.817795021273, 3350.6816852398983, 3377.814220217887, 3461.498082778008, 3542.0436482149676, 346900.0, 347455.9999999975, 348469.0, 348515.0, 348679.0, 57343.71328143332, 58352.41647583555, 65595.0, 66317.66841165764, 66425.33574664191, 61321.38678613246, 61570.0, 61732.69133654303, 61800.69099654473, 61805.69097154486, 18043.458696239133, 18071.367502137364, 18599.25602975893, 18785.906070469835, 18794.154263058193, 14132.717345653029, 14176.291185440892, 14200.644983875485, 14212.573622791126, 14307.0, 21021.89489052545, 21331.573368532852, 21333.78666213318, 21335.146594136062, 21357.78642213589, 8481.830363392697, 8747.956260218658, 8775.868361974575, 8893.28853691703, 8919.152680495343, 1117.474786850179, 1195.0439648281515, 1199.9820002699967, 1200.7118291610125, 1245.688577855536, 31076.223094422367, 31135.706451290986, 31249.687503125133, 31860.840695796836, 31976.36047279088, 1245.2777389114292, 1253.8808813162734, 1272.3256673962815, 1365.5015919189425, 1381.9930900345435, 15306.234688265542, 16716.916415417843, 16752.162391880356, 16784.328626855033, 16931.492055238363, 429098.0, 434418.0, 435068.0, 437017.0, 438007.0, 57593.424065759646, 57911.420885790605, 58120.128198077065, 58146.70926645424, 58158.0, 1474.3512854344053, 1504.090025534536, 1515.3559737111684, 1518.5140754958306, 1521.8325984141957, 32308.192295191868, 32543.674563254066, 32738.181545461553, 33201.66798331986, 33630.3273934515, 50126.0, 50195.996080077464, 50286.245706313704, 50504.49495504998, 50523.24215136703, 225827.0, 227391.0, 352670.0, 400520.0, 402211.0, 33166.17084572905, 33239.0, 33391.49912751262, 33422.16444588808, 33703.3259334807, 47550.76224618855, 48734.26898596595, 49091.0, 49173.26240106473, 49270.75364623154, 40513.59486405216, 40955.0, 41056.79471602623, 41629.58370416257, 42086.78956605197, 41734.58265417307, 41951.0, 42008.78995605002, 42119.57880421157, 42380.36429453499, 41967.790161049, 42776.78611606922, 42915.785421073946, 42925.0, 42977.3553396693, 36062.45906311355, 37184.81407592945, 37493.81253093717, 37900.48398064046, 38130.0, 28107.0, 28312.451879330958, 28410.0, 28442.288942776595, 28481.857590711912], "prototype.html": [397.2332702725517, 403.44929171680644, 407.82259717023095, 408.5138684964892, 412.1180673359014, 5858.472737453629, 5984.311804142525, 6025.066114752215, 6034.547408944325, 6108.022716365383, 5900.911486327708, 5949.6727679977585, 5969.611975221618, 5991.940080599193, 5993.310769261536, 4623.214053610877, 4654.115718013567, 4705.882352941187, 4740.2889566564945, 4762.595179409737, 4748.240281554952, 4761.047790441909, 4764.666473346867, 4765.880852978686, 4773.594244489223, 4718.127146477896, 4721.504242054586, 4726.976365118169, 4728.290756386536, 4730.385049943503, 4681.321208424793, 4715.269133284346, 4723.055388922212, 4736.905261894777, 4740.075685241397, 4126.112885729583, 4192.763134875188, 4209.852655157055, 4238.17355615652, 4282.721623094489, 5696.401877802812, 5702.572307076985, 5708.600397972144, 5710.114932185518, 5720.485156335908, 5263.815766448156, 5460.071787796084, 5461.836144915659, 5462.126059830448, 5462.945370546284, 6183.319834818167, 6240.0327949167495, 6280.309165991737, 6320.241571011462, 6326.367363263683, 4593.63250939924, 4612.123696497688, 4616.376789133491, 4617.191991401525, 4618.307253911907, 6458.160439142928, 6523.902141467882, 6527.0, 6527.086207930894, 6530.869382612369, 4650.18621741194, 4716.29255611661, 4742.0, 4751.216049351888, 4760.880977975578, 4854.417469903634, 4861.076395484846, 4861.392325959255, 4861.586765125004, 4861.659683822169, 5482.122860342326, 5487.917681234785, 5491.28613280271, 5492.5605951523785, 5493.533049690741, 6300.9684951574945, 6427.967860160669, 6429.58207716497, 6433.903491447632, 6439.098526206335, 1740.1560243282, 1757.0, 1759.568905618106, 1760.6918789212093, 1761.6652835961127, 1193.1290158184574, 1197.9341136237417, 1213.3326670331282, 1226.466487078124, 1236.4806781151938, 6087.178230938766, 6112.113743507255, 6113.480354169946, 6119.694015299307, 6126.479249263773, 6546.803595892131, 6547.443467305237, 6624.105745724362, 6625.17185351831, 6635.2037755469655, 6015.0977353396465, 6159.599626024294, 6161.938380616226, 6166.876662466815, 6168.8766224675255, 3629.872954446582, 3636.30910127075, 3653.232821107544, 3674.0447483654443, 3674.779513229215, 6766.5263431559315, 6813.727450901908, 6816.0457535944015, 6817.863642727118, 6827.2831352708245, 6672.833179170462, 6777.695003724844, 6781.559198652072, 6781.694823732944, 6785.219699734495, 6599.307072757388, 6661.067450556926, 6722.932770672329, 6824.488163387766, 6832.521723479408, 6575.704093315717, 6575.868482630225, 6597.109390232449, 6598.274189839018, 6612.735490580323, 6491.35086491366, 6503.089567460654, 6504.837379065561, 6508.8047358579315, 6511.055896895018, 6648.468122550281, 6790.117284752951, 6791.0832037676255, 6794.0, 6795.116634837439, 4822.662413631012, 4824.396950381202, 4827.975860120677, 4828.275758636232, 4831.710097394168, 6631.204255489372, 6661.633610151488, 6668.6665666717445, 6671.366220209073, 6671.966640166768, 6343.143675603735, 6444.420002199825, 6445.677716114269, 6445.70994305248, 6483.805485835433, 6387.361263873576, 6417.2299324081405, 6423.614583125028, 6427.068075129174, 6439.871202575829, 6298.874022519615, 6318.27339855904, 6320.652364120017, 6322.399372059647, 6328.0824280478155, 6328.588641738273, 6500.934990650033, 6539.411452969255, 6542.084108224947, 6544.411003009562, 6380.585261958144, 6381.585196962183, 6394.71223794921, 6395.584287021329, 6395.6802159890885], "yui.html": [851.3614788908319, 892.3619611977435, 899.7885496908225, 968.6416026070355, 976.462945380041, 11130.49912753926, 11448.999999999989, 11450.312981221132, 11451.656450306484, 11464.541418343266, 13377.732445351086, 13464.461421543127, 13477.932610336959, 13479.730405391887, 13490.662733431669, 776.3944123583585, 788.3850596534712, 922.9077092290768, 929.730378190324, 952.1478276942132, 937.1191080384451, 937.3625934364629, 944.8866136063682, 945.1399226703701, 947.3889341374809, 813.4143416739938, 1000.104906109032, 1003.8042581696573, 1005.316384858296, 1007.0885848307257, 823.0082750285922, 987.2151639446621, 1001.1740314240708, 1001.754570130319, 1002.7292630989665, 736.5911918885016, 741.0107506478857, 741.6736635880195, 741.6996116572797, 742.3726950726627, 13114.0, 13281.335933203301, 13324.267165305904, 13328.800067998987, 13434.261115638636, 11683.7079073023, 12237.898589127022, 12401.317927513983, 12411.689707757288, 12653.240805551604, 10704.839427408595, 10759.892401076046, 10853.565857365775, 10859.18556108295, 10934.398608076554, 3617.94573081404, 3673.9081522961874, 3675.5773086095173, 3675.6691897729065, 3720.776753394805, 40756.0, 40914.0, 41251.38122928129, 44945.550544494465, 44949.0, 7990.280874721303, 8063.19368063189, 8064.879026814602, 8072.0, 8072.919270807334, 12709.0, 12717.046221533423, 12736.617901462785, 12745.10784245094, 12760.29818359999, 7185.6766445510075, 7292.8176795579475, 7397.334239918433, 7430.0, 7519.661615227328, 4381.6494680425485, 4500.099980004013, 4501.257292546758, 4656.4877863434995, 4704.153252414599, 3055.724984751383, 3078.5536097266217, 3083.537469379566, 3087.243625311813, 3088.5521599367967, 517.0279873837162, 521.8121476268541, 522.6681057528497, 523.8454655876526, 528.3211073770187, 545.7871430142247, 677.9220389655154, 742.7251916790714, 767.6890859202032, 782.5461232485145, 8433.156684331518, 8636.956815215884, 8680.913190868137, 8845.159709827556, 8940.15068568485, 548.0600769680018, 587.2072701852464, 622.8816524860262, 625.7309356976543, 657.5824351536809, 4265.701400901907, 4327.459067616548, 4375.387445757597, 4421.248387774086, 4510.323451482304, 55193.0, 55975.72012139994, 56056.15915761267, 56265.43734562684, 56290.718546407006, 48914.26628600574, 49474.0, 49557.752211238716, 49603.25595116076, 49824.0, 40792.98017549526, 41019.38470922939, 41427.7928610355, 41672.0, 41773.58226417697, 8470.576471176293, 8617.267532259828, 8677.088905664814, 8694.869576956477, 8722.781930451789, 28073.859630701714, 28329.71670283271, 28355.716442836132, 28493.715062849107, 28643.118124247103, 37493.625063749016, 39407.60592394039, 39644.801775990934, 39747.60252397439, 40220.58676479421, 8236.423450358658, 8244.958775206325, 8245.587720614065, 8293.58532073406, 8489.533075680896, 11272.3800190987, 11562.0, 11707.531698731955, 12112.394380280775, 12389.008879289455, 10512.894871051192, 10554.0, 10843.403612801372, 11099.889001109885, 11131.443427828739, 11020.338779673246, 11327.352745407803, 11391.601293954673, 11461.369624670722, 11636.36000020007, 10256.58973641046, 10325.019123183285, 10579.36523808574, 10855.023047925724, 11513.13651476126, 10015.799684006424, 10015.799684006424, 10432.582696692047, 10567.735806604896, 10964.890351096386, 10014.64948726791, 10033.44816035125, 10049.949750251202, 10214.336068155546, 10253.58985640566]}, "summary": {"suite": 7668.19011519767, "subtests": {"jquery.html": {"std": 104415.54232453257, "min": 423.39031794216305, "max": 655609.0, "median": 12376.501997773168, "filtered": 9861.144967346303, "mean": 34715.563936554216}, "dojo.html": {"std": 663.4527464487669, "min": 3352.832358382081, "max": 6421.743130274736, "median": 6043.214382130295, "filtered": 5717.266398317389, "mean": 5762.493881768414}, "mootools.html": {"std": 4226.060659517078, "min": 571.8227349521661, "max": 16571.91714041422, "median": 8201.378668639945, "filtered": 5595.206691400932, "mean": 7273.285149857353}, "ext.html": {"std": 98026.69633897873, "min": 578.7106446776609, "max": 438007.0, "median": 32142.276383991375, "filtered": 21156.434653046104, "mean": 55351.05402405541}, "prototype.html": {"std": 1553.2774296023972, "min": 397.2332702725517, "max": 6832.521723479408, "median": 6060.862819941545, "filtered": 4928.272175473893, "mean": 5406.846290769893}, "yui.html": {"std": 14537.728793579752, "min": 517.0279873837162, "max": 56290.718546407006, "median": 9477.40008647638, "filtered": 6180.896125406112, "mean": 12783.206037363294}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-032"}, "testrun": {"date": 1446193245, "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, 159.0, 160.0, 160.0, 161.0, 159.0, 160.0, 159.0, 162.0, 160.0], "ai-astar": [102.0, 108.0, 109.0, 110.0, 109.0, 108.0, 116.0, 107.0, 110.0, 109.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0], "audio-beat-detection": [142.0, 119.0, 145.0, 155.0, 123.0, 142.0, 146.0, 122.0, 162.0, 121.0], "json-stringify-tinderbox": [61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0], "stanford-crypto-pbkdf2": [154.0, 137.0, 135.0, 127.0, 137.0, 136.0, 136.0, 135.0, 135.0, 133.0], "json-parse-financial": [58.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 56.0, 68.0, 53.0], "stanford-crypto-sha256-iterative": [61.0, 60.0, 59.0, 62.0, 60.0, 60.0, 60.0, 62.0, 59.0, 59.0], "audio-fft": [70.0, 69.0, 71.0, 154.0, 70.0, 71.0, 69.0, 70.0, 151.0, 70.0], "imaging-darkroom": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 144.0, 146.0], "stanford-crypto-ccm": [106.0, 109.0, 106.0, 124.0, 117.0, 108.0, 113.0, 108.0, 107.0, 106.0], "audio-oscillator": [87.0, 89.0, 130.0, 88.0, 88.0, 88.0, 135.0, 88.0, 88.0, 133.0], "stanford-crypto-aes": [77.0, 77.0, 77.0, 77.0, 79.0, 77.0, 80.0, 80.0, 78.0, 79.0], "imaging-desaturate": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"suite": 1447.5, "subtests": {"audio-fft": {"std": 33.012876275780634, "min": 69.0, "max": 154.0, "median": 70.0, "filtered": 86.5, "mean": 86.5}, "stanford-crypto-pbkdf2": {"std": 6.453681120105021, "min": 127.0, "max": 154.0, "median": 135.5, "filtered": 136.5, "mean": 136.5}, "audio-beat-detection": {"std": 14.629080627298492, "min": 119.0, "max": 162.0, "median": 142.0, "filtered": 137.7, "mean": 137.7}, "stanford-crypto-ccm": {"std": 5.642694391866355, "min": 106.0, "max": 124.0, "median": 108.0, "filtered": 110.4, "mean": 110.4}, "imaging-darkroom": {"std": 0.6708203932499369, "min": 144.0, "max": 146.0, "median": 146.0, "filtered": 145.5, "mean": 145.5}, "json-parse-financial": {"std": 4.142463035441596, "min": 53.0, "max": 68.0, "median": 55.0, "filtered": 56.2, "mean": 56.2}, "audio-oscillator": {"std": 20.50463362267173, "min": 87.0, "max": 135.0, "median": 88.0, "filtered": 101.4, "mean": 101.4}, "ai-astar": {"std": 3.249615361854384, "min": 102.0, "max": 116.0, "median": 109.0, "filtered": 108.8, "mean": 108.8}, "audio-dft": {"std": 0.8944271909999159, "min": 159.0, "max": 162.0, "median": 160.0, "filtered": 160.0, "mean": 160.0}, "stanford-crypto-sha256-iterative": {"std": 1.0770329614269007, "min": 59.0, "max": 62.0, "median": 60.0, "filtered": 60.2, "mean": 60.2}, "json-stringify-tinderbox": {"std": 0.6, "min": 60.0, "max": 62.0, "median": 61.0, "filtered": 61.2, "mean": 61.2}, "imaging-gaussian-blur": {"std": 0.45825756949558394, "min": 109.0, "max": 110.0, "median": 109.0, "filtered": 109.3, "mean": 109.3}, "stanford-crypto-aes": {"std": 1.2206555615733703, "min": 77.0, "max": 80.0, "median": 77.5, "filtered": 78.1, "mean": 78.1}, "imaging-desaturate": {"std": 0.45825756949558394, "min": 95.0, "max": 96.0, "median": 96.0, "filtered": 95.7, "mean": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-032"}, "testrun": {"date": 1446193245, "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": [166.72224074691565], "Encrypt": [281.29395218002816], "NavierStokes": [4817.307692307692], "Decrypt": [5112.244897959184], "Splay": [546.1496450027307], "Richards": [168.26518593303047], "RegExp": [22977.272727272728], "Earley": [541.7118093174431], "Boyer": [10329.896907216495], "RayTrace": [958.7727708533077]}, "summary": {"suite": 23316.13351575895, "subtests": {"DeltaBlue": {"std": 0.0, "min": 166.72224074691565, "max": 166.72224074691565, "median": 166.72224074691565, "value": 396.575764, "filtered": 396.575764, "mean": 166.72224074691565}, "Encrypt": {"std": 0.0, "min": 281.29395218002816, "max": 281.29395218002816, "median": 281.29395218002816, "value": 946.2734550000002, "filtered": 946.2734550000002, "mean": 281.29395218002816}, "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": 5112.244897959184, "max": 5112.244897959184, "median": 5112.244897959184, "value": 52.067341317365305, "filtered": 52.067341317365305, "mean": 5112.244897959184}, "Splay": {"std": 0.0, "min": 546.1496450027307, "max": 546.1496450027307, "median": 546.1496450027307, "value": 149.21002099999998, "filtered": 149.21002099999998, "mean": 546.1496450027307}, "RegExp": {"std": 0.0, "min": 22977.272727272728, "max": 22977.272727272728, "median": 22977.272727272728, "value": 39.64722057368942, "filtered": 39.64722057368942, "mean": 22977.272727272728}, "Richards": {"std": 0.0, "min": 168.26518593303047, "max": 168.26518593303047, "median": 168.26518593303047, "value": 209.79978600000007, "filtered": 209.79978600000007, "mean": 168.26518593303047}, "Earley": {"std": 0.0, "min": 541.7118093174431, "max": 541.7118093174431, "median": 541.7118093174431, "value": 1230.2906979999998, "filtered": 1230.2906979999998, "mean": 541.7118093174431}, "Boyer": {"std": 0.0, "min": 10329.896907216495, "max": 10329.896907216495, "median": 10329.896907216495, "value": 64.51787524950103, "filtered": 64.51787524950103, "mean": 10329.896907216495}, "RayTrace": {"std": 0.0, "min": 958.7727708533077, "max": 958.7727708533077, "median": 958.7727708533077, "value": 771.8085270000001, "filtered": 771.8085270000001, "mean": 958.7727708533077}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-032"}, "testrun": {"date": 1446193245, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "43.0a2", "id": "20151029012446", "branch": "Mozilla-Aurora", "revision": "5e1587041f9a9724055f62c0c5a9f7e9c9c54876"}}] 01:40:54 INFO - RETURN: dromaeo_css: 7668.19 01:40:54 INFO - RETURN: kraken: 1447.50 01:40:54 INFO - RETURN: v8_7: 23316.13 01:40:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23316.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1447.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7668.19"}}} 01:40:54 INFO - Return code: 0 01:40:54 INFO - # TBPL SUCCESS # 01:40:54 INFO - Running post-action listener: _resource_record_post_action 01:40:54 INFO - Running post-run listener: _resource_record_post_run 01:40:55 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 7348224; Write bytes: 423038976; Read time: 3148; Write time: 389944 01:40:55 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 49152000; Read time: 0; Write time: 16376 01:40:55 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 5324800; Write bytes: 306053120; Read time: 2708; Write time: 318452 01:40:55 INFO - Running post-run listener: _upload_blobber_files 01:40:55 INFO - Blob upload gear active. 01:40:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:40:55 INFO - Copying logs to upload dir... 01:40:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.187584 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-10-30 01:40:55.805300) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:40:55.810172) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 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.010035 build_url: 'https://queue.taskcluster.net/v1/task/JrMmOwYyQSuLn5q77Sd6Cg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-30 01:40:55.861066) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:40:55.861413) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1446188090.868252-406834271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-30 01:40:55.915340) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-30 01:40:55.915710) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-30 01:41:00.907747) =========