builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1446071711.95 results: success (0) buildid: 20151028131431 builduid: 32122c98f3294e4bacd0523e0a8242c0 revision: bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:11.953565) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:11.954014) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:11.954347) ========= 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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006236 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.009622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.009984) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.063523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.063918) ========= 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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014163 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.113369) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.113688) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.114086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.114365) ========= 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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-28 15:35:11-- 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-28 15:35:12 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.222432 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.349033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.349355) ========= 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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.086795 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:12.447081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-28 15:35:12.447428) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 --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 bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 --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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-28 15:35:12,202 truncating revision to first 12 chars 2015-10-28 15:35:12,202 Setting DEBUG logging. 2015-10-28 15:35:12,202 attempt 1/10 2015-10-28 15:35:12,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf0aacb5affa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-28 15:35:12,944 unpacking tar archive at: mozilla-aurora-bf0aacb5affa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.003599 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-28 15:35:13.463691) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:13.464085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:13.473963) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:13.474311) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 15:35:13.474721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-10-28 15:35:13.475045) ========= /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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:35:13 INFO - MultiFileLogger online at 20151028 15:35:13 in /builds/slave/test-pgo 15:35:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:35:13 INFO - Guessing talos json url... 15:35:13 INFO - Using buildbot properties: 15:35:13 INFO - { 15:35:13 INFO - "properties": { 15:35:13 INFO - "buildnumber": 3, 15:35:13 INFO - "product": "firefox", 15:35:13 INFO - "script_repo_revision": "production", 15:35:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:35:13 INFO - "repository": "", 15:35:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:35:13 INFO - "buildid": "20151028131431", 15:35:13 INFO - "slavename": "talos-linux64-ix-047", 15:35:13 INFO - "pgo_build": "True", 15:35:13 INFO - "basedir": "/builds/slave/test-pgo", 15:35:13 INFO - "project": "", 15:35:13 INFO - "platform": "ubuntu64_hw", 15:35:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:35:13 INFO - "slavebuilddir": "test", 15:35:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:35:13 INFO - "branch": "mozilla-aurora", 15:35:13 INFO - "repo_path": "releases/mozilla-aurora", 15:35:13 INFO - "stage_platform": "linux64-pgo", 15:35:13 INFO - "builduid": "32122c98f3294e4bacd0523e0a8242c0", 15:35:13 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 15:35:13 INFO - }, 15:35:13 INFO - "sourcestamp": { 15:35:13 INFO - "repository": "", 15:35:13 INFO - "hasPatch": false, 15:35:13 INFO - "project": "", 15:35:13 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:35:13 INFO - "changes": [ 15:35:13 INFO - { 15:35:13 INFO - "category": null, 15:35:13 INFO - "files": [ 15:35:13 INFO - { 15:35:13 INFO - "url": null, 15:35:13 INFO - "name": "https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 15:35:13 INFO - } 15:35:13 INFO - ], 15:35:13 INFO - "repository": "", 15:35:13 INFO - "rev": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8", 15:35:13 INFO - "who": "kwierso@gmail.com", 15:35:13 INFO - "when": 1446071576, 15:35:13 INFO - "number": 6589683, 15:35:13 INFO - "comments": "Followup to bug 1204483 to fix something that was renamed a=me\nCLOSED TREE", 15:35:13 INFO - "project": "", 15:35:13 INFO - "at": "Wed 28 Oct 2015 15:32:56", 15:35:13 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:35:13 INFO - "revlink": "", 15:35:13 INFO - "properties": [ 15:35:13 INFO - [ 15:35:13 INFO - "buildid", 15:35:13 INFO - "20151028131431", 15:35:13 INFO - "Change" 15:35:13 INFO - ], 15:35:13 INFO - [ 15:35:13 INFO - "builduid", 15:35:13 INFO - "32122c98f3294e4bacd0523e0a8242c0", 15:35:13 INFO - "Change" 15:35:13 INFO - ], 15:35:13 INFO - [ 15:35:13 INFO - "pgo_build", 15:35:13 INFO - "True", 15:35:13 INFO - "Change" 15:35:13 INFO - ] 15:35:13 INFO - ], 15:35:13 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 15:35:13 INFO - } 15:35:13 INFO - ], 15:35:13 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 15:35:13 INFO - } 15:35:13 INFO - } 15:35:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 15:35: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')]} 15:35:13 INFO - https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 15:35:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:35:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:35:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:35:13 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt'), kwargs: {}, attempt #1 15:35:14 INFO - Downloaded 107 bytes. 15:35:14 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 15:35:14 INFO - Contents: 15:35:14 INFO - 20151028131431 15:35:14 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 15:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:14 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bf0aacb5af/testing/talos/talos.json 15:35:14 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bf0aacb5af/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 15:35:14 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bf0aacb5af/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 15:35:14 INFO - Downloaded 6818 bytes. 15:35:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:35:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:35:14 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:35:14 INFO - '../fennec_ids.txt'], 15:35:14 INFO - 'tests': ['tcheck2']}, 15:35:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:35:14 INFO - '--tppagecycles', 15:35:14 INFO - '7'], 15:35:14 INFO - 'tests': ['tsvgm']}}, 15:35:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:35:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:35:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:35:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:35:14 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:35:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:35:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:14 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:35:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:35:14 INFO - 'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:14 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'tests': ['damp', 'tps']}, 15:35:14 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['damp', 'tps']}, 15:35:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:35:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:35:14 INFO - 'other': {'tests': ['a11yr', 15:35:14 INFO - 'ts_paint', 15:35:14 INFO - 'tpaint', 15:35:14 INFO - 'sessionrestore', 15:35:14 INFO - 'sessionrestore_no_auto_restore']}, 15:35:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['a11yr', 15:35:14 INFO - 'ts_paint', 15:35:14 INFO - 'tpaint', 15:35:14 INFO - 'sessionrestore', 15:35:14 INFO - 'sessionrestore_no_auto_restore']}, 15:35:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['a11yr', 15:35:14 INFO - 'ts_paint', 15:35:14 INFO - 'tpaint', 15:35:14 INFO - 'sessionrestore', 15:35:14 INFO - 'sessionrestore_no_auto_restore']}, 15:35:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['a11yr', 15:35:14 INFO - 'ts_paint', 15:35:14 INFO - 'tpaint', 15:35:14 INFO - 'sessionrestore', 15:35:14 INFO - 'sessionrestore_no_auto_restore']}, 15:35:14 INFO - 'other_l64': {'tests': ['a11yr', 15:35:14 INFO - 'ts_paint', 15:35:14 INFO - 'tpaint', 15:35:14 INFO - 'sessionrestore', 15:35:14 INFO - 'sessionrestore_no_auto_restore']}, 15:35:14 INFO - 'other_nol64': {'tests': ['a11yr', 15:35:14 INFO - 'ts_paint', 15:35:14 INFO - 'tpaint', 15:35:14 INFO - 'sessionrestore', 15:35:14 INFO - 'sessionrestore_no_auto_restore']}, 15:35:14 INFO - 'svgr': {'tests': ['tsvgx', 15:35:14 INFO - 'tsvgr_opacity', 15:35:14 INFO - 'tart', 15:35:14 INFO - 'tscrollx', 15:35:14 INFO - 'cart']}, 15:35:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['tsvgx', 15:35:14 INFO - 'tsvgr_opacity', 15:35:14 INFO - 'tart', 15:35:14 INFO - 'tscrollx', 15:35:14 INFO - 'cart']}, 15:35:14 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:35:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:35:14 INFO - 'tests': ['tp5o']}, 15:35:14 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:35:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:35:14 INFO - 'talos_options': ['--e10s'], 15:35:14 INFO - 'tests': ['tp5o']}, 15:35:14 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:35:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:35:14 INFO - 'talos_options': ['--xperf_path', 15:35:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:14 INFO - 'tests': ['tp5n']}, 15:35:14 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 15:35:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 15:35:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 15:35:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 15:35:14 INFO - 'talos_options': ['--e10s', 15:35:14 INFO - '--xperf_path', 15:35:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 15:35:14 INFO - 'C:/slave/talos-data/talos/xperf.config'], 15:35:14 INFO - 'tests': ['tp5n']}}, 15:35:14 INFO - 'talos.zip': {'path': '', 15:35:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:35:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:35:14 INFO - {'append_to_log': False, 15:35:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:35:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:35:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:35:14 INFO - 'branch': 'Mozilla-Aurora', 15:35:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:35:14 INFO - 'config_files': ('talos/linux_config.py',), 15:35:14 INFO - 'default_actions': ('clobber', 15:35:14 INFO - 'read-buildbot-config', 15:35:14 INFO - 'download-and-extract', 15:35:14 INFO - 'populate-webroot', 15:35:14 INFO - 'create-virtualenv', 15:35:14 INFO - 'install', 15:35:14 INFO - 'run-tests'), 15:35:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:35:14 INFO - 'download_minidump_stackwalk': True, 15:35:14 INFO - 'download_symbols': 'ondemand', 15:35:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:35:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:35:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:35:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:35:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:35:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:35:14 INFO - 'installer_path': 'installer.exe', 15:35:14 INFO - 'log_level': 'info', 15:35:14 INFO - 'log_name': 'talos', 15:35:14 INFO - 'log_to_console': True, 15:35:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:35:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:35:14 INFO - 'opt_config_files': (), 15:35:14 INFO - 'pip_index': False, 15:35:14 INFO - 'python_webserver': False, 15:35:14 INFO - 'sps_profile': False, 15:35:14 INFO - 'sps_profile_interval': 0, 15:35:14 INFO - 'suite': 'dromaeojs', 15:35:14 INFO - 'system_bits': '64', 15:35:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:35:14 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 15:35:14 INFO - 'tests': (), 15:35:14 INFO - 'title': 'talos-linux64-ix-047', 15:35:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:35:14 INFO - 'use_talos_json': True, 15:35:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:35:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:35:14 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 15:35:14 INFO - 'work_dir': 'build'} 15:35:14 INFO - ##### 15:35:14 INFO - ##### Running clobber step. 15:35:14 INFO - ##### 15:35:14 INFO - Running pre-action listener: _resource_record_pre_action 15:35:14 INFO - Running main action method: clobber 15:35:14 INFO - rmtree: /builds/slave/test-pgo/build 15:35:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:35:15 INFO - Running post-action listener: _resource_record_post_action 15:35:15 INFO - ##### 15:35:15 INFO - ##### Running read-buildbot-config step. 15:35:15 INFO - ##### 15:35:15 INFO - Running pre-action listener: _resource_record_pre_action 15:35:15 INFO - Running main action method: read_buildbot_config 15:35:15 INFO - Using buildbot properties: 15:35:15 INFO - { 15:35:15 INFO - "properties": { 15:35:15 INFO - "buildnumber": 3, 15:35:15 INFO - "product": "firefox", 15:35:15 INFO - "script_repo_revision": "production", 15:35:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:35:15 INFO - "repository": "", 15:35:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:35:15 INFO - "buildid": "20151028131431", 15:35:15 INFO - "slavename": "talos-linux64-ix-047", 15:35:15 INFO - "pgo_build": "True", 15:35:15 INFO - "basedir": "/builds/slave/test-pgo", 15:35:15 INFO - "project": "", 15:35:15 INFO - "platform": "ubuntu64_hw", 15:35:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:35:15 INFO - "slavebuilddir": "test", 15:35:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:35:15 INFO - "branch": "mozilla-aurora", 15:35:15 INFO - "repo_path": "releases/mozilla-aurora", 15:35:15 INFO - "stage_platform": "linux64-pgo", 15:35:15 INFO - "builduid": "32122c98f3294e4bacd0523e0a8242c0", 15:35:15 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 15:35:15 INFO - }, 15:35:15 INFO - "sourcestamp": { 15:35:15 INFO - "repository": "", 15:35:15 INFO - "hasPatch": false, 15:35:15 INFO - "project": "", 15:35:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:35:15 INFO - "changes": [ 15:35:15 INFO - { 15:35:15 INFO - "category": null, 15:35:15 INFO - "files": [ 15:35:15 INFO - { 15:35:15 INFO - "url": null, 15:35:15 INFO - "name": "https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 15:35:15 INFO - } 15:35:15 INFO - ], 15:35:15 INFO - "repository": "", 15:35:15 INFO - "rev": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8", 15:35:15 INFO - "who": "kwierso@gmail.com", 15:35:15 INFO - "when": 1446071576, 15:35:15 INFO - "number": 6589683, 15:35:15 INFO - "comments": "Followup to bug 1204483 to fix something that was renamed a=me\nCLOSED TREE", 15:35:15 INFO - "project": "", 15:35:15 INFO - "at": "Wed 28 Oct 2015 15:32:56", 15:35:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 15:35:15 INFO - "revlink": "", 15:35:15 INFO - "properties": [ 15:35:15 INFO - [ 15:35:15 INFO - "buildid", 15:35:15 INFO - "20151028131431", 15:35:15 INFO - "Change" 15:35:15 INFO - ], 15:35:15 INFO - [ 15:35:15 INFO - "builduid", 15:35:15 INFO - "32122c98f3294e4bacd0523e0a8242c0", 15:35:15 INFO - "Change" 15:35:15 INFO - ], 15:35:15 INFO - [ 15:35:15 INFO - "pgo_build", 15:35:15 INFO - "True", 15:35:15 INFO - "Change" 15:35:15 INFO - ] 15:35:15 INFO - ], 15:35:15 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 15:35:15 INFO - } 15:35:15 INFO - ], 15:35:15 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 15:35:15 INFO - } 15:35:15 INFO - } 15:35:15 INFO - Running post-action listener: _resource_record_post_action 15:35:15 INFO - ##### 15:35:15 INFO - ##### Running download-and-extract step. 15:35:15 INFO - ##### 15:35:15 INFO - Running pre-action listener: _resource_record_pre_action 15:35:15 INFO - Running main action method: download_and_extract 15:35:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:15 INFO - https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:35:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/test_packages.json 15:35:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/test_packages.json 15:35:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:35:15 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 15:35:16 INFO - Downloaded 1302 bytes. 15:35:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:35:16 INFO - Using the following test package requirements: 15:35:16 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 15:35:16 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:16 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:35:16 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:16 INFO - u'jsshell-linux-x86_64.zip'], 15:35:16 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:16 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:35:16 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 15:35:16 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:16 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:35:16 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:16 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:35:16 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:16 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:35:16 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 15:35:16 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 15:35:16 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:35:16 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:16 INFO - https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:35:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:16 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 15:35:17 INFO - Downloaded 22906837 bytes. 15:35:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:35:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:35:18 INFO - Return code: 0 15:35:18 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:18 INFO - https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:18 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 15:35:19 INFO - Downloaded 22906837 bytes. 15:35:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:35:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 15:35:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:35:21 INFO - Return code: 0 15:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:21 INFO - https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:35:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:35:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:35:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:35:21 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'), kwargs: {}, attempt #1 15:35:22 INFO - Downloaded 10881672 bytes. 15:35:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:35:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 15:35:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:35:22 INFO - Return code: 0 15:35: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')]} 15:35:22 INFO - https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:35:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:35:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:35:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:35:22 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2'), kwargs: {}, attempt #1 15:35:24 INFO - Downloaded 56988710 bytes. 15:35:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:35:24 INFO - mkdir: /builds/slave/test-pgo/properties 15:35:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:35:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:35:24 INFO - Contents: 15:35:24 INFO - build_url:https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 15:35:24 INFO - Running post-action listener: _resource_record_post_action 15:35:24 INFO - Running post-action listener: _set_extra_try_arguments 15:35:24 INFO - ##### 15:35:24 INFO - ##### Running populate-webroot step. 15:35:24 INFO - ##### 15:35:24 INFO - Running pre-action listener: _resource_record_pre_action 15:35:24 INFO - Running main action method: populate_webroot 15:35:24 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 15:35:24 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 15:35:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 15:35:35 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 15:35:35 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 15:35:35 INFO - Running post-action listener: _resource_record_post_action 15:35:35 INFO - ##### 15:35:35 INFO - ##### Running create-virtualenv step. 15:35:35 INFO - ##### 15:35:35 INFO - Running pre-action listener: _resource_record_pre_action 15:35:35 INFO - Running main action method: create_virtualenv 15:35:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:35:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:35:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:35:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:35:35 INFO - Using real prefix '/usr' 15:35:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:35:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:35:38 INFO - Installing pip.................done. 15:35:38 INFO - Return code: 0 15:35:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:38 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 0x7fd96fcf5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf627b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, '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': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:35:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:35:38 INFO - Using env: {'DISPLAY': ':0', 15:35:38 INFO - 'HOME': '/home/cltbld', 15:35:38 INFO - 'LANG': 'en_US.UTF-8', 15:35:38 INFO - 'LANGUAGE': 'en_US:en', 15:35:38 INFO - 'LOGNAME': 'cltbld', 15:35:38 INFO - 'MAIL': '/var/mail/cltbld', 15:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:38 INFO - 'MOZ_NO_REMOTE': '1', 15:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:38 INFO - 'NO_EM_RESTART': '1', 15:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:38 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:38 INFO - 'SHELL': '/bin/bash', 15:35:38 INFO - 'SHLVL': '1', 15:35:38 INFO - 'TERM': 'linux', 15:35:38 INFO - 'TMOUT': '86400', 15:35:38 INFO - 'USER': 'cltbld', 15:35:38 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:38 INFO - '_': '/tools/buildbot/bin/python'} 15:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:35:38 INFO - Cleaning up... 15:35:38 INFO - Return code: 0 15:35:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:38 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 0x7fd96fcf5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf627b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, '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': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:35:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:35:38 INFO - Using env: {'DISPLAY': ':0', 15:35:38 INFO - 'HOME': '/home/cltbld', 15:35:38 INFO - 'LANG': 'en_US.UTF-8', 15:35:38 INFO - 'LANGUAGE': 'en_US:en', 15:35:38 INFO - 'LOGNAME': 'cltbld', 15:35:38 INFO - 'MAIL': '/var/mail/cltbld', 15:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:38 INFO - 'MOZ_NO_REMOTE': '1', 15:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:38 INFO - 'NO_EM_RESTART': '1', 15:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:38 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:38 INFO - 'SHELL': '/bin/bash', 15:35:38 INFO - 'SHLVL': '1', 15:35:38 INFO - 'TERM': 'linux', 15:35:38 INFO - 'TMOUT': '86400', 15:35:38 INFO - 'USER': 'cltbld', 15:35:38 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:38 INFO - '_': '/tools/buildbot/bin/python'} 15:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:38 INFO - Downloading/unpacking psutil>=0.7.1 15:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:35:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:35:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:40 INFO - Installing collected packages: psutil 15:35:40 INFO - Running setup.py install for psutil 15:35:40 INFO - building 'psutil._psutil_linux' extension 15:35:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:35:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:35:41 INFO - building 'psutil._psutil_posix' extension 15:35:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:35:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:35:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:41 INFO - Successfully installed psutil 15:35:41 INFO - Cleaning up... 15:35:41 INFO - Return code: 0 15:35:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:35: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')]} 15:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35: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')]} 15:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:41 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 0x7fd96fcf5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf627b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, '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': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:35:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:35:41 INFO - Using env: {'DISPLAY': ':0', 15:35:41 INFO - 'HOME': '/home/cltbld', 15:35:41 INFO - 'LANG': 'en_US.UTF-8', 15:35:41 INFO - 'LANGUAGE': 'en_US:en', 15:35:41 INFO - 'LOGNAME': 'cltbld', 15:35:41 INFO - 'MAIL': '/var/mail/cltbld', 15:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:41 INFO - 'MOZ_NO_REMOTE': '1', 15:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:41 INFO - 'NO_EM_RESTART': '1', 15:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:41 INFO - 'SHELL': '/bin/bash', 15:35:41 INFO - 'SHLVL': '1', 15:35:41 INFO - 'TERM': 'linux', 15:35:41 INFO - 'TMOUT': '86400', 15:35:41 INFO - 'USER': 'cltbld', 15:35:41 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:41 INFO - '_': '/tools/buildbot/bin/python'} 15:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:35:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:35:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:35:43 INFO - Installing collected packages: mozsystemmonitor 15:35:43 INFO - Running setup.py install for mozsystemmonitor 15:35:43 INFO - Successfully installed mozsystemmonitor 15:35:43 INFO - Cleaning up... 15:35:43 INFO - Return code: 0 15:35:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:43 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 0x7fd96fcf5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf627b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, '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': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:35:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:35:43 INFO - Using env: {'DISPLAY': ':0', 15:35:43 INFO - 'HOME': '/home/cltbld', 15:35:43 INFO - 'LANG': 'en_US.UTF-8', 15:35:43 INFO - 'LANGUAGE': 'en_US:en', 15:35:43 INFO - 'LOGNAME': 'cltbld', 15:35:43 INFO - 'MAIL': '/var/mail/cltbld', 15:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:43 INFO - 'MOZ_NO_REMOTE': '1', 15:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:43 INFO - 'NO_EM_RESTART': '1', 15:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:43 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:43 INFO - 'SHELL': '/bin/bash', 15:35:43 INFO - 'SHLVL': '1', 15:35:43 INFO - 'TERM': 'linux', 15:35:43 INFO - 'TMOUT': '86400', 15:35:43 INFO - 'USER': 'cltbld', 15:35:43 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:43 INFO - '_': '/tools/buildbot/bin/python'} 15:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:35:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:35:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:35:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:46 INFO - Downloading docopt-0.6.1.tar.gz 15:35:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:35:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:46 INFO - Running setup.py install for blobuploader 15:35:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:35:46 INFO - Running setup.py install for requests 15:35:47 INFO - Running setup.py install for docopt 15:35:47 INFO - Successfully installed blobuploader requests docopt 15:35:47 INFO - Cleaning up... 15:35:47 INFO - Return code: 0 15:35:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:47 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 0x7fd96fcf5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf627b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, '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': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:35:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:35:47 INFO - Using env: {'DISPLAY': ':0', 15:35:47 INFO - 'HOME': '/home/cltbld', 15:35:47 INFO - 'LANG': 'en_US.UTF-8', 15:35:47 INFO - 'LANGUAGE': 'en_US:en', 15:35:47 INFO - 'LOGNAME': 'cltbld', 15:35:47 INFO - 'MAIL': '/var/mail/cltbld', 15:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:47 INFO - 'MOZ_NO_REMOTE': '1', 15:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:47 INFO - 'NO_EM_RESTART': '1', 15:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:47 INFO - 'SHELL': '/bin/bash', 15:35:47 INFO - 'SHLVL': '1', 15:35:47 INFO - 'TERM': 'linux', 15:35:47 INFO - 'TMOUT': '86400', 15:35:47 INFO - 'USER': 'cltbld', 15:35:47 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:47 INFO - '_': '/tools/buildbot/bin/python'} 15:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:47 INFO - Running setup.py (path:/tmp/pip-EBQH3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:47 INFO - Running setup.py (path:/tmp/pip-owt3Cm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:47 INFO - Running setup.py (path:/tmp/pip-C3mH8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:47 INFO - Running setup.py (path:/tmp/pip-DAK591-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:47 INFO - Running setup.py (path:/tmp/pip-pk4_w3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:47 INFO - Running setup.py (path:/tmp/pip-WsauYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:47 INFO - Running setup.py (path:/tmp/pip-2wA4cE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:48 INFO - Running setup.py (path:/tmp/pip-9zU6MQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:48 INFO - Running setup.py (path:/tmp/pip-3jF732-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:48 INFO - Running setup.py (path:/tmp/pip-Y1mSaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:48 INFO - Running setup.py (path:/tmp/pip-rF8WYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:48 INFO - Running setup.py (path:/tmp/pip-auKO7X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:48 INFO - Running setup.py (path:/tmp/pip-FNuvO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:48 INFO - Running setup.py (path:/tmp/pip-86zWwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:48 INFO - Running setup.py (path:/tmp/pip-lWTqAf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:48 INFO - Running setup.py (path:/tmp/pip-U7BRNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:48 INFO - Running setup.py (path:/tmp/pip-s_0sHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:48 INFO - Running setup.py install for manifestparser 15:35:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:35:48 INFO - Running setup.py install for mozcrash 15:35:48 INFO - Running setup.py install for mozdebug 15:35:49 INFO - Running setup.py install for mozdevice 15:35:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Running setup.py install for mozfile 15:35:49 INFO - Running setup.py install for mozhttpd 15:35:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Running setup.py install for mozinfo 15:35:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Running setup.py install for mozInstall 15:35:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Running setup.py install for mozleak 15:35:49 INFO - Running setup.py install for mozlog 15:35:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Running setup.py install for moznetwork 15:35:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:35:49 INFO - Running setup.py install for mozprocess 15:35:49 INFO - Running setup.py install for mozprofile 15:35:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:35:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:35:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:35:50 INFO - Running setup.py install for mozrunner 15:35:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:35:50 INFO - Running setup.py install for mozscreenshot 15:35:50 INFO - Running setup.py install for moztest 15:35:50 INFO - Running setup.py install for mozversion 15:35:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:35:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:50 INFO - Cleaning up... 15:35:50 INFO - Return code: 0 15:35:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:50 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 0x7fd96fcf5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf627b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, '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': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:35:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:35:50 INFO - Using env: {'DISPLAY': ':0', 15:35:50 INFO - 'HOME': '/home/cltbld', 15:35:50 INFO - 'LANG': 'en_US.UTF-8', 15:35:50 INFO - 'LANGUAGE': 'en_US:en', 15:35:50 INFO - 'LOGNAME': 'cltbld', 15:35:50 INFO - 'MAIL': '/var/mail/cltbld', 15:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:50 INFO - 'MOZ_NO_REMOTE': '1', 15:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:50 INFO - 'NO_EM_RESTART': '1', 15:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:50 INFO - 'SHELL': '/bin/bash', 15:35:50 INFO - 'SHLVL': '1', 15:35:50 INFO - 'TERM': 'linux', 15:35:50 INFO - 'TMOUT': '86400', 15:35:50 INFO - 'USER': 'cltbld', 15:35:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:50 INFO - '_': '/tools/buildbot/bin/python'} 15:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:50 INFO - Running setup.py (path:/tmp/pip-idj39u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:35:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:50 INFO - Running setup.py (path:/tmp/pip-an27B7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:50 INFO - Running setup.py (path:/tmp/pip-_0LIeI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:35:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:50 INFO - Running setup.py (path:/tmp/pip-aKr25f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:51 INFO - Running setup.py (path:/tmp/pip-Tdd4H2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:51 INFO - Running setup.py (path:/tmp/pip-Cw6d5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:51 INFO - Running setup.py (path:/tmp/pip-phiayy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:51 INFO - Running setup.py (path:/tmp/pip-ctbHP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:51 INFO - Running setup.py (path:/tmp/pip-bIwfBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:51 INFO - Running setup.py (path:/tmp/pip-u6Cs7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:51 INFO - Running setup.py (path:/tmp/pip-zy9W2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:51 INFO - Running setup.py (path:/tmp/pip-zqJWCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:51 INFO - Running setup.py (path:/tmp/pip-7o1paT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:51 INFO - Running setup.py (path:/tmp/pip-X83L32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:51 INFO - Running setup.py (path:/tmp/pip-ctE4XZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:51 INFO - Running setup.py (path:/tmp/pip-frl7BW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:35:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:51 INFO - Running setup.py (path:/tmp/pip-6f48Qr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:53 INFO - Downloading blessings-1.5.1.tar.gz 15:35:53 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:35:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:35:53 INFO - Installing collected packages: blessings 15:35:53 INFO - Running setup.py install for blessings 15:35:53 INFO - Successfully installed blessings 15:35:53 INFO - Cleaning up... 15:35:53 INFO - Return code: 0 15:35:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:35:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:35:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:35:54 INFO - Reading from file tmpfile_stdout 15:35:54 INFO - Current package versions: 15:35:54 INFO - argparse == 1.2.1 15:35:54 INFO - blessings == 1.5.1 15:35:54 INFO - blobuploader == 1.2.4 15:35:54 INFO - docopt == 0.6.1 15:35:54 INFO - manifestparser == 1.1 15:35:54 INFO - mozInstall == 1.12 15:35:54 INFO - mozcrash == 0.16 15:35:54 INFO - mozdebug == 0.1 15:35:54 INFO - mozdevice == 0.46 15:35:54 INFO - mozfile == 1.2 15:35:54 INFO - mozhttpd == 0.7 15:35:54 INFO - mozinfo == 0.8 15:35:54 INFO - mozleak == 0.1 15:35:54 INFO - mozlog == 3.0 15:35:54 INFO - moznetwork == 0.27 15:35:54 INFO - mozprocess == 0.22 15:35:54 INFO - mozprofile == 0.27 15:35:54 INFO - mozrunner == 6.10 15:35:54 INFO - mozscreenshot == 0.1 15:35:54 INFO - mozsystemmonitor == 0.0 15:35:54 INFO - moztest == 0.7 15:35:54 INFO - mozversion == 1.4 15:35:54 INFO - psutil == 3.1.1 15:35:54 INFO - requests == 1.2.3 15:35:54 INFO - wsgiref == 0.1.2 15:35:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:54 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 0x7fd96fcf5b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf627b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10274a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, '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': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:35:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:35:54 INFO - Using env: {'DISPLAY': ':0', 15:35:54 INFO - 'HOME': '/home/cltbld', 15:35:54 INFO - 'LANG': 'en_US.UTF-8', 15:35:54 INFO - 'LANGUAGE': 'en_US:en', 15:35:54 INFO - 'LOGNAME': 'cltbld', 15:35:54 INFO - 'MAIL': '/var/mail/cltbld', 15:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:54 INFO - 'MOZ_NO_REMOTE': '1', 15:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:54 INFO - 'NO_EM_RESTART': '1', 15:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:54 INFO - 'SHELL': '/bin/bash', 15:35:54 INFO - 'SHLVL': '1', 15:35:54 INFO - 'TERM': 'linux', 15:35:54 INFO - 'TMOUT': '86400', 15:35:54 INFO - 'USER': 'cltbld', 15:35:54 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:54 INFO - '_': '/tools/buildbot/bin/python'} 15:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:35:54 INFO - Cleaning up... 15:35:54 INFO - Return code: 0 15:35:54 INFO - Running post-action listener: _resource_record_post_action 15:35:54 INFO - Running post-action listener: _start_resource_monitoring 15:35:54 INFO - Starting resource monitoring. 15:35:54 INFO - ##### 15:35:54 INFO - ##### Running install step. 15:35:54 INFO - ##### 15:35:54 INFO - Running pre-action listener: _resource_record_pre_action 15:35:54 INFO - Running main action method: install 15:35:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:35:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:35:54 INFO - Reading from file tmpfile_stdout 15:35:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:35:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:35:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:35:54 INFO - Reading from file tmpfile_stdout 15:35:54 INFO - Output received: 15:35:54 INFO - Usage: mozinstall [options] installer 15:35:54 INFO - Options: 15:35:54 INFO - -h, --help show this help message and exit 15:35:54 INFO - -d DEST, --destination=DEST 15:35:54 INFO - Directory to install application into. [default: 15:35:54 INFO - "/builds/slave/test-pgo"] 15:35:54 INFO - --app=APP Application being installed. [default: firefox] 15:35:54 INFO - mkdir: /builds/slave/test-pgo/build/application 15:35:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:35:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:36:08 INFO - Reading from file tmpfile_stdout 15:36:08 INFO - Output received: 15:36:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:36:08 INFO - Running post-action listener: _resource_record_post_action 15:36:08 INFO - ##### 15:36:08 INFO - ##### Running run-tests step. 15:36:08 INFO - ##### 15:36:08 INFO - Running pre-action listener: _resource_record_pre_action 15:36:08 INFO - Running main action method: run_tests 15:36:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:36:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:36:08 INFO - Python 2.7.3 15:36:08 INFO - Return code: 0 15:36:08 INFO - grabbing minidump binary from tooltool 15:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:08 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 0xdb9bf0>, '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 0x10b74f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b79a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:36:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:36:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:36:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:36:08 INFO - Return code: 0 15:36:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:36:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:36:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:36:08 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/1eUMDjZmSEyn_ZzmMe_Dyg/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-047', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:36:08 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/1eUMDjZmSEyn_ZzmMe_Dyg/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-047 --webServer localhost 15:36:08 INFO - Using env: {'DISPLAY': ':0', 15:36:08 INFO - 'HOME': '/home/cltbld', 15:36:08 INFO - 'LANG': 'en_US.UTF-8', 15:36:08 INFO - 'LANGUAGE': 'en_US:en', 15:36:08 INFO - 'LOGNAME': 'cltbld', 15:36:08 INFO - 'MAIL': '/var/mail/cltbld', 15:36:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:36:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:08 INFO - 'MOZ_NO_REMOTE': '1', 15:36:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:08 INFO - 'NO_EM_RESTART': '1', 15:36:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:36:08 INFO - 'PWD': '/builds/slave/test-pgo', 15:36:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:36:08 INFO - 'SHELL': '/bin/bash', 15:36:08 INFO - 'SHLVL': '1', 15:36:08 INFO - 'TERM': 'linux', 15:36:08 INFO - 'TMOUT': '86400', 15:36:08 INFO - 'USER': 'cltbld', 15:36:08 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453', 15:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:08 INFO - '_': '/tools/buildbot/bin/python'} 15:36:08 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/1eUMDjZmSEyn_ZzmMe_Dyg/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-047', '--webServer', 'localhost'] with output_timeout 3600 15:36:09 INFO - mozversion INFO | application_buildid: 20151028131431 15:36:09 INFO - mozversion INFO | application_changeset: bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 15:36:09 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 15:36:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:36:09 INFO - mozversion INFO | application_name: Firefox 15:36:09 INFO - mozversion INFO | application_remotingname: firefox-dev 15:36:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:36:09 INFO - mozversion INFO | application_vendor: Mozilla 15:36:09 INFO - mozversion INFO | application_version: 43.0a2 15:36:09 INFO - mozversion INFO | platform_buildid: 20151028131431 15:36:09 INFO - mozversion INFO | platform_changeset: bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 15:36:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:36:09 INFO - mozversion INFO | platform_version: 43.0a2 15:36:09 INFO - 2015-10-28 15:36:09,381 DEBUG : using testdate: 1446071769 15:36:09 INFO - 2015-10-28 15:36:09,381 DEBUG : actual date: 1446071769 15:36:09 INFO - 2015-10-28 15:36:09,389 INFO : Starting test suite talos-linux64-ix-047 15:36:09 INFO - 2015-10-28 15:36:09,389 INFO : Starting test dromaeo_css 15:36:09 INFO - 2015-10-28 15:36:09,389 DEBUG : operating with platform_type : linux_ 15:36:09 INFO - 2015-10-28 15:36:09,389 INFO : Initialising browser for dromaeo_css test... 15:36:09 INFO - 2015-10-28 15:36:09,441 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw2Q8it/profile http://localhost/getInfo.html 15:36:15 INFO - 2015-10-28 15:36:15,191 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:36:15 INFO - 2015-10-28 15:36:15,191 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:36:15 INFO - 2015-10-28 15:36:15,191 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:36:15 INFO - 2015-10-28 15:36:15,191 DEBUG : BROWSER_OUTPUT: __metrics 15:36:15 INFO - 2015-10-28 15:36:15,591 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:36:16 INFO - 2015-10-28 15:36:16,912 INFO : Browser initialized. 15:36:16 INFO - 2015-10-28 15:36:16,912 INFO : Running cycle 1/1 for dromaeo_css test... 15:36:16 INFO - 2015-10-28 15:36:16,913 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw2Q8it/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:36:28 INFO - 2015-10-28 15:36:28,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 131710976 15:36:28 INFO - 2015-10-28 15:36:28,622 DEBUG : BROWSER_OUTPUT: 15:39:28 INFO - 2015-10-28 15:39:28,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-dojo.html (next: http://localhost/page_load_test/dromaeo/cssquery-ext.html) 15:39:29 INFO - 2015-10-28 15:39:29,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 250724352 15:39:29 INFO - 2015-10-28 15:39:29,301 DEBUG : BROWSER_OUTPUT: 15:42:31 INFO - 2015-10-28 15:42:31,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-ext.html (next: http://localhost/page_load_test/dromaeo/cssquery-jquery.html) 15:42:32 INFO - 2015-10-28 15:42:32,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 208207872 15:42:32 INFO - 2015-10-28 15:42:32,082 DEBUG : BROWSER_OUTPUT: 15:45:33 INFO - 2015-10-28 15:45:33,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-jquery.html (next: http://localhost/page_load_test/dromaeo/cssquery-mootools.html) 15:45:34 INFO - 2015-10-28 15:45:34,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 211005440 15:45:34 INFO - 2015-10-28 15:45:34,445 DEBUG : BROWSER_OUTPUT: 15:48:36 INFO - 2015-10-28 15:48:36,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-mootools.html (next: http://localhost/page_load_test/dromaeo/cssquery-prototype.html) 15:48:36 INFO - 2015-10-28 15:48:36,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 200224768 15:48:36 INFO - 2015-10-28 15:48:36,672 DEBUG : BROWSER_OUTPUT: 15:51:39 INFO - 2015-10-28 15:51:39,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-prototype.html (next: http://localhost/page_load_test/dromaeo/cssquery-yui.html) 15:51:39 INFO - 2015-10-28 15:51:39,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 195256320 15:51:39 INFO - 2015-10-28 15:51:39,602 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-yui.html (next: http://localhost/page_load_test/dromaeo/cssquery-dojo.html) 15:54:41 INFO - 2015-10-28 15:54:41,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 238596096 15:54:41 INFO - 2015-10-28 15:54:41,850 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,850 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:54:41 INFO - 2015-10-28 15:54:41,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:54:41 INFO - 2015-10-28 15:54:41,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:54:41 INFO - 2015-10-28 15:54:41,851 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:54:41 INFO - 2015-10-28 15:54:41,854 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3373.443381841996;3383.7631365804405;3445.638207988163;3460.8752155549455;3467.5665541807275;5753.798617048405;5758;5796.768129274824;5807.128930660398;5820.621659592129;5806.622569532988;5811.767529298833;5834.970825145869;5835.824925252249;5870.677112758796;5143.3570803649545;5212.113940630083;5212.374515058179;5213.165893457038;5280.313559237294;5251.711155886424;5262.368515778112;5353.759080841352;5362.91955620666;5379.865503362408;5298.23175639532;5307.38965019022;5308.867278318035;5311.57507399409;5319.654222475546;5105.974470127626;5176.870578235536;5201.349831271091;5214.348206474191;5301.549368303698;5108.055009823158;5204.011237864794;5212.478752124795;5220.138677118271;5233.4243233244315;5531.834044978657;5532.059549876531;5537.390887002426;5537.529310008654;5559.749811258503;5979.073243647242;6100.9439798830535;6108.572399932006;6131.570790044699;6153.784617538409;6279.838229927433;6288.937110628926;6322.336154703782;6329.493640508748;6340.11238426616;5774.682392468412;5778.8266352009505;5781.4507621775865;5786;5787.94212057874;6054.152418661391;6144.784932527429;6190.535709821781;6325.14610527582;6331.240251169889;6100.359462256488;6104.26748790148;6105.236845394325;6105.48103411215;6106.084087386927;6190.690465476709;6191.9690401547705;6193.907091393633;6225.035119556476;6235.625862448177;6037.9396206038255;6072.848178795565;6130.574042846152;6148.415900489446;6163.291221509494;6187.102870083812;6200.348963358872;6204.162438070893;6217.626942383471;6254.3745625437095;4603.884902877455;4709.623230141649;4709.835155769531;4733.053389322149;4736.786844592001;4142.523609784853;4193.496780386312;4197.349410841324;4203.201391735561;4214.789260536961;5953.672548009901;5984.888157402506;5987.221661184019;5991.400859914061;6020.247469066367;6009.45914867664;6116.08009436919;6284.622922624657;6340.270868850049;6367.681615919186;5888.823335299948;5980.73086711099;5981.730822113015;5982.760689572456;5993.250843644544;5429.755660995185;5439.728013599383;5441.782328706887;5442.782288708408;5476.863078423071;6218.689065546704;6309.652969086653;6310.558260921784;6512.185976752906;6523.086767852505;6289.905651415141;6294;6307.085472606538;6309.242890853127;6369.267534233622;6482.124913136855;6486.513511486563;6499.805005849832;6501.934980650133;6505.739770409131;5926.318473375617;6004.489618382487;6024.819255422344;6125.531522459876;6151.231096112986;6304.810855674337;6320.083587879823;6327.683615819283;6328.050792381179;6335.113084168128;6150.876982460415;6152.661603611844;6156.661383623765;6161.260648722003;6170.876582468415;5951.672658003851;6023.548233882564;6049.425304596057;6114.700526355248;6126.548209434937;6051.304100028553;6087.66517841523;6094.055421409688;6095.786647467317;6100.054491553817;5843.620164689281;6151.6001459904965;6181.165542651865;6202.844928876814;6218;5885.558583106199;5925.140854576149;5948.315943666534;5988.550858685703;6011.188489554029 15:54:41 INFO - 2015-10-28 15:54:41,854 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.7241560258877;633.6103296472671;640.6284355074057;646.7639311651249;649.1398896462189;45427.545724542746;45990.310145347845;46010.53989460108;46023;46061.30908036378;49735.50264497354;50343.24485132726;50397.49602503974;50408;50432.747836260765;8300.626471808753;8436.493810371398;9352.298577606673;9524.761880952963;11046.668599942015;11106.722331941684;11226.49480773363;11229.270097443681;11232;11238.887611123866;10951.288166269167;11155;11156.553737850476;11156.888431115665;11166.665000050012;8581.52801595912;8811.867821982676;11327.490262938187;11520.942395288053;11594.652160435116;10933.343999359984;11055.391953442557;11070.446477676083;11081.72295692606;11082.556697732081;46348.536514635096;46536;46897;46993;47012;3863.7102217333813;4017.7589344639123;4050.8379664813374;4061.735987160825;4236.755188242457;33769.6623033769;33873;34397.31205375904;34426.65573344284;34614.134646633785;3573.8927832165077;3710.07248187953;3835.098751793354;3837.597052309495;3849.903752406184;334690;336162;336318.99999999756;337338;338615;63468.36531634717;63837;72642.63678681572;72987;73394.63302683452;69413.3058669417;69599.3040069603;69646.30353696398;69871.3012869875;70022.64988675024;17614.823851761575;17708;17726.734098988527;17756.289748410178;17776.200070996838;13138.671533211555;13353.866461335456;14865.628359290888;15091.396344146331;15104;23258.185963491534;23669.763302366755;23760.524789504114;23802.16692415792;23904.282871513882;8981.14679105484;8985.415947963362;9070.183683468387;9169.816603668023;9239;1079.4980334144504;1083.875354334246;1197.4072833947077;1201.627495476405;1238.721287710258;32715.50926736101;32771.50842737361;33010.339793204;33051;33590.328193436486;1175.8118701007797;1213.769383817072;1222.49877550204;1229.3914512316283;1300.7073408483016;15130;17286.654266914844;17474.82525174732;17810.732839007425;18452.446426607225;378181;380132;380668;381360;382406;62113.37886621076;62362.68818655969;62871;62915;63048.68475657592;1351.5810098869185;1367.4598533579378;1500.3998400639832;1508.6831765329184;1526.587821288246;33290;33393;33592.664073359934;33861.830690847375;34671.82664086663;51534.22698659598;52076.739616301675;58294.4170558289;59964.70017649884;60006;519054;530744;534652;534670;534763;50419.747901260256;50508.747456262485;50968.235476468624;51048.74475627747;51910.480895190565;53819.19271211013;54076;54185.72907135597;54692;54802.17796732973;44135.33796993112;45518;45537.357011439664;45831.54168458273;46226;45145.77427112844;45496.77251613721;45583;45724;46737.29894051524;45490.09019819519;46226.76886615546;46381.76809115933;46647.06705865796;46728.766356168;37913;42036;42121.78939105407;42153;42502.59979201718;29615.407691846474;30307.393852123274;30555.694443055287;30575.847120764254;30741.23146921345 15:54:41 INFO - 2015-10-28 15:54:41,855 DEBUG : BROWSER_OUTPUT: |2;jquery.html;421.05473212637634;421.54894263138453;422.4951183335914;428.9699721019528;429.7464495947391;15811.92094039531;16306.42927497535;19368.12843422046;19754.90122549387;20370.490737731565;20282.594348113027;20495.590088198263;20497.38507844767;20691.172353105896;20837.583248335024;5802.419758024195;5882.852928676774;5886.941130588703;5937.228160339171;5941.197938278342;4206.348016057516;4338.045629961403;5723.284589426322;6222.533310001768;6406.775762848301;6349.650769207692;6349.809505714836;6354.078658594524;6379.106925030476;6380.649064301485;5160.535551800337;5282.894342113174;5287.576993840503;5289.894202115936;5292.523672869441;4593.63250939924;4605.769711514445;4624.329472226508;4646.279826626878;4650.069986002813;14589.197594132318;14687.926560367237;14785.852141478555;14914.776278355834;14976.17631030293;2303.1478353009325;2307.4462129088897;2352.470694093832;2357.092519380051;2550.13295479536;11190.496427660775;11230.55077796887;11242.156838237164;11357.091432685365;11397.487113079931;1815.3101821307819;1816.609428972764;1850.1859181959894;1852.3424184414473;1904.3620387170315;73284.6335768323;73788.63105684491;76172;76527.61736191339;76778;8062.1937806220085;8098.878516822252;8192.30365418946;8251.95874020626;8262.132476090044;9992.550335234931;9993.450360230258;10006.09945104944;10008.39949603026;10008.749781255527;6513;6545.312742162099;6595.901061484082;6597.076409302702;6631.403173714389;6865.347791959855;6901.654917254217;6907.447404207652;6929.618870962045;6930.7227710891;3787.110029143149;3804.0489877530617;3808.8476460941806;3823.967528767217;3846;1276.4000919567975;1293.6377814212035;1294.4498588100207;1301.134745394321;1326.4959315460255;549.9120140777457;570.3668927490482;570.7916610437161;580.7618876260713;583.8394441528528;13698.726025479435;13747.793783093262;14189.077709949026;14189.574312770634;14225.715485690229;575.4274496875636;581.8836232753466;591.721890711365;597.4622839444448;616.4267231474771;6263.342349053375;7633.770986870402;7693.038370203724;7698.307152356315;7815.53106813593;377920;525225;536106;544076;544642;67629.66185169043;78330.6083469579;79888.20111798808;80640.59679701681;82627;573.3635664412499;575.9078547432391;580.9070548712185;585.8652509922656;586.7095787585173;12036.75926481483;12123;12316.507339706312;12415.37923103823;12443.128980971607;40041.399379008755;40286.39570406388;40591.1881762369;41136.79431602823;41680;55411.44588554224;56192.438075618724;56281.43718562926;56972;57263;7416.332530072319;7446.73936412223;7477.401807855467;7517.736879209201;7601.087869455479;11112.777744445228;11410.543578256777;13635.522756703467;13727.519536816164;13927.234002129575;11405.372704501;11637.825432618349;11645.301281923112;12147.45336459879;12341.259524428562;11503.137264705014;11685.707857303636;12161.756764864831;12250.081243906921;12381.938090309492;12320.383980800745;12370.381480925738;12711.682207944876;12908.870911291142;13089.607311780663;7880.3301719354495;7894.802629934297;7900.209979002054;7964.163762804822;7971.083325417651;12499.687507812378;12509.749805003667;12621.684457888627;12772.552960646333;12901.419436125208 15:54:41 INFO - 2015-10-28 15:54:41,856 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1560.0717573044035;1692.6699293637741;1815.1559524820957;2065.999999999999;2084.3851063936127;8986.2810975122;10165.085142337188;10398.272120951528;10410.687679369612;10411.06300432961;9867.259955503348;9894.50527473627;10041.899581004187;10045.397276163436;10065.64770233042;2061.618600558894;2131.701561781344;2399.20826127378;2406.32622865597;2451.6199989001734;2509.82431229814;2528.203615861007;2543.9491210175784;2548.6941567011986;2549.0823303610687;2446.889889954947;2468.7407822178684;2470.147799009339;2473.0973194783865;2474.1958863369478;2142.0574947023338;2172.1854304635763;2397.700287464067;2470.468849197431;2477.6283557466345;2468.5309791139807;2488.962665560018;2493.1523282084177;2500.8749562521803;2521.432677647533;10302.072813446826;10316.690499285034;10395;10406.323588966769;10424.218183636258;5655.915161272585;5743.54051675865;5753.194552762617;5754.6547207167705;5755.654660720328;3420.7605467617277;3431.24512607226;3446.1556918554866;3547.4856145858707;3552.0409489437966;1190.2798806721896;1192.8866757658009;1202.0563857372008;1235.116891422637;1274.4265080713624;14752.409903603842;14790.334434950453;14790.630234244123;14794.260286985715;14797.556073317817;4884.267359895973;4887.926681099786;4918.90162196754;4996;5004.449510553836;11955.282683039046;11988.220765650205;11988.760224795455;11991.820122698167;12008.339541325311;5649;5652.869426114794;5652.943470565324;5666.46168613981;5673.631213971161;5029.994001199775;5122.564582010496;5124.897502050013;5125.513076257749;5126.128558145124;4391.978040109779;4393.450818647669;4410.4927933287445;4424.181526417623;4452.0873220989615;1268.3848333558217;1295.3070107492447;1295.8121072444442;1296.4684479363416;1312.0553201694765;1489.508462207469;1501.2493753123438;1510;1534.332565334061;1548.2568367183815;9574.377665451724;9638.662646807328;9645.758856028515;9650.227981761442;9656.517174141405;567.9261695979496;571.87418767871;573.057320707434;573.5096492498936;578.0548802707603;7572.659230334648;7586.317231449196;7649.464537482323;7655.923440765632;7679.308862202429;12985.480580776662;13219.206847589176;13236.338183090807;13238.470461181638;13256.138351007154;12848.550300739616;13138.868611313956;13207.207567545978;13207.735845283041;13214.207147570984;9365.765855853659;9384.5307734613;9405.388649737744;9432.151106400457;9519.952400238093;9244.306676999386;9314.44113353201;9375.859362109437;9378.718638440858;9383.671571494964;11122.165837562054;11290.983811457008;11363.261388009752;11407;11431.828522572334;11424.885751142714;11644.76710465769;11664.125190610568;11722.355270460206;11739.23694959825;9202.447853128833;9214.216791572791;9220.769480763034;9272.350935434455;9283.35016548862;9642;9647.807043858944;9651.324407291422;9690.418574885529;9758.316917815684;8554.700585479479;8709.825803484022;8775;8790.956045219733;9323.906760932305;9224.815503690023;9283.907160928575;9354.625814967325;9391.85912211331;9448.149666529771;9342.972273049823;9346;9350.298727595322;9458.479783611692;9531.142197202285;8446.831063378575;8446.831063378575;8478.83042339162;8526.914730852612;8545.316374689886;8724.825503490021;8733.65065397377;8814.51520166397;8836.602352894006;8857.025727170136 15:54:41 INFO - 2015-10-28 15:54:41,857 DEBUG : BROWSER_OUTPUT: |4;prototype.html;396.85713143268435;398.2731514985151;398.50386269094975;400.2927514152142;405.4870588705288;5922.822315330536;5923.37804530524;6000.819975400734;6049.274087109553;6055.182550355701;5867.794627188049;5926.051831706928;5955.987482128038;5963.284405871291;5966.492848107905;4528.43394575678;4579.381783459224;4648.279516674921;4734.952650473486;4762.071396077767;4667.8599642010795;4671.813127474897;4675.555822196886;4701.858944231679;4741.288806679008;4644.187267228239;4645.767711614422;4668.9766551167195;4698.2482802751565;4703.318018887259;4651.88370290742;4683.906321873577;4688.835890743825;4691.906161876777;4698.1778188816825;4162.83348666053;4232.195882782262;4234.830606775725;4280.951166964082;4284.400183974215;5740.282464691913;5749.31008279005;5773.191753154561;5774.249347584829;5774.595778295521;5311.920321195185;5541.750621222055;5548.056830338852;5551.777928882881;5557.72211389433;6224.221972253468;6266.310705822356;6325.430711236011;6328.778492752732;6335.081413195107;4657.301404789275;4661.510541393172;4662.580367766917;4664.976675116636;4665.206914824488;6456.612603243821;6498.610083395011;6515.576487528296;6518.315576864408;6519.119918810948;4709.740964246931;4813.735244561512;4814.566688998007;4829.6860704054825;4874.610031197496;4936.605071594264;4937.432195297587;4938.308636790852;4943.777530011158;4944.579710724629;5528.336599608073;5528.419515950848;5528.723563821793;5531.557475401958;5538.0585300499015;6296.622202667854;6388.233411990591;6412.775552855627;6414.935850641527;6420.903686444707;1759.744836998628;1765.188013513798;1766.0816375484676;1766.1081154017395;1767.3902503636225;1246.6073186946264;1249.2317224906617;1254.6047994881583;1259.9685007874693;1284.3257289922865;6240.53196010292;6242.625442473466;6244.0321750128805;6247.250329960434;6250.749970001149;6549.214094308713;6568.376004279586;6575.83560410984;6582.144321238208;6588.505862060269;6064.878702425926;6219.191505104308;6243.094751261042;6249.75000999964;6253.374662533801;3600.351936651428;3613.259281847215;3627.038834708804;3632.727545434103;3637.2361804020925;6799.762008329685;6800.727970881208;6801.18385793708;6801.65991700413;6805;6655.035019922084;6757.020232066323;6761.5604985676755;6762.256151823295;6766.951122576009;6448.580842245239;6654.70053847578;6750.628715420699;6792.932070679329;6798.5241033128195;6543.1821022372205;6578.309277525791;6584.670766461562;6593.175853018372;6602.207735071822;6482.351764823668;6487.286398496256;6515.218173819172;6542.607443553402;6548.967255163694;6691.866162676816;6737.66311684404;6767.1879374475375;6803.659817009228;6844.555103918229;4790.353302304145;4791.401074865642;4794.760261986957;4803.615710743063;4810.687305325143;6550.344965503602;6552.049952756919;6582.440492558187;6610.305917878746;6610.438112760469;6290.905636415366;6359.682015899094;6367.172267605181;6377.362263773771;6438.130852335063;6351.555391122577;6359.332270111757;6365.61806291624;6367.745290188341;6369.681515924092;6230.096635987847;6239.313675495601;6251.71867265965;6266.655333956676;6266.749330026931;6257.78097766576;6356.078368636614;6357.268914074755;6359.936400635935;6365.77719779824;6258.843528911813;6280.0893870389455;6291.087792270187;6294.433500984934;6301.180846489927 15:54:41 INFO - 2015-10-28 15:54:41,857 DEBUG : BROWSER_OUTPUT: |5;yui.html;816.5427360678017;845.129516597904;871.2507243770357;955.9235261179106;965.4882912056612;13817.37821798019;14216.28918554072;14694.191819449927;14738.263086845669;14779.261036948163;13545.255010974393;13563.52527661532;13598.796018059713;13605.659858503543;13619.863801361984;771.0362047440699;776.3323541754087;929.8977112517617;936.0826390137669;940.4545363689078;885.8494056010494;938.2822141062093;940.2853831088354;943.575391074016;945.654835984864;803.1887793328722;931.6087243357772;979.3438396274513;984.6996666016862;988.7478692933328;812.544974814103;978.33473238198;984.242133557157;985.5367977050774;987.575342602677;693.3136195166799;715.1346870286959;732.4543215304632;732.6300218389732;733.611186071383;13248.73502529944;13326.666833329147;13350.799738003938;13364.599062028155;13384.397702103428;12460.252384856938;12709.173903696323;12874.356282185854;12917.160384574972;12934.805977910244;10532.315399499008;10695;10845.891541084568;10914.181436392302;11091.944540277327;3752.2683076800035;3764.642358975893;3781.2248489059675;3782.3002744492355;3800.7339486235974;43554.346684799755;43572.564274357166;43803.12393752107;44015.339769903476;44406.11187776226;10224.795504090025;10284.485775711184;10306.793864122676;10493.317934334244;10783.08343790771;12435.253884766942;12541.310227937369;12547.811782823264;19357.12892919822;19411.805881941;7037.085178926707;7103.786886393416;7144.3570078693165;7253.310935461122;7281.890771638429;4471.418715566955;4489.720429677526;4508.797104130322;4550.49944506104;4616.3537104805355;2857.2571131505542;2861.5993760873494;2874.870630821576;2879.481693295185;2889.956650650242;502.62052150626045;512.0987062769552;514.3133916221811;517.2189993110355;517.2603177456274;701.1796198447828;701.4528667639147;725.9312150422464;729.8978143059976;747.2751431111813;8773.473591584398;9027.277817774562;9044.547772611475;9050.27597792175;9136.817263654822;564.6414526775527;637.9521535884827;702.9261927497539;711.9786406407816;715.1989771455899;4388.71473354231;4480.484744254387;4599.2871104978785;4603.976980115078;4676.438827340741;50510.74744626253;53306.73346633319;53328;53805.1929221062;53914;44272;44475.33287000633;44960.3255951161;47356.2896556545;47411.52588474071;39655.60344396577;39820.20359592792;39834.800825995684;40036.799816001316;40441.79779101086;9049.728508144766;9056.818863622559;9166.724998250063;9340.065993400878;9467.763305917408;27969.44061118807;28106.2973425666;28503.857480712464;28630.14109576716;28663.140105796858;36145.81927090348;36721.44917826288;36913.815430922674;37066;39851.402228966006;8113.8377232456205;8294.58527073632;8324.458910170819;8337.666493340199;8587.184217499327;12192.329421881881;12254.938725306316;12442.751144976868;12449.44381952256;12470.064745144331;11456.770864582495;11477.598284060352;11568.826467603161;11597.5360985563;11725.941370293094;11723.882761172279;12014.579489717818;12137.757244855231;12146.574869879865;12413.131080824256;9259.470929972422;10811.891881081088;11526.1931664786;12033.45849436795;12487.687807804878;9847.261455391017;10015.849762253427;10281.228907831794;10610.52252648648;10722.571097156026;10200.28597998133;10679.786404271716;10758.40828754426;10777.191710621892;10782.406967616856 15:54:41 INFO - 2015-10-28 15:54:41,857 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:54:41 INFO - 2015-10-28 15:54:41,857 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:54:41 INFO - 2015-10-28 15:54:41,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,914 15:54:41 INFO - 2015-10-28 15:54:41,858 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:54:41 INFO - 2015-10-28 15:54:41,858 DEBUG : BROWSER_OUTPUT: __startTimestamp1446072881850__endTimestamp 15:54:41 INFO - 2015-10-28 15:54:41,858 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,858 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:54:41 INFO - 2015-10-28 15:54:41,858 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:54:41 INFO - 2015-10-28 15:54:41,858 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,860 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5766.40 Median:6004.49 stddev:661.14 (11.0%) stddev-sans-first:635.96 15:54:41 INFO - 2015-10-28 15:54:41,860 DEBUG : BROWSER_OUTPUT: Values: 3373.4 3383.8 3445.6 3460.9 3467.6 5753.8 5758.0 5796.8 5807.1 5820.6 5806.6 5811.8 5835.0 5835.8 5870.7 5143.4 5212.1 5212.4 5213.2 5280.3 5251.7 5262.4 5353.8 5362.9 5379.9 5298.2 5307.4 5308.9 5311.6 5319.7 5106.0 5176.9 5201.3 5214.3 5301.5 5108.1 5204.0 5212.5 5220.1 5233.4 5531.8 5532.1 5537.4 5537.5 5559.7 5979.1 6100.9 6108.6 6131.6 6153.8 6279.8 6288.9 6322.3 6329.5 6340.1 5774.7 5778.8 5781.5 5786.0 5787.9 6054.2 6144.8 6190.5 6325.1 6331.2 6100.4 6104.3 6105.2 6105.5 6106.1 6190.7 6192.0 6193.9 6225.0 6235.6 6037.9 6072.8 6130.6 6148.4 6163.3 6187.1 6200.3 6204.2 6217.6 6254.4 4603.9 4709.6 4709.8 4733.1 4736.8 4142.5 4193.5 4197.3 4203.2 4214.8 5953.7 5984.9 5987.2 5991.4 6020.2 6009.5 6116.1 6284.6 6340.3 6367.7 5888.8 5980.7 5981.7 5982.8 5993.3 5429.8 5439.7 5441.8 5442.8 5476.9 6218.7 6309.7 6310.6 6512.2 6523.1 6289.9 6294.0 6307.1 6309.2 6369.3 6482.1 6486.5 6499.8 6501.9 6505.7 5926.3 6004.5 6024.8 6125.5 6151.2 6304.8 6320.1 6327.7 6328.1 6335.1 6150.9 6152.7 6156.7 6161.3 6170.9 5951.7 6023.5 6049.4 6114.7 6126.5 6051.3 6087.7 6094.1 6095.8 6100.1 5843.6 6151.6 6181.2 6202.8 6218.0 5885.6 5925.1 5948.3 5988.6 6011.2 15:54:41 INFO - 2015-10-28 15:54:41,860 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,860 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:61437.16 Median:3940.73 stddev:111814.01 (2837.4%) stddev-sans-first:112034.31 15:54:41 INFO - 2015-10-28 15:54:41,861 DEBUG : BROWSER_OUTPUT: Values: 580.7 633.6 640.6 646.8 649.1 45427.5 45990.3 46010.5 46023.0 46061.3 49735.5 50343.2 50397.5 50408.0 50432.7 8300.6 8436.5 9352.3 9524.8 11046.7 11106.7 11226.5 11229.3 11232.0 11238.9 10951.3 11155.0 11156.6 11156.9 11166.7 8581.5 8811.9 11327.5 11520.9 11594.7 10933.3 11055.4 11070.4 11081.7 11082.6 46348.5 46536.0 46897.0 46993.0 47012.0 3863.7 4017.8 4050.8 4061.7 4236.8 33769.7 33873.0 34397.3 34426.7 34614.1 3573.9 3710.1 3835.1 3837.6 3849.9 334690.0 336162.0 336319.0 337338.0 338615.0 63468.4 63837.0 72642.6 72987.0 73394.6 69413.3 69599.3 69646.3 69871.3 70022.6 17614.8 17708.0 17726.7 17756.3 17776.2 13138.7 13353.9 14865.6 15091.4 15104.0 23258.2 23669.8 23760.5 23802.2 23904.3 8981.1 8985.4 9070.2 9169.8 9239.0 1079.5 1083.9 1197.4 1201.6 1238.7 32715.5 32771.5 33010.3 33051.0 33590.3 1175.8 1213.8 1222.5 1229.4 1300.7 15130.0 17286.7 17474.8 17810.7 18452.4 378181.0 380132.0 380668.0 381360.0 382406.0 62113.4 62362.7 62871.0 62915.0 63048.7 1351.6 1367.5 1500.4 1508.7 1526.6 33290.0 33393.0 33592.7 33861.8 34671.8 51534.2 52076.7 58294.4 59964.7 60006.0 519054.0 530744.0 534652.0 534670.0 534763.0 50419.7 50508.7 50968.2 51048.7 51910.5 53819.2 54076.0 54185.7 54692.0 54802.2 44135.3 45518.0 45537.4 45831.5 46226.0 45145.8 45496.8 45583.0 45724.0 46737.3 45490.1 46226.8 46381.8 46647.1 46728.8 37913.0 42036.0 42121.8 42153.0 42502.6 29615.4 30307.4 30555.7 30575.8 30741.2 15:54:41 INFO - 2015-10-28 15:54:41,861 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,861 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27849.58 Median:4465.84 stddev:83777.51 (1876.0%) stddev-sans-first:83987.22 15:54:41 INFO - 2015-10-28 15:54:41,862 DEBUG : BROWSER_OUTPUT: Values: 421.1 421.5 422.5 429.0 429.7 15811.9 16306.4 19368.1 19754.9 20370.5 20282.6 20495.6 20497.4 20691.2 20837.6 5802.4 5882.9 5886.9 5937.2 5941.2 4206.3 4338.0 5723.3 6222.5 6406.8 6349.7 6349.8 6354.1 6379.1 6380.6 5160.5 5282.9 5287.6 5289.9 5292.5 4593.6 4605.8 4624.3 4646.3 4650.1 14589.2 14687.9 14785.9 14914.8 14976.2 2303.1 2307.4 2352.5 2357.1 2550.1 11190.5 11230.6 11242.2 11357.1 11397.5 1815.3 1816.6 1850.2 1852.3 1904.4 73284.6 73788.6 76172.0 76527.6 76778.0 8062.2 8098.9 8192.3 8252.0 8262.1 9992.6 9993.5 10006.1 10008.4 10008.7 6513.0 6545.3 6595.9 6597.1 6631.4 6865.3 6901.7 6907.4 6929.6 6930.7 3787.1 3804.0 3808.8 3824.0 3846.0 1276.4 1293.6 1294.4 1301.1 1326.5 549.9 570.4 570.8 580.8 583.8 13698.7 13747.8 14189.1 14189.6 14225.7 575.4 581.9 591.7 597.5 616.4 6263.3 7633.8 7693.0 7698.3 7815.5 377920.0 525225.0 536106.0 544076.0 544642.0 67629.7 78330.6 79888.2 80640.6 82627.0 573.4 575.9 580.9 585.9 586.7 12036.8 12123.0 12316.5 12415.4 12443.1 40041.4 40286.4 40591.2 41136.8 41680.0 55411.4 56192.4 56281.4 56972.0 57263.0 7416.3 7446.7 7477.4 7517.7 7601.1 11112.8 11410.5 13635.5 13727.5 13927.2 11405.4 11637.8 11645.3 12147.5 12341.3 11503.1 11685.7 12161.8 12250.1 12381.9 12320.4 12370.4 12711.7 12908.9 13089.6 7880.3 7894.8 7900.2 7964.2 7971.1 12499.7 12509.7 12621.7 12772.6 12901.4 15:54:41 INFO - 2015-10-28 15:54:41,862 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,863 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7060.11 Median:3549.76 stddev:4030.30 (113.5%) stddev-sans-first:4020.41 15:54:41 INFO - 2015-10-28 15:54:41,863 DEBUG : BROWSER_OUTPUT: Values: 1560.1 1692.7 1815.2 2066.0 2084.4 8986.3 10165.1 10398.3 10410.7 10411.1 9867.3 9894.5 10041.9 10045.4 10065.6 2061.6 2131.7 2399.2 2406.3 2451.6 2509.8 2528.2 2543.9 2548.7 2549.1 2446.9 2468.7 2470.1 2473.1 2474.2 2142.1 2172.2 2397.7 2470.5 2477.6 2468.5 2489.0 2493.2 2500.9 2521.4 10302.1 10316.7 10395.0 10406.3 10424.2 5655.9 5743.5 5753.2 5754.7 5755.7 3420.8 3431.2 3446.2 3547.5 3552.0 1190.3 1192.9 1202.1 1235.1 1274.4 14752.4 14790.3 14790.6 14794.3 14797.6 4884.3 4887.9 4918.9 4996.0 5004.4 11955.3 11988.2 11988.8 11991.8 12008.3 5649.0 5652.9 5652.9 5666.5 5673.6 5030.0 5122.6 5124.9 5125.5 5126.1 4392.0 4393.5 4410.5 4424.2 4452.1 1268.4 1295.3 1295.8 1296.5 1312.1 1489.5 1501.2 1510.0 1534.3 1548.3 9574.4 9638.7 9645.8 9650.2 9656.5 567.9 571.9 573.1 573.5 578.1 7572.7 7586.3 7649.5 7655.9 7679.3 12985.5 13219.2 13236.3 13238.5 13256.1 12848.6 13138.9 13207.2 13207.7 13214.2 9365.8 9384.5 9405.4 9432.2 9520.0 9244.3 9314.4 9375.9 9378.7 9383.7 11122.2 11291.0 11363.3 11407.0 11431.8 11424.9 11644.8 11664.1 11722.4 11739.2 9202.4 9214.2 9220.8 9272.4 9283.4 9642.0 9647.8 9651.3 9690.4 9758.3 8554.7 8709.8 8775.0 8791.0 9323.9 9224.8 9283.9 9354.6 9391.9 9448.1 9343.0 9346.0 9350.3 9458.5 9531.1 8446.8 8446.8 8478.8 8526.9 8545.3 8724.8 8733.7 8814.5 8836.6 8857.0 15:54:41 INFO - 2015-10-28 15:54:41,863 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,863 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5400.09 Median:6142.04 stddev:1546.47 (25.2%) stddev-sans-first:1504.53 15:54:41 INFO - 2015-10-28 15:54:41,863 DEBUG : BROWSER_OUTPUT: Values: 396.9 398.3 398.5 400.3 405.5 5922.8 5923.4 6000.8 6049.3 6055.2 5867.8 5926.1 5956.0 5963.3 5966.5 4528.4 4579.4 4648.3 4735.0 4762.1 4667.9 4671.8 4675.6 4701.9 4741.3 4644.2 4645.8 4669.0 4698.2 4703.3 4651.9 4683.9 4688.8 4691.9 4698.2 4162.8 4232.2 4234.8 4281.0 4284.4 5740.3 5749.3 5773.2 5774.2 5774.6 5311.9 5541.8 5548.1 5551.8 5557.7 6224.2 6266.3 6325.4 6328.8 6335.1 4657.3 4661.5 4662.6 4665.0 4665.2 6456.6 6498.6 6515.6 6518.3 6519.1 4709.7 4813.7 4814.6 4829.7 4874.6 4936.6 4937.4 4938.3 4943.8 4944.6 5528.3 5528.4 5528.7 5531.6 5538.1 6296.6 6388.2 6412.8 6414.9 6420.9 1759.7 1765.2 1766.1 1766.1 1767.4 1246.6 1249.2 1254.6 1260.0 1284.3 6240.5 6242.6 6244.0 6247.3 6250.7 6549.2 6568.4 6575.8 6582.1 6588.5 6064.9 6219.2 6243.1 6249.8 6253.4 3600.4 3613.3 3627.0 3632.7 3637.2 6799.8 6800.7 6801.2 6801.7 6805.0 6655.0 6757.0 6761.6 6762.3 6767.0 6448.6 6654.7 6750.6 6792.9 6798.5 6543.2 6578.3 6584.7 6593.2 6602.2 6482.4 6487.3 6515.2 6542.6 6549.0 6691.9 6737.7 6767.2 6803.7 6844.6 4790.4 4791.4 4794.8 4803.6 4810.7 6550.3 6552.0 6582.4 6610.3 6610.4 6290.9 6359.7 6367.2 6377.4 6438.1 6351.6 6359.3 6365.6 6367.7 6369.7 6230.1 6239.3 6251.7 6266.7 6266.7 6257.8 6356.1 6357.3 6359.9 6365.8 6258.8 6280.1 6291.1 6294.4 6301.2 15:54:41 INFO - 2015-10-28 15:54:41,863 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2015-10-28 15:54:41,863 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12879.79 Median:24095.92 stddev:13971.84 (58.0%) stddev-sans-first:13981.67 15:54:41 INFO - 2015-10-28 15:54:41,865 DEBUG : BROWSER_OUTPUT: Values: 816.5 845.1 871.3 955.9 965.5 13817.4 14216.3 14694.2 14738.3 14779.3 13545.3 13563.5 13598.8 13605.7 13619.9 771.0 776.3 929.9 936.1 940.5 885.8 938.3 940.3 943.6 945.7 803.2 931.6 979.3 984.7 988.7 812.5 978.3 984.2 985.5 987.6 693.3 715.1 732.5 732.6 733.6 13248.7 13326.7 13350.8 13364.6 13384.4 12460.3 12709.2 12874.4 12917.2 12934.8 10532.3 10695.0 10845.9 10914.2 11091.9 3752.3 3764.6 3781.2 3782.3 3800.7 43554.3 43572.6 43803.1 44015.3 44406.1 10224.8 10284.5 10306.8 10493.3 10783.1 12435.3 12541.3 12547.8 19357.1 19411.8 7037.1 7103.8 7144.4 7253.3 7281.9 4471.4 4489.7 4508.8 4550.5 4616.4 2857.3 2861.6 2874.9 2879.5 2890.0 502.6 512.1 514.3 517.2 517.3 701.2 701.5 725.9 729.9 747.3 8773.5 9027.3 9044.5 9050.3 9136.8 564.6 638.0 702.9 712.0 715.2 4388.7 4480.5 4599.3 4604.0 4676.4 50510.7 53306.7 53328.0 53805.2 53914.0 44272.0 44475.3 44960.3 47356.3 47411.5 39655.6 39820.2 39834.8 40036.8 40441.8 9049.7 9056.8 9166.7 9340.1 9467.8 27969.4 28106.3 28503.9 28630.1 28663.1 36145.8 36721.4 36913.8 37066.0 39851.4 8113.8 8294.6 8324.5 8337.7 8587.2 12192.3 12254.9 12442.8 12449.4 12470.1 11456.8 11477.6 11568.8 11597.5 11725.9 11723.9 12014.6 12137.8 12146.6 12413.1 9259.5 10811.9 11526.2 12033.5 12487.7 9847.3 10015.8 10281.2 10610.5 10722.6 10200.3 10679.8 10758.4 10777.2 10782.4 15:54:41 INFO - 2015-10-28 15:54:41,865 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:54:41 INFO - 2015-10-28 15:54:41,865 DEBUG : BROWSER_OUTPUT: 15:54:42 INFO - 2015-10-28 15:54:42,437 INFO : Browser exited with error code: 0 15:54:42 INFO - 2015-10-28 15:54:42,458 INFO : Completed test dromaeo_css (00:18:33) 15:54:42 INFO - 2015-10-28 15:54:42,459 INFO : Starting test kraken 15:54:42 INFO - 2015-10-28 15:54:42,459 DEBUG : operating with platform_type : linux_ 15:54:42 INFO - 2015-10-28 15:54:42,459 INFO : Initialising browser for kraken test... 15:54:42 INFO - 2015-10-28 15:54:42,465 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSgbITC/profile http://localhost/getInfo.html 15:54:46 INFO - 2015-10-28 15:54:46,126 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:54:46 INFO - 2015-10-28 15:54:46,126 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:54:46 INFO - 2015-10-28 15:54:46,126 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:54:46 INFO - 2015-10-28 15:54:46,127 DEBUG : BROWSER_OUTPUT: __metrics 15:54:46 INFO - 2015-10-28 15:54:46,255 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:47 INFO - 2015-10-28 15:54:47,633 INFO : Browser initialized. 15:54:47 INFO - 2015-10-28 15:54:47,634 INFO : Running cycle 1/1 for kraken test... 15:54:47 INFO - 2015-10-28 15:54:47,634 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSgbITC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:54:59 INFO - 2015-10-28 15:54:59,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 132173824 15:54:59 INFO - 2015-10-28 15:54:59,352 DEBUG : BROWSER_OUTPUT: 15:55:02 INFO - 2015-10-28 15:55:02,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=ai-astar (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection) 15:55:02 INFO - 2015-10-28 15:55:02,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 165941248 15:55:02 INFO - 2015-10-28 15:55:02,807 DEBUG : BROWSER_OUTPUT: 15:55:05 INFO - 2015-10-28 15:55:05,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-dft) 15:55:05 INFO - 2015-10-28 15:55:05,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 164081664 15:55:05 INFO - 2015-10-28 15:55:05,910 DEBUG : BROWSER_OUTPUT: 15:55:08 INFO - 2015-10-28 15:55:08,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-dft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-fft) 15:55:09 INFO - 2015-10-28 15:55:09,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 161513472 15:55:09 INFO - 2015-10-28 15:55:09,230 DEBUG : BROWSER_OUTPUT: 15:55:11 INFO - 2015-10-28 15:55:11,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-fft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator) 15:55:11 INFO - 2015-10-28 15:55:11,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 160563200 15:55:11 INFO - 2015-10-28 15:55:11,729 DEBUG : BROWSER_OUTPUT: 15:55:13 INFO - 2015-10-28 15:55:13,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur) 15:55:14 INFO - 2015-10-28 15:55:14,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 156286976 15:55:14 INFO - 2015-10-28 15:55:14,384 DEBUG : BROWSER_OUTPUT: 15:55:17 INFO - 2015-10-28 15:55:17,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom) 15:55:17 INFO - 2015-10-28 15:55:17,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 156200960 15:55:17 INFO - 2015-10-28 15:55:17,791 DEBUG : BROWSER_OUTPUT: 15:55:21 INFO - 2015-10-28 15:55:21,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate) 15:55:21 INFO - 2015-10-28 15:55:21,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 155496448 15:55:21 INFO - 2015-10-28 15:55:21,701 DEBUG : BROWSER_OUTPUT: 15:55:24 INFO - 2015-10-28 15:55:24,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate (next: http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial) 15:55:24 INFO - 2015-10-28 15:55:24,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 156561408 15:55:24 INFO - 2015-10-28 15:55:24,945 DEBUG : BROWSER_OUTPUT: 15:55:26 INFO - 2015-10-28 15:55:26,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial (next: http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox) 15:55:26 INFO - 2015-10-28 15:55:26,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 162844672 15:55:26 INFO - 2015-10-28 15:55:26,958 DEBUG : BROWSER_OUTPUT: 15:55:28 INFO - 2015-10-28 15:55:28,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes) 15:55:29 INFO - 2015-10-28 15:55:29,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 162648064 15:55:29 INFO - 2015-10-28 15:55:29,213 DEBUG : BROWSER_OUTPUT: 15:55:31 INFO - 2015-10-28 15:55:31,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm) 15:55:31 INFO - 2015-10-28 15:55:31,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 169758720 15:55:31 INFO - 2015-10-28 15:55:31,718 DEBUG : BROWSER_OUTPUT: 15:55:34 INFO - 2015-10-28 15:55:34,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:55:34 INFO - 2015-10-28 15:55:34,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 176238592 15:55:34 INFO - 2015-10-28 15:55:34,909 DEBUG : BROWSER_OUTPUT: 15:55:37 INFO - 2015-10-28 15:55:37,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:55:37 INFO - 2015-10-28 15:55:37,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 173772800 15:55:37 INFO - 2015-10-28 15:55:37,830 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost/page_load_test/kraken/driver.html?testName=ai-astar) 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 231948288 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;109;111;109;109;108;116;109;109;109 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;129;144;159;128;152;145;121;158;122 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;159;159;157;160;161;160;160 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;71;142;72;70;70;69;152;71 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;89;130;88;88;88;134;87;88;132 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;109;109;109;109 15:55:39 INFO - 2015-10-28 15:55:39,657 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;147;145;145;146;145 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;95;95;96;95 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;51;52;51;51;53;52;52;52;66;49 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;61;62;61;61;61;61;62;62 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;78;80;84;79;78;78;78;78;84 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;105;106;105;110;113;111;107;109;106 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;135;131;132;133;121;133;131;130;133 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;61;59;60;59;61;59;60;60;60 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,874 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: __startTimestamp1446072939650__endTimestamp 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:55:39 INFO - 2015-10-28 15:55:39,658 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:109.00 stddev:2.76 (2.5%) stddev-sans-first:2.42 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: Values: 105.0 109.0 111.0 109.0 109.0 108.0 116.0 109.0 109.0 109.0 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.70 Median:148.50 stddev:15.46 (10.4%) stddev-sans-first:15.08 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: Values: 159.0 129.0 144.0 159.0 128.0 152.0 145.0 121.0 158.0 122.0 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,659 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.60 Median:160.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 159.0 159.0 157.0 160.0 161.0 160.0 160.0 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.70 Median:70.00 stddev:32.40 (46.3%) stddev-sans-first:33.87 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 142.0 72.0 70.0 70.0 69.0 152.0 71.0 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.20 Median:88.00 stddev:21.28 (24.2%) stddev-sans-first:22.03 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 130.0 88.0 88.0 88.0 134.0 87.0 88.0 132.0 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 147.0 145.0 145.0 146.0 145.0 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,660 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.00 stddev:4.72 (9.1%) stddev-sans-first:4.96 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: Values: 51.0 52.0 51.0 51.0 53.0 52.0 52.0 52.0 66.0 49.0 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 61.0 62.0 61.0 61.0 61.0 61.0 62.0 62.0 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:78.50 stddev:2.46 (3.1%) stddev-sans-first:2.55 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: Values: 78.0 78.0 80.0 84.0 79.0 78.0 78.0 78.0 78.0 84.0 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:108.50 Median:109.50 stddev:3.14 (2.9%) stddev-sans-first:2.87 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: Values: 113.0 105.0 106.0 105.0 110.0 113.0 111.0 107.0 109.0 106.0 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,661 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.00 Median:132.50 stddev:3.80 (2.9%) stddev-sans-first:4.03 15:55:39 INFO - 2015-10-28 15:55:39,662 DEBUG : BROWSER_OUTPUT: Values: 131.0 135.0 131.0 132.0 133.0 121.0 133.0 131.0 130.0 133.0 15:55:39 INFO - 2015-10-28 15:55:39,662 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-10-28 15:55:39,662 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 15:55:39 INFO - 2015-10-28 15:55:39,662 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 59.0 60.0 59.0 61.0 59.0 60.0 60.0 60.0 15:55:39 INFO - 2015-10-28 15:55:39,662 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:55:39 INFO - 2015-10-28 15:55:39,662 DEBUG : BROWSER_OUTPUT: 15:55:40 INFO - 2015-10-28 15:55:40,441 INFO : Browser exited with error code: 0 15:55:40 INFO - 2015-10-28 15:55:40,494 INFO : Completed test kraken (00:00:58) 15:55:40 INFO - 2015-10-28 15:55:40,494 INFO : Starting test v8_7 15:55:40 INFO - 2015-10-28 15:55:40,494 DEBUG : operating with platform_type : linux_ 15:55:40 INFO - 2015-10-28 15:55:40,494 INFO : Initialising browser for v8_7 test... 15:55:40 INFO - 2015-10-28 15:55:40,501 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0tkYuE/profile http://localhost/getInfo.html 15:55:44 INFO - 2015-10-28 15:55:44,092 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:55:44 INFO - 2015-10-28 15:55:44,092 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:55:44 INFO - 2015-10-28 15:55:44,092 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:55:44 INFO - 2015-10-28 15:55:44,092 DEBUG : BROWSER_OUTPUT: __metrics 15:55:44 INFO - 2015-10-28 15:55:44,196 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:55:45 INFO - 2015-10-28 15:55:45,471 INFO : Browser initialized. 15:55:45 INFO - 2015-10-28 15:55:45,471 INFO : Running cycle 1/1 for v8_7 test... 15:55:45 INFO - 2015-10-28 15:55:45,472 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0tkYuE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:55:57 INFO - 2015-10-28 15:55:57,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 132268032 15:55:57 INFO - 2015-10-28 15:55:57,159 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/v8_7/run.html (next: http://localhost/page_load_test/v8_7/run.html) 15:56:18 INFO - 2015-10-28 15:56:18,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 427327488 15:56:18 INFO - 2015-10-28 15:56:18,808 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,808 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:56:18 INFO - 2015-10-28 15:56:18,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:56:18 INFO - 2015-10-28 15:56:18,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:56:18 INFO - 2015-10-28 15:56:18,809 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:56:18 INFO - 2015-10-28 15:56:18,809 DEBUG : BROWSER_OUTPUT: |0;Richards;168.8048615800135 15:56:18 INFO - 2015-10-28 15:56:18,809 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.85328058028355 15:56:18 INFO - 2015-10-28 15:56:18,809 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.9654782116582 15:56:18 INFO - 2015-10-28 15:56:18,809 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 15:56:18 INFO - 2015-10-28 15:56:18,810 DEBUG : BROWSER_OUTPUT: |4;RayTrace;953.2888465204957 15:56:18 INFO - 2015-10-28 15:56:18,810 DEBUG : BROWSER_OUTPUT: |5;Earley;540.5405405405405 15:56:18 INFO - 2015-10-28 15:56:18,810 DEBUG : BROWSER_OUTPUT: |6;Boyer;10265.30612244898 15:56:18 INFO - 2015-10-28 15:56:18,810 DEBUG : BROWSER_OUTPUT: |7;RegExp;23181.81818181818 15:56:18 INFO - 2015-10-28 15:56:18,811 DEBUG : BROWSER_OUTPUT: |8;Splay;537.345513164965 15:56:18 INFO - 2015-10-28 15:56:18,811 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:56:18 INFO - 2015-10-28 15:56:18,811 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:56:18 INFO - 2015-10-28 15:56:18,812 DEBUG : BROWSER_OUTPUT: __startTimestamp1446072978807__endTimestamp 15:56:18 INFO - 2015-10-28 15:56:18,812 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,812 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:56:18 INFO - 2015-10-28 15:56:18,812 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:56:18 INFO - 2015-10-28 15:56:18,813 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,813 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.80 Median:168.80 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,813 DEBUG : BROWSER_OUTPUT: Values: 168.8 15:56:18 INFO - 2015-10-28 15:56:18,813 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,813 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.85 Median:164.85 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: Values: 164.9 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.97 Median:282.97 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: Values: 283.0 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: Values: 5138.5 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,814 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:953.29 Median:953.29 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,815 DEBUG : BROWSER_OUTPUT: Values: 953.3 15:56:18 INFO - 2015-10-28 15:56:18,815 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,816 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.54 Median:540.54 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,816 DEBUG : BROWSER_OUTPUT: Values: 540.5 15:56:18 INFO - 2015-10-28 15:56:18,816 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,816 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10265.31 Median:10265.31 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,816 DEBUG : BROWSER_OUTPUT: Values: 10265.3 15:56:18 INFO - 2015-10-28 15:56:18,816 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23181.82 Median:23181.82 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: Values: 23181.8 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:537.35 Median:537.35 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: Values: 537.3 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:56:18 INFO - 2015-10-28 15:56:18,817 DEBUG : BROWSER_OUTPUT: 15:56:19 INFO - 2015-10-28 15:56:19,653 INFO : Browser exited with error code: 0 15:56:19 INFO - 2015-10-28 15:56:19,668 INFO : Completed test v8_7 (00:00:39) 15:56:19 INFO - 2015-10-28 15:56:19,668 INFO : Completed test suite (00:20:10) 15:56:19 INFO - 2015-10-28 15:56:19,668 DEBUG : Working with test: dromaeo_css 15:56:19 INFO - 2015-10-28 15:56:19,668 DEBUG : Generating results file: dromaeo_css 15:56:19 INFO - 2015-10-28 15:56:19,669 DEBUG : Working with test: kraken 15:56:19 INFO - 2015-10-28 15:56:19,669 DEBUG : Generating results file: kraken 15:56:19 INFO - 2015-10-28 15:56:19,669 INFO : javascript benchmark 15:56:19 INFO - 2015-10-28 15:56:19,669 DEBUG : Working with test: v8_7 15:56:19 INFO - 2015-10-28 15:56:19,670 DEBUG : Generating results file: v8_7 15:56:19 INFO - 2015-10-28 15:56:19,670 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:56:19 INFO - 2015-10-28 15:56:19,728 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 15:56:19 INFO - 2015-10-28 15:56:19,728 DEBUG : process_Request line: dromaeo_css 7476.49 graph.html#tests=[[72,52,35]] 15:56:19 INFO - 2015-10-28 15:56:19,728 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:56:19 INFO - 2015-10-28 15:56:19,762 DEBUG : process_Request line: kraken 1441.20 graph.html#tests=[[232,52,35]] 15:56:19 INFO - 2015-10-28 15:56:19,762 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:56:19 INFO - 2015-10-28 15:56:19,795 DEBUG : process_Request line: v8_7 23353.34 graph.html#tests=[[230,52,35]] 15:56:19 INFO - 2015-10-28 15:56:19,798 INFO : javascript benchmark 15:56:19 INFO - 2015-10-28 15:56:19,803 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [421.05473212637634, 421.54894263138453, 422.4951183335914, 428.9699721019528, 429.7464495947391, 15811.92094039531, 16306.42927497535, 19368.12843422046, 19754.90122549387, 20370.490737731565, 20282.594348113027, 20495.590088198263, 20497.38507844767, 20691.172353105896, 20837.583248335024, 5802.419758024195, 5882.852928676774, 5886.941130588703, 5937.228160339171, 5941.197938278342, 4206.348016057516, 4338.045629961403, 5723.284589426322, 6222.533310001768, 6406.775762848301, 6349.650769207692, 6349.809505714836, 6354.078658594524, 6379.106925030476, 6380.649064301485, 5160.535551800337, 5282.894342113174, 5287.576993840503, 5289.894202115936, 5292.523672869441, 4593.63250939924, 4605.769711514445, 4624.329472226508, 4646.279826626878, 4650.069986002813, 14589.197594132318, 14687.926560367237, 14785.852141478555, 14914.776278355834, 14976.17631030293, 2303.1478353009325, 2307.4462129088897, 2352.470694093832, 2357.092519380051, 2550.13295479536, 11190.496427660775, 11230.55077796887, 11242.156838237164, 11357.091432685365, 11397.487113079931, 1815.3101821307819, 1816.609428972764, 1850.1859181959894, 1852.3424184414473, 1904.3620387170315, 73284.6335768323, 73788.63105684491, 76172.0, 76527.61736191339, 76778.0, 8062.1937806220085, 8098.878516822252, 8192.30365418946, 8251.95874020626, 8262.132476090044, 9992.550335234931, 9993.450360230258, 10006.09945104944, 10008.39949603026, 10008.749781255527, 6513.0, 6545.312742162099, 6595.901061484082, 6597.076409302702, 6631.403173714389, 6865.347791959855, 6901.654917254217, 6907.447404207652, 6929.618870962045, 6930.7227710891, 3787.110029143149, 3804.0489877530617, 3808.8476460941806, 3823.967528767217, 3846.0, 1276.4000919567975, 1293.6377814212035, 1294.4498588100207, 1301.134745394321, 1326.4959315460255, 549.9120140777457, 570.3668927490482, 570.7916610437161, 580.7618876260713, 583.8394441528528, 13698.726025479435, 13747.793783093262, 14189.077709949026, 14189.574312770634, 14225.715485690229, 575.4274496875636, 581.8836232753466, 591.721890711365, 597.4622839444448, 616.4267231474771, 6263.342349053375, 7633.770986870402, 7693.038370203724, 7698.307152356315, 7815.53106813593, 377920.0, 525225.0, 536106.0, 544076.0, 544642.0, 67629.66185169043, 78330.6083469579, 79888.20111798808, 80640.59679701681, 82627.0, 573.3635664412499, 575.9078547432391, 580.9070548712185, 585.8652509922656, 586.7095787585173, 12036.75926481483, 12123.0, 12316.507339706312, 12415.37923103823, 12443.128980971607, 40041.399379008755, 40286.39570406388, 40591.1881762369, 41136.79431602823, 41680.0, 55411.44588554224, 56192.438075618724, 56281.43718562926, 56972.0, 57263.0, 7416.332530072319, 7446.73936412223, 7477.401807855467, 7517.736879209201, 7601.087869455479, 11112.777744445228, 11410.543578256777, 13635.522756703467, 13727.519536816164, 13927.234002129575, 11405.372704501, 11637.825432618349, 11645.301281923112, 12147.45336459879, 12341.259524428562, 11503.137264705014, 11685.707857303636, 12161.756764864831, 12250.081243906921, 12381.938090309492, 12320.383980800745, 12370.381480925738, 12711.682207944876, 12908.870911291142, 13089.607311780663, 7880.3301719354495, 7894.802629934297, 7900.209979002054, 7964.163762804822, 7971.083325417651, 12499.687507812378, 12509.749805003667, 12621.684457888627, 12772.552960646333, 12901.419436125208], "dojo.html": [3373.443381841996, 3383.7631365804405, 3445.638207988163, 3460.8752155549455, 3467.5665541807275, 5753.798617048405, 5758.0, 5796.768129274824, 5807.128930660398, 5820.621659592129, 5806.622569532988, 5811.767529298833, 5834.970825145869, 5835.824925252249, 5870.677112758796, 5143.3570803649545, 5212.113940630083, 5212.374515058179, 5213.165893457038, 5280.313559237294, 5251.711155886424, 5262.368515778112, 5353.759080841352, 5362.91955620666, 5379.865503362408, 5298.23175639532, 5307.38965019022, 5308.867278318035, 5311.57507399409, 5319.654222475546, 5105.974470127626, 5176.870578235536, 5201.349831271091, 5214.348206474191, 5301.549368303698, 5108.055009823158, 5204.011237864794, 5212.478752124795, 5220.138677118271, 5233.4243233244315, 5531.834044978657, 5532.059549876531, 5537.390887002426, 5537.529310008654, 5559.749811258503, 5979.073243647242, 6100.9439798830535, 6108.572399932006, 6131.570790044699, 6153.784617538409, 6279.838229927433, 6288.937110628926, 6322.336154703782, 6329.493640508748, 6340.11238426616, 5774.682392468412, 5778.8266352009505, 5781.4507621775865, 5786.0, 5787.94212057874, 6054.152418661391, 6144.784932527429, 6190.535709821781, 6325.14610527582, 6331.240251169889, 6100.359462256488, 6104.26748790148, 6105.236845394325, 6105.48103411215, 6106.084087386927, 6190.690465476709, 6191.9690401547705, 6193.907091393633, 6225.035119556476, 6235.625862448177, 6037.9396206038255, 6072.848178795565, 6130.574042846152, 6148.415900489446, 6163.291221509494, 6187.102870083812, 6200.348963358872, 6204.162438070893, 6217.626942383471, 6254.3745625437095, 4603.884902877455, 4709.623230141649, 4709.835155769531, 4733.053389322149, 4736.786844592001, 4142.523609784853, 4193.496780386312, 4197.349410841324, 4203.201391735561, 4214.789260536961, 5953.672548009901, 5984.888157402506, 5987.221661184019, 5991.400859914061, 6020.247469066367, 6009.45914867664, 6116.08009436919, 6284.622922624657, 6340.270868850049, 6367.681615919186, 5888.823335299948, 5980.73086711099, 5981.730822113015, 5982.760689572456, 5993.250843644544, 5429.755660995185, 5439.728013599383, 5441.782328706887, 5442.782288708408, 5476.863078423071, 6218.689065546704, 6309.652969086653, 6310.558260921784, 6512.185976752906, 6523.086767852505, 6289.905651415141, 6294.0, 6307.085472606538, 6309.242890853127, 6369.267534233622, 6482.124913136855, 6486.513511486563, 6499.805005849832, 6501.934980650133, 6505.739770409131, 5926.318473375617, 6004.489618382487, 6024.819255422344, 6125.531522459876, 6151.231096112986, 6304.810855674337, 6320.083587879823, 6327.683615819283, 6328.050792381179, 6335.113084168128, 6150.876982460415, 6152.661603611844, 6156.661383623765, 6161.260648722003, 6170.876582468415, 5951.672658003851, 6023.548233882564, 6049.425304596057, 6114.700526355248, 6126.548209434937, 6051.304100028553, 6087.66517841523, 6094.055421409688, 6095.786647467317, 6100.054491553817, 5843.620164689281, 6151.6001459904965, 6181.165542651865, 6202.844928876814, 6218.0, 5885.558583106199, 5925.140854576149, 5948.315943666534, 5988.550858685703, 6011.188489554029], "mootools.html": [1560.0717573044035, 1692.6699293637741, 1815.1559524820957, 2065.999999999999, 2084.3851063936127, 8986.2810975122, 10165.085142337188, 10398.272120951528, 10410.687679369612, 10411.06300432961, 9867.259955503348, 9894.50527473627, 10041.899581004187, 10045.397276163436, 10065.64770233042, 2061.618600558894, 2131.701561781344, 2399.20826127378, 2406.32622865597, 2451.6199989001734, 2509.82431229814, 2528.203615861007, 2543.9491210175784, 2548.6941567011986, 2549.0823303610687, 2446.889889954947, 2468.7407822178684, 2470.147799009339, 2473.0973194783865, 2474.1958863369478, 2142.0574947023338, 2172.1854304635763, 2397.700287464067, 2470.468849197431, 2477.6283557466345, 2468.5309791139807, 2488.962665560018, 2493.1523282084177, 2500.8749562521803, 2521.432677647533, 10302.072813446826, 10316.690499285034, 10395.0, 10406.323588966769, 10424.218183636258, 5655.915161272585, 5743.54051675865, 5753.194552762617, 5754.6547207167705, 5755.654660720328, 3420.7605467617277, 3431.24512607226, 3446.1556918554866, 3547.4856145858707, 3552.0409489437966, 1190.2798806721896, 1192.8866757658009, 1202.0563857372008, 1235.116891422637, 1274.4265080713624, 14752.409903603842, 14790.334434950453, 14790.630234244123, 14794.260286985715, 14797.556073317817, 4884.267359895973, 4887.926681099786, 4918.90162196754, 4996.0, 5004.449510553836, 11955.282683039046, 11988.220765650205, 11988.760224795455, 11991.820122698167, 12008.339541325311, 5649.0, 5652.869426114794, 5652.943470565324, 5666.46168613981, 5673.631213971161, 5029.994001199775, 5122.564582010496, 5124.897502050013, 5125.513076257749, 5126.128558145124, 4391.978040109779, 4393.450818647669, 4410.4927933287445, 4424.181526417623, 4452.0873220989615, 1268.3848333558217, 1295.3070107492447, 1295.8121072444442, 1296.4684479363416, 1312.0553201694765, 1489.508462207469, 1501.2493753123438, 1510.0, 1534.332565334061, 1548.2568367183815, 9574.377665451724, 9638.662646807328, 9645.758856028515, 9650.227981761442, 9656.517174141405, 567.9261695979496, 571.87418767871, 573.057320707434, 573.5096492498936, 578.0548802707603, 7572.659230334648, 7586.317231449196, 7649.464537482323, 7655.923440765632, 7679.308862202429, 12985.480580776662, 13219.206847589176, 13236.338183090807, 13238.470461181638, 13256.138351007154, 12848.550300739616, 13138.868611313956, 13207.207567545978, 13207.735845283041, 13214.207147570984, 9365.765855853659, 9384.5307734613, 9405.388649737744, 9432.151106400457, 9519.952400238093, 9244.306676999386, 9314.44113353201, 9375.859362109437, 9378.718638440858, 9383.671571494964, 11122.165837562054, 11290.983811457008, 11363.261388009752, 11407.0, 11431.828522572334, 11424.885751142714, 11644.76710465769, 11664.125190610568, 11722.355270460206, 11739.23694959825, 9202.447853128833, 9214.216791572791, 9220.769480763034, 9272.350935434455, 9283.35016548862, 9642.0, 9647.807043858944, 9651.324407291422, 9690.418574885529, 9758.316917815684, 8554.700585479479, 8709.825803484022, 8775.0, 8790.956045219733, 9323.906760932305, 9224.815503690023, 9283.907160928575, 9354.625814967325, 9391.85912211331, 9448.149666529771, 9342.972273049823, 9346.0, 9350.298727595322, 9458.479783611692, 9531.142197202285, 8446.831063378575, 8446.831063378575, 8478.83042339162, 8526.914730852612, 8545.316374689886, 8724.825503490021, 8733.65065397377, 8814.51520166397, 8836.602352894006, 8857.025727170136], "ext.html": [580.7241560258877, 633.6103296472671, 640.6284355074057, 646.7639311651249, 649.1398896462189, 45427.545724542746, 45990.310145347845, 46010.53989460108, 46023.0, 46061.30908036378, 49735.50264497354, 50343.24485132726, 50397.49602503974, 50408.0, 50432.747836260765, 8300.626471808753, 8436.493810371398, 9352.298577606673, 9524.761880952963, 11046.668599942015, 11106.722331941684, 11226.49480773363, 11229.270097443681, 11232.0, 11238.887611123866, 10951.288166269167, 11155.0, 11156.553737850476, 11156.888431115665, 11166.665000050012, 8581.52801595912, 8811.867821982676, 11327.490262938187, 11520.942395288053, 11594.652160435116, 10933.343999359984, 11055.391953442557, 11070.446477676083, 11081.72295692606, 11082.556697732081, 46348.536514635096, 46536.0, 46897.0, 46993.0, 47012.0, 3863.7102217333813, 4017.7589344639123, 4050.8379664813374, 4061.735987160825, 4236.755188242457, 33769.6623033769, 33873.0, 34397.31205375904, 34426.65573344284, 34614.134646633785, 3573.8927832165077, 3710.07248187953, 3835.098751793354, 3837.597052309495, 3849.903752406184, 334690.0, 336162.0, 336318.99999999756, 337338.0, 338615.0, 63468.36531634717, 63837.0, 72642.63678681572, 72987.0, 73394.63302683452, 69413.3058669417, 69599.3040069603, 69646.30353696398, 69871.3012869875, 70022.64988675024, 17614.823851761575, 17708.0, 17726.734098988527, 17756.289748410178, 17776.200070996838, 13138.671533211555, 13353.866461335456, 14865.628359290888, 15091.396344146331, 15104.0, 23258.185963491534, 23669.763302366755, 23760.524789504114, 23802.16692415792, 23904.282871513882, 8981.14679105484, 8985.415947963362, 9070.183683468387, 9169.816603668023, 9239.0, 1079.4980334144504, 1083.875354334246, 1197.4072833947077, 1201.627495476405, 1238.721287710258, 32715.50926736101, 32771.50842737361, 33010.339793204, 33051.0, 33590.328193436486, 1175.8118701007797, 1213.769383817072, 1222.49877550204, 1229.3914512316283, 1300.7073408483016, 15130.0, 17286.654266914844, 17474.82525174732, 17810.732839007425, 18452.446426607225, 378181.0, 380132.0, 380668.0, 381360.0, 382406.0, 62113.37886621076, 62362.68818655969, 62871.0, 62915.0, 63048.68475657592, 1351.5810098869185, 1367.4598533579378, 1500.3998400639832, 1508.6831765329184, 1526.587821288246, 33290.0, 33393.0, 33592.664073359934, 33861.830690847375, 34671.82664086663, 51534.22698659598, 52076.739616301675, 58294.4170558289, 59964.70017649884, 60006.0, 519054.0, 530744.0, 534652.0, 534670.0, 534763.0, 50419.747901260256, 50508.747456262485, 50968.235476468624, 51048.74475627747, 51910.480895190565, 53819.19271211013, 54076.0, 54185.72907135597, 54692.0, 54802.17796732973, 44135.33796993112, 45518.0, 45537.357011439664, 45831.54168458273, 46226.0, 45145.77427112844, 45496.77251613721, 45583.0, 45724.0, 46737.29894051524, 45490.09019819519, 46226.76886615546, 46381.76809115933, 46647.06705865796, 46728.766356168, 37913.0, 42036.0, 42121.78939105407, 42153.0, 42502.59979201718, 29615.407691846474, 30307.393852123274, 30555.694443055287, 30575.847120764254, 30741.23146921345], "prototype.html": [396.85713143268435, 398.2731514985151, 398.50386269094975, 400.2927514152142, 405.4870588705288, 5922.822315330536, 5923.37804530524, 6000.819975400734, 6049.274087109553, 6055.182550355701, 5867.794627188049, 5926.051831706928, 5955.987482128038, 5963.284405871291, 5966.492848107905, 4528.43394575678, 4579.381783459224, 4648.279516674921, 4734.952650473486, 4762.071396077767, 4667.8599642010795, 4671.813127474897, 4675.555822196886, 4701.858944231679, 4741.288806679008, 4644.187267228239, 4645.767711614422, 4668.9766551167195, 4698.2482802751565, 4703.318018887259, 4651.88370290742, 4683.906321873577, 4688.835890743825, 4691.906161876777, 4698.1778188816825, 4162.83348666053, 4232.195882782262, 4234.830606775725, 4280.951166964082, 4284.400183974215, 5740.282464691913, 5749.31008279005, 5773.191753154561, 5774.249347584829, 5774.595778295521, 5311.920321195185, 5541.750621222055, 5548.056830338852, 5551.777928882881, 5557.72211389433, 6224.221972253468, 6266.310705822356, 6325.430711236011, 6328.778492752732, 6335.081413195107, 4657.301404789275, 4661.510541393172, 4662.580367766917, 4664.976675116636, 4665.206914824488, 6456.612603243821, 6498.610083395011, 6515.576487528296, 6518.315576864408, 6519.119918810948, 4709.740964246931, 4813.735244561512, 4814.566688998007, 4829.6860704054825, 4874.610031197496, 4936.605071594264, 4937.432195297587, 4938.308636790852, 4943.777530011158, 4944.579710724629, 5528.336599608073, 5528.419515950848, 5528.723563821793, 5531.557475401958, 5538.0585300499015, 6296.622202667854, 6388.233411990591, 6412.775552855627, 6414.935850641527, 6420.903686444707, 1759.744836998628, 1765.188013513798, 1766.0816375484676, 1766.1081154017395, 1767.3902503636225, 1246.6073186946264, 1249.2317224906617, 1254.6047994881583, 1259.9685007874693, 1284.3257289922865, 6240.53196010292, 6242.625442473466, 6244.0321750128805, 6247.250329960434, 6250.749970001149, 6549.214094308713, 6568.376004279586, 6575.83560410984, 6582.144321238208, 6588.505862060269, 6064.878702425926, 6219.191505104308, 6243.094751261042, 6249.75000999964, 6253.374662533801, 3600.351936651428, 3613.259281847215, 3627.038834708804, 3632.727545434103, 3637.2361804020925, 6799.762008329685, 6800.727970881208, 6801.18385793708, 6801.65991700413, 6805.0, 6655.035019922084, 6757.020232066323, 6761.5604985676755, 6762.256151823295, 6766.951122576009, 6448.580842245239, 6654.70053847578, 6750.628715420699, 6792.932070679329, 6798.5241033128195, 6543.1821022372205, 6578.309277525791, 6584.670766461562, 6593.175853018372, 6602.207735071822, 6482.351764823668, 6487.286398496256, 6515.218173819172, 6542.607443553402, 6548.967255163694, 6691.866162676816, 6737.66311684404, 6767.1879374475375, 6803.659817009228, 6844.555103918229, 4790.353302304145, 4791.401074865642, 4794.760261986957, 4803.615710743063, 4810.687305325143, 6550.344965503602, 6552.049952756919, 6582.440492558187, 6610.305917878746, 6610.438112760469, 6290.905636415366, 6359.682015899094, 6367.172267605181, 6377.362263773771, 6438.130852335063, 6351.555391122577, 6359.332270111757, 6365.61806291624, 6367.745290188341, 6369.681515924092, 6230.096635987847, 6239.313675495601, 6251.71867265965, 6266.655333956676, 6266.749330026931, 6257.78097766576, 6356.078368636614, 6357.268914074755, 6359.936400635935, 6365.77719779824, 6258.843528911813, 6280.0893870389455, 6291.087792270187, 6294.433500984934, 6301.180846489927], "yui.html": [816.5427360678017, 845.129516597904, 871.2507243770357, 955.9235261179106, 965.4882912056612, 13817.37821798019, 14216.28918554072, 14694.191819449927, 14738.263086845669, 14779.261036948163, 13545.255010974393, 13563.52527661532, 13598.796018059713, 13605.659858503543, 13619.863801361984, 771.0362047440699, 776.3323541754087, 929.8977112517617, 936.0826390137669, 940.4545363689078, 885.8494056010494, 938.2822141062093, 940.2853831088354, 943.575391074016, 945.654835984864, 803.1887793328722, 931.6087243357772, 979.3438396274513, 984.6996666016862, 988.7478692933328, 812.544974814103, 978.33473238198, 984.242133557157, 985.5367977050774, 987.575342602677, 693.3136195166799, 715.1346870286959, 732.4543215304632, 732.6300218389732, 733.611186071383, 13248.73502529944, 13326.666833329147, 13350.799738003938, 13364.599062028155, 13384.397702103428, 12460.252384856938, 12709.173903696323, 12874.356282185854, 12917.160384574972, 12934.805977910244, 10532.315399499008, 10695.0, 10845.891541084568, 10914.181436392302, 11091.944540277327, 3752.2683076800035, 3764.642358975893, 3781.2248489059675, 3782.3002744492355, 3800.7339486235974, 43554.346684799755, 43572.564274357166, 43803.12393752107, 44015.339769903476, 44406.11187776226, 10224.795504090025, 10284.485775711184, 10306.793864122676, 10493.317934334244, 10783.08343790771, 12435.253884766942, 12541.310227937369, 12547.811782823264, 19357.12892919822, 19411.805881941, 7037.085178926707, 7103.786886393416, 7144.3570078693165, 7253.310935461122, 7281.890771638429, 4471.418715566955, 4489.720429677526, 4508.797104130322, 4550.49944506104, 4616.3537104805355, 2857.2571131505542, 2861.5993760873494, 2874.870630821576, 2879.481693295185, 2889.956650650242, 502.62052150626045, 512.0987062769552, 514.3133916221811, 517.2189993110355, 517.2603177456274, 701.1796198447828, 701.4528667639147, 725.9312150422464, 729.8978143059976, 747.2751431111813, 8773.473591584398, 9027.277817774562, 9044.547772611475, 9050.27597792175, 9136.817263654822, 564.6414526775527, 637.9521535884827, 702.9261927497539, 711.9786406407816, 715.1989771455899, 4388.71473354231, 4480.484744254387, 4599.2871104978785, 4603.976980115078, 4676.438827340741, 50510.74744626253, 53306.73346633319, 53328.0, 53805.1929221062, 53914.0, 44272.0, 44475.33287000633, 44960.3255951161, 47356.2896556545, 47411.52588474071, 39655.60344396577, 39820.20359592792, 39834.800825995684, 40036.799816001316, 40441.79779101086, 9049.728508144766, 9056.818863622559, 9166.724998250063, 9340.065993400878, 9467.763305917408, 27969.44061118807, 28106.2973425666, 28503.857480712464, 28630.14109576716, 28663.140105796858, 36145.81927090348, 36721.44917826288, 36913.815430922674, 37066.0, 39851.402228966006, 8113.8377232456205, 8294.58527073632, 8324.458910170819, 8337.666493340199, 8587.184217499327, 12192.329421881881, 12254.938725306316, 12442.751144976868, 12449.44381952256, 12470.064745144331, 11456.770864582495, 11477.598284060352, 11568.826467603161, 11597.5360985563, 11725.941370293094, 11723.882761172279, 12014.579489717818, 12137.757244855231, 12146.574869879865, 12413.131080824256, 9259.470929972422, 10811.891881081088, 11526.1931664786, 12033.45849436795, 12487.687807804878, 9847.261455391017, 10015.849762253427, 10281.228907831794, 10610.52252648648, 10722.571097156026, 10200.28597998133, 10679.786404271716, 10758.40828754426, 10777.191710621892, 10782.406967616856]}, "summary": {"suite": 7476.4933029706635, "subtests": {"jquery.html": {"std": 83544.47445715421, "min": 421.05473212637634, "max": 544642.0, "median": 8016.6385530198295, "filtered": 7992.6573302931665, "mean": 27849.57740536994}, "dojo.html": {"std": 659.1318171770248, "min": 3373.443381841996, "max": 6523.086767852505, "median": 6004.489618382487, "filtered": 5721.851357520761, "mean": 5766.3998070116}, "mootools.html": {"std": 4019.0914456229007, "min": 567.9261695979496, "max": 14797.556073317817, "median": 8550.008480084682, "filtered": 5472.061689622883, "mean": 7060.107484947241}, "ext.html": {"std": 111502.978487269, "min": 580.7241560258877, "max": 534763.0, "median": 33341.5, "filtered": 22386.92863324726, "mean": 61437.158172747324}, "prototype.html": {"std": 1542.1728769359088, "min": 396.85713143268435, "max": 6844.555103918229, "median": 6060.030626390813, "filtered": 4926.099775966128, "mean": 5400.088678686749}, "yui.html": {"std": 13932.97965038558, "min": 502.62052150626045, "max": 53914.0, "median": 10253.01220596091, "filtered": 6328.109205176999, "mean": 12879.785987699877}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-047"}, "testrun": {"date": 1446071769, "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": "20151028131431", "branch": "Mozilla-Aurora", "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 160.0, 160.0, 159.0, 159.0, 157.0, 160.0, 161.0, 160.0, 160.0], "ai-astar": [105.0, 109.0, 111.0, 109.0, 109.0, 108.0, 116.0, 109.0, 109.0, 109.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "audio-beat-detection": [159.0, 129.0, 144.0, 159.0, 128.0, 152.0, 145.0, 121.0, 158.0, 122.0], "json-stringify-tinderbox": [62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0], "stanford-crypto-pbkdf2": [131.0, 135.0, 131.0, 132.0, 133.0, 121.0, 133.0, 131.0, 130.0, 133.0], "json-parse-financial": [51.0, 52.0, 51.0, 51.0, 53.0, 52.0, 52.0, 52.0, 66.0, 49.0], "stanford-crypto-sha256-iterative": [61.0, 61.0, 59.0, 60.0, 59.0, 61.0, 59.0, 60.0, 60.0, 60.0], "audio-fft": [70.0, 70.0, 71.0, 142.0, 72.0, 70.0, 70.0, 69.0, 152.0, 71.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 146.0, 145.0], "stanford-crypto-ccm": [113.0, 105.0, 106.0, 105.0, 110.0, 113.0, 111.0, 107.0, 109.0, 106.0], "audio-oscillator": [88.0, 89.0, 130.0, 88.0, 88.0, 88.0, 134.0, 87.0, 88.0, 132.0], "stanford-crypto-aes": [78.0, 78.0, 80.0, 84.0, 79.0, 78.0, 78.0, 78.0, 78.0, 84.0], "imaging-desaturate": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0]}, "summary": {"suite": 1441.2, "subtests": {"audio-fft": {"std": 30.741014947460663, "min": 69.0, "max": 152.0, "median": 70.5, "filtered": 85.7, "mean": 85.7}, "stanford-crypto-pbkdf2": {"std": 3.605551275463989, "min": 121.0, "max": 135.0, "median": 131.5, "filtered": 131.0, "mean": 131.0}, "audio-beat-detection": {"std": 14.670037491431303, "min": 121.0, "max": 159.0, "median": 144.5, "filtered": 141.7, "mean": 141.7}, "stanford-crypto-ccm": {"std": 2.9748949561287032, "min": 105.0, "max": 113.0, "median": 108.0, "filtered": 108.5, "mean": 108.5}, "imaging-darkroom": {"std": 0.6403124237432849, "min": 145.0, "max": 147.0, "median": 145.0, "filtered": 145.3, "mean": 145.3}, "json-parse-financial": {"std": 4.4821869662029945, "min": 49.0, "max": 66.0, "median": 52.0, "filtered": 52.9, "mean": 52.9}, "audio-oscillator": {"std": 20.188115315699978, "min": 87.0, "max": 134.0, "median": 88.0, "filtered": 101.2, "mean": 101.2}, "ai-astar": {"std": 2.6153393661244047, "min": 105.0, "max": 116.0, "median": 109.0, "filtered": 109.4, "mean": 109.4}, "audio-dft": {"std": 1.0198039027185568, "min": 157.0, "max": 161.0, "median": 160.0, "filtered": 159.6, "mean": 159.6}, "stanford-crypto-sha256-iterative": {"std": 0.7745966692414834, "min": 59.0, "max": 61.0, "median": 60.0, "filtered": 60.0, "mean": 60.0}, "json-stringify-tinderbox": {"std": 0.5, "min": 61.0, "max": 62.0, "median": 61.5, "filtered": 61.5, "mean": 61.5}, "imaging-gaussian-blur": {"std": 0.5, "min": 109.0, "max": 110.0, "median": 109.5, "filtered": 109.5, "mean": 109.5}, "stanford-crypto-aes": {"std": 2.3345235059857505, "min": 78.0, "max": 84.0, "median": 78.0, "filtered": 79.5, "mean": 79.5}, "imaging-desaturate": {"std": 0.4898979485566356, "min": 95.0, "max": 96.0, "median": 95.0, "filtered": 95.4, "mean": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-047"}, "testrun": {"date": 1446071769, "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": "20151028131431", "branch": "Mozilla-Aurora", "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.85328058028355], "Encrypt": [282.9654782116582], "NavierStokes": [4830.917874396136], "Decrypt": [5138.461538461538], "Splay": [537.345513164965], "Richards": [168.8048615800135], "RegExp": [23181.81818181818], "Earley": [540.5405405405405], "Boyer": [10265.30612244898], "RayTrace": [953.2888465204957]}, "summary": {"suite": 23353.343966160162, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.85328058028355, "max": 164.85328058028355, "median": 164.85328058028355, "value": 401.0717880000001, "filtered": 401.0717880000001, "mean": 164.85328058028355}, "Encrypt": {"std": 0.0, "min": 282.9654782116582, "max": 282.9654782116582, "median": 282.9654782116582, "value": 940.6836540000003, "filtered": 940.6836540000003, "mean": 282.9654782116582}, "NavierStokes": {"std": 0.0, "min": 4830.917874396136, "max": 4830.917874396136, "median": 4830.917874396136, "value": 307.1879999999999, "filtered": 307.1879999999999, "mean": 4830.917874396136}, "Decrypt": {"std": 0.0, "min": 5138.461538461538, "max": 5138.461538461538, "median": 5138.461538461538, "value": 51.80169161676644, "filtered": 51.80169161676644, "mean": 5138.461538461538}, "Splay": {"std": 0.0, "min": 537.345513164965, "max": 537.345513164965, "median": 537.345513164965, "value": 151.65475100000006, "filtered": 151.65475100000006, "mean": 537.345513164965}, "RegExp": {"std": 0.0, "min": 23181.81818181818, "max": 23181.81818181818, "median": 23181.81818181818, "value": 39.29739215686276, "filtered": 39.29739215686276, "mean": 23181.81818181818}, "Richards": {"std": 0.0, "min": 168.8048615800135, "max": 168.8048615800135, "median": 168.8048615800135, "value": 209.1290480000001, "filtered": 209.1290480000001, "mean": 168.8048615800135}, "Earley": {"std": 0.0, "min": 540.5405405405405, "max": 540.5405405405405, "median": 540.5405405405405, "value": 1232.95655, "filtered": 1232.95655, "mean": 540.5405405405405}, "Boyer": {"std": 0.0, "min": 10265.30612244898, "max": 10265.30612244898, "median": 10265.30612244898, "value": 64.9238310139165, "filtered": 64.9238310139165, "mean": 10265.30612244898}, "RayTrace": {"std": 0.0, "min": 953.2888465204957, "max": 953.2888465204957, "median": 953.2888465204957, "value": 776.2484609999998, "filtered": 776.2484609999998, "mean": 953.2888465204957}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-047"}, "testrun": {"date": 1446071769, "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": "20151028131431", "branch": "Mozilla-Aurora", "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8"}}] 15:56:19 INFO - RETURN: dromaeo_css: 7476.49 15:56:19 INFO - RETURN: kraken: 1441.20 15:56:19 INFO - RETURN: v8_7: 23353.34 15:56:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23353.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1441.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7476.49"}}} 15:56:19 INFO - Return code: 0 15:56:19 INFO - # TBPL SUCCESS # 15:56:19 INFO - Running post-action listener: _resource_record_post_action 15:56:19 INFO - Running post-run listener: _resource_record_post_run 15:56:20 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 7405568; Write bytes: 434085888; Read time: 1744; Write time: 385640 15:56:20 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 10768384; Read time: 0; Write time: 3900 15:56:21 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 5378048; Write bytes: 384253952; Read time: 1436; Write time: 348724 15:56:21 INFO - Running post-run listener: _upload_blobber_files 15:56:21 INFO - Blob upload gear active. 15:56:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:56:21 INFO - Copying logs to upload dir... 15:56:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.839289 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-10-28 15:56:20.986464) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:56:20.990170) ========= 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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009860 build_url: 'https://queue.taskcluster.net/v1/task/1eUMDjZmSEyn_ZzmMe_Dyg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-28 15:56:21.040955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:56:21.041320) ========= 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=f5f5a079460e1a9be8676904000001c1-1446071709.978678-517569453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 15:56:21.091925) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-28 15:56:21.092315) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-28 15:56:25.116464) =========