builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1446113769.09 results: success (0) buildid: 20151029005548 builduid: d4afcc33d65f4632a3c5b2dc010383ad revision: 9470fd1a1c8952f9d949715f2be3e3262762e536 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.085680) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.086107) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.086398) ========= 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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006892 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.157414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.157700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.200402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.200764) ========= 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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019562 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.247594) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.247901) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.248286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.248564) ========= 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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-29 03:16:09-- 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% 29.4M=0s 2015-10-29 03:16:09 (29.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.278345 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.539168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.539498) ========= 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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.108498 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.660505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:09.660924) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9470fd1a1c8952f9d949715f2be3e3262762e536 --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 9470fd1a1c8952f9d949715f2be3e3262762e536 --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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-29 03:16:09,769 truncating revision to first 12 chars 2015-10-29 03:16:09,770 Setting DEBUG logging. 2015-10-29 03:16:09,770 attempt 1/10 2015-10-29 03:16:09,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9470fd1a1c89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-29 03:16:10,035 unpacking tar archive at: mozilla-aurora-9470fd1a1c89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535637 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:10.209827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:10.210182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:10.219332) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:10.219636) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 03:16:10.220053) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-10-29 03:16:10.220346) ========= /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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:10 INFO - MultiFileLogger online at 20151029 03:16:10 in /builds/slave/test-pgo 03:16:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:16:10 INFO - Guessing talos json url... 03:16:10 INFO - Using buildbot properties: 03:16:10 INFO - { 03:16:10 INFO - "properties": { 03:16:10 INFO - "buildnumber": 5, 03:16:10 INFO - "product": "firefox", 03:16:10 INFO - "script_repo_revision": "production", 03:16:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:16:10 INFO - "repository": "", 03:16:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:16:10 INFO - "buildid": "20151029005548", 03:16:10 INFO - "slavename": "talos-linux64-ix-002", 03:16:10 INFO - "pgo_build": "True", 03:16:10 INFO - "basedir": "/builds/slave/test-pgo", 03:16:10 INFO - "project": "", 03:16:10 INFO - "platform": "ubuntu64_hw", 03:16:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:16:10 INFO - "slavebuilddir": "test", 03:16:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:16:10 INFO - "branch": "mozilla-aurora", 03:16:10 INFO - "repo_path": "releases/mozilla-aurora", 03:16:10 INFO - "stage_platform": "linux64-pgo", 03:16:10 INFO - "builduid": "d4afcc33d65f4632a3c5b2dc010383ad", 03:16:10 INFO - "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536" 03:16:10 INFO - }, 03:16:10 INFO - "sourcestamp": { 03:16:10 INFO - "repository": "", 03:16:10 INFO - "hasPatch": false, 03:16:10 INFO - "project": "", 03:16:10 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:16:10 INFO - "changes": [ 03:16:10 INFO - { 03:16:10 INFO - "category": null, 03:16:10 INFO - "files": [ 03:16:10 INFO - { 03:16:10 INFO - "url": null, 03:16:10 INFO - "name": "https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:16:10 INFO - } 03:16:10 INFO - ], 03:16:10 INFO - "repository": "", 03:16:10 INFO - "rev": "9470fd1a1c8952f9d949715f2be3e3262762e536", 03:16:10 INFO - "who": "cbook@mozilla.com", 03:16:10 INFO - "when": 1446113750, 03:16:10 INFO - "number": 6592748, 03:16:10 INFO - "comments": "Bug 1218395 - Avoid calling AddFlags from SharedSurfaceTextureClient constructor. r=milan, a=lizzard\n\nInstead pass the flags to the parent constructor.", 03:16:10 INFO - "project": "", 03:16:10 INFO - "at": "Thu 29 Oct 2015 03:15:50", 03:16:10 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:16:10 INFO - "revlink": "", 03:16:10 INFO - "properties": [ 03:16:10 INFO - [ 03:16:10 INFO - "buildid", 03:16:10 INFO - "20151029005548", 03:16:10 INFO - "Change" 03:16:10 INFO - ], 03:16:10 INFO - [ 03:16:10 INFO - "builduid", 03:16:10 INFO - "d4afcc33d65f4632a3c5b2dc010383ad", 03:16:10 INFO - "Change" 03:16:10 INFO - ], 03:16:10 INFO - [ 03:16:10 INFO - "pgo_build", 03:16:10 INFO - "True", 03:16:10 INFO - "Change" 03:16:10 INFO - ] 03:16:10 INFO - ], 03:16:10 INFO - "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536" 03:16:10 INFO - } 03:16:10 INFO - ], 03:16:10 INFO - "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536" 03:16:10 INFO - } 03:16:10 INFO - } 03:16:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 03:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:10 INFO - https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 03:16:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:16:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:16:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:16:10 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt'), kwargs: {}, attempt #1 03:16:11 INFO - Downloaded 107 bytes. 03:16:11 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:16:11 INFO - Contents: 03:16:11 INFO - 20151029005548 03:16:11 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/9470fd1a1c8952f9d949715f2be3e3262762e536 03:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:11 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/9470fd1a1c/testing/talos/talos.json 03:16:11 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/9470fd1a1c/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 03:16:11 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/9470fd1a1c/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 03:16:12 INFO - Downloaded 6818 bytes. 03:16:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:16:12 INFO - '../fennec_ids.txt'], 03:16:12 INFO - 'tests': ['tcheck2']}, 03:16:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:12 INFO - '--tppagecycles', 03:16:12 INFO - '7'], 03:16:12 INFO - 'tests': ['tsvgm']}}, 03:16:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:16:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:16:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:16:12 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:16:12 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:12 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:16:12 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:16:12 INFO - 'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:12 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'tests': ['damp', 'tps']}, 03:16:12 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['damp', 'tps']}, 03:16:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:16:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:12 INFO - 'other': {'tests': ['a11yr', 03:16:12 INFO - 'ts_paint', 03:16:12 INFO - 'tpaint', 03:16:12 INFO - 'sessionrestore', 03:16:12 INFO - 'sessionrestore_no_auto_restore']}, 03:16:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['a11yr', 03:16:12 INFO - 'ts_paint', 03:16:12 INFO - 'tpaint', 03:16:12 INFO - 'sessionrestore', 03:16:12 INFO - 'sessionrestore_no_auto_restore']}, 03:16:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['a11yr', 03:16:12 INFO - 'ts_paint', 03:16:12 INFO - 'tpaint', 03:16:12 INFO - 'sessionrestore', 03:16:12 INFO - 'sessionrestore_no_auto_restore']}, 03:16:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['a11yr', 03:16:12 INFO - 'ts_paint', 03:16:12 INFO - 'tpaint', 03:16:12 INFO - 'sessionrestore', 03:16:12 INFO - 'sessionrestore_no_auto_restore']}, 03:16:12 INFO - 'other_l64': {'tests': ['a11yr', 03:16:12 INFO - 'ts_paint', 03:16:12 INFO - 'tpaint', 03:16:12 INFO - 'sessionrestore', 03:16:12 INFO - 'sessionrestore_no_auto_restore']}, 03:16:12 INFO - 'other_nol64': {'tests': ['a11yr', 03:16:12 INFO - 'ts_paint', 03:16:12 INFO - 'tpaint', 03:16:12 INFO - 'sessionrestore', 03:16:12 INFO - 'sessionrestore_no_auto_restore']}, 03:16:12 INFO - 'svgr': {'tests': ['tsvgx', 03:16:12 INFO - 'tsvgr_opacity', 03:16:12 INFO - 'tart', 03:16:12 INFO - 'tscrollx', 03:16:12 INFO - 'cart']}, 03:16:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['tsvgx', 03:16:12 INFO - 'tsvgr_opacity', 03:16:12 INFO - 'tart', 03:16:12 INFO - 'tscrollx', 03:16:12 INFO - 'cart']}, 03:16:12 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:16:12 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:16:12 INFO - 'tests': ['tp5o']}, 03:16:12 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:16:12 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:16:12 INFO - 'talos_options': ['--e10s'], 03:16:12 INFO - 'tests': ['tp5o']}, 03:16:12 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:16:12 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:16:12 INFO - 'talos_options': ['--xperf_path', 03:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:12 INFO - 'tests': ['tp5n']}, 03:16:12 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:16:12 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:16:12 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:12 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:16:12 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:16:12 INFO - 'talos_options': ['--e10s', 03:16:12 INFO - '--xperf_path', 03:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 03:16:12 INFO - 'C:/slave/talos-data/talos/xperf.config'], 03:16:12 INFO - 'tests': ['tp5n']}}, 03:16:12 INFO - 'talos.zip': {'path': '', 03:16:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:16:12 INFO - {'append_to_log': False, 03:16:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:16:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:16:12 INFO - 'branch': 'Mozilla-Aurora', 03:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:12 INFO - 'config_files': ('talos/linux_config.py',), 03:16:12 INFO - 'default_actions': ('clobber', 03:16:12 INFO - 'read-buildbot-config', 03:16:12 INFO - 'download-and-extract', 03:16:12 INFO - 'populate-webroot', 03:16:12 INFO - 'create-virtualenv', 03:16:12 INFO - 'install', 03:16:12 INFO - 'run-tests'), 03:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:12 INFO - 'download_minidump_stackwalk': True, 03:16:12 INFO - 'download_symbols': 'ondemand', 03:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:12 INFO - 'installer_path': 'installer.exe', 03:16:12 INFO - 'log_level': 'info', 03:16:12 INFO - 'log_name': 'talos', 03:16:12 INFO - 'log_to_console': True, 03:16:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:12 INFO - 'opt_config_files': (), 03:16:12 INFO - 'pip_index': False, 03:16:12 INFO - 'python_webserver': False, 03:16:12 INFO - 'sps_profile': False, 03:16:12 INFO - 'sps_profile_interval': 0, 03:16:12 INFO - 'suite': 'dromaeojs', 03:16:12 INFO - 'system_bits': '64', 03:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:12 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 03:16:12 INFO - 'tests': (), 03:16:12 INFO - 'title': 'talos-linux64-ix-002', 03:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:12 INFO - 'use_talos_json': True, 03:16:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:12 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 03:16:12 INFO - 'work_dir': 'build'} 03:16:12 INFO - ##### 03:16:12 INFO - ##### Running clobber step. 03:16:12 INFO - ##### 03:16:12 INFO - Running pre-action listener: _resource_record_pre_action 03:16:12 INFO - Running main action method: clobber 03:16:12 INFO - rmtree: /builds/slave/test-pgo/build 03:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:16:17 INFO - Running post-action listener: _resource_record_post_action 03:16:17 INFO - ##### 03:16:17 INFO - ##### Running read-buildbot-config step. 03:16:17 INFO - ##### 03:16:17 INFO - Running pre-action listener: _resource_record_pre_action 03:16:17 INFO - Running main action method: read_buildbot_config 03:16:17 INFO - Using buildbot properties: 03:16:17 INFO - { 03:16:17 INFO - "properties": { 03:16:17 INFO - "buildnumber": 5, 03:16:17 INFO - "product": "firefox", 03:16:17 INFO - "script_repo_revision": "production", 03:16:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:16:17 INFO - "repository": "", 03:16:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:16:17 INFO - "buildid": "20151029005548", 03:16:17 INFO - "slavename": "talos-linux64-ix-002", 03:16:17 INFO - "pgo_build": "True", 03:16:17 INFO - "basedir": "/builds/slave/test-pgo", 03:16:17 INFO - "project": "", 03:16:17 INFO - "platform": "ubuntu64_hw", 03:16:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:16:17 INFO - "slavebuilddir": "test", 03:16:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:16:17 INFO - "branch": "mozilla-aurora", 03:16:17 INFO - "repo_path": "releases/mozilla-aurora", 03:16:17 INFO - "stage_platform": "linux64-pgo", 03:16:17 INFO - "builduid": "d4afcc33d65f4632a3c5b2dc010383ad", 03:16:17 INFO - "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536" 03:16:17 INFO - }, 03:16:17 INFO - "sourcestamp": { 03:16:17 INFO - "repository": "", 03:16:17 INFO - "hasPatch": false, 03:16:17 INFO - "project": "", 03:16:17 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:16:17 INFO - "changes": [ 03:16:17 INFO - { 03:16:17 INFO - "category": null, 03:16:17 INFO - "files": [ 03:16:17 INFO - { 03:16:17 INFO - "url": null, 03:16:17 INFO - "name": "https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:16:17 INFO - } 03:16:17 INFO - ], 03:16:17 INFO - "repository": "", 03:16:17 INFO - "rev": "9470fd1a1c8952f9d949715f2be3e3262762e536", 03:16:17 INFO - "who": "cbook@mozilla.com", 03:16:17 INFO - "when": 1446113750, 03:16:17 INFO - "number": 6592748, 03:16:17 INFO - "comments": "Bug 1218395 - Avoid calling AddFlags from SharedSurfaceTextureClient constructor. r=milan, a=lizzard\n\nInstead pass the flags to the parent constructor.", 03:16:17 INFO - "project": "", 03:16:17 INFO - "at": "Thu 29 Oct 2015 03:15:50", 03:16:17 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:16:17 INFO - "revlink": "", 03:16:17 INFO - "properties": [ 03:16:17 INFO - [ 03:16:17 INFO - "buildid", 03:16:17 INFO - "20151029005548", 03:16:17 INFO - "Change" 03:16:17 INFO - ], 03:16:17 INFO - [ 03:16:17 INFO - "builduid", 03:16:17 INFO - "d4afcc33d65f4632a3c5b2dc010383ad", 03:16:17 INFO - "Change" 03:16:17 INFO - ], 03:16:17 INFO - [ 03:16:17 INFO - "pgo_build", 03:16:17 INFO - "True", 03:16:17 INFO - "Change" 03:16:17 INFO - ] 03:16:17 INFO - ], 03:16:17 INFO - "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536" 03:16:17 INFO - } 03:16:17 INFO - ], 03:16:17 INFO - "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536" 03:16:17 INFO - } 03:16:17 INFO - } 03:16:17 INFO - Running post-action listener: _resource_record_post_action 03:16:17 INFO - ##### 03:16:17 INFO - ##### Running download-and-extract step. 03:16:17 INFO - ##### 03:16:17 INFO - Running pre-action listener: _resource_record_pre_action 03:16:17 INFO - Running main action method: download_and_extract 03:16:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:17 INFO - https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/test_packages.json 03:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/test_packages.json 03:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:16:17 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 03:16:19 INFO - Downloaded 1302 bytes. 03:16:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:16:19 INFO - Using the following test package requirements: 03:16:19 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:19 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:19 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:19 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:19 INFO - u'jsshell-linux-x86_64.zip'], 03:16:19 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:19 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:19 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:19 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:19 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:16:19 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:19 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:16:19 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:19 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:19 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:19 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:19 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:19 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:19 INFO - https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:19 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 03:16:20 INFO - Downloaded 22906651 bytes. 03:16:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:16:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:16:21 INFO - Return code: 0 03:16:21 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:16: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')]} 03:16:21 INFO - https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:21 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 03:16:22 INFO - Downloaded 22906651 bytes. 03:16:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:16:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:16:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:16:24 INFO - Return code: 0 03:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:24 INFO - https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:24 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'), kwargs: {}, attempt #1 03:16:25 INFO - Downloaded 10881672 bytes. 03:16:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:16:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:16:26 INFO - Return code: 0 03:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:26 INFO - https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:16:26 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2'), kwargs: {}, attempt #1 03:16:30 INFO - Downloaded 56985913 bytes. 03:16:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:16:30 INFO - mkdir: /builds/slave/test-pgo/properties 03:16:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:16:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:16:30 INFO - Contents: 03:16:30 INFO - build_url:https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:16:30 INFO - Running post-action listener: _resource_record_post_action 03:16:30 INFO - Running post-action listener: _set_extra_try_arguments 03:16:30 INFO - ##### 03:16:30 INFO - ##### Running populate-webroot step. 03:16:30 INFO - ##### 03:16:30 INFO - Running pre-action listener: _resource_record_pre_action 03:16:30 INFO - Running main action method: populate_webroot 03:16:30 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 03:16:30 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:16:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 03:16:30 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 03:16:30 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:16:30 INFO - Running post-action listener: _resource_record_post_action 03:16:30 INFO - ##### 03:16:30 INFO - ##### Running create-virtualenv step. 03:16:30 INFO - ##### 03:16:30 INFO - Running pre-action listener: _resource_record_pre_action 03:16:30 INFO - Running main action method: create_virtualenv 03:16:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:16:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:16:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:16:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:30 INFO - Using real prefix '/usr' 03:16:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:16:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:33 INFO - Installing pip.................done. 03:16:33 INFO - Return code: 0 03:16:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6ab51b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23577b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, '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': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:16:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:16:33 INFO - Using env: {'DISPLAY': ':0', 03:16:33 INFO - 'HOME': '/home/cltbld', 03:16:33 INFO - 'LANG': 'en_US.UTF-8', 03:16:33 INFO - 'LANGUAGE': 'en_US:en', 03:16:33 INFO - 'LOGNAME': 'cltbld', 03:16:33 INFO - 'MAIL': '/var/mail/cltbld', 03:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:33 INFO - 'MOZ_NO_REMOTE': '1', 03:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:33 INFO - 'NO_EM_RESTART': '1', 03:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:33 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:33 INFO - 'SHELL': '/bin/bash', 03:16:33 INFO - 'SHLVL': '1', 03:16:33 INFO - 'TERM': 'linux', 03:16:33 INFO - 'TMOUT': '86400', 03:16:33 INFO - 'USER': 'cltbld', 03:16:33 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:33 INFO - '_': '/tools/buildbot/bin/python'} 03:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:16:34 INFO - Cleaning up... 03:16:34 INFO - Return code: 0 03:16:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:34 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 0x7f6ab51b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23577b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, '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': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:16:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:16:34 INFO - Using env: {'DISPLAY': ':0', 03:16:34 INFO - 'HOME': '/home/cltbld', 03:16:34 INFO - 'LANG': 'en_US.UTF-8', 03:16:34 INFO - 'LANGUAGE': 'en_US:en', 03:16:34 INFO - 'LOGNAME': 'cltbld', 03:16:34 INFO - 'MAIL': '/var/mail/cltbld', 03:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:34 INFO - 'MOZ_NO_REMOTE': '1', 03:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:34 INFO - 'NO_EM_RESTART': '1', 03:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:34 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:34 INFO - 'SHELL': '/bin/bash', 03:16:34 INFO - 'SHLVL': '1', 03:16:34 INFO - 'TERM': 'linux', 03:16:34 INFO - 'TMOUT': '86400', 03:16:34 INFO - 'USER': 'cltbld', 03:16:34 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:34 INFO - '_': '/tools/buildbot/bin/python'} 03:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:34 INFO - Downloading/unpacking psutil>=0.7.1 03:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:36 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:16:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:16:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:36 INFO - Installing collected packages: psutil 03:16:36 INFO - Running setup.py install for psutil 03:16:36 INFO - building 'psutil._psutil_linux' extension 03:16:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:16:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:16:37 INFO - building 'psutil._psutil_posix' extension 03:16:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:16:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:37 INFO - Successfully installed psutil 03:16:37 INFO - Cleaning up... 03:16:37 INFO - Return code: 0 03:16:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:37 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 0x7f6ab51b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23577b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, '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': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:16:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:16:37 INFO - Using env: {'DISPLAY': ':0', 03:16:37 INFO - 'HOME': '/home/cltbld', 03:16:37 INFO - 'LANG': 'en_US.UTF-8', 03:16:37 INFO - 'LANGUAGE': 'en_US:en', 03:16:37 INFO - 'LOGNAME': 'cltbld', 03:16:37 INFO - 'MAIL': '/var/mail/cltbld', 03:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:37 INFO - 'MOZ_NO_REMOTE': '1', 03:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:37 INFO - 'NO_EM_RESTART': '1', 03:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:37 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:37 INFO - 'SHELL': '/bin/bash', 03:16:37 INFO - 'SHLVL': '1', 03:16:37 INFO - 'TERM': 'linux', 03:16:37 INFO - 'TMOUT': '86400', 03:16:37 INFO - 'USER': 'cltbld', 03:16:37 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:37 INFO - '_': '/tools/buildbot/bin/python'} 03:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:16:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:16:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:16:39 INFO - Installing collected packages: mozsystemmonitor 03:16:39 INFO - Running setup.py install for mozsystemmonitor 03:16:39 INFO - Successfully installed mozsystemmonitor 03:16:39 INFO - Cleaning up... 03:16:39 INFO - Return code: 0 03:16:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:39 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 0x7f6ab51b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23577b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, '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': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:16:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:16:39 INFO - Using env: {'DISPLAY': ':0', 03:16:39 INFO - 'HOME': '/home/cltbld', 03:16:39 INFO - 'LANG': 'en_US.UTF-8', 03:16:39 INFO - 'LANGUAGE': 'en_US:en', 03:16:39 INFO - 'LOGNAME': 'cltbld', 03:16:39 INFO - 'MAIL': '/var/mail/cltbld', 03:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:39 INFO - 'MOZ_NO_REMOTE': '1', 03:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:39 INFO - 'NO_EM_RESTART': '1', 03:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:39 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:39 INFO - 'SHELL': '/bin/bash', 03:16:39 INFO - 'SHLVL': '1', 03:16:39 INFO - 'TERM': 'linux', 03:16:39 INFO - 'TMOUT': '86400', 03:16:39 INFO - 'USER': 'cltbld', 03:16:39 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:39 INFO - '_': '/tools/buildbot/bin/python'} 03:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:16:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:16:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:16:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:42 INFO - Downloading docopt-0.6.1.tar.gz 03:16:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:16:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:42 INFO - Running setup.py install for blobuploader 03:16:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:16:42 INFO - Running setup.py install for requests 03:16:42 INFO - Running setup.py install for docopt 03:16:42 INFO - Successfully installed blobuploader requests docopt 03:16:42 INFO - Cleaning up... 03:16:43 INFO - Return code: 0 03:16:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16: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')]} 03:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:43 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 0x7f6ab51b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23577b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, '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': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:16:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:16:43 INFO - Using env: {'DISPLAY': ':0', 03:16:43 INFO - 'HOME': '/home/cltbld', 03:16:43 INFO - 'LANG': 'en_US.UTF-8', 03:16:43 INFO - 'LANGUAGE': 'en_US:en', 03:16:43 INFO - 'LOGNAME': 'cltbld', 03:16:43 INFO - 'MAIL': '/var/mail/cltbld', 03:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:43 INFO - 'MOZ_NO_REMOTE': '1', 03:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:43 INFO - 'NO_EM_RESTART': '1', 03:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:43 INFO - 'SHELL': '/bin/bash', 03:16:43 INFO - 'SHLVL': '1', 03:16:43 INFO - 'TERM': 'linux', 03:16:43 INFO - 'TMOUT': '86400', 03:16:43 INFO - 'USER': 'cltbld', 03:16:43 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:43 INFO - '_': '/tools/buildbot/bin/python'} 03:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:43 INFO - Running setup.py (path:/tmp/pip-1kUbtc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:43 INFO - Running setup.py (path:/tmp/pip-sdY300-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:43 INFO - Running setup.py (path:/tmp/pip-ErALj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:43 INFO - Running setup.py (path:/tmp/pip-MNnYd5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:43 INFO - Running setup.py (path:/tmp/pip-zenzBi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:43 INFO - Running setup.py (path:/tmp/pip-L0WDkH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:43 INFO - Running setup.py (path:/tmp/pip-_3jfPm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:43 INFO - Running setup.py (path:/tmp/pip-G55RKt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:43 INFO - Running setup.py (path:/tmp/pip-X7Vf40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:43 INFO - Running setup.py (path:/tmp/pip-NlKDFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:43 INFO - Running setup.py (path:/tmp/pip-iaP463-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:44 INFO - Running setup.py (path:/tmp/pip-RxGiyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:44 INFO - Running setup.py (path:/tmp/pip-ckrTiX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:44 INFO - Running setup.py (path:/tmp/pip-_q8ZMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:44 INFO - Running setup.py (path:/tmp/pip-gSYET0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:44 INFO - Running setup.py (path:/tmp/pip-pD9Qcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:44 INFO - Running setup.py (path:/tmp/pip-ESWTFS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:44 INFO - Running setup.py install for manifestparser 03:16:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:16:44 INFO - Running setup.py install for mozcrash 03:16:44 INFO - Running setup.py install for mozdebug 03:16:44 INFO - Running setup.py install for mozdevice 03:16:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:16:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:16:44 INFO - Running setup.py install for mozfile 03:16:44 INFO - Running setup.py install for mozhttpd 03:16:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Running setup.py install for mozinfo 03:16:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Running setup.py install for mozInstall 03:16:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Running setup.py install for mozleak 03:16:45 INFO - Running setup.py install for mozlog 03:16:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Running setup.py install for moznetwork 03:16:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Running setup.py install for mozprocess 03:16:45 INFO - Running setup.py install for mozprofile 03:16:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Running setup.py install for mozrunner 03:16:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:16:45 INFO - Running setup.py install for mozscreenshot 03:16:46 INFO - Running setup.py install for moztest 03:16:46 INFO - Running setup.py install for mozversion 03:16:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:16:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:46 INFO - Cleaning up... 03:16:46 INFO - Return code: 0 03:16:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:46 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 0x7f6ab51b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23577b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, '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': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:16:46 INFO - Using env: {'DISPLAY': ':0', 03:16:46 INFO - 'HOME': '/home/cltbld', 03:16:46 INFO - 'LANG': 'en_US.UTF-8', 03:16:46 INFO - 'LANGUAGE': 'en_US:en', 03:16:46 INFO - 'LOGNAME': 'cltbld', 03:16:46 INFO - 'MAIL': '/var/mail/cltbld', 03:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:46 INFO - 'MOZ_NO_REMOTE': '1', 03:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:46 INFO - 'NO_EM_RESTART': '1', 03:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:46 INFO - 'SHELL': '/bin/bash', 03:16:46 INFO - 'SHLVL': '1', 03:16:46 INFO - 'TERM': 'linux', 03:16:46 INFO - 'TMOUT': '86400', 03:16:46 INFO - 'USER': 'cltbld', 03:16:46 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:46 INFO - '_': '/tools/buildbot/bin/python'} 03:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:46 INFO - Running setup.py (path:/tmp/pip-FqCHvw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:46 INFO - Running setup.py (path:/tmp/pip-L2gXZh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:46 INFO - Running setup.py (path:/tmp/pip-MAc0mg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:46 INFO - Running setup.py (path:/tmp/pip-AwiZwp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:46 INFO - Running setup.py (path:/tmp/pip-mC1FlI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:46 INFO - Running setup.py (path:/tmp/pip-lm0pDR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:46 INFO - Running setup.py (path:/tmp/pip-N9vs7J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:16:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:46 INFO - Running setup.py (path:/tmp/pip-pp2QT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:47 INFO - Running setup.py (path:/tmp/pip-ONtjZB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:47 INFO - Running setup.py (path:/tmp/pip-QNEoAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:47 INFO - Running setup.py (path:/tmp/pip-ely9EO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:47 INFO - Running setup.py (path:/tmp/pip-O5Ec9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:47 INFO - Running setup.py (path:/tmp/pip-am0VE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:47 INFO - Running setup.py (path:/tmp/pip-7CENPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:47 INFO - Running setup.py (path:/tmp/pip-jrwyJZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:47 INFO - Running setup.py (path:/tmp/pip-wBJs3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:16:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:47 INFO - Running setup.py (path:/tmp/pip-nAosaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:49 INFO - Downloading blessings-1.5.1.tar.gz 03:16:49 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:16:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:49 INFO - Installing collected packages: blessings 03:16:49 INFO - Running setup.py install for blessings 03:16:49 INFO - Successfully installed blessings 03:16:49 INFO - Cleaning up... 03:16:49 INFO - Return code: 0 03:16:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:16:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:16:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:16:49 INFO - Reading from file tmpfile_stdout 03:16:49 INFO - Current package versions: 03:16:49 INFO - argparse == 1.2.1 03:16:49 INFO - blessings == 1.5.1 03:16:49 INFO - blobuploader == 1.2.4 03:16:49 INFO - docopt == 0.6.1 03:16:49 INFO - manifestparser == 1.1 03:16:49 INFO - mozInstall == 1.12 03:16:49 INFO - mozcrash == 0.16 03:16:49 INFO - mozdebug == 0.1 03:16:49 INFO - mozdevice == 0.46 03:16:49 INFO - mozfile == 1.2 03:16:49 INFO - mozhttpd == 0.7 03:16:49 INFO - mozinfo == 0.8 03:16:49 INFO - mozleak == 0.1 03:16:49 INFO - mozlog == 3.0 03:16:49 INFO - moznetwork == 0.27 03:16:49 INFO - mozprocess == 0.22 03:16:49 INFO - mozprofile == 0.27 03:16:49 INFO - mozrunner == 6.10 03:16:49 INFO - mozscreenshot == 0.1 03:16:49 INFO - mozsystemmonitor == 0.0 03:16:49 INFO - moztest == 0.7 03:16:49 INFO - mozversion == 1.4 03:16:49 INFO - psutil == 3.1.1 03:16:49 INFO - requests == 1.2.3 03:16:49 INFO - wsgiref == 0.1.2 03:16:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:49 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 0x7f6ab51b7b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23577b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, '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': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:16:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:16:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:16:49 INFO - Using env: {'DISPLAY': ':0', 03:16:49 INFO - 'HOME': '/home/cltbld', 03:16:49 INFO - 'LANG': 'en_US.UTF-8', 03:16:49 INFO - 'LANGUAGE': 'en_US:en', 03:16:49 INFO - 'LOGNAME': 'cltbld', 03:16:49 INFO - 'MAIL': '/var/mail/cltbld', 03:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:49 INFO - 'MOZ_NO_REMOTE': '1', 03:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:49 INFO - 'NO_EM_RESTART': '1', 03:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:49 INFO - 'SHELL': '/bin/bash', 03:16:49 INFO - 'SHLVL': '1', 03:16:49 INFO - 'TERM': 'linux', 03:16:49 INFO - 'TMOUT': '86400', 03:16:49 INFO - 'USER': 'cltbld', 03:16:49 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:49 INFO - '_': '/tools/buildbot/bin/python'} 03:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:16:50 INFO - Cleaning up... 03:16:50 INFO - Return code: 0 03:16:50 INFO - Running post-action listener: _resource_record_post_action 03:16:50 INFO - Running post-action listener: _start_resource_monitoring 03:16:50 INFO - Starting resource monitoring. 03:16:50 INFO - ##### 03:16:50 INFO - ##### Running install step. 03:16:50 INFO - ##### 03:16:50 INFO - Running pre-action listener: _resource_record_pre_action 03:16:50 INFO - Running main action method: install 03:16:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:16:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:16:50 INFO - Reading from file tmpfile_stdout 03:16:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:16:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:16:50 INFO - Reading from file tmpfile_stdout 03:16:50 INFO - Output received: 03:16:50 INFO - Usage: mozinstall [options] installer 03:16:50 INFO - Options: 03:16:50 INFO - -h, --help show this help message and exit 03:16:50 INFO - -d DEST, --destination=DEST 03:16:50 INFO - Directory to install application into. [default: 03:16:50 INFO - "/builds/slave/test-pgo"] 03:16:50 INFO - --app=APP Application being installed. [default: firefox] 03:16:50 INFO - mkdir: /builds/slave/test-pgo/build/application 03:16:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:16:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:17:04 INFO - Reading from file tmpfile_stdout 03:17:04 INFO - Output received: 03:17:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:17:04 INFO - Running post-action listener: _resource_record_post_action 03:17:04 INFO - ##### 03:17:04 INFO - ##### Running run-tests step. 03:17:04 INFO - ##### 03:17:04 INFO - Running pre-action listener: _resource_record_pre_action 03:17:04 INFO - Running main action method: run_tests 03:17:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:17:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:17:04 INFO - Python 2.7.3 03:17:04 INFO - Return code: 0 03:17:04 INFO - grabbing minidump binary from tooltool 03:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:04 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 0x21aebf0>, '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 0x24ac4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ac9a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:17:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:17:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:17:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:04 INFO - Return code: 0 03:17:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:17:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:17:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:17:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:17:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:17:04 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/H58T4liwS7KuEJvKaRYbDg/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-002', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:17:04 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/H58T4liwS7KuEJvKaRYbDg/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-002 --webServer localhost 03:17:04 INFO - Using env: {'DISPLAY': ':0', 03:17:04 INFO - 'HOME': '/home/cltbld', 03:17:04 INFO - 'LANG': 'en_US.UTF-8', 03:17:04 INFO - 'LANGUAGE': 'en_US:en', 03:17:04 INFO - 'LOGNAME': 'cltbld', 03:17:04 INFO - 'MAIL': '/var/mail/cltbld', 03:17:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:17:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:04 INFO - 'MOZ_NO_REMOTE': '1', 03:17:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:04 INFO - 'NO_EM_RESTART': '1', 03:17:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:17:04 INFO - 'SHELL': '/bin/bash', 03:17:04 INFO - 'SHLVL': '1', 03:17:04 INFO - 'TERM': 'linux', 03:17:04 INFO - 'TMOUT': '86400', 03:17:04 INFO - 'USER': 'cltbld', 03:17:04 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499', 03:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:04 INFO - '_': '/tools/buildbot/bin/python'} 03:17:04 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/H58T4liwS7KuEJvKaRYbDg/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-002', '--webServer', 'localhost'] with output_timeout 3600 03:17:04 INFO - mozversion INFO | application_buildid: 20151029005548 03:17:04 INFO - mozversion INFO | application_changeset: 9470fd1a1c8952f9d949715f2be3e3262762e536 03:17:04 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:17:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:04 INFO - mozversion INFO | application_name: Firefox 03:17:04 INFO - mozversion INFO | application_remotingname: firefox-dev 03:17:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:04 INFO - mozversion INFO | application_vendor: Mozilla 03:17:04 INFO - mozversion INFO | application_version: 43.0a2 03:17:04 INFO - mozversion INFO | platform_buildid: 20151029005548 03:17:04 INFO - mozversion INFO | platform_changeset: 9470fd1a1c8952f9d949715f2be3e3262762e536 03:17:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:04 INFO - mozversion INFO | platform_version: 43.0a2 03:17:04 INFO - 2015-10-29 03:17:04,980 DEBUG : using testdate: 1446113824 03:17:04 INFO - 2015-10-29 03:17:04,980 DEBUG : actual date: 1446113824 03:17:05 INFO - 2015-10-29 03:17:05,028 INFO : Starting test suite talos-linux64-ix-002 03:17:05 INFO - 2015-10-29 03:17:05,028 INFO : Starting test dromaeo_css 03:17:05 INFO - 2015-10-29 03:17:05,029 DEBUG : operating with platform_type : linux_ 03:17:05 INFO - 2015-10-29 03:17:05,029 INFO : Initialising browser for dromaeo_css test... 03:17:05 INFO - 2015-10-29 03:17:05,051 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp08kpDw/profile http://localhost/getInfo.html 03:17:10 INFO - 2015-10-29 03:17:10,062 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:17:10 INFO - 2015-10-29 03:17:10,062 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:17:10 INFO - 2015-10-29 03:17:10,062 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:17:10 INFO - 2015-10-29 03:17:10,063 DEBUG : BROWSER_OUTPUT: __metrics 03:17:10 INFO - 2015-10-29 03:17:10,252 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:17:11 INFO - 2015-10-29 03:17:11,470 INFO : Browser initialized. 03:17:12 INFO - 2015-10-29 03:17:11,471 INFO : Running cycle 1/1 for dromaeo_css test... 03:17:12 INFO - 2015-10-29 03:17:11,471 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp08kpDw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:17:23 INFO - 2015-10-29 03:17:23,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 133083136 03:17:23 INFO - 2015-10-29 03:17:23,695 DEBUG : BROWSER_OUTPUT: 03:20:23 INFO - 2015-10-29 03:20:23,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-dojo.html (next: http://localhost/page_load_test/dromaeo/cssquery-ext.html) 03:20:24 INFO - 2015-10-29 03:20:24,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 240848896 03:20:24 INFO - 2015-10-29 03:20:24,117 DEBUG : BROWSER_OUTPUT: 03:23:26 INFO - 2015-10-29 03:23:26,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-ext.html (next: http://localhost/page_load_test/dromaeo/cssquery-jquery.html) 03:23:26 INFO - 2015-10-29 03:23:26,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 205312000 03:23:26 INFO - 2015-10-29 03:23:26,745 DEBUG : BROWSER_OUTPUT: 03:26:28 INFO - 2015-10-29 03:26:28,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-jquery.html (next: http://localhost/page_load_test/dromaeo/cssquery-mootools.html) 03:26:29 INFO - 2015-10-29 03:26:29,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 206868480 03:26:29 INFO - 2015-10-29 03:26:29,103 DEBUG : BROWSER_OUTPUT: 03:29:30 INFO - 2015-10-29 03:29:30,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-mootools.html (next: http://localhost/page_load_test/dromaeo/cssquery-prototype.html) 03:29:31 INFO - 2015-10-29 03:29:31,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 195870720 03:29:31 INFO - 2015-10-29 03:29:31,392 DEBUG : BROWSER_OUTPUT: 03:32:33 INFO - 2015-10-29 03:32:33,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-prototype.html (next: http://localhost/page_load_test/dromaeo/cssquery-yui.html) 03:32:34 INFO - 2015-10-29 03:32:34,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 194670592 03:32:34 INFO - 2015-10-29 03:32:34,401 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-yui.html (next: http://localhost/page_load_test/dromaeo/cssquery-dojo.html) 03:35:36 INFO - 2015-10-29 03:35:36,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 238522368 03:35:36 INFO - 2015-10-29 03:35:36,807 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,809 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:35:36 INFO - 2015-10-29 03:35:36,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:35:36 INFO - 2015-10-29 03:35:36,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:35:36 INFO - 2015-10-29 03:35:36,809 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:35:36 INFO - 2015-10-29 03:35:36,811 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3353.76523643345;3383.780054296469;3406.540117084193;3418.6239513653495;3425.109471537401;5589.7205139743;5600.243967064445;5610.775568977247;5640.802571909979;5661.377248502661;5686.630369026021;5702.714864256791;5717.914231286534;5722.484976352128;5731.484166425021;5051.924221136685;5109.897802043957;5187.533122019027;5199.584033277329;5274.898569239901;5088.872778180556;5145.3311069560905;5175.663581867167;5190.948090519084;5286.629935904488;5216.6087543434205;5298.549623282026;5310.73446327684;5313.574914006889;5319.601029922752;5191.091558977164;5229.3201883755055;5243.606729495284;5254.369475662945;5256.894862102775;4962.1812400953795;5012.573931215851;5058.0895438821;5115.079285728568;5181.637285390024;5493.2034854946205;5503.954248692776;5507.256520369739;5527.419620939783;5541.113421852525;6127.050307202391;6130.356312587203;6134.693265336716;6135.049067394561;6144.201253837017;5956.851078723023;6041.063635136561;6062.666553339564;6076.270847498285;6122.469382654336;5761.222234998306;5765.740541675635;5767;5768.7980920668;5774.278215223055;5934.821955341346;6225.750969961241;6225.906611400833;6226.782062627786;6234.1583886175695;5844.444777746107;6050.878982420415;6110.511159107261;6142.447179753844;6148.1392605035335;6228.190335256388;6231.626102433868;6235.75056997715;6239.75040998355;6247.250329960434;5846.941530584725;5989.251343582052;6181.536384771161;6185.505159587222;6195.938040619536;6020.397960204032;6110.198596386424;6126.111753679267;6128.647737417829;6141.631502109888;4690.577847993697;4700.858974230779;4707.223308154184;4713.929291060636;4730.053989202104;4001.1197536541913;4080.367543030835;4094.570070142592;4207.389928460356;4225.873223803291;5794;5871.119332100134;5871.6770577618645;5886.381929897299;5887.558433117448;6254.15568898202;6268.4671802896355;6271.843203919847;6283.59156654816;6284.968575157186;5548.69482178484;5660.830175094754;5773;5816.040353341736;5849.181114643953;5296.602754793406;5296.655717378358;5304.177852432879;5306.257124002643;5311.52196302327;6320.652364120017;6346.555741098079;6368.044793280952;6369.745210191633;6371.171747672773;5895.14520394549;6001.579889407874;6113.51091912637;6195.473384762166;6210.844728881814;6348.428641422294;6359.491240700825;6379.5215358847345;6382.489400848014;6389.297177310399;5877.676727780014;6077.24034495688;6079.452849243589;6087.360827113266;6088.238970128734;6073.878522429615;6077.058056001327;6146.723397447215;6164.106204600218;6170.660613666112;5991.2510936132985;6073.848153796013;6079.270487541523;6081.087836824512;6087.512998959984;5737.569682273763;5832.475077243069;6040.214772079602;6071.241094863142;6080.574359794772;5872.618279811799;5951.077582974646;5956.344802071682;5963.403659634002;5980.880382392241;6059.909101363395;6082.939170608414;6096.878062438637;6110.847228819315;6114.510839132769;5634.098544232903;5756.453136951983;5833.241678581757;5973.91039134422;5993.790217342372 03:35:36 INFO - 2015-10-29 03:35:36,812 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.4499268220804;593.6022864680664;606.7451670298472;608.1455554945303;624.3506752976904;35273.47089793652;44437.55562444375;44538;44547.77726111373;44561.33158002632;47420;47733.76133119338;48004.759976200156;48046.75976620112;48050.27924581134;8084.191580841898;8191.549464779435;9280.071992800733;9466.384684995488;10847.511861966192;10964.342139471617;11031.72420689481;11035.72410689735;11045.005949464547;11050.834237486444;11182.049525790277;11276.210665253435;11297;11297.378644174567;11298.435078246095;11130.554777808878;11143.164262680291;11226.943865280662;11239.887601124048;11241;10969.451527423676;11053.336799791958;11067.778644427066;11086.16853735965;11133.888661113448;44644.77677611624;44904;44921.550784492065;45010.09979800419;45050.32424513635;3446.3451944130784;3458.56767904012;3658.5426821647293;4095.221907837531;4102.200070986159;33821.323573528636;34408;34452.31095378104;34587.6541234587;34726.82636586826;3794.5256842894637;3798.409759068015;3810.314143454177;3874.5156855393075;3910.354791459406;311891;313684;313867;315119;316630;59230.40769592335;59549.10676339858;67447.3255267441;67944;72115;69026;69090;69221.3077869225;69383;69460;18915.52711182204;19161.52096197606;19171.520711982033;19171.712424313646;19182.520436988907;12152.817707734392;12238.632841014783;13976.161430314214;14286.714265714627;14303.570892873022;21466.57066858654;21512.677309840365;21779;21840.471167018157;21885.781142188695;7702.1912699166905;7905.604719764104;7981.441299109123;8081.797955051171;8149.796255093552;1083.8590983172137;1102.090775110521;1141.520561364229;1173.747644256489;1211.8182272658996;31706.524402133986;31729.524057139162;31957.52063719046;32277.193070173435;32733.836330818194;1158.5018442069822;1187.1986409173946;1255.836741223635;1265.9620211393674;1303.2219091804757;14599.140236533978;15401.22993850303;15770.13264270476;16939.830601694073;17218.31126754941;386619;393839;393939;394009;395238;57871;58156.41843581595;58162.127568086515;58198.12702809461;58297;1520.8098987626547;1530.9387624494896;1542.159523059935;1542.7223099841913;1556.828748837627;32045.51931721073;32058.67941320557;32316;33104.83447582747;33217.501737473474;51321.23018154805;51920.48079519308;52031.69920752011;52039.479605203465;52052.47947520476;353861;355290;355901;356066;356858;31987.360252794348;37556;38005.619943801314;38161;38468.23063538769;47094.52905470901;47615.52384476111;47841.76079119582;48172.27741583809;48341.5165848337;39599;40240;40430.595694042684;41043.38434923419;41116.794416027726;34659.82670086633;39904;41023.7948810254;42760.497938550456;44370.334444982705;39529.604703952595;40346.1930761389;40354;40399;40430.39354409745;34503.827480862434;35828;36528;37772;38796.03009924774;27762.722372776014;27998.86000569984;28257.43485130327;28381.716182837907;28414.85792571024 03:35:36 INFO - 2015-10-29 03:35:36,816 DEBUG : BROWSER_OUTPUT: |2;jquery.html;411.8229161460572;412.1016184717317;418.78851180154015;419.30395543397964;424.8088360237893;19732.60534789305;19970.900145499287;20338.796612033875;20346.389608311736;20352.69470957933;19089.23643054276;19341.613167736636;19653.70519442206;20423.897880510613;20587.691184632204;5106.310648062501;5215.58275337972;5231.398389185235;5770.567207459447;5924.792632257871;5197.922031169535;5208.817691380802;5212.947870521303;5213.817516386927;5219.660722053073;3682.466042423847;3742.494763206973;5092.898142037157;5173.275741396207;5198.064348417283;5249.658772179815;5366;5396.379416367089;5404.7838086476495;5405.8107966221;4622.14490319292;4636.53634636537;4688.742119183444;4690.624750019991;4691.061787642485;13461.528846490424;13828.654283642989;15305.923470382688;15472.303746331441;15529.378824846992;2195.429188411025;2205.6691496275525;2212.723409573803;2221.555688862234;2290.3014580552926;10702.090322322612;10865.619703310425;10882.673519794418;10890.23768336209;11101.278416902956;1814.6280012597385;1825.7443957845912;1842.7512285841374;1857.5820440400937;1883.6326916251337;68197.65901170512;69607.3039269606;69917;70440.94338584926;71261.28738712598;7974.082980457321;8017.599120043975;8024.398170137263;8040.477368970998;8050.476719013245;9791.951040244754;9792.265580081523;9798.461084640414;9800.754981125529;9801.803963920682;6247.375262473716;6403.679816009181;6475.514336424787;6480.513961452815;6507.414332709984;6665.100211471487;6670.466362690973;6697.966510167418;6716.429103526158;6725.798226053226;3679.466477360821;3717.683996860243;3722.590515043343;3760.605136460687;3807.6192380762254;1274.4647248155798;1275.789494733377;1289.5744404346542;1311.7573248948975;1325.6478392040258;473.2121018504221;541.3611937913222;555.2615022020702;558.9385167631557;559.3735016781231;12885.742285154245;13135.343232838512;13174.934125329311;13224.801627975588;13338.066335356625;576.6223123853882;580;586.1003359842706;592.8814237152501;594.1325664529749;7132.679029443688;7144.464165187632;7267.418606511466;7378.5941773202985;7414.925850741423;568725;580912;583163;589102;601202;76333.61833190799;76378;85544.57227713821;87524;88617.11382886089;589.3075636127533;625.9217597800275;636.0364048466485;637.2607774981093;638.2628064585411;12671.17637353569;12942.054215369311;13082.411291491715;13108.737825243632;13185.142965707199;39894;40468.1906361877;40583.3912491307;41369.1726165481;41721.16557668769;51181.7440912793;51571.22643160281;51780;55235.44764552303;56080.71959640176;7588.886166707393;7769.689212431439;7776.183500732568;7810.414218933489;7849.136594974434;13287.335633218107;13441.46234150623;14024.78962815579;14116.717665646423;14164.504242351468;12033.097517686034;12133.817992730294;12220;12270.631881043226;12442.37788110609;4912.5016869855035;9633.710988670351;11838;12146.002836455993;12452.066095043088;12723.172993755376;12758.234505929673;12958.935205323913;12978.740425191632;12989.870101298866;7884;7889.053313602404;7924.762257132295;7930.643121059451;7990.360771138178;12434.75130497403;12436.129470937309;12614.810777838524;12648.873511265137;12752.74494510123 03:35:36 INFO - 2015-10-29 03:35:36,817 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1646.868250539957;1673.8326167383264;1825.7535232743578;2048.918043278269;2064.4826052851163;9149.67976120836;10276.17790576754;10551.73620659483;10561.471926403687;10564.577416903334;10022.19822414207;10024.899751002487;10146;10152.898471015287;10174.949125254381;2155.0948601587293;2202.757696653367;2374.050379848057;2409.72288186859;2421.32202983165;2389.2951579284154;2391.4380120671626;2398.8680622565753;2401.0755858994326;2401.9639705404434;2270.0465804362207;2300.8274379421528;2305.2162264829954;2307.377008207783;2307.6538519222167;2152.3865698275995;2196.077647388093;2359.433735903388;2405.8075353971817;2429.514097180553;2380.9285721428387;2412.433078226615;2426.2842461473906;2450.9754902450927;2454.312792418126;10490.16078713701;10591.311564748266;10594.735131621694;10595.735106622318;10614.78770424595;5508.944910550883;5583.720813959327;5587.078132108198;5590.049691552445;5595.8880822383735;3523.823808809549;3539.522164507784;3550.520679708258;3566.785992840412;3582.4268117101137;1062.3041907550567;1082.2694681090234;1090.1714696830386;1098.9615363462322;1099.9560017599285;14709.117452952856;14716.190609516472;14735.263236838115;14740;14743.705125897422;4785.688930219525;4787.114383839001;4804.375431193923;4830.637702172351;4848.80604775805;11703.122265830098;11767.293962362286;11782.52869885195;11786.29282243051;11806.704832379259;5437.184422336682;5442.564594832404;5444.646098003617;5447.373552041566;5449.891002179934;4861.319415281863;4863.537963893425;4868.3427737255015;4870.732109733999;4874.8050077997195;3993.7603743775467;4003.399490076512;4025.7785821780085;4041.333180025322;4058.918821623551;1145.0381679389352;1161.5644133449957;1170.1867202294325;1180.0323734537596;1187.6377704800118;1142.8400023996646;1161.355447726503;1162.604714397092;1207.9033677305795;1225.6200577820905;9962.750931226632;10011.299209055296;10062.39625622465;10077.949610251902;10100.696979090639;1273.6688461000206;1282.1153404151105;1289.6711338608595;1295.1581472043058;1296;7538.170801211862;7593.5823529706395;7635.580043097571;7644.885326720104;7718.729844455529;13501.324933753272;13654.249016304198;13706.45174193041;13717.519886803913;13724.862751372559;13379.53171638988;13627.863721362659;13649;13650.385732642055;13664.385102670403;9449.527523623929;9563.713088607354;9607.615695372248;9623.230141588656;9659.758506037406;9193.678221262224;9289.489078100769;9328.253739700673;9351.48566828831;9358;11124.443777810915;11301.378424186749;11323.603673871376;11326.773464530499;11397.145214108808;11359;11564.190506664452;11647.6505704829;11661.708457288636;11662.766744665229;8792.208701216921;8803.075677053817;8804.251638610789;8879.644814207617;8880;10206.897931020892;10262.384256944608;10282.383057016603;10388.688339349832;10395.58417663285;8008.919910800817;9451.574679139592;9478.336516443782;9645.08371704687;9700.12698857078;9043.186113249576;9218.769530761785;9220.124088211609;9233;9302.441853488812;9290.16388525036;9383.436993780395;9393.906060939304;9406.952965235403;9419.058094190526;8367.95816020916;8544.530050847014;8560.14398560139;8580.828383432172;8592.785180370542;8312.792180195544;8347.415680902279;8363.121872203332;8368.623411946599;8382.455140415854 03:35:36 INFO - 2015-10-29 03:35:36,818 DEBUG : BROWSER_OUTPUT: |4;prototype.html;395.6617092386008;397.04510651882225;399.26535175277485;402.05918151525424;403.8384646141543;5877.3241077276125;5884.529237660988;5935.614185077967;5941.138534912435;5942.643441393519;5792.218050563172;5795.3335366432875;5800.854978625536;5856.970715146429;5972.0444728843395;4564.863054108374;4632.027274272406;4666.486686464486;4674.719516829001;4718.127146477896;4673.088747694184;4696.859094227161;4701.4593321767925;4704.270838020096;4734.763261836912;4525.162844873693;4583.014651849851;4665.230237010889;4671.532846715319;4675.088357770219;4610.354550362952;4659.743714095724;4683.2038553446;4684;4688.69523480976;4165.97917010416;4170.91658166835;4178.289690752579;4180.038591124058;4182.91634167318;5660.320761508646;5680.4319568043275;5693.857653558653;5702.201691763156;5703.40114288002;5412.215228791803;5437.6465529740835;5448.45515448456;5449.073657478199;5498.890022199574;6336.3346848580695;6344.7462101515885;6346.048092786073;6346.0798184263485;6350.7777227796805;4657.906841863178;4658.161530924433;4660.743659098748;4661.137689527448;4661.300804879295;6482.254540727829;6537.93462065378;6540.901886471659;6555.573887697332;6556.541042127005;4635.837745678885;4686.531346865286;4693.342931989524;4695.131400690883;4707.599854012379;4746.928796068062;4748.501407352247;4749.525047495292;4750.904981900343;4751.477337492873;5402.702851343135;5413.539849112791;5417.620766546383;5418.024755543961;5419.837404877781;6143.692815359214;6279.403456671609;6280.277768056732;6287;6383.585066970632;1735.0977491704243;1746.56335916021;1753.6668033073674;1754.491197552721;1758.2703178180911;1166.2128063557234;1194.6535504703713;1205.1864991130951;1212.8302037714727;1228.2139430764319;6196.039613859859;6196.597221180609;6219.968900155561;6221.160143380585;6224.253089629183;6559.7376104955265;6603.900941485882;6610.471162307004;6612.305707900698;6621.172353455818;5809.883802324014;6006.699665016732;6196.783112591038;6197.783077592263;6198.597091189058;3535.7701749386724;3562.412201986695;3563.8574457021946;3564.6613571710645;3569.3218288525095;6740.056392105109;6742.9662851685425;6747.730090796314;6748.797536073926;6749;6696.765613203612;6710.966445167743;6720.395164435126;6721.764738234138;6727.360900714424;6568.737250510022;6815.352541508549;6844.760433384808;6846.931530684629;6848.931510684829;6620.602763834186;6633.2371777246235;6637.634930078699;6640;6646.501512386687;6493.870122597427;6523.67381630907;6524.608523488606;6525.314841941527;6535.705893234721;6706.966465167643;6752.020956961312;6791.422729068085;6792.694328755119;6795.558288711218;4734.124187025412;4735.408073990751;4766.952330476651;4783.306420568929;4783.473817879961;6565.376289252514;6588.8023359299295;6590.80227593173;6591.538592298493;6592.604443733391;6279.937200627935;6401.615903045832;6403.391677790789;6404.839879003062;6517.73929042833;6482.935170648233;6484.578502397329;6490.091387205889;6490.513211509061;6506.967465162644;6322.178116844781;6351.936480635134;6355.300916899045;6377;6379.904301435389;6319.96840015797;6408.487321014401;6409.9679501602195;6412.679366031586;6413.0701048348665;6089.208402907594;6146.323904370426;6163.3836616338;6263.3736626337;6265.27949285838 03:35:36 INFO - 2015-10-29 03:35:36,820 DEBUG : BROWSER_OUTPUT: |5;yui.html;923.7967647117633;937.9906200937993;951.1012093571574;958.5734348215043;962.191758922505;13803.2408217548;13809.930950345246;14025.509107181251;14045.929770351147;14050.578482645524;13511.054226204169;13545.322733863317;13574;13589.93205033976;13602.659933501667;787.8936343593599;797.8922845415852;935.2237642756496;950.4819873169105;968.864358989742;968.2060710217625;970.2965350121141;972.5526257921365;978.3102912446743;980.5293459139617;836.5942517878824;1012.1801340913846;1022;1029.3206483720746;1031.0411317474745;844.4933040175875;1004.8492726091108;1012.5443550402348;1017.2319898476677;1017.247237044589;750.5721738608995;751.9736809211652;752.8945947567345;752.9887051694229;753.0060320377105;13671.17972921628;13885.375158117808;13885.861141388557;13926.09480383782;13938.024338296324;12733.236005839679;12989.675258118528;13127.212367257995;13160.6709832254;13343.799843002364;9905.554250058765;9942.105210531015;10173.186145108373;10275.948620256926;10779.784404311948;3476.6349533298894;3520.049586611626;3537.8584856605703;3542.769719968194;3547.627499112582;41283.7935810319;41512.1697566047;44617.10765784666;44746;45007.32489012668;7774.455788094892;7883.132855385903;7972.880406793903;7984.24149705777;7987.760367188994;12484.81272780909;12533.93733031329;12547.435365408579;12554.309512976692;12574.245545267313;6897.310268973163;6909.170899491993;6957.512974091765;7024.05175301338;7099.57402555838;4282.978585107055;4352.630026447724;4392;4393;4412.514623391425;2805.957910631342;2832.6317578714634;2837.6736675282195;2842.07632519432;2846.644169478815;469.5539237724176;473.81284392665395;476.8235752771497;487.30558953491135;490.5682998960963;676.2797620534116;695.2769120115024;710.8294009437801;718.5975853522044;726.4442701333484;9102.408343457653;9204.585793639302;9401.388909720847;9446.763830904283;9554.713358599114;683.135833171039;714.7962830593256;719.3525826755962;724.9492535522463;727.7343769524085;3996.6403023728003;4131.814068366931;4146.398772178078;4217.62041416274;4398.582134697199;55432.44567554354;55481.44518554763;56524.15213771797;57326;57655.13517297244;47874;47987.04025919462;48158;49905.75047124814;50794;40381.1923761529;40493.797531012155;40573.594264057574;40580;41272.58727412747;8462.238398543914;8555.230029297392;8777.780555486164;8839.558022098741;8907.421017633833;28431.43137137287;28952.855235723688;29018.56472152877;29335;29637.703622964356;38352;39157.2168556633;39486.605133948295;39564;39595;8195.672173113247;8203.917960820316;8384;8483.74548763538;8647.351448641502;11858.229215100991;11948.35575149553;12070.396480176132;12433.254004759743;13172.538961136313;10840.620578279722;11207.159463040141;11323.377214253294;11414.201005929504;12039.337836419081;10807.567697292336;11024.50389732448;11050.613228536962;11082.833757493483;11503.367314797431;10023.69928902134;11096.33421994683;11317.71705707364;11675.532978680758;11856.407179640812;9008.819823603622;9104.635814567344;9303.813923721353;9828.4102953823;10001.899981000097;9235.722928312161;9953.253505987224;10120.544575493974;10124.240681948737;10133.18934485254 03:35:36 INFO - 2015-10-29 03:35:36,820 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:35:36 INFO - 2015-10-29 03:35:36,820 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:35:36 INFO - 2015-10-29 03:35:36,820 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,785 03:35:36 INFO - 2015-10-29 03:35:36,820 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: __startTimestamp1446114936807__endTimestamp 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5686.42 Median:5886.38 stddev:649.60 (11.0%) stddev-sans-first:625.29 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: Values: 3353.8 3383.8 3406.5 3418.6 3425.1 5589.7 5600.2 5610.8 5640.8 5661.4 5686.6 5702.7 5717.9 5722.5 5731.5 5051.9 5109.9 5187.5 5199.6 5274.9 5088.9 5145.3 5175.7 5190.9 5286.6 5216.6 5298.5 5310.7 5313.6 5319.6 5191.1 5229.3 5243.6 5254.4 5256.9 4962.2 5012.6 5058.1 5115.1 5181.6 5493.2 5504.0 5507.3 5527.4 5541.1 6127.1 6130.4 6134.7 6135.0 6144.2 5956.9 6041.1 6062.7 6076.3 6122.5 5761.2 5765.7 5767.0 5768.8 5774.3 5934.8 6225.8 6225.9 6226.8 6234.2 5844.4 6050.9 6110.5 6142.4 6148.1 6228.2 6231.6 6235.8 6239.8 6247.3 5846.9 5989.3 6181.5 6185.5 6195.9 6020.4 6110.2 6126.1 6128.6 6141.6 4690.6 4700.9 4707.2 4713.9 4730.1 4001.1 4080.4 4094.6 4207.4 4225.9 5794.0 5871.1 5871.7 5886.4 5887.6 6254.2 6268.5 6271.8 6283.6 6285.0 5548.7 5660.8 5773.0 5816.0 5849.2 5296.6 5296.7 5304.2 5306.3 5311.5 6320.7 6346.6 6368.0 6369.7 6371.2 5895.1 6001.6 6113.5 6195.5 6210.8 6348.4 6359.5 6379.5 6382.5 6389.3 5877.7 6077.2 6079.5 6087.4 6088.2 6073.9 6077.1 6146.7 6164.1 6170.7 5991.3 6073.8 6079.3 6081.1 6087.5 5737.6 5832.5 6040.2 6071.2 6080.6 5872.6 5951.1 5956.3 5963.4 5980.9 6059.9 6082.9 6096.9 6110.8 6114.5 5634.1 5756.5 5833.2 5973.9 5993.8 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,821 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54340.35 Median:356462.00 stddev:93108.23 (26.1%) stddev-sans-first:93281.86 03:35:36 INFO - 2015-10-29 03:35:36,823 DEBUG : BROWSER_OUTPUT: Values: 558.4 593.6 606.7 608.1 624.4 35273.5 44437.6 44538.0 44547.8 44561.3 47420.0 47733.8 48004.8 48046.8 48050.3 8084.2 8191.5 9280.1 9466.4 10847.5 10964.3 11031.7 11035.7 11045.0 11050.8 11182.0 11276.2 11297.0 11297.4 11298.4 11130.6 11143.2 11226.9 11239.9 11241.0 10969.5 11053.3 11067.8 11086.2 11133.9 44644.8 44904.0 44921.6 45010.1 45050.3 3446.3 3458.6 3658.5 4095.2 4102.2 33821.3 34408.0 34452.3 34587.7 34726.8 3794.5 3798.4 3810.3 3874.5 3910.4 311891.0 313684.0 313867.0 315119.0 316630.0 59230.4 59549.1 67447.3 67944.0 72115.0 69026.0 69090.0 69221.3 69383.0 69460.0 18915.5 19161.5 19171.5 19171.7 19182.5 12152.8 12238.6 13976.2 14286.7 14303.6 21466.6 21512.7 21779.0 21840.5 21885.8 7702.2 7905.6 7981.4 8081.8 8149.8 1083.9 1102.1 1141.5 1173.7 1211.8 31706.5 31729.5 31957.5 32277.2 32733.8 1158.5 1187.2 1255.8 1266.0 1303.2 14599.1 15401.2 15770.1 16939.8 17218.3 386619.0 393839.0 393939.0 394009.0 395238.0 57871.0 58156.4 58162.1 58198.1 58297.0 1520.8 1530.9 1542.2 1542.7 1556.8 32045.5 32058.7 32316.0 33104.8 33217.5 51321.2 51920.5 52031.7 52039.5 52052.5 353861.0 355290.0 355901.0 356066.0 356858.0 31987.4 37556.0 38005.6 38161.0 38468.2 47094.5 47615.5 47841.8 48172.3 48341.5 39599.0 40240.0 40430.6 41043.4 41116.8 34659.8 39904.0 41023.8 42760.5 44370.3 39529.6 40346.2 40354.0 40399.0 40430.4 34503.8 35828.0 36528.0 37772.0 38796.0 27762.7 27998.9 28257.4 28381.7 28414.9 03:35:36 INFO - 2015-10-29 03:35:36,823 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,823 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29866.51 Median:2692.86 stddev:95848.44 (3559.4%) stddev-sans-first:96091.80 03:35:36 INFO - 2015-10-29 03:35:36,823 DEBUG : BROWSER_OUTPUT: Values: 411.8 412.1 418.8 419.3 424.8 19732.6 19970.9 20338.8 20346.4 20352.7 19089.2 19341.6 19653.7 20423.9 20587.7 5106.3 5215.6 5231.4 5770.6 5924.8 5197.9 5208.8 5212.9 5213.8 5219.7 3682.5 3742.5 5092.9 5173.3 5198.1 5249.7 5366.0 5396.4 5404.8 5405.8 4622.1 4636.5 4688.7 4690.6 4691.1 13461.5 13828.7 15305.9 15472.3 15529.4 2195.4 2205.7 2212.7 2221.6 2290.3 10702.1 10865.6 10882.7 10890.2 11101.3 1814.6 1825.7 1842.8 1857.6 1883.6 68197.7 69607.3 69917.0 70440.9 71261.3 7974.1 8017.6 8024.4 8040.5 8050.5 9792.0 9792.3 9798.5 9800.8 9801.8 6247.4 6403.7 6475.5 6480.5 6507.4 6665.1 6670.5 6698.0 6716.4 6725.8 3679.5 3717.7 3722.6 3760.6 3807.6 1274.5 1275.8 1289.6 1311.8 1325.6 473.2 541.4 555.3 558.9 559.4 12885.7 13135.3 13174.9 13224.8 13338.1 576.6 580.0 586.1 592.9 594.1 7132.7 7144.5 7267.4 7378.6 7414.9 568725.0 580912.0 583163.0 589102.0 601202.0 76333.6 76378.0 85544.6 87524.0 88617.1 589.3 625.9 636.0 637.3 638.3 12671.2 12942.1 13082.4 13108.7 13185.1 39894.0 40468.2 40583.4 41369.2 41721.2 51181.7 51571.2 51780.0 55235.4 56080.7 7588.9 7769.7 7776.2 7810.4 7849.1 13287.3 13441.5 14024.8 14116.7 14164.5 12033.1 12133.8 12220.0 12270.6 12442.4 4912.5 9633.7 11838.0 12146.0 12452.1 12723.2 12758.2 12958.9 12978.7 12989.9 7884.0 7889.1 7924.8 7930.6 7990.4 12434.8 12436.1 12614.8 12648.9 12752.7 03:35:36 INFO - 2015-10-29 03:35:36,824 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,824 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7070.42 Median:2390.37 stddev:4106.24 (171.8%) stddev-sans-first:4097.53 03:35:36 INFO - 2015-10-29 03:35:36,825 DEBUG : BROWSER_OUTPUT: Values: 1646.9 1673.8 1825.8 2048.9 2064.5 9149.7 10276.2 10551.7 10561.5 10564.6 10022.2 10024.9 10146.0 10152.9 10174.9 2155.1 2202.8 2374.1 2409.7 2421.3 2389.3 2391.4 2398.9 2401.1 2402.0 2270.0 2300.8 2305.2 2307.4 2307.7 2152.4 2196.1 2359.4 2405.8 2429.5 2380.9 2412.4 2426.3 2451.0 2454.3 10490.2 10591.3 10594.7 10595.7 10614.8 5508.9 5583.7 5587.1 5590.0 5595.9 3523.8 3539.5 3550.5 3566.8 3582.4 1062.3 1082.3 1090.2 1099.0 1100.0 14709.1 14716.2 14735.3 14740.0 14743.7 4785.7 4787.1 4804.4 4830.6 4848.8 11703.1 11767.3 11782.5 11786.3 11806.7 5437.2 5442.6 5444.6 5447.4 5449.9 4861.3 4863.5 4868.3 4870.7 4874.8 3993.8 4003.4 4025.8 4041.3 4058.9 1145.0 1161.6 1170.2 1180.0 1187.6 1142.8 1161.4 1162.6 1207.9 1225.6 9962.8 10011.3 10062.4 10077.9 10100.7 1273.7 1282.1 1289.7 1295.2 1296.0 7538.2 7593.6 7635.6 7644.9 7718.7 13501.3 13654.2 13706.5 13717.5 13724.9 13379.5 13627.9 13649.0 13650.4 13664.4 9449.5 9563.7 9607.6 9623.2 9659.8 9193.7 9289.5 9328.3 9351.5 9358.0 11124.4 11301.4 11323.6 11326.8 11397.1 11359.0 11564.2 11647.7 11661.7 11662.8 8792.2 8803.1 8804.3 8879.6 8880.0 10206.9 10262.4 10282.4 10388.7 10395.6 8008.9 9451.6 9478.3 9645.1 9700.1 9043.2 9218.8 9220.1 9233.0 9302.4 9290.2 9383.4 9393.9 9407.0 9419.1 8368.0 8544.5 8560.1 8580.8 8592.8 8312.8 8347.4 8363.1 8368.6 8382.5 03:35:36 INFO - 2015-10-29 03:35:36,825 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,825 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5375.73 Median:5989.37 stddev:1561.34 (26.1%) stddev-sans-first:1520.32 03:35:36 INFO - 2015-10-29 03:35:36,825 DEBUG : BROWSER_OUTPUT: Values: 395.7 397.0 399.3 402.1 403.8 5877.3 5884.5 5935.6 5941.1 5942.6 5792.2 5795.3 5800.9 5857.0 5972.0 4564.9 4632.0 4666.5 4674.7 4718.1 4673.1 4696.9 4701.5 4704.3 4734.8 4525.2 4583.0 4665.2 4671.5 4675.1 4610.4 4659.7 4683.2 4684.0 4688.7 4166.0 4170.9 4178.3 4180.0 4182.9 5660.3 5680.4 5693.9 5702.2 5703.4 5412.2 5437.6 5448.5 5449.1 5498.9 6336.3 6344.7 6346.0 6346.1 6350.8 4657.9 4658.2 4660.7 4661.1 4661.3 6482.3 6537.9 6540.9 6555.6 6556.5 4635.8 4686.5 4693.3 4695.1 4707.6 4746.9 4748.5 4749.5 4750.9 4751.5 5402.7 5413.5 5417.6 5418.0 5419.8 6143.7 6279.4 6280.3 6287.0 6383.6 1735.1 1746.6 1753.7 1754.5 1758.3 1166.2 1194.7 1205.2 1212.8 1228.2 6196.0 6196.6 6220.0 6221.2 6224.3 6559.7 6603.9 6610.5 6612.3 6621.2 5809.9 6006.7 6196.8 6197.8 6198.6 3535.8 3562.4 3563.9 3564.7 3569.3 6740.1 6743.0 6747.7 6748.8 6749.0 6696.8 6711.0 6720.4 6721.8 6727.4 6568.7 6815.4 6844.8 6846.9 6848.9 6620.6 6633.2 6637.6 6640.0 6646.5 6493.9 6523.7 6524.6 6525.3 6535.7 6707.0 6752.0 6791.4 6792.7 6795.6 4734.1 4735.4 4767.0 4783.3 4783.5 6565.4 6588.8 6590.8 6591.5 6592.6 6279.9 6401.6 6403.4 6404.8 6517.7 6482.9 6484.6 6490.1 6490.5 6507.0 6322.2 6351.9 6355.3 6377.0 6379.9 6320.0 6408.5 6410.0 6412.7 6413.1 6089.2 6146.3 6163.4 6263.4 6265.3 03:35:36 INFO - 2015-10-29 03:35:36,825 DEBUG : BROWSER_OUTPUT: 03:35:36 INFO - 2015-10-29 03:35:36,825 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12888.81 Median:4250.30 stddev:14631.55 (344.2%) stddev-sans-first:14645.01 03:35:36 INFO - 2015-10-29 03:35:36,826 DEBUG : BROWSER_OUTPUT: Values: 923.8 938.0 951.1 958.6 962.2 13803.2 13809.9 14025.5 14045.9 14050.6 13511.1 13545.3 13574.0 13589.9 13602.7 787.9 797.9 935.2 950.5 968.9 968.2 970.3 972.6 978.3 980.5 836.6 1012.2 1022.0 1029.3 1031.0 844.5 1004.8 1012.5 1017.2 1017.2 750.6 752.0 752.9 753.0 753.0 13671.2 13885.4 13885.9 13926.1 13938.0 12733.2 12989.7 13127.2 13160.7 13343.8 9905.6 9942.1 10173.2 10275.9 10779.8 3476.6 3520.0 3537.9 3542.8 3547.6 41283.8 41512.2 44617.1 44746.0 45007.3 7774.5 7883.1 7972.9 7984.2 7987.8 12484.8 12533.9 12547.4 12554.3 12574.2 6897.3 6909.2 6957.5 7024.1 7099.6 4283.0 4352.6 4392.0 4393.0 4412.5 2806.0 2832.6 2837.7 2842.1 2846.6 469.6 473.8 476.8 487.3 490.6 676.3 695.3 710.8 718.6 726.4 9102.4 9204.6 9401.4 9446.8 9554.7 683.1 714.8 719.4 724.9 727.7 3996.6 4131.8 4146.4 4217.6 4398.6 55432.4 55481.4 56524.2 57326.0 57655.1 47874.0 47987.0 48158.0 49905.8 50794.0 40381.2 40493.8 40573.6 40580.0 41272.6 8462.2 8555.2 8777.8 8839.6 8907.4 28431.4 28952.9 29018.6 29335.0 29637.7 38352.0 39157.2 39486.6 39564.0 39595.0 8195.7 8203.9 8384.0 8483.7 8647.4 11858.2 11948.4 12070.4 12433.3 13172.5 10840.6 11207.2 11323.4 11414.2 12039.3 10807.6 11024.5 11050.6 11082.8 11503.4 10023.7 11096.3 11317.7 11675.5 11856.4 9008.8 9104.6 9303.8 9828.4 10001.9 9235.7 9953.3 10120.5 10124.2 10133.2 03:35:36 INFO - 2015-10-29 03:35:36,826 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:35:36 INFO - 2015-10-29 03:35:36,826 DEBUG : BROWSER_OUTPUT: 03:35:37 INFO - 2015-10-29 03:35:37,322 INFO : Browser exited with error code: 0 03:35:37 INFO - 2015-10-29 03:35:37,343 INFO : Completed test dromaeo_css (00:18:32) 03:35:37 INFO - 2015-10-29 03:35:37,343 INFO : Starting test kraken 03:35:37 INFO - 2015-10-29 03:35:37,343 DEBUG : operating with platform_type : linux_ 03:35:37 INFO - 2015-10-29 03:35:37,343 INFO : Initialising browser for kraken test... 03:35:37 INFO - 2015-10-29 03:35:37,349 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph5bAar/profile http://localhost/getInfo.html 03:35:41 INFO - 2015-10-29 03:35:41,092 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:35:41 INFO - 2015-10-29 03:35:41,093 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:35:41 INFO - 2015-10-29 03:35:41,093 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:35:41 INFO - 2015-10-29 03:35:41,093 DEBUG : BROWSER_OUTPUT: __metrics 03:35:41 INFO - 2015-10-29 03:35:41,296 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:42 INFO - 2015-10-29 03:35:42,567 INFO : Browser initialized. 03:35:42 INFO - 2015-10-29 03:35:42,568 INFO : Running cycle 1/1 for kraken test... 03:35:42 INFO - 2015-10-29 03:35:42,568 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph5bAar/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:35:54 INFO - 2015-10-29 03:35:54,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 132714496 03:35:54 INFO - 2015-10-29 03:35:54,280 DEBUG : BROWSER_OUTPUT: 03:35:57 INFO - 2015-10-29 03:35:57,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=ai-astar (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection) 03:35:57 INFO - 2015-10-29 03:35:57,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 166490112 03:35:57 INFO - 2015-10-29 03:35:57,748 DEBUG : BROWSER_OUTPUT: 03:36:00 INFO - 2015-10-29 03:36:00,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-dft) 03:36:00 INFO - 2015-10-29 03:36:00,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 164642816 03:36:00 INFO - 2015-10-29 03:36:00,835 DEBUG : BROWSER_OUTPUT: 03:36:03 INFO - 2015-10-29 03:36:03,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-dft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-fft) 03:36:04 INFO - 2015-10-29 03:36:04,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 161169408 03:36:04 INFO - 2015-10-29 03:36:04,162 DEBUG : BROWSER_OUTPUT: 03:36:06 INFO - 2015-10-29 03:36:06,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-fft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator) 03:36:06 INFO - 2015-10-29 03:36:06,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 159457280 03:36:06 INFO - 2015-10-29 03:36:06,647 DEBUG : BROWSER_OUTPUT: 03:36:08 INFO - 2015-10-29 03:36:08,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:09 INFO - 2015-10-29 03:36:09,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 156385280 03:36:09 INFO - 2015-10-29 03:36:09,289 DEBUG : BROWSER_OUTPUT: 03:36:12 INFO - 2015-10-29 03:36:12,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom) 03:36:12 INFO - 2015-10-29 03:36:12,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 155553792 03:36:12 INFO - 2015-10-29 03:36:12,675 DEBUG : BROWSER_OUTPUT: 03:36:16 INFO - 2015-10-29 03:36:16,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate) 03:36:16 INFO - 2015-10-29 03:36:16,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 157466624 03:36:16 INFO - 2015-10-29 03:36:16,578 DEBUG : BROWSER_OUTPUT: 03:36:19 INFO - 2015-10-29 03:36:19,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate (next: http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial) 03:36:19 INFO - 2015-10-29 03:36:19,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 156995584 03:36:19 INFO - 2015-10-29 03:36:19,803 DEBUG : BROWSER_OUTPUT: 03:36:21 INFO - 2015-10-29 03:36:21,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial (next: http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:21 INFO - 2015-10-29 03:36:21,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 166522880 03:36:22 INFO - 2015-10-29 03:36:21,853 DEBUG : BROWSER_OUTPUT: 03:36:23 INFO - 2015-10-29 03:36:23,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes) 03:36:24 INFO - 2015-10-29 03:36:24,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 164847616 03:36:24 INFO - 2015-10-29 03:36:24,100 DEBUG : BROWSER_OUTPUT: 03:36:26 INFO - 2015-10-29 03:36:26,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:26 INFO - 2015-10-29 03:36:26,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 172154880 03:36:26 INFO - 2015-10-29 03:36:26,610 DEBUG : BROWSER_OUTPUT: 03:36:28 INFO - 2015-10-29 03:36:28,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:29 INFO - 2015-10-29 03:36:29,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 178438144 03:36:29 INFO - 2015-10-29 03:36:29,435 DEBUG : BROWSER_OUTPUT: 03:36:31 INFO - 2015-10-29 03:36:31,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:32 INFO - 2015-10-29 03:36:32,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 176128000 03:36:32 INFO - 2015-10-29 03:36:32,398 DEBUG : BROWSER_OUTPUT: 03:36:33 INFO - 2015-10-29 03:36:33,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost/page_load_test/kraken/driver.html?testName=ai-astar) 03:36:34 INFO - 2015-10-29 03:36:34,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 233590784 03:36:34 INFO - 2015-10-29 03:36:34,244 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,248 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:36:34 INFO - 2015-10-29 03:36:34,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:36:34 INFO - 2015-10-29 03:36:34,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:36:34 INFO - 2015-10-29 03:36:34,248 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:36:34 INFO - 2015-10-29 03:36:34,248 DEBUG : BROWSER_OUTPUT: |0;ai-astar;103;108;109;108;109;111;118;109;107;108 03:36:34 INFO - 2015-10-29 03:36:34,249 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;118;153;155;126;142;148;124;164;123 03:36:34 INFO - 2015-10-29 03:36:34,249 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;157;158;161;161;159;159;159 03:36:34 INFO - 2015-10-29 03:36:34,249 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;71;150;70;71;69;70;158;71 03:36:34 INFO - 2015-10-29 03:36:34,249 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;87;88;130;87;88;88;136;87;87;127 03:36:34 INFO - 2015-10-29 03:36:34,249 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;109;110;110;111;109;109 03:36:34 INFO - 2015-10-29 03:36:34,249 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 03:36:34 INFO - 2015-10-29 03:36:34,249 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;52;53;54;54;54;52;53;53;73;51 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;60;61;61;60;61;60;60;60;61;60 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;85;78;91;79;78;77;78;79;77 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;107;120;111;106;112;106;127;109;107;112 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;134;137;135;133;134;135;134;138;133 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;61;60;60;62;60;60;60;60;60 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:36:34 INFO - 2015-10-29 03:36:34,250 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:36:34 INFO - 2015-10-29 03:36:34,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,845 03:36:34 INFO - 2015-10-29 03:36:34,251 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:36:34 INFO - 2015-10-29 03:36:34,251 DEBUG : BROWSER_OUTPUT: __startTimestamp1446114994246__endTimestamp 03:36:34 INFO - 2015-10-29 03:36:34,251 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,254 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:36:34 INFO - 2015-10-29 03:36:34,254 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:3.77 (3.5%) stddev-sans-first:3.32 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: Values: 103.0 108.0 109.0 108.0 109.0 111.0 118.0 109.0 107.0 108.0 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.20 Median:148.50 stddev:16.14 (10.9%) stddev-sans-first:16.80 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: Values: 149.0 118.0 153.0 155.0 126.0 142.0 148.0 124.0 164.0 123.0 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.60 Median:160.50 stddev:1.43 (0.9%) stddev-sans-first:1.42 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 157.0 158.0 161.0 161.0 159.0 159.0 159.0 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.10 Median:70.50 stddev:35.32 (50.1%) stddev-sans-first:36.97 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 150.0 70.0 71.0 69.0 70.0 158.0 71.0 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.50 Median:87.00 stddev:21.16 (24.3%) stddev-sans-first:21.87 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 130.0 87.0 88.0 88.0 136.0 87.0 87.0 127.0 03:36:34 INFO - 2015-10-29 03:36:34,255 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 109.0 110.0 110.0 111.0 109.0 109.0 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,256 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.90 Median:53.50 stddev:6.44 (12.0%) stddev-sans-first:6.74 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: Values: 52.0 53.0 54.0 54.0 54.0 52.0 53.0 53.0 73.0 51.0 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 61.0 60.0 61.0 60.0 60.0 60.0 61.0 60.0 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:78.50 stddev:4.50 (5.7%) stddev-sans-first:4.71 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: Values: 78.0 85.0 78.0 91.0 79.0 78.0 77.0 78.0 79.0 77.0 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:111.70 Median:111.50 stddev:6.83 (6.1%) stddev-sans-first:7.03 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: Values: 107.0 120.0 111.0 106.0 112.0 106.0 127.0 109.0 107.0 112.0 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.90 Median:135.00 stddev:1.66 (1.2%) stddev-sans-first:1.72 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: Values: 136.0 134.0 137.0 135.0 133.0 134.0 135.0 134.0 138.0 133.0 03:36:34 INFO - 2015-10-29 03:36:34,257 DEBUG : BROWSER_OUTPUT: 03:36:34 INFO - 2015-10-29 03:36:34,258 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 03:36:34 INFO - 2015-10-29 03:36:34,258 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 60.0 60.0 62.0 60.0 60.0 60.0 60.0 60.0 03:36:34 INFO - 2015-10-29 03:36:34,258 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:36:34 INFO - 2015-10-29 03:36:34,258 DEBUG : BROWSER_OUTPUT: 03:36:35 INFO - 2015-10-29 03:36:35,049 INFO : Browser exited with error code: 0 03:36:35 INFO - 2015-10-29 03:36:35,095 INFO : Completed test kraken (00:00:57) 03:36:35 INFO - 2015-10-29 03:36:35,095 INFO : Starting test v8_7 03:36:35 INFO - 2015-10-29 03:36:35,095 DEBUG : operating with platform_type : linux_ 03:36:35 INFO - 2015-10-29 03:36:35,095 INFO : Initialising browser for v8_7 test... 03:36:35 INFO - 2015-10-29 03:36:35,101 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB47eJc/profile http://localhost/getInfo.html 03:36:38 INFO - 2015-10-29 03:36:38,755 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:36:38 INFO - 2015-10-29 03:36:38,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:36:38 INFO - 2015-10-29 03:36:38,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:36:38 INFO - 2015-10-29 03:36:38,756 DEBUG : BROWSER_OUTPUT: __metrics 03:36:38 INFO - 2015-10-29 03:36:38,933 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:36:40 INFO - 2015-10-29 03:36:40,071 INFO : Browser initialized. 03:36:40 INFO - 2015-10-29 03:36:40,072 INFO : Running cycle 1/1 for v8_7 test... 03:36:40 INFO - 2015-10-29 03:36:40,072 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB47eJc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:36:51 INFO - 2015-10-29 03:36:51,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 132964352 03:36:51 INFO - 2015-10-29 03:36:51,743 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/v8_7/run.html (next: http://localhost/page_load_test/v8_7/run.html) 03:37:13 INFO - 2015-10-29 03:37:13,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 430469120 03:37:13 INFO - 2015-10-29 03:37:13,403 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,403 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:37:13 INFO - 2015-10-29 03:37:13,403 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:37:13 INFO - 2015-10-29 03:37:13,403 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:37:13 INFO - 2015-10-29 03:37:13,403 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:37:13 INFO - 2015-10-29 03:37:13,403 DEBUG : BROWSER_OUTPUT: |0;Richards;168.63406408094434 03:37:13 INFO - 2015-10-29 03:37:13,404 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.79894528675015 03:37:13 INFO - 2015-10-29 03:37:13,404 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.0567734682406 03:37:13 INFO - 2015-10-29 03:37:13,404 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5107.142857142857 03:37:13 INFO - 2015-10-29 03:37:13,404 DEBUG : BROWSER_OUTPUT: |4;RayTrace;955.1098376313277 03:37:13 INFO - 2015-10-29 03:37:13,404 DEBUG : BROWSER_OUTPUT: |5;Earley;536.480686695279 03:37:13 INFO - 2015-10-29 03:37:13,404 DEBUG : BROWSER_OUTPUT: |6;Boyer;10181.818181818182 03:37:13 INFO - 2015-10-29 03:37:13,404 DEBUG : BROWSER_OUTPUT: |7;RegExp;23488.372093023256 03:37:13 INFO - 2015-10-29 03:37:13,405 DEBUG : BROWSER_OUTPUT: |8;Splay;537.9236148466917 03:37:13 INFO - 2015-10-29 03:37:13,405 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 03:37:13 INFO - 2015-10-29 03:37:13,405 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:37:13 INFO - 2015-10-29 03:37:13,405 DEBUG : BROWSER_OUTPUT: __startTimestamp1446115033396__endTimestamp 03:37:13 INFO - 2015-10-29 03:37:13,405 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,405 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:37:13 INFO - 2015-10-29 03:37:13,405 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.63 Median:168.63 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: Values: 168.6 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.80 Median:164.80 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: Values: 164.8 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,406 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,407 DEBUG : BROWSER_OUTPUT: Values: 281.1 03:37:13 INFO - 2015-10-29 03:37:13,407 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,407 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5107.14 Median:5107.14 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,407 DEBUG : BROWSER_OUTPUT: Values: 5107.1 03:37:13 INFO - 2015-10-29 03:37:13,407 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,407 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:955.11 Median:955.11 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,407 DEBUG : BROWSER_OUTPUT: Values: 955.1 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:536.48 Median:536.48 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: Values: 536.5 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10181.82 Median:10181.82 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: Values: 10181.8 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,408 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23488.37 Median:23488.37 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: Values: 23488.4 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:537.92 Median:537.92 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: Values: 537.9 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: Values: 4835.7 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:37:13 INFO - 2015-10-29 03:37:13,409 DEBUG : BROWSER_OUTPUT: 03:37:14 INFO - 2015-10-29 03:37:14,181 INFO : Browser exited with error code: 0 03:37:14 INFO - 2015-10-29 03:37:14,193 INFO : Completed test v8_7 (00:00:39) 03:37:14 INFO - 2015-10-29 03:37:14,193 INFO : Completed test suite (00:20:09) 03:37:14 INFO - 2015-10-29 03:37:14,194 DEBUG : Working with test: dromaeo_css 03:37:14 INFO - 2015-10-29 03:37:14,194 DEBUG : Generating results file: dromaeo_css 03:37:14 INFO - 2015-10-29 03:37:14,195 DEBUG : Working with test: kraken 03:37:14 INFO - 2015-10-29 03:37:14,195 DEBUG : Generating results file: kraken 03:37:14 INFO - 2015-10-29 03:37:14,195 INFO : javascript benchmark 03:37:14 INFO - 2015-10-29 03:37:14,195 DEBUG : Working with test: v8_7 03:37:14 INFO - 2015-10-29 03:37:14,195 DEBUG : Generating results file: v8_7 03:37:14 INFO - 2015-10-29 03:37:14,195 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:37:14 INFO - 2015-10-29 03:37:14,254 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:37:14 INFO - 2015-10-29 03:37:14,254 DEBUG : process_Request line: dromaeo_css 7342.03 graph.html#tests=[[72,52,35]] 03:37:14 INFO - 2015-10-29 03:37:14,254 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:37:14 INFO - 2015-10-29 03:37:14,285 DEBUG : process_Request line: kraken 1448.80 graph.html#tests=[[232,52,35]] 03:37:14 INFO - 2015-10-29 03:37:14,285 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:37:14 INFO - 2015-10-29 03:37:14,317 DEBUG : process_Request line: v8_7 23383.60 graph.html#tests=[[230,52,35]] 03:37:14 INFO - 2015-10-29 03:37:14,319 INFO : javascript benchmark 03:37:14 INFO - 2015-10-29 03:37:14,324 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [411.8229161460572, 412.1016184717317, 418.78851180154015, 419.30395543397964, 424.8088360237893, 19732.60534789305, 19970.900145499287, 20338.796612033875, 20346.389608311736, 20352.69470957933, 19089.23643054276, 19341.613167736636, 19653.70519442206, 20423.897880510613, 20587.691184632204, 5106.310648062501, 5215.58275337972, 5231.398389185235, 5770.567207459447, 5924.792632257871, 5197.922031169535, 5208.817691380802, 5212.947870521303, 5213.817516386927, 5219.660722053073, 3682.466042423847, 3742.494763206973, 5092.898142037157, 5173.275741396207, 5198.064348417283, 5249.658772179815, 5366.0, 5396.379416367089, 5404.7838086476495, 5405.8107966221, 4622.14490319292, 4636.53634636537, 4688.742119183444, 4690.624750019991, 4691.061787642485, 13461.528846490424, 13828.654283642989, 15305.923470382688, 15472.303746331441, 15529.378824846992, 2195.429188411025, 2205.6691496275525, 2212.723409573803, 2221.555688862234, 2290.3014580552926, 10702.090322322612, 10865.619703310425, 10882.673519794418, 10890.23768336209, 11101.278416902956, 1814.6280012597385, 1825.7443957845912, 1842.7512285841374, 1857.5820440400937, 1883.6326916251337, 68197.65901170512, 69607.3039269606, 69917.0, 70440.94338584926, 71261.28738712598, 7974.082980457321, 8017.599120043975, 8024.398170137263, 8040.477368970998, 8050.476719013245, 9791.951040244754, 9792.265580081523, 9798.461084640414, 9800.754981125529, 9801.803963920682, 6247.375262473716, 6403.679816009181, 6475.514336424787, 6480.513961452815, 6507.414332709984, 6665.100211471487, 6670.466362690973, 6697.966510167418, 6716.429103526158, 6725.798226053226, 3679.466477360821, 3717.683996860243, 3722.590515043343, 3760.605136460687, 3807.6192380762254, 1274.4647248155798, 1275.789494733377, 1289.5744404346542, 1311.7573248948975, 1325.6478392040258, 473.2121018504221, 541.3611937913222, 555.2615022020702, 558.9385167631557, 559.3735016781231, 12885.742285154245, 13135.343232838512, 13174.934125329311, 13224.801627975588, 13338.066335356625, 576.6223123853882, 580.0, 586.1003359842706, 592.8814237152501, 594.1325664529749, 7132.679029443688, 7144.464165187632, 7267.418606511466, 7378.5941773202985, 7414.925850741423, 568725.0, 580912.0, 583163.0, 589102.0, 601202.0, 76333.61833190799, 76378.0, 85544.57227713821, 87524.0, 88617.11382886089, 589.3075636127533, 625.9217597800275, 636.0364048466485, 637.2607774981093, 638.2628064585411, 12671.17637353569, 12942.054215369311, 13082.411291491715, 13108.737825243632, 13185.142965707199, 39894.0, 40468.1906361877, 40583.3912491307, 41369.1726165481, 41721.16557668769, 51181.7440912793, 51571.22643160281, 51780.0, 55235.44764552303, 56080.71959640176, 7588.886166707393, 7769.689212431439, 7776.183500732568, 7810.414218933489, 7849.136594974434, 13287.335633218107, 13441.46234150623, 14024.78962815579, 14116.717665646423, 14164.504242351468, 12033.097517686034, 12133.817992730294, 12220.0, 12270.631881043226, 12442.37788110609, 4912.5016869855035, 9633.710988670351, 11838.0, 12146.002836455993, 12452.066095043088, 12723.172993755376, 12758.234505929673, 12958.935205323913, 12978.740425191632, 12989.870101298866, 7884.0, 7889.053313602404, 7924.762257132295, 7930.643121059451, 7990.360771138178, 12434.75130497403, 12436.129470937309, 12614.810777838524, 12648.873511265137, 12752.74494510123], "dojo.html": [3353.76523643345, 3383.780054296469, 3406.540117084193, 3418.6239513653495, 3425.109471537401, 5589.7205139743, 5600.243967064445, 5610.775568977247, 5640.802571909979, 5661.377248502661, 5686.630369026021, 5702.714864256791, 5717.914231286534, 5722.484976352128, 5731.484166425021, 5051.924221136685, 5109.897802043957, 5187.533122019027, 5199.584033277329, 5274.898569239901, 5088.872778180556, 5145.3311069560905, 5175.663581867167, 5190.948090519084, 5286.629935904488, 5216.6087543434205, 5298.549623282026, 5310.73446327684, 5313.574914006889, 5319.601029922752, 5191.091558977164, 5229.3201883755055, 5243.606729495284, 5254.369475662945, 5256.894862102775, 4962.1812400953795, 5012.573931215851, 5058.0895438821, 5115.079285728568, 5181.637285390024, 5493.2034854946205, 5503.954248692776, 5507.256520369739, 5527.419620939783, 5541.113421852525, 6127.050307202391, 6130.356312587203, 6134.693265336716, 6135.049067394561, 6144.201253837017, 5956.851078723023, 6041.063635136561, 6062.666553339564, 6076.270847498285, 6122.469382654336, 5761.222234998306, 5765.740541675635, 5767.0, 5768.7980920668, 5774.278215223055, 5934.821955341346, 6225.750969961241, 6225.906611400833, 6226.782062627786, 6234.1583886175695, 5844.444777746107, 6050.878982420415, 6110.511159107261, 6142.447179753844, 6148.1392605035335, 6228.190335256388, 6231.626102433868, 6235.75056997715, 6239.75040998355, 6247.250329960434, 5846.941530584725, 5989.251343582052, 6181.536384771161, 6185.505159587222, 6195.938040619536, 6020.397960204032, 6110.198596386424, 6126.111753679267, 6128.647737417829, 6141.631502109888, 4690.577847993697, 4700.858974230779, 4707.223308154184, 4713.929291060636, 4730.053989202104, 4001.1197536541913, 4080.367543030835, 4094.570070142592, 4207.389928460356, 4225.873223803291, 5794.0, 5871.119332100134, 5871.6770577618645, 5886.381929897299, 5887.558433117448, 6254.15568898202, 6268.4671802896355, 6271.843203919847, 6283.59156654816, 6284.968575157186, 5548.69482178484, 5660.830175094754, 5773.0, 5816.040353341736, 5849.181114643953, 5296.602754793406, 5296.655717378358, 5304.177852432879, 5306.257124002643, 5311.52196302327, 6320.652364120017, 6346.555741098079, 6368.044793280952, 6369.745210191633, 6371.171747672773, 5895.14520394549, 6001.579889407874, 6113.51091912637, 6195.473384762166, 6210.844728881814, 6348.428641422294, 6359.491240700825, 6379.5215358847345, 6382.489400848014, 6389.297177310399, 5877.676727780014, 6077.24034495688, 6079.452849243589, 6087.360827113266, 6088.238970128734, 6073.878522429615, 6077.058056001327, 6146.723397447215, 6164.106204600218, 6170.660613666112, 5991.2510936132985, 6073.848153796013, 6079.270487541523, 6081.087836824512, 6087.512998959984, 5737.569682273763, 5832.475077243069, 6040.214772079602, 6071.241094863142, 6080.574359794772, 5872.618279811799, 5951.077582974646, 5956.344802071682, 5963.403659634002, 5980.880382392241, 6059.909101363395, 6082.939170608414, 6096.878062438637, 6110.847228819315, 6114.510839132769, 5634.098544232903, 5756.453136951983, 5833.241678581757, 5973.91039134422, 5993.790217342372], "mootools.html": [1646.868250539957, 1673.8326167383264, 1825.7535232743578, 2048.918043278269, 2064.4826052851163, 9149.67976120836, 10276.17790576754, 10551.73620659483, 10561.471926403687, 10564.577416903334, 10022.19822414207, 10024.899751002487, 10146.0, 10152.898471015287, 10174.949125254381, 2155.0948601587293, 2202.757696653367, 2374.050379848057, 2409.72288186859, 2421.32202983165, 2389.2951579284154, 2391.4380120671626, 2398.8680622565753, 2401.0755858994326, 2401.9639705404434, 2270.0465804362207, 2300.8274379421528, 2305.2162264829954, 2307.377008207783, 2307.6538519222167, 2152.3865698275995, 2196.077647388093, 2359.433735903388, 2405.8075353971817, 2429.514097180553, 2380.9285721428387, 2412.433078226615, 2426.2842461473906, 2450.9754902450927, 2454.312792418126, 10490.16078713701, 10591.311564748266, 10594.735131621694, 10595.735106622318, 10614.78770424595, 5508.944910550883, 5583.720813959327, 5587.078132108198, 5590.049691552445, 5595.8880822383735, 3523.823808809549, 3539.522164507784, 3550.520679708258, 3566.785992840412, 3582.4268117101137, 1062.3041907550567, 1082.2694681090234, 1090.1714696830386, 1098.9615363462322, 1099.9560017599285, 14709.117452952856, 14716.190609516472, 14735.263236838115, 14740.0, 14743.705125897422, 4785.688930219525, 4787.114383839001, 4804.375431193923, 4830.637702172351, 4848.80604775805, 11703.122265830098, 11767.293962362286, 11782.52869885195, 11786.29282243051, 11806.704832379259, 5437.184422336682, 5442.564594832404, 5444.646098003617, 5447.373552041566, 5449.891002179934, 4861.319415281863, 4863.537963893425, 4868.3427737255015, 4870.732109733999, 4874.8050077997195, 3993.7603743775467, 4003.399490076512, 4025.7785821780085, 4041.333180025322, 4058.918821623551, 1145.0381679389352, 1161.5644133449957, 1170.1867202294325, 1180.0323734537596, 1187.6377704800118, 1142.8400023996646, 1161.355447726503, 1162.604714397092, 1207.9033677305795, 1225.6200577820905, 9962.750931226632, 10011.299209055296, 10062.39625622465, 10077.949610251902, 10100.696979090639, 1273.6688461000206, 1282.1153404151105, 1289.6711338608595, 1295.1581472043058, 1296.0, 7538.170801211862, 7593.5823529706395, 7635.580043097571, 7644.885326720104, 7718.729844455529, 13501.324933753272, 13654.249016304198, 13706.45174193041, 13717.519886803913, 13724.862751372559, 13379.53171638988, 13627.863721362659, 13649.0, 13650.385732642055, 13664.385102670403, 9449.527523623929, 9563.713088607354, 9607.615695372248, 9623.230141588656, 9659.758506037406, 9193.678221262224, 9289.489078100769, 9328.253739700673, 9351.48566828831, 9358.0, 11124.443777810915, 11301.378424186749, 11323.603673871376, 11326.773464530499, 11397.145214108808, 11359.0, 11564.190506664452, 11647.6505704829, 11661.708457288636, 11662.766744665229, 8792.208701216921, 8803.075677053817, 8804.251638610789, 8879.644814207617, 8880.0, 10206.897931020892, 10262.384256944608, 10282.383057016603, 10388.688339349832, 10395.58417663285, 8008.919910800817, 9451.574679139592, 9478.336516443782, 9645.08371704687, 9700.12698857078, 9043.186113249576, 9218.769530761785, 9220.124088211609, 9233.0, 9302.441853488812, 9290.16388525036, 9383.436993780395, 9393.906060939304, 9406.952965235403, 9419.058094190526, 8367.95816020916, 8544.530050847014, 8560.14398560139, 8580.828383432172, 8592.785180370542, 8312.792180195544, 8347.415680902279, 8363.121872203332, 8368.623411946599, 8382.455140415854], "ext.html": [558.4499268220804, 593.6022864680664, 606.7451670298472, 608.1455554945303, 624.3506752976904, 35273.47089793652, 44437.55562444375, 44538.0, 44547.77726111373, 44561.33158002632, 47420.0, 47733.76133119338, 48004.759976200156, 48046.75976620112, 48050.27924581134, 8084.191580841898, 8191.549464779435, 9280.071992800733, 9466.384684995488, 10847.511861966192, 10964.342139471617, 11031.72420689481, 11035.72410689735, 11045.005949464547, 11050.834237486444, 11182.049525790277, 11276.210665253435, 11297.0, 11297.378644174567, 11298.435078246095, 11130.554777808878, 11143.164262680291, 11226.943865280662, 11239.887601124048, 11241.0, 10969.451527423676, 11053.336799791958, 11067.778644427066, 11086.16853735965, 11133.888661113448, 44644.77677611624, 44904.0, 44921.550784492065, 45010.09979800419, 45050.32424513635, 3446.3451944130784, 3458.56767904012, 3658.5426821647293, 4095.221907837531, 4102.200070986159, 33821.323573528636, 34408.0, 34452.31095378104, 34587.6541234587, 34726.82636586826, 3794.5256842894637, 3798.409759068015, 3810.314143454177, 3874.5156855393075, 3910.354791459406, 311891.0, 313684.0, 313867.0, 315119.0, 316630.0, 59230.40769592335, 59549.10676339858, 67447.3255267441, 67944.0, 72115.0, 69026.0, 69090.0, 69221.3077869225, 69383.0, 69460.0, 18915.52711182204, 19161.52096197606, 19171.520711982033, 19171.712424313646, 19182.520436988907, 12152.817707734392, 12238.632841014783, 13976.161430314214, 14286.714265714627, 14303.570892873022, 21466.57066858654, 21512.677309840365, 21779.0, 21840.471167018157, 21885.781142188695, 7702.1912699166905, 7905.604719764104, 7981.441299109123, 8081.797955051171, 8149.796255093552, 1083.8590983172137, 1102.090775110521, 1141.520561364229, 1173.747644256489, 1211.8182272658996, 31706.524402133986, 31729.524057139162, 31957.52063719046, 32277.193070173435, 32733.836330818194, 1158.5018442069822, 1187.1986409173946, 1255.836741223635, 1265.9620211393674, 1303.2219091804757, 14599.140236533978, 15401.22993850303, 15770.13264270476, 16939.830601694073, 17218.31126754941, 386619.0, 393839.0, 393939.0, 394009.0, 395238.0, 57871.0, 58156.41843581595, 58162.127568086515, 58198.12702809461, 58297.0, 1520.8098987626547, 1530.9387624494896, 1542.159523059935, 1542.7223099841913, 1556.828748837627, 32045.51931721073, 32058.67941320557, 32316.0, 33104.83447582747, 33217.501737473474, 51321.23018154805, 51920.48079519308, 52031.69920752011, 52039.479605203465, 52052.47947520476, 353861.0, 355290.0, 355901.0, 356066.0, 356858.0, 31987.360252794348, 37556.0, 38005.619943801314, 38161.0, 38468.23063538769, 47094.52905470901, 47615.52384476111, 47841.76079119582, 48172.27741583809, 48341.5165848337, 39599.0, 40240.0, 40430.595694042684, 41043.38434923419, 41116.794416027726, 34659.82670086633, 39904.0, 41023.7948810254, 42760.497938550456, 44370.334444982705, 39529.604703952595, 40346.1930761389, 40354.0, 40399.0, 40430.39354409745, 34503.827480862434, 35828.0, 36528.0, 37772.0, 38796.03009924774, 27762.722372776014, 27998.86000569984, 28257.43485130327, 28381.716182837907, 28414.85792571024], "prototype.html": [395.6617092386008, 397.04510651882225, 399.26535175277485, 402.05918151525424, 403.8384646141543, 5877.3241077276125, 5884.529237660988, 5935.614185077967, 5941.138534912435, 5942.643441393519, 5792.218050563172, 5795.3335366432875, 5800.854978625536, 5856.970715146429, 5972.0444728843395, 4564.863054108374, 4632.027274272406, 4666.486686464486, 4674.719516829001, 4718.127146477896, 4673.088747694184, 4696.859094227161, 4701.4593321767925, 4704.270838020096, 4734.763261836912, 4525.162844873693, 4583.014651849851, 4665.230237010889, 4671.532846715319, 4675.088357770219, 4610.354550362952, 4659.743714095724, 4683.2038553446, 4684.0, 4688.69523480976, 4165.97917010416, 4170.91658166835, 4178.289690752579, 4180.038591124058, 4182.91634167318, 5660.320761508646, 5680.4319568043275, 5693.857653558653, 5702.201691763156, 5703.40114288002, 5412.215228791803, 5437.6465529740835, 5448.45515448456, 5449.073657478199, 5498.890022199574, 6336.3346848580695, 6344.7462101515885, 6346.048092786073, 6346.0798184263485, 6350.7777227796805, 4657.906841863178, 4658.161530924433, 4660.743659098748, 4661.137689527448, 4661.300804879295, 6482.254540727829, 6537.93462065378, 6540.901886471659, 6555.573887697332, 6556.541042127005, 4635.837745678885, 4686.531346865286, 4693.342931989524, 4695.131400690883, 4707.599854012379, 4746.928796068062, 4748.501407352247, 4749.525047495292, 4750.904981900343, 4751.477337492873, 5402.702851343135, 5413.539849112791, 5417.620766546383, 5418.024755543961, 5419.837404877781, 6143.692815359214, 6279.403456671609, 6280.277768056732, 6287.0, 6383.585066970632, 1735.0977491704243, 1746.56335916021, 1753.6668033073674, 1754.491197552721, 1758.2703178180911, 1166.2128063557234, 1194.6535504703713, 1205.1864991130951, 1212.8302037714727, 1228.2139430764319, 6196.039613859859, 6196.597221180609, 6219.968900155561, 6221.160143380585, 6224.253089629183, 6559.7376104955265, 6603.900941485882, 6610.471162307004, 6612.305707900698, 6621.172353455818, 5809.883802324014, 6006.699665016732, 6196.783112591038, 6197.783077592263, 6198.597091189058, 3535.7701749386724, 3562.412201986695, 3563.8574457021946, 3564.6613571710645, 3569.3218288525095, 6740.056392105109, 6742.9662851685425, 6747.730090796314, 6748.797536073926, 6749.0, 6696.765613203612, 6710.966445167743, 6720.395164435126, 6721.764738234138, 6727.360900714424, 6568.737250510022, 6815.352541508549, 6844.760433384808, 6846.931530684629, 6848.931510684829, 6620.602763834186, 6633.2371777246235, 6637.634930078699, 6640.0, 6646.501512386687, 6493.870122597427, 6523.67381630907, 6524.608523488606, 6525.314841941527, 6535.705893234721, 6706.966465167643, 6752.020956961312, 6791.422729068085, 6792.694328755119, 6795.558288711218, 4734.124187025412, 4735.408073990751, 4766.952330476651, 4783.306420568929, 4783.473817879961, 6565.376289252514, 6588.8023359299295, 6590.80227593173, 6591.538592298493, 6592.604443733391, 6279.937200627935, 6401.615903045832, 6403.391677790789, 6404.839879003062, 6517.73929042833, 6482.935170648233, 6484.578502397329, 6490.091387205889, 6490.513211509061, 6506.967465162644, 6322.178116844781, 6351.936480635134, 6355.300916899045, 6377.0, 6379.904301435389, 6319.96840015797, 6408.487321014401, 6409.9679501602195, 6412.679366031586, 6413.0701048348665, 6089.208402907594, 6146.323904370426, 6163.3836616338, 6263.3736626337, 6265.27949285838], "yui.html": [923.7967647117633, 937.9906200937993, 951.1012093571574, 958.5734348215043, 962.191758922505, 13803.2408217548, 13809.930950345246, 14025.509107181251, 14045.929770351147, 14050.578482645524, 13511.054226204169, 13545.322733863317, 13574.0, 13589.93205033976, 13602.659933501667, 787.8936343593599, 797.8922845415852, 935.2237642756496, 950.4819873169105, 968.864358989742, 968.2060710217625, 970.2965350121141, 972.5526257921365, 978.3102912446743, 980.5293459139617, 836.5942517878824, 1012.1801340913846, 1022.0, 1029.3206483720746, 1031.0411317474745, 844.4933040175875, 1004.8492726091108, 1012.5443550402348, 1017.2319898476677, 1017.247237044589, 750.5721738608995, 751.9736809211652, 752.8945947567345, 752.9887051694229, 753.0060320377105, 13671.17972921628, 13885.375158117808, 13885.861141388557, 13926.09480383782, 13938.024338296324, 12733.236005839679, 12989.675258118528, 13127.212367257995, 13160.6709832254, 13343.799843002364, 9905.554250058765, 9942.105210531015, 10173.186145108373, 10275.948620256926, 10779.784404311948, 3476.6349533298894, 3520.049586611626, 3537.8584856605703, 3542.769719968194, 3547.627499112582, 41283.7935810319, 41512.1697566047, 44617.10765784666, 44746.0, 45007.32489012668, 7774.455788094892, 7883.132855385903, 7972.880406793903, 7984.24149705777, 7987.760367188994, 12484.81272780909, 12533.93733031329, 12547.435365408579, 12554.309512976692, 12574.245545267313, 6897.310268973163, 6909.170899491993, 6957.512974091765, 7024.05175301338, 7099.57402555838, 4282.978585107055, 4352.630026447724, 4392.0, 4393.0, 4412.514623391425, 2805.957910631342, 2832.6317578714634, 2837.6736675282195, 2842.07632519432, 2846.644169478815, 469.5539237724176, 473.81284392665395, 476.8235752771497, 487.30558953491135, 490.5682998960963, 676.2797620534116, 695.2769120115024, 710.8294009437801, 718.5975853522044, 726.4442701333484, 9102.408343457653, 9204.585793639302, 9401.388909720847, 9446.763830904283, 9554.713358599114, 683.135833171039, 714.7962830593256, 719.3525826755962, 724.9492535522463, 727.7343769524085, 3996.6403023728003, 4131.814068366931, 4146.398772178078, 4217.62041416274, 4398.582134697199, 55432.44567554354, 55481.44518554763, 56524.15213771797, 57326.0, 57655.13517297244, 47874.0, 47987.04025919462, 48158.0, 49905.75047124814, 50794.0, 40381.1923761529, 40493.797531012155, 40573.594264057574, 40580.0, 41272.58727412747, 8462.238398543914, 8555.230029297392, 8777.780555486164, 8839.558022098741, 8907.421017633833, 28431.43137137287, 28952.855235723688, 29018.56472152877, 29335.0, 29637.703622964356, 38352.0, 39157.2168556633, 39486.605133948295, 39564.0, 39595.0, 8195.672173113247, 8203.917960820316, 8384.0, 8483.74548763538, 8647.351448641502, 11858.229215100991, 11948.35575149553, 12070.396480176132, 12433.254004759743, 13172.538961136313, 10840.620578279722, 11207.159463040141, 11323.377214253294, 11414.201005929504, 12039.337836419081, 10807.567697292336, 11024.50389732448, 11050.613228536962, 11082.833757493483, 11503.367314797431, 10023.69928902134, 11096.33421994683, 11317.71705707364, 11675.532978680758, 11856.407179640812, 9008.819823603622, 9104.635814567344, 9303.813923721353, 9828.4102953823, 10001.899981000097, 9235.722928312161, 9953.253505987224, 10120.544575493974, 10124.240681948737, 10133.18934485254]}, "summary": {"suite": 7342.0292665571615, "subtests": {"jquery.html": {"std": 95581.82320450933, "min": 411.8229161460572, "max": 601202.0, "median": 7952.363050758386, "filtered": 7871.664190531124, "mean": 29866.51488537425}, "dojo.html": {"std": 647.6283525524979, "min": 3353.76523643345, "max": 6389.297177310399, "median": 5886.381929897299, "filtered": 5643.131984136372, "mean": 5686.420463788864}, "mootools.html": {"std": 4094.816147387928, "min": 1062.3041907550567, "max": 14743.705125897422, "median": 8368.29078607788, "filtered": 5490.453886175725, "mean": 7070.423162587609}, "ext.html": {"std": 92849.23708459036, "min": 558.4499268220804, "max": 395238.0, "median": 32052.09936520815, "filtered": 21062.987710554185, "mean": 54340.346361081196}, "prototype.html": {"std": 1556.994479739429, "min": 395.6617092386008, "max": 6848.931510684829, "median": 5957.34395713893, "filtered": 4895.248285195414, "mean": 5375.731818806925}, "yui.html": {"std": 14590.850968820514, "min": 469.5539237724176, "max": 57655.13517297244, "median": 9269.768426016757, "filtered": 6228.329462672775, "mean": 12888.813165852924}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-002"}, "testrun": {"date": 1446113824, "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": "20151029005548", "branch": "Mozilla-Aurora", "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 160.0, 157.0, 158.0, 161.0, 161.0, 159.0, 159.0, 159.0], "ai-astar": [103.0, 108.0, 109.0, 108.0, 109.0, 111.0, 118.0, 109.0, 107.0, 108.0], "imaging-gaussian-blur": [110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 111.0, 109.0, 109.0], "audio-beat-detection": [149.0, 118.0, 153.0, 155.0, 126.0, 142.0, 148.0, 124.0, 164.0, 123.0], "json-stringify-tinderbox": [60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0], "stanford-crypto-pbkdf2": [136.0, 134.0, 137.0, 135.0, 133.0, 134.0, 135.0, 134.0, 138.0, 133.0], "json-parse-financial": [52.0, 53.0, 54.0, 54.0, 54.0, 52.0, 53.0, 53.0, 73.0, 51.0], "stanford-crypto-sha256-iterative": [61.0, 61.0, 60.0, 60.0, 62.0, 60.0, 60.0, 60.0, 60.0, 60.0], "audio-fft": [71.0, 70.0, 71.0, 150.0, 70.0, 71.0, 69.0, 70.0, 158.0, 71.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [107.0, 120.0, 111.0, 106.0, 112.0, 106.0, 127.0, 109.0, 107.0, 112.0], "audio-oscillator": [87.0, 88.0, 130.0, 87.0, 88.0, 88.0, 136.0, 87.0, 87.0, 127.0], "stanford-crypto-aes": [78.0, 85.0, 78.0, 91.0, 79.0, 78.0, 77.0, 78.0, 79.0, 77.0], "imaging-desaturate": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0]}, "summary": {"suite": 1448.8000000000002, "subtests": {"audio-fft": {"std": 33.50358189805979, "min": 69.0, "max": 158.0, "median": 71.0, "filtered": 87.1, "mean": 87.1}, "stanford-crypto-pbkdf2": {"std": 1.5779733838059498, "min": 133.0, "max": 138.0, "median": 134.5, "filtered": 134.9, "mean": 134.9}, "audio-beat-detection": {"std": 15.308820986607689, "min": 118.0, "max": 164.0, "median": 145.0, "filtered": 140.2, "mean": 140.2}, "stanford-crypto-ccm": {"std": 6.4815121692395214, "min": 106.0, "max": 127.0, "median": 110.0, "filtered": 111.7, "mean": 111.7}, "imaging-darkroom": {"std": 0.0, "min": 145.0, "max": 145.0, "median": 145.0, "filtered": 145.0, "mean": 145.0}, "json-parse-financial": {"std": 6.10655385630881, "min": 51.0, "max": 73.0, "median": 53.0, "filtered": 54.9, "mean": 54.9}, "audio-oscillator": {"std": 20.076105199963465, "min": 87.0, "max": 136.0, "median": 88.0, "filtered": 100.5, "mean": 100.5}, "ai-astar": {"std": 3.5777087639996634, "min": 103.0, "max": 118.0, "median": 108.5, "filtered": 109.0, "mean": 109.0}, "audio-dft": {"std": 1.3564659966250534, "min": 157.0, "max": 161.0, "median": 159.5, "filtered": 159.6, "mean": 159.6}, "stanford-crypto-sha256-iterative": {"std": 0.66332495807108, "min": 60.0, "max": 62.0, "median": 60.0, "filtered": 60.4, "mean": 60.4}, "json-stringify-tinderbox": {"std": 0.4898979485566356, "min": 60.0, "max": 61.0, "median": 60.0, "filtered": 60.4, "mean": 60.4}, "imaging-gaussian-blur": {"std": 0.7000000000000001, "min": 109.0, "max": 111.0, "median": 110.0, "filtered": 109.9, "mean": 109.9}, "stanford-crypto-aes": {"std": 4.266145801540309, "min": 77.0, "max": 91.0, "median": 78.0, "filtered": 80.0, "mean": 80.0}, "imaging-desaturate": {"std": 0.4, "min": 95.0, "max": 96.0, "median": 95.0, "filtered": 95.2, "mean": 95.2}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-002"}, "testrun": {"date": 1446113824, "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": "20151029005548", "branch": "Mozilla-Aurora", "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.79894528675015], "Encrypt": [281.0567734682406], "NavierStokes": [4835.748792270531], "Decrypt": [5107.142857142857], "Splay": [537.9236148466917], "Richards": [168.63406408094434], "RegExp": [23488.372093023256], "Earley": [536.480686695279], "Boyer": [10181.818181818182], "RayTrace": [955.1098376313277]}, "summary": {"suite": 23383.599287947287, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.79894528675015, "max": 164.79894528675015, "median": 164.79894528675015, "value": 401.20402399999995, "filtered": 401.20402399999995, "mean": 164.79894528675015}, "Encrypt": {"std": 0.0, "min": 281.0567734682406, "max": 281.0567734682406, "median": 281.0567734682406, "value": 947.0719979999998, "filtered": 947.0719979999998, "mean": 281.0567734682406}, "NavierStokes": {"std": 0.0, "min": 4835.748792270531, "max": 4835.748792270531, "median": 4835.748792270531, "value": 306.881118881119, "filtered": 306.881118881119, "mean": 4835.748792270531}, "Decrypt": {"std": 0.0, "min": 5107.142857142857, "max": 5107.142857142857, "median": 5107.142857142857, "value": 52.119356643356625, "filtered": 52.119356643356625, "mean": 5107.142857142857}, "Splay": {"std": 0.0, "min": 537.9236148466917, "max": 537.9236148466917, "median": 537.9236148466917, "value": 151.49176899999995, "filtered": 151.49176899999995, "mean": 537.9236148466917}, "RegExp": {"std": 0.0, "min": 23488.372093023256, "max": 23488.372093023256, "median": 23488.372093023256, "value": 38.78450990099014, "filtered": 38.78450990099014, "mean": 23488.372093023256}, "Richards": {"std": 0.0, "min": 168.63406408094434, "max": 168.63406408094434, "median": 168.63406408094434, "value": 209.34085999999994, "filtered": 209.34085999999994, "mean": 168.63406408094434}, "Earley": {"std": 0.0, "min": 536.480686695279, "max": 536.480686695279, "median": 536.480686695279, "value": 1242.2870320000002, "filtered": 1242.2870320000002, "mean": 536.480686695279}, "Boyer": {"std": 0.0, "min": 10181.818181818182, "max": 10181.818181818182, "median": 10181.818181818182, "value": 65.45618750000003, "filtered": 65.45618750000003, "mean": 10181.818181818182}, "RayTrace": {"std": 0.0, "min": 955.1098376313277, "max": 955.1098376313277, "median": 955.1098376313277, "value": 774.7684829999998, "filtered": 774.7684829999998, "mean": 955.1098376313277}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-002"}, "testrun": {"date": 1446113824, "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": "20151029005548", "branch": "Mozilla-Aurora", "revision": "9470fd1a1c8952f9d949715f2be3e3262762e536"}}] 03:37:14 INFO - RETURN: dromaeo_css: 7342.03 03:37:14 INFO - RETURN: kraken: 1448.80 03:37:14 INFO - RETURN: v8_7: 23383.60 03:37:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23383.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1448.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7342.03"}}} 03:37:14 INFO - Return code: 0 03:37:14 INFO - # TBPL SUCCESS # 03:37:14 INFO - Running post-action listener: _resource_record_post_action 03:37:14 INFO - Running post-run listener: _resource_record_post_run 03:37:15 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 7217152; Write bytes: 424849408; Read time: 1108; Write time: 313492 03:37:15 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 36864; Write bytes: 26791936; Read time: 32; Write time: 4712 03:37:15 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 5017600; Write bytes: 398057472; Read time: 924; Write time: 308780 03:37:15 INFO - Running post-run listener: _upload_blobber_files 03:37:15 INFO - Blob upload gear active. 03:37:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:37:15 INFO - Copying logs to upload dir... 03:37:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.223268 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-10-29 03:37:15.575755) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:37:15.579589) ========= 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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009917 build_url: 'https://queue.taskcluster.net/v1/task/H58T4liwS7KuEJvKaRYbDg/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:37:15.630949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:37:15.631281) ========= 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=dd132779db58144225c4cf24000001c8-1446113664.650284-1409255499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:37:15.680781) ========= ========= Started reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-29 03:37:15.681109) ========= ========= Finished reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-29 03:37:18.692214) =========