builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1446113091.94 results: success (0) buildid: 20151029004130 builduid: d039cd74376449d7a80dc7dd54815289 revision: bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:51.942000) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:51.942506) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:51.942853) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004476 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.017709) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.018071) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.046028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.046345) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027454 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.095725) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.096056) ========= 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:04:52.096456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.096785) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-29 03:04:52-- 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% 47.3M=0s 2015-10-29 03:04:52 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241570 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.351756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.352115) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.081378 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.444198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:52.444609) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-29 03:04:52,568 truncating revision to first 12 chars 2015-10-29 03:04:52,568 Setting DEBUG logging. 2015-10-29 03:04:52,568 attempt 1/10 2015-10-29 03:04:52,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf0aacb5affa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-29 03:04:53,040 unpacking tar archive at: mozilla-aurora-bf0aacb5affa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754467 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:53.211949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:53.212340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:53.222361) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-29 03:04:53.222952) ========= 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:04:53.223639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-10-29 03:04:53.224206) ========= /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=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:53 INFO - MultiFileLogger online at 20151029 03:04:53 in /builds/slave/test-pgo 03:04:53 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:04:53 INFO - Guessing talos json url... 03:04:53 INFO - Using buildbot properties: 03:04:53 INFO - { 03:04:53 INFO - "properties": { 03:04:53 INFO - "buildnumber": 5, 03:04:53 INFO - "product": "firefox", 03:04:53 INFO - "script_repo_revision": "production", 03:04:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:04:53 INFO - "repository": "", 03:04:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:04:53 INFO - "buildid": "20151029004130", 03:04:53 INFO - "slavename": "talos-linux64-ix-057", 03:04:53 INFO - "stage_platform": "linux64-pgo", 03:04:53 INFO - "basedir": "/builds/slave/test-pgo", 03:04:53 INFO - "nightly_build": "True", 03:04:53 INFO - "project": "", 03:04:53 INFO - "platform": "ubuntu64_hw", 03:04:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:04:53 INFO - "slavebuilddir": "test", 03:04:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:04:53 INFO - "branch": "mozilla-aurora", 03:04:53 INFO - "repo_path": "releases/mozilla-aurora", 03:04:53 INFO - "pgo_build": "True", 03:04:53 INFO - "builduid": "d039cd74376449d7a80dc7dd54815289", 03:04:53 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 03:04:53 INFO - }, 03:04:53 INFO - "sourcestamp": { 03:04:53 INFO - "repository": "", 03:04:53 INFO - "hasPatch": false, 03:04:53 INFO - "project": "", 03:04:53 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:04:53 INFO - "changes": [ 03:04:53 INFO - { 03:04:53 INFO - "category": null, 03:04:53 INFO - "files": [ 03:04:53 INFO - { 03:04:53 INFO - "url": null, 03:04:53 INFO - "name": "https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:04:53 INFO - } 03:04:53 INFO - ], 03:04:53 INFO - "repository": "", 03:04:53 INFO - "rev": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8", 03:04:53 INFO - "who": "sendchange", 03:04:53 INFO - "when": 1446112975, 03:04:53 INFO - "number": 6592698, 03:04:53 INFO - "comments": "", 03:04:53 INFO - "project": "", 03:04:53 INFO - "at": "Thu 29 Oct 2015 03:02:55", 03:04:53 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:04:53 INFO - "revlink": "", 03:04:53 INFO - "properties": [ 03:04:53 INFO - [ 03:04:53 INFO - "buildid", 03:04:53 INFO - "20151029004130", 03:04:53 INFO - "Change" 03:04:53 INFO - ], 03:04:53 INFO - [ 03:04:53 INFO - "builduid", 03:04:53 INFO - "d039cd74376449d7a80dc7dd54815289", 03:04:53 INFO - "Change" 03:04:53 INFO - ], 03:04:53 INFO - [ 03:04:53 INFO - "nightly_build", 03:04:53 INFO - "True", 03:04:53 INFO - "Change" 03:04:53 INFO - ], 03:04:53 INFO - [ 03:04:53 INFO - "pgo_build", 03:04:53 INFO - "True", 03:04:53 INFO - "Change" 03:04:53 INFO - ] 03:04:53 INFO - ], 03:04:53 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 03:04:53 INFO - } 03:04:53 INFO - ], 03:04:53 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 03:04:53 INFO - } 03:04:53 INFO - } 03:04:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 03:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:53 INFO - https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 03:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:04:53 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:04:55 INFO - Downloaded 107 bytes. 03:04:55 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:04:55 INFO - Contents: 03:04:55 INFO - 20151029004130 03:04:55 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 03:04:55 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:04:55 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bf0aacb5af/testing/talos/talos.json 03:04:55 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bf0aacb5af/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 03:04:55 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/bf0aacb5af/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 03:04:55 INFO - Downloaded 6818 bytes. 03:04:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:04:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:04:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:04:55 INFO - '../fennec_ids.txt'], 03:04:55 INFO - 'tests': ['tcheck2']}, 03:04:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:04:55 INFO - '--tppagecycles', 03:04:55 INFO - '7'], 03:04:55 INFO - 'tests': ['tsvgm']}}, 03:04:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:04:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:04:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:04:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:04:55 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:04:55 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:04:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:55 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:04:55 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:04:55 INFO - 'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:55 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'tests': ['damp', 'tps']}, 03:04:55 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['damp', 'tps']}, 03:04:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:04:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:04:55 INFO - 'other': {'tests': ['a11yr', 03:04:55 INFO - 'ts_paint', 03:04:55 INFO - 'tpaint', 03:04:55 INFO - 'sessionrestore', 03:04:55 INFO - 'sessionrestore_no_auto_restore']}, 03:04:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['a11yr', 03:04:55 INFO - 'ts_paint', 03:04:55 INFO - 'tpaint', 03:04:55 INFO - 'sessionrestore', 03:04:55 INFO - 'sessionrestore_no_auto_restore']}, 03:04:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['a11yr', 03:04:55 INFO - 'ts_paint', 03:04:55 INFO - 'tpaint', 03:04:55 INFO - 'sessionrestore', 03:04:55 INFO - 'sessionrestore_no_auto_restore']}, 03:04:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['a11yr', 03:04:55 INFO - 'ts_paint', 03:04:55 INFO - 'tpaint', 03:04:55 INFO - 'sessionrestore', 03:04:55 INFO - 'sessionrestore_no_auto_restore']}, 03:04:55 INFO - 'other_l64': {'tests': ['a11yr', 03:04:55 INFO - 'ts_paint', 03:04:55 INFO - 'tpaint', 03:04:55 INFO - 'sessionrestore', 03:04:55 INFO - 'sessionrestore_no_auto_restore']}, 03:04:55 INFO - 'other_nol64': {'tests': ['a11yr', 03:04:55 INFO - 'ts_paint', 03:04:55 INFO - 'tpaint', 03:04:55 INFO - 'sessionrestore', 03:04:55 INFO - 'sessionrestore_no_auto_restore']}, 03:04:55 INFO - 'svgr': {'tests': ['tsvgx', 03:04:55 INFO - 'tsvgr_opacity', 03:04:55 INFO - 'tart', 03:04:55 INFO - 'tscrollx', 03:04:55 INFO - 'cart']}, 03:04:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['tsvgx', 03:04:55 INFO - 'tsvgr_opacity', 03:04:55 INFO - 'tart', 03:04:55 INFO - 'tscrollx', 03:04:55 INFO - 'cart']}, 03:04:55 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:04:55 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:04:55 INFO - 'tests': ['tp5o']}, 03:04:55 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:04:55 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:04:55 INFO - 'talos_options': ['--e10s'], 03:04:55 INFO - 'tests': ['tp5o']}, 03:04:55 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:04:55 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:04:55 INFO - 'talos_options': ['--xperf_path', 03:04:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:55 INFO - 'tests': ['tp5n']}, 03:04:55 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:04:55 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:04:55 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:55 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:04:55 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:04:55 INFO - 'talos_options': ['--e10s', 03:04:55 INFO - '--xperf_path', 03:04:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 03:04:55 INFO - 'C:/slave/talos-data/talos/xperf.config'], 03:04:55 INFO - 'tests': ['tp5n']}}, 03:04:55 INFO - 'talos.zip': {'path': '', 03:04:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:04:55 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:04:55 INFO - {'append_to_log': False, 03:04:55 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:04:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:04:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:04:55 INFO - 'branch': 'Mozilla-Aurora', 03:04:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:55 INFO - 'config_files': ('talos/linux_config.py',), 03:04:55 INFO - 'default_actions': ('clobber', 03:04:55 INFO - 'read-buildbot-config', 03:04:55 INFO - 'download-and-extract', 03:04:55 INFO - 'populate-webroot', 03:04:55 INFO - 'create-virtualenv', 03:04:55 INFO - 'install', 03:04:55 INFO - 'run-tests'), 03:04:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:55 INFO - 'download_minidump_stackwalk': True, 03:04:55 INFO - 'download_symbols': 'ondemand', 03:04:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:55 INFO - 'installer_path': 'installer.exe', 03:04:55 INFO - 'log_level': 'info', 03:04:55 INFO - 'log_name': 'talos', 03:04:55 INFO - 'log_to_console': True, 03:04:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:55 INFO - 'opt_config_files': (), 03:04:55 INFO - 'pip_index': False, 03:04:55 INFO - 'python_webserver': False, 03:04:55 INFO - 'sps_profile': False, 03:04:55 INFO - 'sps_profile_interval': 0, 03:04:55 INFO - 'suite': 'dromaeojs', 03:04:55 INFO - 'system_bits': '64', 03:04:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:55 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 03:04:55 INFO - 'tests': (), 03:04:55 INFO - 'title': 'talos-linux64-ix-057', 03:04:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:55 INFO - 'use_talos_json': True, 03:04:55 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:04:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:55 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 03:04:55 INFO - 'work_dir': 'build'} 03:04:55 INFO - ##### 03:04:55 INFO - ##### Running clobber step. 03:04:55 INFO - ##### 03:04:55 INFO - Running pre-action listener: _resource_record_pre_action 03:04:55 INFO - Running main action method: clobber 03:04:55 INFO - rmtree: /builds/slave/test-pgo/build 03:04:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:04:56 INFO - Running post-action listener: _resource_record_post_action 03:04:56 INFO - ##### 03:04:56 INFO - ##### Running read-buildbot-config step. 03:04:56 INFO - ##### 03:04:56 INFO - Running pre-action listener: _resource_record_pre_action 03:04:56 INFO - Running main action method: read_buildbot_config 03:04:56 INFO - Using buildbot properties: 03:04:56 INFO - { 03:04:56 INFO - "properties": { 03:04:56 INFO - "buildnumber": 5, 03:04:56 INFO - "product": "firefox", 03:04:56 INFO - "script_repo_revision": "production", 03:04:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:04:56 INFO - "repository": "", 03:04:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:04:56 INFO - "buildid": "20151029004130", 03:04:56 INFO - "slavename": "talos-linux64-ix-057", 03:04:56 INFO - "stage_platform": "linux64-pgo", 03:04:56 INFO - "basedir": "/builds/slave/test-pgo", 03:04:56 INFO - "nightly_build": "True", 03:04:56 INFO - "project": "", 03:04:56 INFO - "platform": "ubuntu64_hw", 03:04:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:04:56 INFO - "slavebuilddir": "test", 03:04:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:04:56 INFO - "branch": "mozilla-aurora", 03:04:56 INFO - "repo_path": "releases/mozilla-aurora", 03:04:56 INFO - "pgo_build": "True", 03:04:56 INFO - "builduid": "d039cd74376449d7a80dc7dd54815289", 03:04:56 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 03:04:56 INFO - }, 03:04:56 INFO - "sourcestamp": { 03:04:56 INFO - "repository": "", 03:04:56 INFO - "hasPatch": false, 03:04:56 INFO - "project": "", 03:04:56 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:04:56 INFO - "changes": [ 03:04:56 INFO - { 03:04:56 INFO - "category": null, 03:04:56 INFO - "files": [ 03:04:56 INFO - { 03:04:56 INFO - "url": null, 03:04:56 INFO - "name": "https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:04:56 INFO - } 03:04:56 INFO - ], 03:04:56 INFO - "repository": "", 03:04:56 INFO - "rev": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8", 03:04:56 INFO - "who": "sendchange", 03:04:56 INFO - "when": 1446112975, 03:04:56 INFO - "number": 6592698, 03:04:56 INFO - "comments": "", 03:04:56 INFO - "project": "", 03:04:56 INFO - "at": "Thu 29 Oct 2015 03:02:55", 03:04:56 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:04:56 INFO - "revlink": "", 03:04:56 INFO - "properties": [ 03:04:56 INFO - [ 03:04:56 INFO - "buildid", 03:04:56 INFO - "20151029004130", 03:04:56 INFO - "Change" 03:04:56 INFO - ], 03:04:56 INFO - [ 03:04:56 INFO - "builduid", 03:04:56 INFO - "d039cd74376449d7a80dc7dd54815289", 03:04:56 INFO - "Change" 03:04:56 INFO - ], 03:04:56 INFO - [ 03:04:56 INFO - "nightly_build", 03:04:56 INFO - "True", 03:04:56 INFO - "Change" 03:04:56 INFO - ], 03:04:56 INFO - [ 03:04:56 INFO - "pgo_build", 03:04:56 INFO - "True", 03:04:56 INFO - "Change" 03:04:56 INFO - ] 03:04:56 INFO - ], 03:04:56 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 03:04:56 INFO - } 03:04:56 INFO - ], 03:04:56 INFO - "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8" 03:04:56 INFO - } 03:04:56 INFO - } 03:04:56 INFO - Running post-action listener: _resource_record_post_action 03:04:56 INFO - ##### 03:04:56 INFO - ##### Running download-and-extract step. 03:04:56 INFO - ##### 03:04:56 INFO - Running pre-action listener: _resource_record_pre_action 03:04:56 INFO - Running main action method: download_and_extract 03:04:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:04:56 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:04:56 INFO - https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/test_packages.json 03:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/test_packages.json 03:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:04:56 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 03:04:57 INFO - Downloaded 1302 bytes. 03:04:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:04:57 INFO - Using the following test package requirements: 03:04:57 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:04:57 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:04:57 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:57 INFO - u'jsshell-linux-x86_64.zip'], 03:04:57 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:04:57 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:04:57 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:04:57 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:04:57 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:04:57 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:04:57 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:04:57 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:04:57 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:57 INFO - https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:04:57 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:04:58 INFO - Downloaded 22907519 bytes. 03:04:58 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:04:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:04:58 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:04:59 INFO - Return code: 0 03:04:59 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:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:59 INFO - https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:04:59 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:05:00 INFO - Downloaded 22907519 bytes. 03:05:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:05:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:05:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:05:02 INFO - Return code: 0 03:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:02 INFO - https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:05:02 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:05:03 INFO - Downloaded 10881672 bytes. 03:05:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:05:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:05:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:05:03 INFO - Return code: 0 03:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:03 INFO - https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:05:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:05:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:05:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:05:03 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:05:06 INFO - Downloaded 56984429 bytes. 03:05:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:05:06 INFO - mkdir: /builds/slave/test-pgo/properties 03:05:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:05:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:05:06 INFO - Contents: 03:05:06 INFO - build_url:https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:05:06 INFO - Running post-action listener: _resource_record_post_action 03:05:06 INFO - Running post-action listener: _set_extra_try_arguments 03:05:06 INFO - ##### 03:05:06 INFO - ##### Running populate-webroot step. 03:05:06 INFO - ##### 03:05:06 INFO - Running pre-action listener: _resource_record_pre_action 03:05:06 INFO - Running main action method: populate_webroot 03:05:06 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 03:05:06 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:05:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 03:05:06 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 03:05:06 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:05:06 INFO - Running post-action listener: _resource_record_post_action 03:05:06 INFO - ##### 03:05:06 INFO - ##### Running create-virtualenv step. 03:05:06 INFO - ##### 03:05:06 INFO - Running pre-action listener: _resource_record_pre_action 03:05:06 INFO - Running main action method: create_virtualenv 03:05:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:05:06 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:05:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:05:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:05:06 INFO - Using real prefix '/usr' 03:05:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:05:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:05:09 INFO - Installing pip.................done. 03:05:09 INFO - Return code: 0 03:05:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:05:09 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:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:09 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:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:09 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 0x7f5f876f1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd334a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', '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:05:09 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:05:09 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:05:09 INFO - Using env: {'DISPLAY': ':0', 03:05:09 INFO - 'HOME': '/home/cltbld', 03:05:09 INFO - 'LANG': 'en_US.UTF-8', 03:05:09 INFO - 'LANGUAGE': 'en_US:en', 03:05:09 INFO - 'LOGNAME': 'cltbld', 03:05:09 INFO - 'MAIL': '/var/mail/cltbld', 03:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:09 INFO - 'MOZ_NO_REMOTE': '1', 03:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:09 INFO - 'NO_EM_RESTART': '1', 03:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:09 INFO - 'SHELL': '/bin/bash', 03:05:09 INFO - 'SHLVL': '1', 03:05:09 INFO - 'TERM': 'linux', 03:05:09 INFO - 'TMOUT': '86400', 03:05:09 INFO - 'USER': 'cltbld', 03:05:09 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:09 INFO - '_': '/tools/buildbot/bin/python'} 03:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:10 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:05:10 INFO - Cleaning up... 03:05:10 INFO - Return code: 0 03:05:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:05: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:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:10 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 0x7f5f876f1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd334a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', '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:05:10 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:05:10 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:05:10 INFO - Using env: {'DISPLAY': ':0', 03:05:10 INFO - 'HOME': '/home/cltbld', 03:05:10 INFO - 'LANG': 'en_US.UTF-8', 03:05:10 INFO - 'LANGUAGE': 'en_US:en', 03:05:10 INFO - 'LOGNAME': 'cltbld', 03:05:10 INFO - 'MAIL': '/var/mail/cltbld', 03:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:10 INFO - 'MOZ_NO_REMOTE': '1', 03:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:10 INFO - 'NO_EM_RESTART': '1', 03:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:10 INFO - 'SHELL': '/bin/bash', 03:05:10 INFO - 'SHLVL': '1', 03:05:10 INFO - 'TERM': 'linux', 03:05:10 INFO - 'TMOUT': '86400', 03:05:10 INFO - 'USER': 'cltbld', 03:05:10 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:10 INFO - '_': '/tools/buildbot/bin/python'} 03:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:10 INFO - Downloading/unpacking psutil>=0.7.1 03:05:10 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:05:10 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:05:10 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:05:10 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:05:10 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:05:10 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:05:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:05:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:05:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:05:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:12 INFO - Installing collected packages: psutil 03:05:12 INFO - Running setup.py install for psutil 03:05:12 INFO - building 'psutil._psutil_linux' extension 03:05:12 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:05:13 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:05:13 INFO - building 'psutil._psutil_posix' extension 03:05:13 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:05:13 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:05:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:13 INFO - Successfully installed psutil 03:05:13 INFO - Cleaning up... 03:05:13 INFO - Return code: 0 03:05:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5f876f1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd334a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', '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:05:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:05:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:05:13 INFO - Using env: {'DISPLAY': ':0', 03:05:13 INFO - 'HOME': '/home/cltbld', 03:05:13 INFO - 'LANG': 'en_US.UTF-8', 03:05:13 INFO - 'LANGUAGE': 'en_US:en', 03:05:13 INFO - 'LOGNAME': 'cltbld', 03:05:13 INFO - 'MAIL': '/var/mail/cltbld', 03:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:13 INFO - 'MOZ_NO_REMOTE': '1', 03:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:13 INFO - 'NO_EM_RESTART': '1', 03:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:13 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:13 INFO - 'SHELL': '/bin/bash', 03:05:13 INFO - 'SHLVL': '1', 03:05:13 INFO - 'TERM': 'linux', 03:05:13 INFO - 'TMOUT': '86400', 03:05:13 INFO - 'USER': 'cltbld', 03:05:13 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:13 INFO - '_': '/tools/buildbot/bin/python'} 03:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:05:14 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:05:14 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:05:14 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:05:14 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:05:14 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:05:14 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:05:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:05:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:05:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:05:15 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:05:15 INFO - Installing collected packages: mozsystemmonitor 03:05:15 INFO - Running setup.py install for mozsystemmonitor 03:05:15 INFO - Successfully installed mozsystemmonitor 03:05:15 INFO - Cleaning up... 03:05:15 INFO - Return code: 0 03:05:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f5f876f1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd334a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', '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:05:15 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:05:15 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:05:15 INFO - Using env: {'DISPLAY': ':0', 03:05:15 INFO - 'HOME': '/home/cltbld', 03:05:15 INFO - 'LANG': 'en_US.UTF-8', 03:05:15 INFO - 'LANGUAGE': 'en_US:en', 03:05:15 INFO - 'LOGNAME': 'cltbld', 03:05:15 INFO - 'MAIL': '/var/mail/cltbld', 03:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:15 INFO - 'MOZ_NO_REMOTE': '1', 03:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:15 INFO - 'NO_EM_RESTART': '1', 03:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:15 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:15 INFO - 'SHELL': '/bin/bash', 03:05:15 INFO - 'SHLVL': '1', 03:05:15 INFO - 'TERM': 'linux', 03:05:15 INFO - 'TMOUT': '86400', 03:05:15 INFO - 'USER': 'cltbld', 03:05:15 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:15 INFO - '_': '/tools/buildbot/bin/python'} 03:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:05:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:05:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:05:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:05:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:05:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:05:18 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:05:18 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:05:18 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:05:18 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:05:18 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:05:18 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:05:18 INFO - Downloading docopt-0.6.1.tar.gz 03:05:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:05:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:05:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:05:18 INFO - Running setup.py install for blobuploader 03:05:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:05:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:05:18 INFO - Running setup.py install for requests 03:05:18 INFO - Running setup.py install for docopt 03:05:19 INFO - Successfully installed blobuploader requests docopt 03:05:19 INFO - Cleaning up... 03:05:19 INFO - Return code: 0 03:05:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:05: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:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05: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:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:19 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 0x7f5f876f1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd334a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', '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:05:19 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:05:19 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:05:19 INFO - Using env: {'DISPLAY': ':0', 03:05:19 INFO - 'HOME': '/home/cltbld', 03:05:19 INFO - 'LANG': 'en_US.UTF-8', 03:05:19 INFO - 'LANGUAGE': 'en_US:en', 03:05:19 INFO - 'LOGNAME': 'cltbld', 03:05:19 INFO - 'MAIL': '/var/mail/cltbld', 03:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:19 INFO - 'MOZ_NO_REMOTE': '1', 03:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:19 INFO - 'NO_EM_RESTART': '1', 03:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:19 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:19 INFO - 'SHELL': '/bin/bash', 03:05:19 INFO - 'SHLVL': '1', 03:05:19 INFO - 'TERM': 'linux', 03:05:19 INFO - 'TMOUT': '86400', 03:05:19 INFO - 'USER': 'cltbld', 03:05:19 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:19 INFO - '_': '/tools/buildbot/bin/python'} 03:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:05:19 INFO - Running setup.py (path:/tmp/pip-8E1jO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:05:19 INFO - Running setup.py (path:/tmp/pip-0ZbMqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:05:19 INFO - Running setup.py (path:/tmp/pip-N8yPYu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:05:19 INFO - Running setup.py (path:/tmp/pip-j6WHZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:05:19 INFO - Running setup.py (path:/tmp/pip-V1DgHc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:05:19 INFO - Running setup.py (path:/tmp/pip-z0X7dW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:05:19 INFO - Running setup.py (path:/tmp/pip-E1BifY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:05:19 INFO - Running setup.py (path:/tmp/pip-wUpKQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:05:19 INFO - Running setup.py (path:/tmp/pip-ClMA7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:05:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:05:19 INFO - Running setup.py (path:/tmp/pip-S6Mxc5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:05:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:05:20 INFO - Running setup.py (path:/tmp/pip-BKVbV_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:05:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:05:20 INFO - Running setup.py (path:/tmp/pip-HiimqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:05:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:05:20 INFO - Running setup.py (path:/tmp/pip-Xul6KU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:05:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:05:20 INFO - Running setup.py (path:/tmp/pip-b5SmOM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:05:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:05:20 INFO - Running setup.py (path:/tmp/pip-SJCxB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:05:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:05:20 INFO - Running setup.py (path:/tmp/pip-pKV3BD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:05:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:05:20 INFO - Running setup.py (path:/tmp/pip-N31QxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:05:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:05:20 INFO - Running setup.py install for manifestparser 03:05:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:05:20 INFO - Running setup.py install for mozcrash 03:05:20 INFO - Running setup.py install for mozdebug 03:05:20 INFO - Running setup.py install for mozdevice 03:05:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:05:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:05:20 INFO - Running setup.py install for mozfile 03:05:21 INFO - Running setup.py install for mozhttpd 03:05:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Running setup.py install for mozinfo 03:05:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Running setup.py install for mozInstall 03:05:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Running setup.py install for mozleak 03:05:21 INFO - Running setup.py install for mozlog 03:05:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Running setup.py install for moznetwork 03:05:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Running setup.py install for mozprocess 03:05:21 INFO - Running setup.py install for mozprofile 03:05:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Running setup.py install for mozrunner 03:05:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:05:21 INFO - Running setup.py install for mozscreenshot 03:05:22 INFO - Running setup.py install for moztest 03:05:22 INFO - Running setup.py install for mozversion 03:05:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:05:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:05:22 INFO - Cleaning up... 03:05:22 INFO - Return code: 0 03:05:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:22 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 0x7f5f876f1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd334a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', '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:05:22 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:05:22 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:05:22 INFO - Using env: {'DISPLAY': ':0', 03:05:22 INFO - 'HOME': '/home/cltbld', 03:05:22 INFO - 'LANG': 'en_US.UTF-8', 03:05:22 INFO - 'LANGUAGE': 'en_US:en', 03:05:22 INFO - 'LOGNAME': 'cltbld', 03:05:22 INFO - 'MAIL': '/var/mail/cltbld', 03:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:22 INFO - 'MOZ_NO_REMOTE': '1', 03:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:22 INFO - 'NO_EM_RESTART': '1', 03:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:22 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:22 INFO - 'SHELL': '/bin/bash', 03:05:22 INFO - 'SHLVL': '1', 03:05:22 INFO - 'TERM': 'linux', 03:05:22 INFO - 'TMOUT': '86400', 03:05:22 INFO - 'USER': 'cltbld', 03:05:22 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:22 INFO - '_': '/tools/buildbot/bin/python'} 03:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:05:22 INFO - Running setup.py (path:/tmp/pip-m7NdEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:05:22 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:05:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:05:22 INFO - Running setup.py (path:/tmp/pip-Hvr4o9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:05:22 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:05:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:05:22 INFO - Running setup.py (path:/tmp/pip-VTJB7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:05:22 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:05:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:05:22 INFO - Running setup.py (path:/tmp/pip-tHES7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:05:22 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:05:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:05:22 INFO - Running setup.py (path:/tmp/pip-m5gj14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:05:22 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:05:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:05:22 INFO - Running setup.py (path:/tmp/pip-Bq7eJM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:05:22 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:05:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:05:22 INFO - Running setup.py (path:/tmp/pip-2Dgu3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:05:23 INFO - Running setup.py (path:/tmp/pip-UO7U9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:05:23 INFO - Running setup.py (path:/tmp/pip-nzzjHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:05:23 INFO - Running setup.py (path:/tmp/pip-0jRljG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:05:23 INFO - Running setup.py (path:/tmp/pip-Cj5wIQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:05:23 INFO - Running setup.py (path:/tmp/pip-vKyYwx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:05:23 INFO - Running setup.py (path:/tmp/pip-3nx3W3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:05:23 INFO - Running setup.py (path:/tmp/pip-o6BNXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:05:23 INFO - Running setup.py (path:/tmp/pip-EXv30l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:05:23 INFO - Running setup.py (path:/tmp/pip-Bt6U6T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:05:23 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:05:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:05:23 INFO - Running setup.py (path:/tmp/pip-MO_tKt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:25 INFO - Downloading blessings-1.5.1.tar.gz 03:05:25 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:05:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:05:25 INFO - Installing collected packages: blessings 03:05:25 INFO - Running setup.py install for blessings 03:05:25 INFO - Successfully installed blessings 03:05:25 INFO - Cleaning up... 03:05:25 INFO - Return code: 0 03:05:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:05:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:05:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:05:25 INFO - Reading from file tmpfile_stdout 03:05:25 INFO - Current package versions: 03:05:25 INFO - argparse == 1.2.1 03:05:25 INFO - blessings == 1.5.1 03:05:25 INFO - blobuploader == 1.2.4 03:05:25 INFO - docopt == 0.6.1 03:05:25 INFO - manifestparser == 1.1 03:05:25 INFO - mozInstall == 1.12 03:05:25 INFO - mozcrash == 0.16 03:05:25 INFO - mozdebug == 0.1 03:05:25 INFO - mozdevice == 0.46 03:05:25 INFO - mozfile == 1.2 03:05:25 INFO - mozhttpd == 0.7 03:05:25 INFO - mozinfo == 0.8 03:05:25 INFO - mozleak == 0.1 03:05:25 INFO - mozlog == 3.0 03:05:25 INFO - moznetwork == 0.27 03:05:25 INFO - mozprocess == 0.22 03:05:25 INFO - mozprofile == 0.27 03:05:25 INFO - mozrunner == 6.10 03:05:25 INFO - mozscreenshot == 0.1 03:05:25 INFO - mozsystemmonitor == 0.0 03:05:25 INFO - moztest == 0.7 03:05:25 INFO - mozversion == 1.4 03:05:25 INFO - psutil == 3.1.1 03:05:25 INFO - requests == 1.2.3 03:05:25 INFO - wsgiref == 0.1.2 03:05:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f5f876f1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6e7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd334a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', '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:05:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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:05:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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:05:25 INFO - Using env: {'DISPLAY': ':0', 03:05:25 INFO - 'HOME': '/home/cltbld', 03:05:25 INFO - 'LANG': 'en_US.UTF-8', 03:05:25 INFO - 'LANGUAGE': 'en_US:en', 03:05:25 INFO - 'LOGNAME': 'cltbld', 03:05:25 INFO - 'MAIL': '/var/mail/cltbld', 03:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:25 INFO - 'MOZ_NO_REMOTE': '1', 03:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:25 INFO - 'NO_EM_RESTART': '1', 03:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:25 INFO - 'SHELL': '/bin/bash', 03:05:25 INFO - 'SHLVL': '1', 03:05:25 INFO - 'TERM': 'linux', 03:05:25 INFO - 'TMOUT': '86400', 03:05:25 INFO - 'USER': 'cltbld', 03:05:25 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:25 INFO - '_': '/tools/buildbot/bin/python'} 03:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:26 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:05:26 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:05:26 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:05:26 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:05:26 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:05:26 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:05:26 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:05:26 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:05:26 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:05:26 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:05:26 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:05:26 INFO - Cleaning up... 03:05:26 INFO - Return code: 0 03:05:26 INFO - Running post-action listener: _resource_record_post_action 03:05:26 INFO - Running post-action listener: _start_resource_monitoring 03:05:26 INFO - Starting resource monitoring. 03:05:26 INFO - ##### 03:05:26 INFO - ##### Running install step. 03:05:26 INFO - ##### 03:05:26 INFO - Running pre-action listener: _resource_record_pre_action 03:05:26 INFO - Running main action method: install 03:05:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:05:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:05:26 INFO - Reading from file tmpfile_stdout 03:05:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:05:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:05:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:05:26 INFO - Reading from file tmpfile_stdout 03:05:26 INFO - Output received: 03:05:26 INFO - Usage: mozinstall [options] installer 03:05:26 INFO - Options: 03:05:26 INFO - -h, --help show this help message and exit 03:05:26 INFO - -d DEST, --destination=DEST 03:05:26 INFO - Directory to install application into. [default: 03:05:26 INFO - "/builds/slave/test-pgo"] 03:05:26 INFO - --app=APP Application being installed. [default: firefox] 03:05:26 INFO - mkdir: /builds/slave/test-pgo/build/application 03:05:26 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:05:26 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:05:40 INFO - Reading from file tmpfile_stdout 03:05:40 INFO - Output received: 03:05:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:05:40 INFO - Running post-action listener: _resource_record_post_action 03:05:40 INFO - ##### 03:05:40 INFO - ##### Running run-tests step. 03:05:40 INFO - ##### 03:05:40 INFO - Running pre-action listener: _resource_record_pre_action 03:05:40 INFO - Running main action method: run_tests 03:05:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:05:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:05:40 INFO - Python 2.7.3 03:05:40 INFO - Return code: 0 03:05:40 INFO - grabbing minidump binary from tooltool 03:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:40 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 0xac5bf0>, '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 0xdc34f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc39a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:05:40 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:05:40 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:05:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:40 INFO - Return code: 0 03:05:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:05:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:05:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:05:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:05:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:05:40 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/xs4EC6-ERm-JWdIwfrYl1A/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-057', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:05:40 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/xs4EC6-ERm-JWdIwfrYl1A/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-057 --webServer localhost 03:05:40 INFO - Using env: {'DISPLAY': ':0', 03:05:40 INFO - 'HOME': '/home/cltbld', 03:05:40 INFO - 'LANG': 'en_US.UTF-8', 03:05:40 INFO - 'LANGUAGE': 'en_US:en', 03:05:40 INFO - 'LOGNAME': 'cltbld', 03:05:40 INFO - 'MAIL': '/var/mail/cltbld', 03:05:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:05:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:40 INFO - 'MOZ_NO_REMOTE': '1', 03:05:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:40 INFO - 'NO_EM_RESTART': '1', 03:05:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:05:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:05:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:05:40 INFO - 'SHELL': '/bin/bash', 03:05:40 INFO - 'SHLVL': '1', 03:05:40 INFO - 'TERM': 'linux', 03:05:40 INFO - 'TMOUT': '86400', 03:05:40 INFO - 'USER': 'cltbld', 03:05:40 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688', 03:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:40 INFO - '_': '/tools/buildbot/bin/python'} 03:05:40 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/xs4EC6-ERm-JWdIwfrYl1A/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-057', '--webServer', 'localhost'] with output_timeout 3600 03:05:41 INFO - mozversion INFO | application_buildid: 20151029004130 03:05:41 INFO - mozversion INFO | application_changeset: bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 03:05:41 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:05:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:41 INFO - mozversion INFO | application_name: Firefox 03:05:41 INFO - mozversion INFO | application_remotingname: firefox-dev 03:05:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:05:41 INFO - mozversion INFO | application_vendor: Mozilla 03:05:41 INFO - mozversion INFO | application_version: 43.0a2 03:05:41 INFO - mozversion INFO | platform_buildid: 20151029004130 03:05:41 INFO - mozversion INFO | platform_changeset: bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8 03:05:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:05:41 INFO - mozversion INFO | platform_version: 43.0a2 03:05:41 INFO - 2015-10-29 03:05:41,004 DEBUG : using testdate: 1446113141 03:05:41 INFO - 2015-10-29 03:05:41,005 DEBUG : actual date: 1446113141 03:05:41 INFO - 2015-10-29 03:05:41,087 INFO : Starting test suite talos-linux64-ix-057 03:05:41 INFO - 2015-10-29 03:05:41,087 INFO : Starting test dromaeo_css 03:05:41 INFO - 2015-10-29 03:05:41,087 DEBUG : operating with platform_type : linux_ 03:05:41 INFO - 2015-10-29 03:05:41,088 INFO : Initialising browser for dromaeo_css test... 03:05:41 INFO - 2015-10-29 03:05:41,104 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWLzRyQ/profile http://localhost/getInfo.html 03:05:46 INFO - 2015-10-29 03:05:46,813 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:05:46 INFO - 2015-10-29 03:05:46,813 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:05:46 INFO - 2015-10-29 03:05:46,813 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:05:46 INFO - 2015-10-29 03:05:46,813 DEBUG : BROWSER_OUTPUT: __metrics 03:05:46 INFO - 2015-10-29 03:05:46,982 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:05:48 INFO - 2015-10-29 03:05:48,149 INFO : Browser initialized. 03:05:48 INFO - 2015-10-29 03:05:48,150 INFO : Running cycle 1/1 for dromaeo_css test... 03:05:48 INFO - 2015-10-29 03:05:48,150 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWLzRyQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:05:59 INFO - 2015-10-29 03:05:59,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 132878336 03:05:59 INFO - 2015-10-29 03:05:59,823 DEBUG : BROWSER_OUTPUT: 03:08:59 INFO - 2015-10-29 03:08:59,324 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:09:00 INFO - 2015-10-29 03:09:00,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 227168256 03:09:00 INFO - 2015-10-29 03:09:00,331 DEBUG : BROWSER_OUTPUT: 03:12:02 INFO - 2015-10-29 03:12:02,532 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:12:03 INFO - 2015-10-29 03:12:03,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 207683584 03:12:03 INFO - 2015-10-29 03:12:03,081 DEBUG : BROWSER_OUTPUT: 03:15:04 INFO - 2015-10-29 03:15:04,850 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:15:05 INFO - 2015-10-29 03:15:05,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 206733312 03:15:05 INFO - 2015-10-29 03:15:05,420 DEBUG : BROWSER_OUTPUT: 03:18:07 INFO - 2015-10-29 03:18:07,172 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:18:07 INFO - 2015-10-29 03:18:07,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 199827456 03:18:07 INFO - 2015-10-29 03:18:07,738 DEBUG : BROWSER_OUTPUT: 03:21:10 INFO - 2015-10-29 03:21:10,107 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:21:10 INFO - 2015-10-29 03:21:10,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 194748416 03:21:10 INFO - 2015-10-29 03:21:10,689 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,642 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:24:12 INFO - 2015-10-29 03:24:12,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 235905024 03:24:12 INFO - 2015-10-29 03:24:12,893 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,893 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:24:12 INFO - 2015-10-29 03:24:12,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:24:12 INFO - 2015-10-29 03:24:12,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:24:12 INFO - 2015-10-29 03:24:12,894 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:24:12 INFO - 2015-10-29 03:24:12,897 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3274.574305340306;3336.2660214752746;3364.1589602599333;3373.2241584435596;3388.3223355328923;5600.215969764226;5601.795613943002;5616.410276920926;5619.381867994517;5638.8590285242835;5630.71846407679;5646.20953066571;5698.658080515162;5708.800191993281;5725.112607545837;4994.650374473788;5049.949500505003;5146.588272938156;5151.536361727443;5258.290130832327;5171.09505836479;5187.766550505217;5191.143461328877;5191.480851914816;5192.428832828386;5091.185410334348;5135.1526998045465;5201.141811601081;5212.817551385702;5253.527182553569;5252.054630166568;5258.737063146866;5262.500062494057;5273.578113750891;5286.894262114736;4915.877103072416;4980.975095124538;5176.912848301861;5191.506806853343;5241.79032838686;5404.135338345845;5490.450954904518;5547.084731019377;5548.4174161712845;5555.138953462219;6135.785247516315;6158.692065396713;6170.475509581691;6180.474659653934;6185.783497577609;5965.4929331006915;6011.819645410645;6034.939650603482;6212.534059945522;6215.533834962396;5807.157962095514;5825.650460972398;5827.533797296206;5831.504322132624;5834.949709052369;6265.624062556261;6296.244450665858;6300.9684951574945;6306.1171435998995;6310.274318453345;5803.390643982406;5856.59003869725;5953.136795164677;5990.4908082813445;6126.386638414559;6112.724927378279;6142.170806941095;6146.262448506208;6162.383761623802;6181.609137943927;6041.818745437644;6052.969735151296;6054.424829641177;6065.939340606626;6082.756689732361;5807.709614519257;5918.763249470059;6003.6998150093195;6104.053871649901;6110.694465276719;4684.203685373494;4685.765711714401;4691.1555919934735;4694.835680751157;4720.858374248778;4185.330347144442;4206.8737937861915;4207.074443622399;4213.641840443535;4229.069604687025;5493.09363954943;5573.359063707644;5719.628224165416;5787.739551720183;5845.707714614337;6117.571769976148;6133.478654314434;6152.538559608047;6184.721687524072;6198.535109866688;5588.357338905997;5864.648121112747;5866.12008198765;5872.471477567039;5886.735096920649;5237.502437268454;5293.920591191135;5336.252924590561;5339.439358867341;5358.11591087474;6369.808905732835;6392.20097487814;6405.29541750407;6406.199225096863;6418.037294405876;5980.222571065734;6078.817635470943;6220.315765265907;6235.095911092957;6242.313345531897;6237.5321850860455;6350.7777227796805;6354.714037868214;6372.968135159294;6424.935750642434;6048.5161187105805;6057.4851137653795;6060.636361818305;6078.665673388006;6080.513558915188;6004;6055.757769689163;6113.144159817718;6134.938650613437;6147.200863887845;5966.522678185822;6024.487918526975;6033.095035744674;6054;6071.574989750675;6012.248468941382;6013.879722405615;6045.848853778515;6052.334243233153;6063;5605.775768969195;5701.059325211294;5843.532517398683;5867.354590994902;5959.553033522417;5938.495227905676;6022.90965635507;6033.064874944391;6057.182280392267;6058.333583305921;5884.264466941632;5895.7052147391605;5899.026660600953;5900.291964964232;5903.0555111182 03:24:12 INFO - 2015-10-29 03:24:12,897 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.0634716252295;597.259398346051;601.6510423954105;623.1182876230134;626.1077963901439;44742.32886506701;45162.548374516286;45278;45285.547144528544;45351.319730204035;48534;49109.754451227695;49220.753896230555;49234.52296431113;49282.50717492824;7991.041075071;8084.231997960213;9103.317251206154;9255.213306868924;10518.474076296194;10799.892001080007;10913;10918.181136414762;10922.18083643726;10940.343579385222;10897.564097436092;10983.505742241618;11007;11008.834867476955;11016.834747478793;8250.051244106915;8424.115467875878;11098.944505277423;11282.94358528202;11319.264247823947;10650.520726567245;10802.027817496384;10808.243422960395;10810.081143102845;10827.621033263877;45751.77124114358;46226.76886615579;46229.30656040129;46239.76880115612;46284.5371546287;3881.6118388160958;3946.980265098656;3954.485916830822;3967.327887981321;4014.959850401488;33924.660753392396;34092.31815363679;34278;34593.82703086468;34601.653983460346;3878.9612103879163;3911.178652482982;4000.719949603529;4014.417909403149;4041.1109555897656;347871;350878;351729;351829;445084.99999999674;54125.45874541204;76264;77763.61118194372;77809.61095194488;77915.61042194752;72964;73589.68846401924;74002.25997740061;74021;74054;17113.657726845395;17131;17171.055591942564;17189.914050429918;17263.827361726475;14174.503892363718;14438.639034024234;14467.638309042148;14476;14483.0586011911;22749;23174.42063948415;23220.76779232186;23231.419214519774;23243.76756232416;8663.263622592025;8854.070322616033;8863.335249856287;8940.50827204497;8944.776380590407;1063.8457423673524;1101.5979167603928;1164.5109054197258;1185.8339832423467;1210.056156198167;32588.83705581457;32704.83647581747;32967.83516082452;33073.50389744156;35855.17655882908;1140.5095808802296;1151.3034614058543;1223.932683702405;1246.2771592476342;1263.9368031598383;15306.923465382602;16635.66728665444;16720.247588858532;18238.90880545589;18428.262869485072;539525;541747;542055;544511;546252;59432;59931.101033484534;59945.40054599398;60042.39957600455;60187.69906150441;1535.5163123616026;1535.7466018107111;1548.9767653485208;1550.4185930276146;1555.3778488604648;30695.693043069285;32961.505577415875;33200;34123.829380852934;35619.64380356163;56433.43566564282;56880.43119568751;56912.43087569071;57003.42996569981;57087.42912570821;406462;408233;408645;409204;409755;30790.846045769627;31910.60670449679;31974.36051279008;34359.31281374409;37305.62694373022;36952.26095478129;39937.40093898536;44020;44501.554984449744;45238.77380613076;38479;38616;39259;46654.53345466638;47398.28902566395;42675.146497070506;43194.56805432031;43370.78314608407;43817;43915.12169756523;40336.79831600823;41286.1742765149;47502;47598.76200619113;47947.76026119847;34383.48424773681;38531;38761.22477550377;39054.80472597732;39472.605273946894;29173.270668233465;29400.558991614715;29406.264843379086;29482.852585736935;29562.852185738935 03:24:12 INFO - 2015-10-29 03:24:12,898 DEBUG : BROWSER_OUTPUT: |2;jquery.html;419.36256889527937;421.2459697142116;422.8055094656458;424.77911486027267;432.1680764528283;16068.598285042879;16387.59031024225;18016.729749053775;19100.140493677784;19636;18967.430977070675;19963.800361996375;19987.800121998775;20372.69440958387;20656.89671551644;5634.605577609559;5793.217915581385;5803.564732645069;5806.216160818278;5810.041343178371;4176.4570605821355;4280.3793449949735;5606.55147588192;6123.632582045091;6308.3060863305;6168;6242.063690446446;6259.0298503731765;6270.31026587075;6277.309495955441;5084;5155.329807125087;5189.7405129743365;5198.324217851655;5198.402183748861;4304.182205380967;4509.03055842992;4551.4083169188125;4551.977240113778;4556.020455602028;15535.223238838013;15687;15826.604334891605;15853.60365990848;15897.52307430779;2295.644175152854;2326.4649130700036;2349.788519033278;2370.928872133839;2374.3470545599926;11057.557697692082;11192.160587955854;11216.158788090926;11232.550697972072;11297.26567773092;1766.8144844791368;1830.5606654402848;1868.7103498957683;1892.7539419875466;1899.3637131560943;71106.64446677786;71800.6409967952;73080.26919730788;73355.63322183408;74020;7885.250901164381;7895.842083158304;7896.32881205104;7946.165652606509;7971.641276142587;9662.420254784736;9696.854547181798;9710.902890971;9722.513874306256;9723.465209413409;6189.164462797465;6211.192544969125;6293.213348331458;6299.496040316855;6309.652969086653;6454.225492940784;6472.3204063573585;6510.869782604322;6526.967365163144;6552.049952756824;3532.0640030391965;3556.6976806971697;3676.4522485221964;3682.2635472905527;3711.2391959648207;1246.2335663567023;1265.063852748959;1275.0628288208159;1276.24701426159;1331.4274861809322;525.1938274748243;568.0286709726414;568.835037839022;570.5264630356877;572.547687327007;11831.230969986924;13323;13461.663458413617;13687.178769273876;13804.585862424143;566.8724536979229;567.0303780535248;571.8627529392916;573.9397363276879;596.5496050481859;7171.533850299714;7270.600116993616;7312.305330993653;7371.078615173104;7435.070616172979;621361;633209;633955;635154;635623;85024.14975850162;89621;90033.09966900379;90263.54868225747;90918;597.7101105963604;622.3185611755121;622.6295354264206;622.7353374815776;623.4700504571169;12275.754484910072;12421.813672794735;12472.688182795502;12501.93749031249;12551.49794008266;37133.07167320839;37542.24915501729;37909.241815164096;38620.22759544737;38626.6137338623;49289;49871;50291;50929.490705092474;51021.7448912753;7294.817629559304;7443.330100291;7445;7461.253874612496;7461.925380746123;11031.39327336972;11405.942970285096;11934.582289619822;12078.456469459072;12492.43784029739;11735.882641173479;11812.468438920097;12085.818712719492;12089.39553022363;12096.092793040381;11352.927082501477;11577.189596728485;11910.940445298065;12010.519579216734;12202.267863928193;11932.343721095423;12002.879971200526;12026.27842329463;12111.818322725343;12179.695507612381;7784.455088143775;7806.804829879298;7867.095284042409;7902.051753789352;7914.327282181079;12100.757984840078;12285.75428491443;12292.508299667914;12363.93818030904;12385.071119666241 03:24:12 INFO - 2015-10-29 03:24:12,900 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1507.0279669613094;1625.219894450664;1879.7932227454983;2022.5954809038196;2023.1098316740643;9264.768380790483;10182.389056656606;10383.896161038387;10408.219383546237;10410;9840.557174927128;9932.900670993287;9965.352252103627;9968.401895886253;9997.3501722388;2121.2363549122306;2144;2383.2016274548046;2495.4634753527944;2531.4810463854865;2534.6958364996135;2568.961465578018;2570.6658134442496;2570.7429257074236;2575.163072001598;2487.676602041732;2506.6741323627903;2506.962395564059;2512.786413154884;2518.987405062972;2166.198506552578;2212.225720997654;2444.1811992982284;2481.1440053181623;2490.2653717153303;2449.546833835746;2471.7775400213886;2478.4051827561257;2569.0622922633106;2583.2121203033066;10492.160627149886;10571.577136914515;10600.734981625445;10604.416757078357;10604.57581696739;5910.054391297372;6005.3394126646035;6016.09758536223;6019.759209631653;6020.1872747179;3768.3970564709516;3802.3535998880257;3818.7517811342173;3916.8824935251987;3918.8432462701458;1140.4810811080938;1147.701597584634;1148.5692865175558;1165.3066425476827;1179.6225207933464;16269.18654067292;16284.75572866408;16294.75557866621;16329.59176020597;16362.754558681629;5213.452587478336;5252.080885844962;5290.947090529045;5298.97350513245;5305.787768489295;12623.116381853182;12721.300328482022;12733.617991460085;12743.681407964876;12745.044121690726;5853.912191317134;5910.320313163955;5912.054071348563;5913.852153696106;5937.881242375215;5287.7884884604955;5290.709011004355;5290.735463226823;5291.550218231493;5294.761735721825;4527.185106680763;4546.636269098464;4563.338315944169;4567.497575266718;4627.514111018295;1385.6051025457696;1385.8683425074603;1395.7138786548733;1399.090591115783;1414.2151106135987;1520.711064897666;1526.587821288246;1552.8369521200336;1557.7196104701263;1585.651156745514;9858.507074646239;9929.106380425796;9935.80128397428;9935.80128397428;9935.950320248352;519.6803965561153;523.6543881038497;1354.7696891528465;1390.844191503166;1405.6626409661812;7401.962990185015;7470.477066605394;7491.925080749123;7561.659725312375;7569.091708994846;13497.595072147851;13672.931635341958;13687.589372318846;13714.794278085838;13731.588052358446;13055.34723263852;13299.202047876965;13507.729845403233;13546.254955977516;13564.864351356557;9512.476813775309;9780.070893265129;9883.654072107585;9911.504424778876;9920.751981200383;9521.143097121292;9915.851262230928;9964.302498825013;9967.10296073357;9999.450030248116;11626.53493860236;11695.064394848221;11737.471813768572;11806.704832378915;11858.16992810495;11936.76126477483;12189.268643881041;12189.817152742893;12211.69470763238;12215.26708397499;9029.864552031857;9509;9511.286653500876;9517.476538790434;9525.333226674065;9817.754556136153;10404.68785936423;10412.32319899204;10447.111995480469;10448.425336606255;8410.074891762024;8887.866681999645;9470.195033422237;9619.230461563198;9720.368176068532;9230.953845230732;9343.486108264111;9358.344915856098;9383.108604682544;9430.056994300516;9473;9578.616855325708;9590.856137158087;9645.636818979396;9687;8634.654613815628;8686.218240358145;8698.826023479369;8704.695335663222;8704.91295087041;8332.6666933322;8495.830083398174;8541.871871921801;8542.103079176597;8546.78633034179 03:24:12 INFO - 2015-10-29 03:24:12,900 DEBUG : BROWSER_OUTPUT: |4;prototype.html;371.8586936963955;380.8267238406525;390.5762247960962;397.6381492841514;400.07582484460886;5940.079287710401;5971.671558064305;5990.101484777286;6001.789937352193;6066.4236897494775;5876.9118463223085;5975.163477113208;6014.067819487976;6018.157457955879;6018.9398106018925;4630.722156670602;4680.765961701918;4757.571818536331;4760.404949381327;4795.760211989404;4768.73771942543;4772.188727916263;4780.426348838127;4785.976070119645;4800.711957282557;4752.643551733617;4756.7383793891495;4758.881027974294;4760.85717428476;4771.069641419925;4751.833685820997;4760.047990401933;4764.118638051937;4769.046190761844;4770.045990801854;4148.211839750468;4149.460570125894;4190.979045104786;4192.706510544263;4197.433346498215;5623.690697011662;5630.690312032836;5651.208830763697;5661.065924122515;5676.2620859288445;5287.735613219362;5333;5378.946210537883;5472.179173124024;5472.206530053159;6284.811455656338;6285.088662143963;6288.496920246369;6292.024736165856;6304.432601065881;4473.060657261979;4494.797734101973;4500.594946454835;4514.9774251128865;4531.252343363341;6417.903731444032;6441.355864413568;6460.160179176724;6488.772892948771;6498.90251646221;4667.299905014207;4677.087967846237;4677.789499472532;4678.204705200056;4681.087187998308;4737.313089601988;4737.549932756383;4742;4742.099001189763;4746.976265118652;5399.730013499309;5403.8108666196495;5405.837824865261;5408.053590621704;5410.3507579090765;6266.874662506724;6361.268454127742;6373.936260637427;6450;6463.547551671432;1728.1791149204028;1758.78015248094;1759.3754217252947;1759.4018033868547;1759.9384021559183;1169.2107827216594;1191.440023189117;1212.0243204220687;1218.056006594896;1220.969475763113;6215.223097112861;6215.658138802319;6219.222597175353;6228;6233.594816336924;6600.60396376219;6605.372489613479;6608.00879868014;6619.86760264792;6620.9006864897065;6093.360197179232;6206.751729930752;6209.720562574695;6214.689265536705;6217.720202590895;3619.94570081449;3631.909202269964;3646.908827279339;3655.177585043344;3657.487951686766;6792.932070679329;6794.898076528856;6797.0823938767635;6801;6805.557638753465;6535.8366040848405;6738.258791532928;6759.932400675931;6764.56030358035;6766.221884483348;6428.678566071678;6681.231658359254;6761.594304341756;6788.117544719254;6793;6584;6591.571547849375;6599.076129341992;6601.438877695257;6601.834954125993;6512.283648798723;6517.055027020961;6525.3148419417175;6525.673716314261;6551.639659818565;6601.33986601336;6792.558483698544;6850.862982740217;6853.623050732258;6859.657017149222;4710.26990816424;4718.598919091778;4720.669553131385;4748.8100475981955;4750.239961606127;6643.634600097041;6686.966565167338;6687.899681504684;6689.665516724047;6690.69891854858;6358.014507751306;6451.032345148265;6461.0954466373805;6462.773802916875;6515.576487528296;6374.171357723466;6413.390727880844;6414.775482858077;6423.871522569616;6426.3573642635365;6381.266154392304;6389.52078594098;6397.168368112116;6399.64801935898;6402.775902843378;6417.807465776034;6534.444572211225;6537.313582073813;6549.148610680581;6563.507736919845;6390.90413643805;6392.232932048184;6394.23269207698;6398.200224971879;6404.103425520524 03:24:12 INFO - 2015-10-29 03:24:12,901 DEBUG : BROWSER_OUTPUT: |5;yui.html;842.8187939592987;877.1316396767203;916.761641973087;939.6664184214605;988.5304480371824;14413.495527656534;14526.491572794954;14806.18565978872;14816.407343706253;14949.701005979874;14181.858181418183;14218;14313.856861431408;14318.212498312589;14340.067895586806;777.0287141073658;778.0740918307224;940.9905900940988;947.1381043250643;947.767796889763;949.520492151466;950.9239260859115;955.5556666150238;956.0535070280407;959.0792838874654;986.8717066781309;987.9901200988006;994.9403035817874;997.820392329384;998.181491177235;805.5851236613149;808.1716240853143;992.4938281476427;996.9700908972742;1005.2159315733703;731.6561216228364;732.842438875639;732.9193788683241;733.0616810482537;734.9485536012481;13711.931440342734;13784.655383615389;13792.448302067905;13824.377902994389;13878.791818122736;12123.818142727867;12658.430130938905;12670.429830657551;12738.363081845871;12797.680057998532;10777.030067293903;10804;10875.564977400974;10946.124310055176;10990.285631434012;3674.0814796300924;3722.7021838252876;3727.403615421547;3742.4760533525055;3747.4191500317493;39962.80018599918;40561.391579126335;40586.39120413196;45179.548204517865;45213.32180017302;8001.079875814239;8006.519608823489;8019;8091.595420228965;8133.755987320272;12711.68220794469;12726.745465090646;12738.363081845871;12744.6813829655;12843.422046007952;7151.856962860714;7209.243029481934;7265.97745760274;7300.379467745195;7424.814379640552;4696.272077827942;4696.272077827942;4770.642201834807;4819.060283244804;4897.706137631753;3084.814911105341;3095.1024202981334;3107.37852429515;3115.688431156866;3119.641241257239;495.0890361734426;510.61193492944886;511;575.5740751843606;594.8750762339871;601.0623427453187;607.4836389069344;622.5362105231541;698.155232169081;723.2658851265969;8125.75622731319;8544.700935467228;8622.31021518277;8630.482171069756;8648.783780405414;582.4321286745474;718.6658203935195;722.989155162673;735.7572001239578;737.7749786315118;3658.926821463556;3738.420544815558;3763.6424539668687;3799.696024318048;3900.6294402031763;55896;57088.71455642778;57795.711021445466;58481.41518584845;58706.41293587095;47727;48243.276350854765;48285.758571207625;48366.27450588244;48381.75809120932;39803;40060.59939400569;40769.38845917313;42124.78937605354;42406.57593424088;8298.128696486781;8467.57662116904;8600.698975535826;8646.567671616269;8794.98857631355;28929.132126036253;29139.562906555995;29812.850935745184;29832.85083574568;30319.696803031686;39409.60590394174;39597.2080558393;40136;41679.374809377274;41801;8098.3116435103675;8166.142555031874;8361.080281168945;8386.077531471412;8492.532910689972;11886.108541859223;12087.469214120247;12114.333711645591;12180.390980450764;12217.633470995885;10690.144788416752;10806;11117.388543630179;11287.943560282147;11466.484008219484;10257.897131088259;10664.093552047852;10714;10898.346099234072;11185;9652.806943861224;10939.398333091756;11009.229353945148;11427.142964277546;11629.360385178896;9440.716778496657;9698.224142068477;9800.264980126662;9989.650362237287;10098.343607665478;9202.585883635118;9562.139407453362;9722.368046076983;9951.253655975976;9953 03:24:12 INFO - 2015-10-29 03:24:12,901 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:24:12 INFO - 2015-10-29 03:24:12,901 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:24:12 INFO - 2015-10-29 03:24:12,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,770 03:24:12 INFO - 2015-10-29 03:24:12,901 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:24:12 INFO - 2015-10-29 03:24:12,901 DEBUG : BROWSER_OUTPUT: __startTimestamp1446114252892__endTimestamp 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5673.81 Median:5886.74 stddev:646.52 (11.0%) stddev-sans-first:620.50 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: Values: 3274.6 3336.3 3364.2 3373.2 3388.3 5600.2 5601.8 5616.4 5619.4 5638.9 5630.7 5646.2 5698.7 5708.8 5725.1 4994.7 5049.9 5146.6 5151.5 5258.3 5171.1 5187.8 5191.1 5191.5 5192.4 5091.2 5135.2 5201.1 5212.8 5253.5 5252.1 5258.7 5262.5 5273.6 5286.9 4915.9 4981.0 5176.9 5191.5 5241.8 5404.1 5490.5 5547.1 5548.4 5555.1 6135.8 6158.7 6170.5 6180.5 6185.8 5965.5 6011.8 6034.9 6212.5 6215.5 5807.2 5825.7 5827.5 5831.5 5834.9 6265.6 6296.2 6301.0 6306.1 6310.3 5803.4 5856.6 5953.1 5990.5 6126.4 6112.7 6142.2 6146.3 6162.4 6181.6 6041.8 6053.0 6054.4 6065.9 6082.8 5807.7 5918.8 6003.7 6104.1 6110.7 4684.2 4685.8 4691.2 4694.8 4720.9 4185.3 4206.9 4207.1 4213.6 4229.1 5493.1 5573.4 5719.6 5787.7 5845.7 6117.6 6133.5 6152.5 6184.7 6198.5 5588.4 5864.6 5866.1 5872.5 5886.7 5237.5 5293.9 5336.3 5339.4 5358.1 6369.8 6392.2 6405.3 6406.2 6418.0 5980.2 6078.8 6220.3 6235.1 6242.3 6237.5 6350.8 6354.7 6373.0 6424.9 6048.5 6057.5 6060.6 6078.7 6080.5 6004.0 6055.8 6113.1 6134.9 6147.2 5966.5 6024.5 6033.1 6054.0 6071.6 6012.2 6013.9 6045.8 6052.3 6063.0 5605.8 5701.1 5843.5 5867.4 5959.6 5938.5 6022.9 6033.1 6057.2 6058.3 5884.3 5895.7 5899.0 5900.3 5903.1 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,902 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62319.42 Median:21468.21 stddev:118198.48 (550.6%) stddev-sans-first:118439.13 03:24:12 INFO - 2015-10-29 03:24:12,904 DEBUG : BROWSER_OUTPUT: Values: 568.1 597.3 601.7 623.1 626.1 44742.3 45162.5 45278.0 45285.5 45351.3 48534.0 49109.8 49220.8 49234.5 49282.5 7991.0 8084.2 9103.3 9255.2 10518.5 10799.9 10913.0 10918.2 10922.2 10940.3 10897.6 10983.5 11007.0 11008.8 11016.8 8250.1 8424.1 11098.9 11282.9 11319.3 10650.5 10802.0 10808.2 10810.1 10827.6 45751.8 46226.8 46229.3 46239.8 46284.5 3881.6 3947.0 3954.5 3967.3 4015.0 33924.7 34092.3 34278.0 34593.8 34601.7 3879.0 3911.2 4000.7 4014.4 4041.1 347871.0 350878.0 351729.0 351829.0 445085.0 54125.5 76264.0 77763.6 77809.6 77915.6 72964.0 73589.7 74002.3 74021.0 74054.0 17113.7 17131.0 17171.1 17189.9 17263.8 14174.5 14438.6 14467.6 14476.0 14483.1 22749.0 23174.4 23220.8 23231.4 23243.8 8663.3 8854.1 8863.3 8940.5 8944.8 1063.8 1101.6 1164.5 1185.8 1210.1 32588.8 32704.8 32967.8 33073.5 35855.2 1140.5 1151.3 1223.9 1246.3 1263.9 15306.9 16635.7 16720.2 18238.9 18428.3 539525.0 541747.0 542055.0 544511.0 546252.0 59432.0 59931.1 59945.4 60042.4 60187.7 1535.5 1535.7 1549.0 1550.4 1555.4 30695.7 32961.5 33200.0 34123.8 35619.6 56433.4 56880.4 56912.4 57003.4 57087.4 406462.0 408233.0 408645.0 409204.0 409755.0 30790.8 31910.6 31974.4 34359.3 37305.6 36952.3 39937.4 44020.0 44501.6 45238.8 38479.0 38616.0 39259.0 46654.5 47398.3 42675.1 43194.6 43370.8 43817.0 43915.1 40336.8 41286.2 47502.0 47598.8 47947.8 34383.5 38531.0 38761.2 39054.8 39472.6 29173.3 29400.6 29406.3 29482.9 29562.9 03:24:12 INFO - 2015-10-29 03:24:12,904 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,904 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31209.39 Median:4554.00 stddev:103587.05 (2274.6%) stddev-sans-first:103851.83 03:24:12 INFO - 2015-10-29 03:24:12,904 DEBUG : BROWSER_OUTPUT: Values: 419.4 421.2 422.8 424.8 432.2 16068.6 16387.6 18016.7 19100.1 19636.0 18967.4 19963.8 19987.8 20372.7 20656.9 5634.6 5793.2 5803.6 5806.2 5810.0 4176.5 4280.4 5606.6 6123.6 6308.3 6168.0 6242.1 6259.0 6270.3 6277.3 5084.0 5155.3 5189.7 5198.3 5198.4 4304.2 4509.0 4551.4 4552.0 4556.0 15535.2 15687.0 15826.6 15853.6 15897.5 2295.6 2326.5 2349.8 2370.9 2374.3 11057.6 11192.2 11216.2 11232.6 11297.3 1766.8 1830.6 1868.7 1892.8 1899.4 71106.6 71800.6 73080.3 73355.6 74020.0 7885.3 7895.8 7896.3 7946.2 7971.6 9662.4 9696.9 9710.9 9722.5 9723.5 6189.2 6211.2 6293.2 6299.5 6309.7 6454.2 6472.3 6510.9 6527.0 6552.0 3532.1 3556.7 3676.5 3682.3 3711.2 1246.2 1265.1 1275.1 1276.2 1331.4 525.2 568.0 568.8 570.5 572.5 11831.2 13323.0 13461.7 13687.2 13804.6 566.9 567.0 571.9 573.9 596.5 7171.5 7270.6 7312.3 7371.1 7435.1 621361.0 633209.0 633955.0 635154.0 635623.0 85024.1 89621.0 90033.1 90263.5 90918.0 597.7 622.3 622.6 622.7 623.5 12275.8 12421.8 12472.7 12501.9 12551.5 37133.1 37542.2 37909.2 38620.2 38626.6 49289.0 49871.0 50291.0 50929.5 51021.7 7294.8 7443.3 7445.0 7461.3 7461.9 11031.4 11405.9 11934.6 12078.5 12492.4 11735.9 11812.5 12085.8 12089.4 12096.1 11352.9 11577.2 11910.9 12010.5 12202.3 11932.3 12002.9 12026.3 12111.8 12179.7 7784.5 7806.8 7867.1 7902.1 7914.3 12100.8 12285.8 12292.5 12363.9 12385.1 03:24:12 INFO - 2015-10-29 03:24:12,906 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,906 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7302.19 Median:3175.80 stddev:4199.72 (132.2%) stddev-sans-first:4188.91 03:24:12 INFO - 2015-10-29 03:24:12,907 DEBUG : BROWSER_OUTPUT: Values: 1507.0 1625.2 1879.8 2022.6 2023.1 9264.8 10182.4 10383.9 10408.2 10410.0 9840.6 9932.9 9965.4 9968.4 9997.4 2121.2 2144.0 2383.2 2495.5 2531.5 2534.7 2569.0 2570.7 2570.7 2575.2 2487.7 2506.7 2507.0 2512.8 2519.0 2166.2 2212.2 2444.2 2481.1 2490.3 2449.5 2471.8 2478.4 2569.1 2583.2 10492.2 10571.6 10600.7 10604.4 10604.6 5910.1 6005.3 6016.1 6019.8 6020.2 3768.4 3802.4 3818.8 3916.9 3918.8 1140.5 1147.7 1148.6 1165.3 1179.6 16269.2 16284.8 16294.8 16329.6 16362.8 5213.5 5252.1 5290.9 5299.0 5305.8 12623.1 12721.3 12733.6 12743.7 12745.0 5853.9 5910.3 5912.1 5913.9 5937.9 5287.8 5290.7 5290.7 5291.6 5294.8 4527.2 4546.6 4563.3 4567.5 4627.5 1385.6 1385.9 1395.7 1399.1 1414.2 1520.7 1526.6 1552.8 1557.7 1585.7 9858.5 9929.1 9935.8 9935.8 9936.0 519.7 523.7 1354.8 1390.8 1405.7 7402.0 7470.5 7491.9 7561.7 7569.1 13497.6 13672.9 13687.6 13714.8 13731.6 13055.3 13299.2 13507.7 13546.3 13564.9 9512.5 9780.1 9883.7 9911.5 9920.8 9521.1 9915.9 9964.3 9967.1 9999.5 11626.5 11695.1 11737.5 11806.7 11858.2 11936.8 12189.3 12189.8 12211.7 12215.3 9029.9 9509.0 9511.3 9517.5 9525.3 9817.8 10404.7 10412.3 10447.1 10448.4 8410.1 8887.9 9470.2 9619.2 9720.4 9231.0 9343.5 9358.3 9383.1 9430.1 9473.0 9578.6 9590.9 9645.6 9687.0 8634.7 8686.2 8698.8 8704.7 8704.9 8332.7 8495.8 8541.9 8542.1 8546.8 03:24:12 INFO - 2015-10-29 03:24:12,907 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,908 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5399.51 Median:6150.06 stddev:1567.28 (25.5%) stddev-sans-first:1525.57 03:24:12 INFO - 2015-10-29 03:24:12,908 DEBUG : BROWSER_OUTPUT: Values: 371.9 380.8 390.6 397.6 400.1 5940.1 5971.7 5990.1 6001.8 6066.4 5876.9 5975.2 6014.1 6018.2 6018.9 4630.7 4680.8 4757.6 4760.4 4795.8 4768.7 4772.2 4780.4 4786.0 4800.7 4752.6 4756.7 4758.9 4760.9 4771.1 4751.8 4760.0 4764.1 4769.0 4770.0 4148.2 4149.5 4191.0 4192.7 4197.4 5623.7 5630.7 5651.2 5661.1 5676.3 5287.7 5333.0 5378.9 5472.2 5472.2 6284.8 6285.1 6288.5 6292.0 6304.4 4473.1 4494.8 4500.6 4515.0 4531.3 6417.9 6441.4 6460.2 6488.8 6498.9 4667.3 4677.1 4677.8 4678.2 4681.1 4737.3 4737.5 4742.0 4742.1 4747.0 5399.7 5403.8 5405.8 5408.1 5410.4 6266.9 6361.3 6373.9 6450.0 6463.5 1728.2 1758.8 1759.4 1759.4 1759.9 1169.2 1191.4 1212.0 1218.1 1221.0 6215.2 6215.7 6219.2 6228.0 6233.6 6600.6 6605.4 6608.0 6619.9 6620.9 6093.4 6206.8 6209.7 6214.7 6217.7 3619.9 3631.9 3646.9 3655.2 3657.5 6792.9 6794.9 6797.1 6801.0 6805.6 6535.8 6738.3 6759.9 6764.6 6766.2 6428.7 6681.2 6761.6 6788.1 6793.0 6584.0 6591.6 6599.1 6601.4 6601.8 6512.3 6517.1 6525.3 6525.7 6551.6 6601.3 6792.6 6850.9 6853.6 6859.7 4710.3 4718.6 4720.7 4748.8 4750.2 6643.6 6687.0 6687.9 6689.7 6690.7 6358.0 6451.0 6461.1 6462.8 6515.6 6374.2 6413.4 6414.8 6423.9 6426.4 6381.3 6389.5 6397.2 6399.6 6402.8 6417.8 6534.4 6537.3 6549.1 6563.5 6390.9 6392.2 6394.2 6398.2 6404.1 03:24:12 INFO - 2015-10-29 03:24:12,908 DEBUG : BROWSER_OUTPUT: 03:24:12 INFO - 2015-10-29 03:24:12,909 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12943.00 Median:26531.17 stddev:14717.41 (55.5%) stddev-sans-first:14730.64 03:24:12 INFO - 2015-10-29 03:24:12,910 DEBUG : BROWSER_OUTPUT: Values: 842.8 877.1 916.8 939.7 988.5 14413.5 14526.5 14806.2 14816.4 14949.7 14181.9 14218.0 14313.9 14318.2 14340.1 777.0 778.1 941.0 947.1 947.8 949.5 950.9 955.6 956.1 959.1 986.9 988.0 994.9 997.8 998.2 805.6 808.2 992.5 997.0 1005.2 731.7 732.8 732.9 733.1 734.9 13711.9 13784.7 13792.4 13824.4 13878.8 12123.8 12658.4 12670.4 12738.4 12797.7 10777.0 10804.0 10875.6 10946.1 10990.3 3674.1 3722.7 3727.4 3742.5 3747.4 39962.8 40561.4 40586.4 45179.5 45213.3 8001.1 8006.5 8019.0 8091.6 8133.8 12711.7 12726.7 12738.4 12744.7 12843.4 7151.9 7209.2 7266.0 7300.4 7424.8 4696.3 4696.3 4770.6 4819.1 4897.7 3084.8 3095.1 3107.4 3115.7 3119.6 495.1 510.6 511.0 575.6 594.9 601.1 607.5 622.5 698.2 723.3 8125.8 8544.7 8622.3 8630.5 8648.8 582.4 718.7 723.0 735.8 737.8 3658.9 3738.4 3763.6 3799.7 3900.6 55896.0 57088.7 57795.7 58481.4 58706.4 47727.0 48243.3 48285.8 48366.3 48381.8 39803.0 40060.6 40769.4 42124.8 42406.6 8298.1 8467.6 8600.7 8646.6 8795.0 28929.1 29139.6 29812.9 29832.9 30319.7 39409.6 39597.2 40136.0 41679.4 41801.0 8098.3 8166.1 8361.1 8386.1 8492.5 11886.1 12087.5 12114.3 12180.4 12217.6 10690.1 10806.0 11117.4 11287.9 11466.5 10257.9 10664.1 10714.0 10898.3 11185.0 9652.8 10939.4 11009.2 11427.1 11629.4 9440.7 9698.2 9800.3 9989.7 10098.3 9202.6 9562.1 9722.4 9951.3 9953.0 03:24:12 INFO - 2015-10-29 03:24:12,910 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:24:12 INFO - 2015-10-29 03:24:12,910 DEBUG : BROWSER_OUTPUT: 03:24:13 INFO - 2015-10-29 03:24:13,461 INFO : Browser exited with error code: 0 03:24:13 INFO - 2015-10-29 03:24:13,482 INFO : Completed test dromaeo_css (00:18:32) 03:24:13 INFO - 2015-10-29 03:24:13,482 INFO : Starting test kraken 03:24:13 INFO - 2015-10-29 03:24:13,482 DEBUG : operating with platform_type : linux_ 03:24:13 INFO - 2015-10-29 03:24:13,482 INFO : Initialising browser for kraken test... 03:24:13 INFO - 2015-10-29 03:24:13,488 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPMTp1q/profile http://localhost/getInfo.html 03:24:16 INFO - 2015-10-29 03:24:16,866 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:24:16 INFO - 2015-10-29 03:24:16,866 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:24:16 INFO - 2015-10-29 03:24:16,866 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:24:16 INFO - 2015-10-29 03:24:16,866 DEBUG : BROWSER_OUTPUT: __metrics 03:24:16 INFO - 2015-10-29 03:24:16,995 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:24:18 INFO - 2015-10-29 03:24:18,108 INFO : Browser initialized. 03:24:18 INFO - 2015-10-29 03:24:18,108 INFO : Running cycle 1/1 for kraken test... 03:24:18 INFO - 2015-10-29 03:24:18,109 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPMTp1q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:24:29 INFO - 2015-10-29 03:24:29,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 132902912 03:24:29 INFO - 2015-10-29 03:24:29,840 DEBUG : BROWSER_OUTPUT: 03:24:32 INFO - 2015-10-29 03:24:32,730 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:24:33 INFO - 2015-10-29 03:24:33,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 165679104 03:24:33 INFO - 2015-10-29 03:24:33,303 DEBUG : BROWSER_OUTPUT: 03:24:35 INFO - 2015-10-29 03:24:35,820 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:24:36 INFO - 2015-10-29 03:24:36,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 163110912 03:24:36 INFO - 2015-10-29 03:24:36,393 DEBUG : BROWSER_OUTPUT: 03:24:39 INFO - 2015-10-29 03:24:39,156 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:24:39 INFO - 2015-10-29 03:24:39,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 162721792 03:24:39 INFO - 2015-10-29 03:24:39,723 DEBUG : BROWSER_OUTPUT: 03:24:41 INFO - 2015-10-29 03:24:41,655 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:24:42 INFO - 2015-10-29 03:24:42,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 160948224 03:24:42 INFO - 2015-10-29 03:24:42,216 DEBUG : BROWSER_OUTPUT: 03:24:44 INFO - 2015-10-29 03:24:44,334 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:24:44 INFO - 2015-10-29 03:24:44,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 155828224 03:24:44 INFO - 2015-10-29 03:24:44,896 DEBUG : BROWSER_OUTPUT: 03:24:47 INFO - 2015-10-29 03:24:47,758 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:24:48 INFO - 2015-10-29 03:24:48,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 155381760 03:24:48 INFO - 2015-10-29 03:24:48,324 DEBUG : BROWSER_OUTPUT: 03:24:51 INFO - 2015-10-29 03:24:51,610 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:24:52 INFO - 2015-10-29 03:24:52,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 155893760 03:24:52 INFO - 2015-10-29 03:24:52,180 DEBUG : BROWSER_OUTPUT: 03:24:54 INFO - 2015-10-29 03:24:54,845 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:24:55 INFO - 2015-10-29 03:24:55,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 157040640 03:24:55 INFO - 2015-10-29 03:24:55,411 DEBUG : BROWSER_OUTPUT: 03:24:56 INFO - 2015-10-29 03:24:56,905 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:24:57 INFO - 2015-10-29 03:24:57,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 164171776 03:24:57 INFO - 2015-10-29 03:24:57,467 DEBUG : BROWSER_OUTPUT: 03:24:59 INFO - 2015-10-29 03:24:59,168 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:24:59 INFO - 2015-10-29 03:24:59,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 163561472 03:24:59 INFO - 2015-10-29 03:24:59,761 DEBUG : BROWSER_OUTPUT: 03:25:01 INFO - 2015-10-29 03:25:01,699 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:25:02 INFO - 2015-10-29 03:25:02,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 172314624 03:25:02 INFO - 2015-10-29 03:25:02,265 DEBUG : BROWSER_OUTPUT: 03:25:04 INFO - 2015-10-29 03:25:04,539 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:25:05 INFO - 2015-10-29 03:25:05,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 178327552 03:25:05 INFO - 2015-10-29 03:25:05,108 DEBUG : BROWSER_OUTPUT: 03:25:07 INFO - 2015-10-29 03:25:07,509 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:25:08 INFO - 2015-10-29 03:25:08,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 177684480 03:25:08 INFO - 2015-10-29 03:25:08,082 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,676 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:25:09 INFO - 2015-10-29 03:25:09,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 235773952 03:25:09 INFO - 2015-10-29 03:25:09,926 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,926 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:25:09 INFO - 2015-10-29 03:25:09,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:25:09 INFO - 2015-10-29 03:25:09,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;108;110;110;109;109;116;109;109;109 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;120;144;160;122;154;153;122;159;124 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;160;160;162;159;160;159;162;159 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;71;138;71;72;72;70;150;71 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;87;87;130;94;88;87;131;87;88;129 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;109;110;109;109;109;110 03:25:09 INFO - 2015-10-29 03:25:09,927 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;145;147;146;145;146;145 03:25:09 INFO - 2015-10-29 03:25:09,928 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;97;95;97;96;96;95 03:25:09 INFO - 2015-10-29 03:25:09,928 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;53;51;52;55;52;53;54;68;53 03:25:09 INFO - 2015-10-29 03:25:09,928 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;61;60;60;60;60;60;61;60;61 03:25:09 INFO - 2015-10-29 03:25:09,928 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;78;78;79;79;79;78;79;78;79 03:25:09 INFO - 2015-10-29 03:25:09,928 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;105;113;110;105;111;104;115;113;121;111 03:25:09 INFO - 2015-10-29 03:25:09,928 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;135;134;133;135;137;135;135;135;134 03:25:09 INFO - 2015-10-29 03:25:09,928 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;60;62;62;62;60;61;59;71;60 03:25:09 INFO - 2015-10-29 03:25:09,929 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:25:09 INFO - 2015-10-29 03:25:09,929 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:25:09 INFO - 2015-10-29 03:25:09,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,871 03:25:09 INFO - 2015-10-29 03:25:09,929 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:25:09 INFO - 2015-10-29 03:25:09,929 DEBUG : BROWSER_OUTPUT: __startTimestamp1446114309925__endTimestamp 03:25:09 INFO - 2015-10-29 03:25:09,929 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:109.00 stddev:2.55 (2.3%) stddev-sans-first:2.37 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: Values: 106.0 108.0 110.0 110.0 109.0 109.0 116.0 109.0 109.0 109.0 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:150.00 stddev:16.64 (11.1%) stddev-sans-first:17.48 03:25:09 INFO - 2015-10-29 03:25:09,933 DEBUG : BROWSER_OUTPUT: Values: 147.0 120.0 144.0 160.0 122.0 154.0 153.0 122.0 159.0 124.0 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 160.0 160.0 162.0 159.0 160.0 159.0 162.0 159.0 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.80 Median:71.00 stddev:30.81 (43.4%) stddev-sans-first:32.21 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 138.0 71.0 72.0 72.0 70.0 150.0 71.0 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,934 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.80 Median:87.00 stddev:20.26 (23.3%) stddev-sans-first:20.87 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: Values: 87.0 87.0 130.0 94.0 88.0 87.0 131.0 87.0 88.0 129.0 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 145.0 147.0 146.0 145.0 146.0 145.0 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 97.0 95.0 97.0 96.0 96.0 95.0 03:25:09 INFO - 2015-10-29 03:25:09,935 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.60 Median:53.50 stddev:4.88 (9.1%) stddev-sans-first:5.17 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: Values: 55.0 53.0 51.0 52.0 55.0 52.0 53.0 54.0 68.0 53.0 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 61.0 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.53 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 78.0 79.0 79.0 79.0 78.0 79.0 78.0 79.0 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,936 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:110.80 Median:112.00 stddev:5.22 (4.7%) stddev-sans-first:5.10 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: Values: 105.0 113.0 110.0 105.0 111.0 104.0 115.0 113.0 121.0 111.0 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:135.00 stddev:3.70 (2.7%) stddev-sans-first:1.09 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: Values: 146.0 135.0 134.0 133.0 135.0 137.0 135.0 135.0 135.0 134.0 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:61.50 stddev:3.39 (5.5%) stddev-sans-first:3.59 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 62.0 62.0 62.0 60.0 61.0 59.0 71.0 60.0 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:25:09 INFO - 2015-10-29 03:25:09,937 DEBUG : BROWSER_OUTPUT: 03:25:10 INFO - 2015-10-29 03:25:10,737 INFO : Browser exited with error code: 0 03:25:10 INFO - 2015-10-29 03:25:10,787 INFO : Completed test kraken (00:00:57) 03:25:10 INFO - 2015-10-29 03:25:10,787 INFO : Starting test v8_7 03:25:10 INFO - 2015-10-29 03:25:10,787 DEBUG : operating with platform_type : linux_ 03:25:10 INFO - 2015-10-29 03:25:10,787 INFO : Initialising browser for v8_7 test... 03:25:10 INFO - 2015-10-29 03:25:10,793 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfAP2Hs/profile http://localhost/getInfo.html 03:25:14 INFO - 2015-10-29 03:25:14,150 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:25:14 INFO - 2015-10-29 03:25:14,150 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:25:14 INFO - 2015-10-29 03:25:14,150 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:25:14 INFO - 2015-10-29 03:25:14,150 DEBUG : BROWSER_OUTPUT: __metrics 03:25:14 INFO - 2015-10-29 03:25:14,247 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:25:15 INFO - 2015-10-29 03:25:15,412 INFO : Browser initialized. 03:25:15 INFO - 2015-10-29 03:25:15,413 INFO : Running cycle 1/1 for v8_7 test... 03:25:15 INFO - 2015-10-29 03:25:15,413 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfAP2Hs/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:25:26 INFO - 2015-10-29 03:25:26,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 131649536 03:25:26 INFO - 2015-10-29 03:25:26,973 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,411 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:25:48 INFO - 2015-10-29 03:25:48,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 427122688 03:25:48 INFO - 2015-10-29 03:25:48,662 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,663 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:25:48 INFO - 2015-10-29 03:25:48,663 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:25:48 INFO - 2015-10-29 03:25:48,664 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:25:48 INFO - 2015-10-29 03:25:48,664 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:25:48 INFO - 2015-10-29 03:25:48,664 DEBUG : BROWSER_OUTPUT: |0;Richards;168.35016835016836 03:25:48 INFO - 2015-10-29 03:25:48,664 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.9620587264929 03:25:48 INFO - 2015-10-29 03:25:48,664 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.61081385525205 03:25:48 INFO - 2015-10-29 03:25:48,664 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5091.370558375635 03:25:48 INFO - 2015-10-29 03:25:48,664 DEBUG : BROWSER_OUTPUT: |4;RayTrace;964.3201542912246 03:25:48 INFO - 2015-10-29 03:25:48,665 DEBUG : BROWSER_OUTPUT: |5;Earley;538.2131324004306 03:25:48 INFO - 2015-10-29 03:25:48,665 DEBUG : BROWSER_OUTPUT: |6;Boyer;10214.285714285714 03:25:48 INFO - 2015-10-29 03:25:48,665 DEBUG : BROWSER_OUTPUT: |7;RegExp;23045.454545454544 03:25:48 INFO - 2015-10-29 03:25:48,665 DEBUG : BROWSER_OUTPUT: |8;Splay;525.4860746190226 03:25:48 INFO - 2015-10-29 03:25:48,666 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 03:25:48 INFO - 2015-10-29 03:25:48,666 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:25:48 INFO - 2015-10-29 03:25:48,666 DEBUG : BROWSER_OUTPUT: __startTimestamp1446114348661__endTimestamp 03:25:48 INFO - 2015-10-29 03:25:48,666 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,666 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:25:48 INFO - 2015-10-29 03:25:48,666 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:25:48 INFO - 2015-10-29 03:25:48,667 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,667 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.35 Median:168.35 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,667 DEBUG : BROWSER_OUTPUT: Values: 168.4 03:25:48 INFO - 2015-10-29 03:25:48,667 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,667 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.96 Median:164.96 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,668 DEBUG : BROWSER_OUTPUT: Values: 165.0 03:25:48 INFO - 2015-10-29 03:25:48,668 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,668 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.61 Median:281.61 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,668 DEBUG : BROWSER_OUTPUT: Values: 281.6 03:25:48 INFO - 2015-10-29 03:25:48,668 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,668 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5091.37 Median:5091.37 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,669 DEBUG : BROWSER_OUTPUT: Values: 5091.4 03:25:48 INFO - 2015-10-29 03:25:48,669 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,669 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:964.32 Median:964.32 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,669 DEBUG : BROWSER_OUTPUT: Values: 964.3 03:25:48 INFO - 2015-10-29 03:25:48,669 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,669 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:538.21 Median:538.21 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,670 DEBUG : BROWSER_OUTPUT: Values: 538.2 03:25:48 INFO - 2015-10-29 03:25:48,670 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,670 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10214.29 Median:10214.29 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,670 DEBUG : BROWSER_OUTPUT: Values: 10214.3 03:25:48 INFO - 2015-10-29 03:25:48,670 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,670 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23045.45 Median:23045.45 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: Values: 23045.5 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.49 Median:525.49 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: Values: 525.5 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: Values: 4822.1 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:25:48 INFO - 2015-10-29 03:25:48,671 DEBUG : BROWSER_OUTPUT: 03:25:49 INFO - 2015-10-29 03:25:49,469 INFO : Browser exited with error code: 0 03:25:49 INFO - 2015-10-29 03:25:49,488 INFO : Completed test v8_7 (00:00:38) 03:25:49 INFO - 2015-10-29 03:25:49,488 INFO : Completed test suite (00:20:08) 03:25:49 INFO - 2015-10-29 03:25:49,488 DEBUG : Working with test: dromaeo_css 03:25:49 INFO - 2015-10-29 03:25:49,488 DEBUG : Generating results file: dromaeo_css 03:25:49 INFO - 2015-10-29 03:25:49,489 DEBUG : Working with test: kraken 03:25:49 INFO - 2015-10-29 03:25:49,489 DEBUG : Generating results file: kraken 03:25:49 INFO - 2015-10-29 03:25:49,490 INFO : javascript benchmark 03:25:49 INFO - 2015-10-29 03:25:49,490 DEBUG : Working with test: v8_7 03:25:49 INFO - 2015-10-29 03:25:49,490 DEBUG : Generating results file: v8_7 03:25:49 INFO - 2015-10-29 03:25:49,490 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:25:49 INFO - 2015-10-29 03:25:49,622 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:25:49 INFO - 2015-10-29 03:25:49,622 DEBUG : process_Request line: dromaeo_css 7440.58 graph.html#tests=[[72,52,35]] 03:25:49 INFO - 2015-10-29 03:25:49,622 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:25:49 INFO - 2015-10-29 03:25:49,732 DEBUG : process_Request line: kraken 1449.20 graph.html#tests=[[232,52,35]] 03:25:49 INFO - 2015-10-29 03:25:49,732 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:25:49 INFO - 2015-10-29 03:25:49,845 DEBUG : process_Request line: v8_7 23455.18 graph.html#tests=[[230,52,35]] 03:25:49 INFO - 2015-10-29 03:25:49,848 INFO : javascript benchmark 03:25:49 INFO - 2015-10-29 03:25:49,852 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [419.36256889527937, 421.2459697142116, 422.8055094656458, 424.77911486027267, 432.1680764528283, 16068.598285042879, 16387.59031024225, 18016.729749053775, 19100.140493677784, 19636.0, 18967.430977070675, 19963.800361996375, 19987.800121998775, 20372.69440958387, 20656.89671551644, 5634.605577609559, 5793.217915581385, 5803.564732645069, 5806.216160818278, 5810.041343178371, 4176.4570605821355, 4280.3793449949735, 5606.55147588192, 6123.632582045091, 6308.3060863305, 6168.0, 6242.063690446446, 6259.0298503731765, 6270.31026587075, 6277.309495955441, 5084.0, 5155.329807125087, 5189.7405129743365, 5198.324217851655, 5198.402183748861, 4304.182205380967, 4509.03055842992, 4551.4083169188125, 4551.977240113778, 4556.020455602028, 15535.223238838013, 15687.0, 15826.604334891605, 15853.60365990848, 15897.52307430779, 2295.644175152854, 2326.4649130700036, 2349.788519033278, 2370.928872133839, 2374.3470545599926, 11057.557697692082, 11192.160587955854, 11216.158788090926, 11232.550697972072, 11297.26567773092, 1766.8144844791368, 1830.5606654402848, 1868.7103498957683, 1892.7539419875466, 1899.3637131560943, 71106.64446677786, 71800.6409967952, 73080.26919730788, 73355.63322183408, 74020.0, 7885.250901164381, 7895.842083158304, 7896.32881205104, 7946.165652606509, 7971.641276142587, 9662.420254784736, 9696.854547181798, 9710.902890971, 9722.513874306256, 9723.465209413409, 6189.164462797465, 6211.192544969125, 6293.213348331458, 6299.496040316855, 6309.652969086653, 6454.225492940784, 6472.3204063573585, 6510.869782604322, 6526.967365163144, 6552.049952756824, 3532.0640030391965, 3556.6976806971697, 3676.4522485221964, 3682.2635472905527, 3711.2391959648207, 1246.2335663567023, 1265.063852748959, 1275.0628288208159, 1276.24701426159, 1331.4274861809322, 525.1938274748243, 568.0286709726414, 568.835037839022, 570.5264630356877, 572.547687327007, 11831.230969986924, 13323.0, 13461.663458413617, 13687.178769273876, 13804.585862424143, 566.8724536979229, 567.0303780535248, 571.8627529392916, 573.9397363276879, 596.5496050481859, 7171.533850299714, 7270.600116993616, 7312.305330993653, 7371.078615173104, 7435.070616172979, 621361.0, 633209.0, 633955.0, 635154.0, 635623.0, 85024.14975850162, 89621.0, 90033.09966900379, 90263.54868225747, 90918.0, 597.7101105963604, 622.3185611755121, 622.6295354264206, 622.7353374815776, 623.4700504571169, 12275.754484910072, 12421.813672794735, 12472.688182795502, 12501.93749031249, 12551.49794008266, 37133.07167320839, 37542.24915501729, 37909.241815164096, 38620.22759544737, 38626.6137338623, 49289.0, 49871.0, 50291.0, 50929.490705092474, 51021.7448912753, 7294.817629559304, 7443.330100291, 7445.0, 7461.253874612496, 7461.925380746123, 11031.39327336972, 11405.942970285096, 11934.582289619822, 12078.456469459072, 12492.43784029739, 11735.882641173479, 11812.468438920097, 12085.818712719492, 12089.39553022363, 12096.092793040381, 11352.927082501477, 11577.189596728485, 11910.940445298065, 12010.519579216734, 12202.267863928193, 11932.343721095423, 12002.879971200526, 12026.27842329463, 12111.818322725343, 12179.695507612381, 7784.455088143775, 7806.804829879298, 7867.095284042409, 7902.051753789352, 7914.327282181079, 12100.757984840078, 12285.75428491443, 12292.508299667914, 12363.93818030904, 12385.071119666241], "dojo.html": [3274.574305340306, 3336.2660214752746, 3364.1589602599333, 3373.2241584435596, 3388.3223355328923, 5600.215969764226, 5601.795613943002, 5616.410276920926, 5619.381867994517, 5638.8590285242835, 5630.71846407679, 5646.20953066571, 5698.658080515162, 5708.800191993281, 5725.112607545837, 4994.650374473788, 5049.949500505003, 5146.588272938156, 5151.536361727443, 5258.290130832327, 5171.09505836479, 5187.766550505217, 5191.143461328877, 5191.480851914816, 5192.428832828386, 5091.185410334348, 5135.1526998045465, 5201.141811601081, 5212.817551385702, 5253.527182553569, 5252.054630166568, 5258.737063146866, 5262.500062494057, 5273.578113750891, 5286.894262114736, 4915.877103072416, 4980.975095124538, 5176.912848301861, 5191.506806853343, 5241.79032838686, 5404.135338345845, 5490.450954904518, 5547.084731019377, 5548.4174161712845, 5555.138953462219, 6135.785247516315, 6158.692065396713, 6170.475509581691, 6180.474659653934, 6185.783497577609, 5965.4929331006915, 6011.819645410645, 6034.939650603482, 6212.534059945522, 6215.533834962396, 5807.157962095514, 5825.650460972398, 5827.533797296206, 5831.504322132624, 5834.949709052369, 6265.624062556261, 6296.244450665858, 6300.9684951574945, 6306.1171435998995, 6310.274318453345, 5803.390643982406, 5856.59003869725, 5953.136795164677, 5990.4908082813445, 6126.386638414559, 6112.724927378279, 6142.170806941095, 6146.262448506208, 6162.383761623802, 6181.609137943927, 6041.818745437644, 6052.969735151296, 6054.424829641177, 6065.939340606626, 6082.756689732361, 5807.709614519257, 5918.763249470059, 6003.6998150093195, 6104.053871649901, 6110.694465276719, 4684.203685373494, 4685.765711714401, 4691.1555919934735, 4694.835680751157, 4720.858374248778, 4185.330347144442, 4206.8737937861915, 4207.074443622399, 4213.641840443535, 4229.069604687025, 5493.09363954943, 5573.359063707644, 5719.628224165416, 5787.739551720183, 5845.707714614337, 6117.571769976148, 6133.478654314434, 6152.538559608047, 6184.721687524072, 6198.535109866688, 5588.357338905997, 5864.648121112747, 5866.12008198765, 5872.471477567039, 5886.735096920649, 5237.502437268454, 5293.920591191135, 5336.252924590561, 5339.439358867341, 5358.11591087474, 6369.808905732835, 6392.20097487814, 6405.29541750407, 6406.199225096863, 6418.037294405876, 5980.222571065734, 6078.817635470943, 6220.315765265907, 6235.095911092957, 6242.313345531897, 6237.5321850860455, 6350.7777227796805, 6354.714037868214, 6372.968135159294, 6424.935750642434, 6048.5161187105805, 6057.4851137653795, 6060.636361818305, 6078.665673388006, 6080.513558915188, 6004.0, 6055.757769689163, 6113.144159817718, 6134.938650613437, 6147.200863887845, 5966.522678185822, 6024.487918526975, 6033.095035744674, 6054.0, 6071.574989750675, 6012.248468941382, 6013.879722405615, 6045.848853778515, 6052.334243233153, 6063.0, 5605.775768969195, 5701.059325211294, 5843.532517398683, 5867.354590994902, 5959.553033522417, 5938.495227905676, 6022.90965635507, 6033.064874944391, 6057.182280392267, 6058.333583305921, 5884.264466941632, 5895.7052147391605, 5899.026660600953, 5900.291964964232, 5903.0555111182], "mootools.html": [1507.0279669613094, 1625.219894450664, 1879.7932227454983, 2022.5954809038196, 2023.1098316740643, 9264.768380790483, 10182.389056656606, 10383.896161038387, 10408.219383546237, 10410.0, 9840.557174927128, 9932.900670993287, 9965.352252103627, 9968.401895886253, 9997.3501722388, 2121.2363549122306, 2144.0, 2383.2016274548046, 2495.4634753527944, 2531.4810463854865, 2534.6958364996135, 2568.961465578018, 2570.6658134442496, 2570.7429257074236, 2575.163072001598, 2487.676602041732, 2506.6741323627903, 2506.962395564059, 2512.786413154884, 2518.987405062972, 2166.198506552578, 2212.225720997654, 2444.1811992982284, 2481.1440053181623, 2490.2653717153303, 2449.546833835746, 2471.7775400213886, 2478.4051827561257, 2569.0622922633106, 2583.2121203033066, 10492.160627149886, 10571.577136914515, 10600.734981625445, 10604.416757078357, 10604.57581696739, 5910.054391297372, 6005.3394126646035, 6016.09758536223, 6019.759209631653, 6020.1872747179, 3768.3970564709516, 3802.3535998880257, 3818.7517811342173, 3916.8824935251987, 3918.8432462701458, 1140.4810811080938, 1147.701597584634, 1148.5692865175558, 1165.3066425476827, 1179.6225207933464, 16269.18654067292, 16284.75572866408, 16294.75557866621, 16329.59176020597, 16362.754558681629, 5213.452587478336, 5252.080885844962, 5290.947090529045, 5298.97350513245, 5305.787768489295, 12623.116381853182, 12721.300328482022, 12733.617991460085, 12743.681407964876, 12745.044121690726, 5853.912191317134, 5910.320313163955, 5912.054071348563, 5913.852153696106, 5937.881242375215, 5287.7884884604955, 5290.709011004355, 5290.735463226823, 5291.550218231493, 5294.761735721825, 4527.185106680763, 4546.636269098464, 4563.338315944169, 4567.497575266718, 4627.514111018295, 1385.6051025457696, 1385.8683425074603, 1395.7138786548733, 1399.090591115783, 1414.2151106135987, 1520.711064897666, 1526.587821288246, 1552.8369521200336, 1557.7196104701263, 1585.651156745514, 9858.507074646239, 9929.106380425796, 9935.80128397428, 9935.80128397428, 9935.950320248352, 519.6803965561153, 523.6543881038497, 1354.7696891528465, 1390.844191503166, 1405.6626409661812, 7401.962990185015, 7470.477066605394, 7491.925080749123, 7561.659725312375, 7569.091708994846, 13497.595072147851, 13672.931635341958, 13687.589372318846, 13714.794278085838, 13731.588052358446, 13055.34723263852, 13299.202047876965, 13507.729845403233, 13546.254955977516, 13564.864351356557, 9512.476813775309, 9780.070893265129, 9883.654072107585, 9911.504424778876, 9920.751981200383, 9521.143097121292, 9915.851262230928, 9964.302498825013, 9967.10296073357, 9999.450030248116, 11626.53493860236, 11695.064394848221, 11737.471813768572, 11806.704832378915, 11858.16992810495, 11936.76126477483, 12189.268643881041, 12189.817152742893, 12211.69470763238, 12215.26708397499, 9029.864552031857, 9509.0, 9511.286653500876, 9517.476538790434, 9525.333226674065, 9817.754556136153, 10404.68785936423, 10412.32319899204, 10447.111995480469, 10448.425336606255, 8410.074891762024, 8887.866681999645, 9470.195033422237, 9619.230461563198, 9720.368176068532, 9230.953845230732, 9343.486108264111, 9358.344915856098, 9383.108604682544, 9430.056994300516, 9473.0, 9578.616855325708, 9590.856137158087, 9645.636818979396, 9687.0, 8634.654613815628, 8686.218240358145, 8698.826023479369, 8704.695335663222, 8704.91295087041, 8332.6666933322, 8495.830083398174, 8541.871871921801, 8542.103079176597, 8546.78633034179], "ext.html": [568.0634716252295, 597.259398346051, 601.6510423954105, 623.1182876230134, 626.1077963901439, 44742.32886506701, 45162.548374516286, 45278.0, 45285.547144528544, 45351.319730204035, 48534.0, 49109.754451227695, 49220.753896230555, 49234.52296431113, 49282.50717492824, 7991.041075071, 8084.231997960213, 9103.317251206154, 9255.213306868924, 10518.474076296194, 10799.892001080007, 10913.0, 10918.181136414762, 10922.18083643726, 10940.343579385222, 10897.564097436092, 10983.505742241618, 11007.0, 11008.834867476955, 11016.834747478793, 8250.051244106915, 8424.115467875878, 11098.944505277423, 11282.94358528202, 11319.264247823947, 10650.520726567245, 10802.027817496384, 10808.243422960395, 10810.081143102845, 10827.621033263877, 45751.77124114358, 46226.76886615579, 46229.30656040129, 46239.76880115612, 46284.5371546287, 3881.6118388160958, 3946.980265098656, 3954.485916830822, 3967.327887981321, 4014.959850401488, 33924.660753392396, 34092.31815363679, 34278.0, 34593.82703086468, 34601.653983460346, 3878.9612103879163, 3911.178652482982, 4000.719949603529, 4014.417909403149, 4041.1109555897656, 347871.0, 350878.0, 351729.0, 351829.0, 445084.99999999674, 54125.45874541204, 76264.0, 77763.61118194372, 77809.61095194488, 77915.61042194752, 72964.0, 73589.68846401924, 74002.25997740061, 74021.0, 74054.0, 17113.657726845395, 17131.0, 17171.055591942564, 17189.914050429918, 17263.827361726475, 14174.503892363718, 14438.639034024234, 14467.638309042148, 14476.0, 14483.0586011911, 22749.0, 23174.42063948415, 23220.76779232186, 23231.419214519774, 23243.76756232416, 8663.263622592025, 8854.070322616033, 8863.335249856287, 8940.50827204497, 8944.776380590407, 1063.8457423673524, 1101.5979167603928, 1164.5109054197258, 1185.8339832423467, 1210.056156198167, 32588.83705581457, 32704.83647581747, 32967.83516082452, 33073.50389744156, 35855.17655882908, 1140.5095808802296, 1151.3034614058543, 1223.932683702405, 1246.2771592476342, 1263.9368031598383, 15306.923465382602, 16635.66728665444, 16720.247588858532, 18238.90880545589, 18428.262869485072, 539525.0, 541747.0, 542055.0, 544511.0, 546252.0, 59432.0, 59931.101033484534, 59945.40054599398, 60042.39957600455, 60187.69906150441, 1535.5163123616026, 1535.7466018107111, 1548.9767653485208, 1550.4185930276146, 1555.3778488604648, 30695.693043069285, 32961.505577415875, 33200.0, 34123.829380852934, 35619.64380356163, 56433.43566564282, 56880.43119568751, 56912.43087569071, 57003.42996569981, 57087.42912570821, 406462.0, 408233.0, 408645.0, 409204.0, 409755.0, 30790.846045769627, 31910.60670449679, 31974.36051279008, 34359.31281374409, 37305.62694373022, 36952.26095478129, 39937.40093898536, 44020.0, 44501.554984449744, 45238.77380613076, 38479.0, 38616.0, 39259.0, 46654.53345466638, 47398.28902566395, 42675.146497070506, 43194.56805432031, 43370.78314608407, 43817.0, 43915.12169756523, 40336.79831600823, 41286.1742765149, 47502.0, 47598.76200619113, 47947.76026119847, 34383.48424773681, 38531.0, 38761.22477550377, 39054.80472597732, 39472.605273946894, 29173.270668233465, 29400.558991614715, 29406.264843379086, 29482.852585736935, 29562.852185738935], "prototype.html": [371.8586936963955, 380.8267238406525, 390.5762247960962, 397.6381492841514, 400.07582484460886, 5940.079287710401, 5971.671558064305, 5990.101484777286, 6001.789937352193, 6066.4236897494775, 5876.9118463223085, 5975.163477113208, 6014.067819487976, 6018.157457955879, 6018.9398106018925, 4630.722156670602, 4680.765961701918, 4757.571818536331, 4760.404949381327, 4795.760211989404, 4768.73771942543, 4772.188727916263, 4780.426348838127, 4785.976070119645, 4800.711957282557, 4752.643551733617, 4756.7383793891495, 4758.881027974294, 4760.85717428476, 4771.069641419925, 4751.833685820997, 4760.047990401933, 4764.118638051937, 4769.046190761844, 4770.045990801854, 4148.211839750468, 4149.460570125894, 4190.979045104786, 4192.706510544263, 4197.433346498215, 5623.690697011662, 5630.690312032836, 5651.208830763697, 5661.065924122515, 5676.2620859288445, 5287.735613219362, 5333.0, 5378.946210537883, 5472.179173124024, 5472.206530053159, 6284.811455656338, 6285.088662143963, 6288.496920246369, 6292.024736165856, 6304.432601065881, 4473.060657261979, 4494.797734101973, 4500.594946454835, 4514.9774251128865, 4531.252343363341, 6417.903731444032, 6441.355864413568, 6460.160179176724, 6488.772892948771, 6498.90251646221, 4667.299905014207, 4677.087967846237, 4677.789499472532, 4678.204705200056, 4681.087187998308, 4737.313089601988, 4737.549932756383, 4742.0, 4742.099001189763, 4746.976265118652, 5399.730013499309, 5403.8108666196495, 5405.837824865261, 5408.053590621704, 5410.3507579090765, 6266.874662506724, 6361.268454127742, 6373.936260637427, 6450.0, 6463.547551671432, 1728.1791149204028, 1758.78015248094, 1759.3754217252947, 1759.4018033868547, 1759.9384021559183, 1169.2107827216594, 1191.440023189117, 1212.0243204220687, 1218.056006594896, 1220.969475763113, 6215.223097112861, 6215.658138802319, 6219.222597175353, 6228.0, 6233.594816336924, 6600.60396376219, 6605.372489613479, 6608.00879868014, 6619.86760264792, 6620.9006864897065, 6093.360197179232, 6206.751729930752, 6209.720562574695, 6214.689265536705, 6217.720202590895, 3619.94570081449, 3631.909202269964, 3646.908827279339, 3655.177585043344, 3657.487951686766, 6792.932070679329, 6794.898076528856, 6797.0823938767635, 6801.0, 6805.557638753465, 6535.8366040848405, 6738.258791532928, 6759.932400675931, 6764.56030358035, 6766.221884483348, 6428.678566071678, 6681.231658359254, 6761.594304341756, 6788.117544719254, 6793.0, 6584.0, 6591.571547849375, 6599.076129341992, 6601.438877695257, 6601.834954125993, 6512.283648798723, 6517.055027020961, 6525.3148419417175, 6525.673716314261, 6551.639659818565, 6601.33986601336, 6792.558483698544, 6850.862982740217, 6853.623050732258, 6859.657017149222, 4710.26990816424, 4718.598919091778, 4720.669553131385, 4748.8100475981955, 4750.239961606127, 6643.634600097041, 6686.966565167338, 6687.899681504684, 6689.665516724047, 6690.69891854858, 6358.014507751306, 6451.032345148265, 6461.0954466373805, 6462.773802916875, 6515.576487528296, 6374.171357723466, 6413.390727880844, 6414.775482858077, 6423.871522569616, 6426.3573642635365, 6381.266154392304, 6389.52078594098, 6397.168368112116, 6399.64801935898, 6402.775902843378, 6417.807465776034, 6534.444572211225, 6537.313582073813, 6549.148610680581, 6563.507736919845, 6390.90413643805, 6392.232932048184, 6394.23269207698, 6398.200224971879, 6404.103425520524], "yui.html": [842.8187939592987, 877.1316396767203, 916.761641973087, 939.6664184214605, 988.5304480371824, 14413.495527656534, 14526.491572794954, 14806.18565978872, 14816.407343706253, 14949.701005979874, 14181.858181418183, 14218.0, 14313.856861431408, 14318.212498312589, 14340.067895586806, 777.0287141073658, 778.0740918307224, 940.9905900940988, 947.1381043250643, 947.767796889763, 949.520492151466, 950.9239260859115, 955.5556666150238, 956.0535070280407, 959.0792838874654, 986.8717066781309, 987.9901200988006, 994.9403035817874, 997.820392329384, 998.181491177235, 805.5851236613149, 808.1716240853143, 992.4938281476427, 996.9700908972742, 1005.2159315733703, 731.6561216228364, 732.842438875639, 732.9193788683241, 733.0616810482537, 734.9485536012481, 13711.931440342734, 13784.655383615389, 13792.448302067905, 13824.377902994389, 13878.791818122736, 12123.818142727867, 12658.430130938905, 12670.429830657551, 12738.363081845871, 12797.680057998532, 10777.030067293903, 10804.0, 10875.564977400974, 10946.124310055176, 10990.285631434012, 3674.0814796300924, 3722.7021838252876, 3727.403615421547, 3742.4760533525055, 3747.4191500317493, 39962.80018599918, 40561.391579126335, 40586.39120413196, 45179.548204517865, 45213.32180017302, 8001.079875814239, 8006.519608823489, 8019.0, 8091.595420228965, 8133.755987320272, 12711.68220794469, 12726.745465090646, 12738.363081845871, 12744.6813829655, 12843.422046007952, 7151.856962860714, 7209.243029481934, 7265.97745760274, 7300.379467745195, 7424.814379640552, 4696.272077827942, 4696.272077827942, 4770.642201834807, 4819.060283244804, 4897.706137631753, 3084.814911105341, 3095.1024202981334, 3107.37852429515, 3115.688431156866, 3119.641241257239, 495.0890361734426, 510.61193492944886, 511.0, 575.5740751843606, 594.8750762339871, 601.0623427453187, 607.4836389069344, 622.5362105231541, 698.155232169081, 723.2658851265969, 8125.75622731319, 8544.700935467228, 8622.31021518277, 8630.482171069756, 8648.783780405414, 582.4321286745474, 718.6658203935195, 722.989155162673, 735.7572001239578, 737.7749786315118, 3658.926821463556, 3738.420544815558, 3763.6424539668687, 3799.696024318048, 3900.6294402031763, 55896.0, 57088.71455642778, 57795.711021445466, 58481.41518584845, 58706.41293587095, 47727.0, 48243.276350854765, 48285.758571207625, 48366.27450588244, 48381.75809120932, 39803.0, 40060.59939400569, 40769.38845917313, 42124.78937605354, 42406.57593424088, 8298.128696486781, 8467.57662116904, 8600.698975535826, 8646.567671616269, 8794.98857631355, 28929.132126036253, 29139.562906555995, 29812.850935745184, 29832.85083574568, 30319.696803031686, 39409.60590394174, 39597.2080558393, 40136.0, 41679.374809377274, 41801.0, 8098.3116435103675, 8166.142555031874, 8361.080281168945, 8386.077531471412, 8492.532910689972, 11886.108541859223, 12087.469214120247, 12114.333711645591, 12180.390980450764, 12217.633470995885, 10690.144788416752, 10806.0, 11117.388543630179, 11287.943560282147, 11466.484008219484, 10257.897131088259, 10664.093552047852, 10714.0, 10898.346099234072, 11185.0, 9652.806943861224, 10939.398333091756, 11009.229353945148, 11427.142964277546, 11629.360385178896, 9440.716778496657, 9698.224142068477, 9800.264980126662, 9989.650362237287, 10098.343607665478, 9202.585883635118, 9562.139407453362, 9722.368046076983, 9951.253655975976, 9953.0]}, "summary": {"suite": 7440.579531127916, "subtests": {"jquery.html": {"std": 103298.90526215162, "min": 419.36256889527937, "max": 635623.0, "median": 7896.085447604672, "filtered": 7895.97767217985, "mean": 31209.387195426072}, "dojo.html": {"std": 644.5598320167841, "min": 3274.574305340306, "max": 6424.935750642434, "median": 5886.735096920649, "filtered": 5630.71192642294, "mean": 5673.8089908168695}, "mootools.html": {"std": 4188.035315851242, "min": 519.6803965561153, "max": 16362.754558681629, "median": 8544.444704759193, "filtered": 5714.794560003238, "mean": 7302.185400225139}, "ext.html": {"std": 117869.69355360005, "min": 568.0634716252295, "max": 546252.0, "median": 32646.83676581602, "filtered": 21805.032458881135, "mean": 62319.417822895666}, "prototype.html": {"std": 1562.9194450000796, "min": 371.8586936963955, "max": 6859.657017149222, "median": 6079.891943464355, "filtered": 4912.88849403806, "mean": 5399.506529753791}, "yui.html": {"std": 14676.468338695817, "min": 495.0890361734426, "max": 58706.41293587095, "median": 8998.787229974334, "filtered": 6233.632535774243, "mean": 12943.003053657312}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1446113141, "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": "20151029004130", "branch": "Mozilla-Aurora", "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 159.0, 160.0, 160.0, 162.0, 159.0, 160.0, 159.0, 162.0, 159.0], "ai-astar": [106.0, 108.0, 110.0, 110.0, 109.0, 109.0, 116.0, 109.0, 109.0, 109.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "audio-beat-detection": [147.0, 120.0, 144.0, 160.0, 122.0, 154.0, 153.0, 122.0, 159.0, 124.0], "json-stringify-tinderbox": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0], "stanford-crypto-pbkdf2": [146.0, 135.0, 134.0, 133.0, 135.0, 137.0, 135.0, 135.0, 135.0, 134.0], "json-parse-financial": [55.0, 53.0, 51.0, 52.0, 55.0, 52.0, 53.0, 54.0, 68.0, 53.0], "stanford-crypto-sha256-iterative": [61.0, 60.0, 62.0, 62.0, 62.0, 60.0, 61.0, 59.0, 71.0, 60.0], "audio-fft": [71.0, 72.0, 71.0, 138.0, 71.0, 72.0, 72.0, 70.0, 150.0, 71.0], "imaging-darkroom": [145.0, 145.0, 146.0, 145.0, 145.0, 147.0, 146.0, 145.0, 146.0, 145.0], "stanford-crypto-ccm": [105.0, 113.0, 110.0, 105.0, 111.0, 104.0, 115.0, 113.0, 121.0, 111.0], "audio-oscillator": [87.0, 87.0, 130.0, 94.0, 88.0, 87.0, 131.0, 87.0, 88.0, 129.0], "stanford-crypto-aes": [77.0, 78.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0, 78.0, 79.0], "imaging-desaturate": [95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 97.0, 96.0, 96.0, 95.0]}, "summary": {"suite": 1449.2000000000003, "subtests": {"audio-fft": {"std": 29.22943721661435, "min": 70.0, "max": 150.0, "median": 71.5, "filtered": 85.8, "mean": 85.8}, "stanford-crypto-pbkdf2": {"std": 3.505709628591622, "min": 133.0, "max": 146.0, "median": 135.0, "filtered": 135.9, "mean": 135.9}, "audio-beat-detection": {"std": 15.787653403846944, "min": 120.0, "max": 160.0, "median": 145.5, "filtered": 140.5, "mean": 140.5}, "stanford-crypto-ccm": {"std": 4.955804677345546, "min": 104.0, "max": 121.0, "median": 111.0, "filtered": 110.8, "mean": 110.8}, "imaging-darkroom": {"std": 0.6708203932499369, "min": 145.0, "max": 147.0, "median": 145.0, "filtered": 145.5, "mean": 145.5}, "json-parse-financial": {"std": 4.6303347611160905, "min": 51.0, "max": 68.0, "median": 53.0, "filtered": 54.6, "mean": 54.6}, "audio-oscillator": {"std": 19.223943403994927, "min": 87.0, "max": 131.0, "median": 88.0, "filtered": 100.8, "mean": 100.8}, "ai-astar": {"std": 2.4186773244895647, "min": 106.0, "max": 116.0, "median": 109.0, "filtered": 109.5, "mean": 109.5}, "audio-dft": {"std": 1.1357816691600546, "min": 159.0, "max": 162.0, "median": 160.0, "filtered": 160.1, "mean": 160.1}, "stanford-crypto-sha256-iterative": {"std": 3.2186953878862163, "min": 59.0, "max": 71.0, "median": 61.0, "filtered": 61.8, "mean": 61.8}, "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.4898979485566356, "min": 109.0, "max": 110.0, "median": 109.0, "filtered": 109.4, "mean": 109.4}, "stanford-crypto-aes": {"std": 0.66332495807108, "min": 77.0, "max": 79.0, "median": 78.5, "filtered": 78.4, "mean": 78.4}, "imaging-desaturate": {"std": 0.7810249675906653, "min": 95.0, "max": 97.0, "median": 95.5, "filtered": 95.7, "mean": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1446113141, "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": "20151029004130", "branch": "Mozilla-Aurora", "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.9620587264929], "Encrypt": [281.61081385525205], "NavierStokes": [4822.115384615385], "Decrypt": [5091.370558375635], "Splay": [525.4860746190226], "Richards": [168.35016835016836], "RegExp": [23045.454545454544], "Earley": [538.2131324004306], "Boyer": [10214.285714285714], "RayTrace": [964.3201542912246]}, "summary": {"suite": 23455.178633187676, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.9620587264929, "max": 164.9620587264929, "median": 164.9620587264929, "value": 400.8073159999999, "filtered": 400.8073159999999, "mean": 164.9620587264929}, "Encrypt": {"std": 0.0, "min": 281.61081385525205, "max": 281.61081385525205, "median": 281.61081385525205, "value": 945.2087309999996, "filtered": 945.2087309999996, "mean": 281.61081385525205}, "NavierStokes": {"std": 0.0, "min": 4822.115384615385, "max": 4822.115384615385, "median": 4822.115384615385, "value": 307.7487537387835, "filtered": 307.7487537387835, "mean": 4822.115384615385}, "Decrypt": {"std": 0.0, "min": 5091.370558375635, "max": 5091.370558375635, "median": 5091.370558375635, "value": 52.280814556330995, "filtered": 52.280814556330995, "mean": 5091.370558375635}, "Splay": {"std": 0.0, "min": 525.4860746190226, "max": 525.4860746190226, "median": 525.4860746190226, "value": 155.077373, "filtered": 155.077373, "mean": 525.4860746190226}, "RegExp": {"std": 0.0, "min": 23045.454545454544, "max": 23045.454545454544, "median": 23045.454545454544, "value": 39.529921104536506, "filtered": 39.529921104536506, "mean": 23045.454545454544}, "Richards": {"std": 0.0, "min": 168.35016835016836, "max": 168.35016835016836, "median": 168.35016835016836, "value": 209.69388000000006, "filtered": 209.69388000000006, "mean": 168.35016835016836}, "Earley": {"std": 0.0, "min": 538.2131324004306, "max": 538.2131324004306, "median": 538.2131324004306, "value": 1238.2882539999996, "filtered": 1238.2882539999996, "mean": 538.2131324004306}, "Boyer": {"std": 0.0, "min": 10214.285714285714, "max": 10214.285714285714, "median": 10214.285714285714, "value": 65.24812587412589, "filtered": 65.24812587412589, "mean": 10214.285714285714}, "RayTrace": {"std": 0.0, "min": 964.3201542912246, "max": 964.3201542912246, "median": 964.3201542912246, "value": 767.3685930000003, "filtered": 767.3685930000003, "mean": 964.3201542912246}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1446113141, "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": "20151029004130", "branch": "Mozilla-Aurora", "revision": "bf0aacb5affa91f9554cb01ebfa31a6e8806b9c8"}}] 03:25:49 INFO - RETURN: dromaeo_css: 7440.58 03:25:49 INFO - RETURN: kraken: 1449.20 03:25:49 INFO - RETURN: v8_7: 23455.18 03:25:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23455.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1449.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7440.58"}}} 03:25:49 INFO - Return code: 0 03:25:49 INFO - # TBPL SUCCESS # 03:25:49 INFO - Running post-action listener: _resource_record_post_action 03:25:49 INFO - Running post-run listener: _resource_record_post_run 03:25:51 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 7364608; Write bytes: 389353472; Read time: 1832; Write time: 402340 03:25:51 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 40587264; Read time: 116; Write time: 14356 03:25:51 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 5156864; Write bytes: 348766208; Read time: 1548; Write time: 387984 03:25:51 INFO - Running post-run listener: _upload_blobber_files 03:25:51 INFO - Blob upload gear active. 03:25:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:25:51 INFO - Copying logs to upload dir... 03:25:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.735438 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-10-29 03:25:50.983484) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-29 03:25:50.987060) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009804 build_url: 'https://queue.taskcluster.net/v1/task/xs4EC6-ERm-JWdIwfrYl1A/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:25:51.039450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:25:51.039869) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446112231.98722-686415688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-29 03:25:51.090681) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-29 03:25:51.091055) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-29 03:25:55.294467) =========