builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1445988969.84 results: success (0) buildid: 20151027142931 builduid: 56498e75bd354d5aab82075e90be215d revision: c017ca15c40c99776c84f40c100cb5c578b8ae66 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:09.837432) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:09.837937) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:09.838279) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005695 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:09.914271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:09.915093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:09.943301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:09.944005) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029779 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:10.002254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:10.002600) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:10.003083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:10.003488) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-27 16:36:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2015-10-27 16:36:10 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.278116 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:10.300521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:10.300872) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.086802 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:10.405092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 16:36:10.406050) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c017ca15c40c99776c84f40c100cb5c578b8ae66 --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 c017ca15c40c99776c84f40c100cb5c578b8ae66 --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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-27 16:36:10,424 truncating revision to first 12 chars 2015-10-27 16:36:10,425 Setting DEBUG logging. 2015-10-27 16:36:10,425 attempt 1/10 2015-10-27 16:36:10,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c017ca15c40c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 16:36:11,708 unpacking tar archive at: mozilla-aurora-c017ca15c40c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.532617 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 16:36:11.958537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:11.958893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:11.969967) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:11.970254) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 16:36:11.970671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-10-27 16:36:11.971044) ========= /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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:36:12 INFO - MultiFileLogger online at 20151027 16:36:12 in /builds/slave/test-pgo 16:36:12 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 16:36:12 INFO - Guessing talos json url... 16:36:12 INFO - Using buildbot properties: 16:36:12 INFO - { 16:36:12 INFO - "properties": { 16:36:12 INFO - "buildnumber": 2, 16:36:12 INFO - "product": "firefox", 16:36:12 INFO - "script_repo_revision": "production", 16:36:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:36:12 INFO - "repository": "", 16:36:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:36:12 INFO - "buildid": "20151027142931", 16:36:12 INFO - "slavename": "talos-linux64-ix-058", 16:36:12 INFO - "pgo_build": "True", 16:36:12 INFO - "basedir": "/builds/slave/test-pgo", 16:36:12 INFO - "project": "", 16:36:12 INFO - "platform": "ubuntu64_hw", 16:36:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:36:12 INFO - "slavebuilddir": "test", 16:36:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:36:12 INFO - "branch": "mozilla-aurora", 16:36:12 INFO - "repo_path": "releases/mozilla-aurora", 16:36:12 INFO - "stage_platform": "linux64-pgo", 16:36:12 INFO - "builduid": "56498e75bd354d5aab82075e90be215d", 16:36:12 INFO - "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66" 16:36:12 INFO - }, 16:36:12 INFO - "sourcestamp": { 16:36:12 INFO - "repository": "", 16:36:12 INFO - "hasPatch": false, 16:36:12 INFO - "project": "", 16:36:12 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:36:12 INFO - "changes": [ 16:36:12 INFO - { 16:36:12 INFO - "category": null, 16:36:12 INFO - "files": [ 16:36:12 INFO - { 16:36:12 INFO - "url": null, 16:36:12 INFO - "name": "https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 16:36:12 INFO - } 16:36:12 INFO - ], 16:36:12 INFO - "repository": "", 16:36:12 INFO - "rev": "c017ca15c40c99776c84f40c100cb5c578b8ae66", 16:36:12 INFO - "who": "kwierso@gmail.com", 16:36:12 INFO - "when": 1445988917, 16:36:12 INFO - "number": 6583892, 16:36:12 INFO - "comments": "Bug 1214511 - Show copies, page range selection, and more on the expanded OSX print dialog. r=mstange a=lizzard", 16:36:12 INFO - "project": "", 16:36:12 INFO - "at": "Tue 27 Oct 2015 16:35:17", 16:36:12 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:36:12 INFO - "revlink": "", 16:36:12 INFO - "properties": [ 16:36:12 INFO - [ 16:36:12 INFO - "buildid", 16:36:12 INFO - "20151027142931", 16:36:12 INFO - "Change" 16:36:12 INFO - ], 16:36:12 INFO - [ 16:36:12 INFO - "builduid", 16:36:12 INFO - "56498e75bd354d5aab82075e90be215d", 16:36:12 INFO - "Change" 16:36:12 INFO - ], 16:36:12 INFO - [ 16:36:12 INFO - "pgo_build", 16:36:12 INFO - "True", 16:36:12 INFO - "Change" 16:36:12 INFO - ] 16:36:12 INFO - ], 16:36:12 INFO - "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66" 16:36:12 INFO - } 16:36:12 INFO - ], 16:36:12 INFO - "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66" 16:36:12 INFO - } 16:36:12 INFO - } 16:36:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 16:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:12 INFO - https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 16:36:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 16:36:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 16:36:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:12 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:15 INFO - Downloaded 107 bytes. 16:36:15 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 16:36:15 INFO - Contents: 16:36:15 INFO - 20151027142931 16:36:15 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/c017ca15c40c99776c84f40c100cb5c578b8ae66 16:36: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')]} 16:36:15 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/c017ca15c4/testing/talos/talos.json 16:36:15 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/c017ca15c4/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 16:36:15 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/c017ca15c4/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 16:36:15 INFO - Downloaded 6818 bytes. 16:36:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:36:15 INFO - '../fennec_ids.txt'], 16:36:15 INFO - 'tests': ['tcheck2']}, 16:36:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:15 INFO - '--tppagecycles', 16:36:15 INFO - '7'], 16:36:15 INFO - 'tests': ['tsvgm']}}, 16:36:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:36:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:36:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:36:15 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 16:36:15 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 16:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:15 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 16:36:15 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 16:36:15 INFO - 'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:15 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'tests': ['damp', 'tps']}, 16:36:15 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['damp', 'tps']}, 16:36:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:36:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:15 INFO - 'other': {'tests': ['a11yr', 16:36:15 INFO - 'ts_paint', 16:36:15 INFO - 'tpaint', 16:36:15 INFO - 'sessionrestore', 16:36:15 INFO - 'sessionrestore_no_auto_restore']}, 16:36:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['a11yr', 16:36:15 INFO - 'ts_paint', 16:36:15 INFO - 'tpaint', 16:36:15 INFO - 'sessionrestore', 16:36:15 INFO - 'sessionrestore_no_auto_restore']}, 16:36:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['a11yr', 16:36:15 INFO - 'ts_paint', 16:36:15 INFO - 'tpaint', 16:36:15 INFO - 'sessionrestore', 16:36:15 INFO - 'sessionrestore_no_auto_restore']}, 16:36:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['a11yr', 16:36:15 INFO - 'ts_paint', 16:36:15 INFO - 'tpaint', 16:36:15 INFO - 'sessionrestore', 16:36:15 INFO - 'sessionrestore_no_auto_restore']}, 16:36:15 INFO - 'other_l64': {'tests': ['a11yr', 16:36:15 INFO - 'ts_paint', 16:36:15 INFO - 'tpaint', 16:36:15 INFO - 'sessionrestore', 16:36:15 INFO - 'sessionrestore_no_auto_restore']}, 16:36:15 INFO - 'other_nol64': {'tests': ['a11yr', 16:36:15 INFO - 'ts_paint', 16:36:15 INFO - 'tpaint', 16:36:15 INFO - 'sessionrestore', 16:36:15 INFO - 'sessionrestore_no_auto_restore']}, 16:36:15 INFO - 'svgr': {'tests': ['tsvgx', 16:36:15 INFO - 'tsvgr_opacity', 16:36:15 INFO - 'tart', 16:36:15 INFO - 'tscrollx', 16:36:15 INFO - 'cart']}, 16:36:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['tsvgx', 16:36:15 INFO - 'tsvgr_opacity', 16:36:15 INFO - 'tart', 16:36:15 INFO - 'tscrollx', 16:36:15 INFO - 'cart']}, 16:36:15 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 16:36:15 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 16:36:15 INFO - 'tests': ['tp5o']}, 16:36:15 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 16:36:15 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 16:36:15 INFO - 'talos_options': ['--e10s'], 16:36:15 INFO - 'tests': ['tp5o']}, 16:36:15 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 16:36:15 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 16:36:15 INFO - 'talos_options': ['--xperf_path', 16:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:15 INFO - 'tests': ['tp5n']}, 16:36:15 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 16:36:15 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 16:36:15 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:15 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 16:36:15 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 16:36:15 INFO - 'talos_options': ['--e10s', 16:36:15 INFO - '--xperf_path', 16:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 16:36:15 INFO - 'C:/slave/talos-data/talos/xperf.config'], 16:36:15 INFO - 'tests': ['tp5n']}}, 16:36:15 INFO - 'talos.zip': {'path': '', 16:36:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:36:15 INFO - {'append_to_log': False, 16:36:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:36:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:36:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:36:15 INFO - 'branch': 'Mozilla-Aurora', 16:36:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:15 INFO - 'config_files': ('talos/linux_config.py',), 16:36:15 INFO - 'default_actions': ('clobber', 16:36:15 INFO - 'read-buildbot-config', 16:36:15 INFO - 'download-and-extract', 16:36:15 INFO - 'populate-webroot', 16:36:15 INFO - 'create-virtualenv', 16:36:15 INFO - 'install', 16:36:15 INFO - 'run-tests'), 16:36:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:15 INFO - 'download_minidump_stackwalk': True, 16:36:15 INFO - 'download_symbols': 'ondemand', 16:36:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:15 INFO - 'installer_path': 'installer.exe', 16:36:15 INFO - 'log_level': 'info', 16:36:15 INFO - 'log_name': 'talos', 16:36:15 INFO - 'log_to_console': True, 16:36:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:36:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:36:15 INFO - 'opt_config_files': (), 16:36:15 INFO - 'pip_index': False, 16:36:15 INFO - 'python_webserver': False, 16:36:15 INFO - 'sps_profile': False, 16:36:15 INFO - 'sps_profile_interval': 0, 16:36:15 INFO - 'suite': 'dromaeojs', 16:36:15 INFO - 'system_bits': '64', 16:36:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:15 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 16:36:15 INFO - 'tests': (), 16:36:15 INFO - 'title': 'talos-linux64-ix-058', 16:36:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:15 INFO - 'use_talos_json': True, 16:36:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:36:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:15 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 16:36:15 INFO - 'work_dir': 'build'} 16:36:15 INFO - ##### 16:36:15 INFO - ##### Running clobber step. 16:36:15 INFO - ##### 16:36:15 INFO - Running pre-action listener: _resource_record_pre_action 16:36:15 INFO - Running main action method: clobber 16:36:15 INFO - rmtree: /builds/slave/test-pgo/build 16:36:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:36:16 INFO - Running post-action listener: _resource_record_post_action 16:36:16 INFO - ##### 16:36:16 INFO - ##### Running read-buildbot-config step. 16:36:16 INFO - ##### 16:36:16 INFO - Running pre-action listener: _resource_record_pre_action 16:36:16 INFO - Running main action method: read_buildbot_config 16:36:16 INFO - Using buildbot properties: 16:36:16 INFO - { 16:36:16 INFO - "properties": { 16:36:16 INFO - "buildnumber": 2, 16:36:16 INFO - "product": "firefox", 16:36:16 INFO - "script_repo_revision": "production", 16:36:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:36:16 INFO - "repository": "", 16:36:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:36:16 INFO - "buildid": "20151027142931", 16:36:16 INFO - "slavename": "talos-linux64-ix-058", 16:36:16 INFO - "pgo_build": "True", 16:36:16 INFO - "basedir": "/builds/slave/test-pgo", 16:36:16 INFO - "project": "", 16:36:16 INFO - "platform": "ubuntu64_hw", 16:36:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:36:16 INFO - "slavebuilddir": "test", 16:36:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:36:16 INFO - "branch": "mozilla-aurora", 16:36:16 INFO - "repo_path": "releases/mozilla-aurora", 16:36:16 INFO - "stage_platform": "linux64-pgo", 16:36:16 INFO - "builduid": "56498e75bd354d5aab82075e90be215d", 16:36:16 INFO - "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66" 16:36:16 INFO - }, 16:36:16 INFO - "sourcestamp": { 16:36:16 INFO - "repository": "", 16:36:16 INFO - "hasPatch": false, 16:36:16 INFO - "project": "", 16:36:16 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:36:16 INFO - "changes": [ 16:36:16 INFO - { 16:36:16 INFO - "category": null, 16:36:16 INFO - "files": [ 16:36:16 INFO - { 16:36:16 INFO - "url": null, 16:36:16 INFO - "name": "https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 16:36:16 INFO - } 16:36:16 INFO - ], 16:36:16 INFO - "repository": "", 16:36:16 INFO - "rev": "c017ca15c40c99776c84f40c100cb5c578b8ae66", 16:36:16 INFO - "who": "kwierso@gmail.com", 16:36:16 INFO - "when": 1445988917, 16:36:16 INFO - "number": 6583892, 16:36:16 INFO - "comments": "Bug 1214511 - Show copies, page range selection, and more on the expanded OSX print dialog. r=mstange a=lizzard", 16:36:16 INFO - "project": "", 16:36:16 INFO - "at": "Tue 27 Oct 2015 16:35:17", 16:36:16 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:36:16 INFO - "revlink": "", 16:36:16 INFO - "properties": [ 16:36:16 INFO - [ 16:36:16 INFO - "buildid", 16:36:16 INFO - "20151027142931", 16:36:16 INFO - "Change" 16:36:16 INFO - ], 16:36:16 INFO - [ 16:36:16 INFO - "builduid", 16:36:16 INFO - "56498e75bd354d5aab82075e90be215d", 16:36:16 INFO - "Change" 16:36:16 INFO - ], 16:36:16 INFO - [ 16:36:16 INFO - "pgo_build", 16:36:16 INFO - "True", 16:36:16 INFO - "Change" 16:36:16 INFO - ] 16:36:16 INFO - ], 16:36:16 INFO - "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66" 16:36:16 INFO - } 16:36:16 INFO - ], 16:36:16 INFO - "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66" 16:36:16 INFO - } 16:36:16 INFO - } 16:36:16 INFO - Running post-action listener: _resource_record_post_action 16:36:16 INFO - ##### 16:36:16 INFO - ##### Running download-and-extract step. 16:36:16 INFO - ##### 16:36:16 INFO - Running pre-action listener: _resource_record_pre_action 16:36:16 INFO - Running main action method: download_and_extract 16:36:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:16 INFO - https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/test_packages.json 16:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/test_packages.json 16:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:36:16 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 16:36:17 INFO - Downloaded 1302 bytes. 16:36:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:36:17 INFO - Using the following test package requirements: 16:36:17 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 16:36:17 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 16:36:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:36:17 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 16:36:17 INFO - u'jsshell-linux-x86_64.zip'], 16:36:17 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 16:36:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:36:17 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 16:36:17 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 16:36:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:36:17 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 16:36:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:36:17 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 16:36:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:36:17 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 16:36:17 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 16:36:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:36:17 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:17 INFO - https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 16:36:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 16:36:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:17 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:19 INFO - Downloaded 22907044 bytes. 16:36:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:36:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 16:36:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:36:20 INFO - Return code: 0 16:36:20 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 16:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:20 INFO - https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 16:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 16:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:20 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:27 INFO - Downloaded 22907044 bytes. 16:36:27 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 16:36:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 16:36:27 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 16:36:29 INFO - Return code: 0 16:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:29 INFO - https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 16:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 16:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:29 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:30 INFO - Downloaded 10881672 bytes. 16:36:30 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 16:36:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 16:36:30 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 16:36:30 INFO - Return code: 0 16:36:30 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')]} 16:36:30 INFO - https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:36:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 16:36:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 16:36:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:30 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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 16:36:35 INFO - Downloaded 56978773 bytes. 16:36:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 16:36:35 INFO - mkdir: /builds/slave/test-pgo/properties 16:36:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:36:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:36:35 INFO - Contents: 16:36:35 INFO - build_url:https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 16:36:35 INFO - Running post-action listener: _resource_record_post_action 16:36:35 INFO - Running post-action listener: _set_extra_try_arguments 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running populate-webroot step. 16:36:35 INFO - ##### 16:36:35 INFO - Running pre-action listener: _resource_record_pre_action 16:36:35 INFO - Running main action method: populate_webroot 16:36:35 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 16:36:35 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 16:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 16:36:35 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 16:36:35 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 16:36:35 INFO - Running post-action listener: _resource_record_post_action 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running create-virtualenv step. 16:36:35 INFO - ##### 16:36:35 INFO - Running pre-action listener: _resource_record_pre_action 16:36:35 INFO - Running main action method: create_virtualenv 16:36:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:36:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:36:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:36:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:35 INFO - Using real prefix '/usr' 16:36:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:36:36 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:38 INFO - Installing pip.................done. 16:36:38 INFO - Return code: 0 16:36:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09c37c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a807b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b454a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', '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 16:36:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:36:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:36:38 INFO - Using env: {'DISPLAY': ':0', 16:36:38 INFO - 'HOME': '/home/cltbld', 16:36:38 INFO - 'LANG': 'en_US.UTF-8', 16:36:38 INFO - 'LANGUAGE': 'en_US:en', 16:36:38 INFO - 'LOGNAME': 'cltbld', 16:36:38 INFO - 'MAIL': '/var/mail/cltbld', 16:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:38 INFO - 'MOZ_NO_REMOTE': '1', 16:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:38 INFO - 'NO_EM_RESTART': '1', 16:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:36:38 INFO - 'PWD': '/builds/slave/test-pgo', 16:36:38 INFO - 'SHELL': '/bin/bash', 16:36:38 INFO - 'SHLVL': '1', 16:36:38 INFO - 'TERM': 'linux', 16:36:38 INFO - 'TMOUT': '86400', 16:36:38 INFO - 'USER': 'cltbld', 16:36:38 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:38 INFO - '_': '/tools/buildbot/bin/python'} 16:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:36:38 INFO - Cleaning up... 16:36:38 INFO - Return code: 0 16:36:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09c37c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a807b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b454a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', '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 16:36:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:36:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:36:38 INFO - Using env: {'DISPLAY': ':0', 16:36:38 INFO - 'HOME': '/home/cltbld', 16:36:38 INFO - 'LANG': 'en_US.UTF-8', 16:36:38 INFO - 'LANGUAGE': 'en_US:en', 16:36:38 INFO - 'LOGNAME': 'cltbld', 16:36:38 INFO - 'MAIL': '/var/mail/cltbld', 16:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:38 INFO - 'MOZ_NO_REMOTE': '1', 16:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:38 INFO - 'NO_EM_RESTART': '1', 16:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:36:38 INFO - 'PWD': '/builds/slave/test-pgo', 16:36:38 INFO - 'SHELL': '/bin/bash', 16:36:38 INFO - 'SHLVL': '1', 16:36:38 INFO - 'TERM': 'linux', 16:36:38 INFO - 'TMOUT': '86400', 16:36:38 INFO - 'USER': 'cltbld', 16:36:38 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:38 INFO - '_': '/tools/buildbot/bin/python'} 16:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:38 INFO - Downloading/unpacking psutil>=0.7.1 16:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:36:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:36:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:40 INFO - Installing collected packages: psutil 16:36:40 INFO - Running setup.py install for psutil 16:36:40 INFO - building 'psutil._psutil_linux' extension 16:36:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:36:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:36:41 INFO - building 'psutil._psutil_posix' extension 16:36:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:36:42 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 16:36:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:42 INFO - Successfully installed psutil 16:36:42 INFO - Cleaning up... 16:36:42 INFO - Return code: 0 16:36:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:36:42 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')]} 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:42 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')]} 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:42 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 0x7f09c37c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a807b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b454a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', '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 16:36:42 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 16:36:42 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 16:36:42 INFO - Using env: {'DISPLAY': ':0', 16:36:42 INFO - 'HOME': '/home/cltbld', 16:36:42 INFO - 'LANG': 'en_US.UTF-8', 16:36:42 INFO - 'LANGUAGE': 'en_US:en', 16:36:42 INFO - 'LOGNAME': 'cltbld', 16:36:42 INFO - 'MAIL': '/var/mail/cltbld', 16:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:42 INFO - 'MOZ_NO_REMOTE': '1', 16:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:42 INFO - 'NO_EM_RESTART': '1', 16:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:36:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:36:42 INFO - 'SHELL': '/bin/bash', 16:36:42 INFO - 'SHLVL': '1', 16:36:42 INFO - 'TERM': 'linux', 16:36:42 INFO - 'TMOUT': '86400', 16:36:42 INFO - 'USER': 'cltbld', 16:36:42 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:42 INFO - '_': '/tools/buildbot/bin/python'} 16:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:36:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:36:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:36:44 INFO - Installing collected packages: mozsystemmonitor 16:36:44 INFO - Running setup.py install for mozsystemmonitor 16:36:44 INFO - Successfully installed mozsystemmonitor 16:36:44 INFO - Cleaning up... 16:36:44 INFO - Return code: 0 16:36:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:44 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 0x7f09c37c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a807b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b454a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', '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 16:36:44 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 16:36:44 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 16:36:44 INFO - Using env: {'DISPLAY': ':0', 16:36:44 INFO - 'HOME': '/home/cltbld', 16:36:44 INFO - 'LANG': 'en_US.UTF-8', 16:36:44 INFO - 'LANGUAGE': 'en_US:en', 16:36:44 INFO - 'LOGNAME': 'cltbld', 16:36:44 INFO - 'MAIL': '/var/mail/cltbld', 16:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:44 INFO - 'MOZ_NO_REMOTE': '1', 16:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:44 INFO - 'NO_EM_RESTART': '1', 16:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:36:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:36:44 INFO - 'SHELL': '/bin/bash', 16:36:44 INFO - 'SHLVL': '1', 16:36:44 INFO - 'TERM': 'linux', 16:36:44 INFO - 'TMOUT': '86400', 16:36:44 INFO - 'USER': 'cltbld', 16:36:44 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:44 INFO - '_': '/tools/buildbot/bin/python'} 16:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:44 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:36:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:36:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:36:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:46 INFO - Downloading docopt-0.6.1.tar.gz 16:36:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:36:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:47 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:47 INFO - Running setup.py install for blobuploader 16:36:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:36:47 INFO - Running setup.py install for requests 16:36:47 INFO - Running setup.py install for docopt 16:36:47 INFO - Successfully installed blobuploader requests docopt 16:36:47 INFO - Cleaning up... 16:36:47 INFO - Return code: 0 16:36:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09c37c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a807b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b454a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', '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 16:36:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:36:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:47 INFO - Using env: {'DISPLAY': ':0', 16:36:47 INFO - 'HOME': '/home/cltbld', 16:36:47 INFO - 'LANG': 'en_US.UTF-8', 16:36:47 INFO - 'LANGUAGE': 'en_US:en', 16:36:47 INFO - 'LOGNAME': 'cltbld', 16:36:47 INFO - 'MAIL': '/var/mail/cltbld', 16:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:47 INFO - 'MOZ_NO_REMOTE': '1', 16:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:47 INFO - 'NO_EM_RESTART': '1', 16:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:36:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:36:47 INFO - 'SHELL': '/bin/bash', 16:36:47 INFO - 'SHLVL': '1', 16:36:47 INFO - 'TERM': 'linux', 16:36:47 INFO - 'TMOUT': '86400', 16:36:47 INFO - 'USER': 'cltbld', 16:36:47 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:47 INFO - '_': '/tools/buildbot/bin/python'} 16:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:36:47 INFO - Running setup.py (path:/tmp/pip-j1tbYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:36:47 INFO - Running setup.py (path:/tmp/pip-oeriGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:36:48 INFO - Running setup.py (path:/tmp/pip-QkbKW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:36:48 INFO - Running setup.py (path:/tmp/pip-OT9veM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:36:48 INFO - Running setup.py (path:/tmp/pip-dL_6te-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:36:48 INFO - Running setup.py (path:/tmp/pip-KWtIhk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:36:48 INFO - Running setup.py (path:/tmp/pip-_vPXFM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:36:48 INFO - Running setup.py (path:/tmp/pip-YM6Jfs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:36:48 INFO - Running setup.py (path:/tmp/pip-F_j75H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:36:48 INFO - Running setup.py (path:/tmp/pip-KHzGul-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:36:48 INFO - Running setup.py (path:/tmp/pip-Y4hkOG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:36:48 INFO - Running setup.py (path:/tmp/pip-v6lRdI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:36:48 INFO - Running setup.py (path:/tmp/pip-QOqixJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:36:48 INFO - Running setup.py (path:/tmp/pip-vmuvuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:36:48 INFO - Running setup.py (path:/tmp/pip-oGgcBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:36:48 INFO - Running setup.py (path:/tmp/pip-AThNjp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:36:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:36:49 INFO - Running setup.py (path:/tmp/pip-1atuZp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:36:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:49 INFO - Running setup.py install for manifestparser 16:36:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Running setup.py install for mozcrash 16:36:49 INFO - Running setup.py install for mozdebug 16:36:49 INFO - Running setup.py install for mozdevice 16:36:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Running setup.py install for mozfile 16:36:49 INFO - Running setup.py install for mozhttpd 16:36:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Running setup.py install for mozinfo 16:36:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Running setup.py install for mozInstall 16:36:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:36:49 INFO - Running setup.py install for mozleak 16:36:50 INFO - Running setup.py install for mozlog 16:36:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:36:50 INFO - Running setup.py install for moznetwork 16:36:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:36:50 INFO - Running setup.py install for mozprocess 16:36:50 INFO - Running setup.py install for mozprofile 16:36:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:36:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:36:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:36:50 INFO - Running setup.py install for mozrunner 16:36:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:36:50 INFO - Running setup.py install for mozscreenshot 16:36:50 INFO - Running setup.py install for moztest 16:36:50 INFO - Running setup.py install for mozversion 16:36:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:36:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:50 INFO - Cleaning up... 16:36:50 INFO - Return code: 0 16:36:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09c37c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a807b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b454a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', '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 16:36:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:36:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:50 INFO - Using env: {'DISPLAY': ':0', 16:36:50 INFO - 'HOME': '/home/cltbld', 16:36:50 INFO - 'LANG': 'en_US.UTF-8', 16:36:50 INFO - 'LANGUAGE': 'en_US:en', 16:36:50 INFO - 'LOGNAME': 'cltbld', 16:36:50 INFO - 'MAIL': '/var/mail/cltbld', 16:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:50 INFO - 'MOZ_NO_REMOTE': '1', 16:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:50 INFO - 'NO_EM_RESTART': '1', 16:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:36:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:36:50 INFO - 'SHELL': '/bin/bash', 16:36:50 INFO - 'SHLVL': '1', 16:36:50 INFO - 'TERM': 'linux', 16:36:50 INFO - 'TMOUT': '86400', 16:36:50 INFO - 'USER': 'cltbld', 16:36:50 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:50 INFO - '_': '/tools/buildbot/bin/python'} 16:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:36:51 INFO - Running setup.py (path:/tmp/pip-Nk1eC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:36:51 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)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:36:51 INFO - Running setup.py (path:/tmp/pip-UUJbAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:36:51 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)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:36:51 INFO - Running setup.py (path:/tmp/pip-BWdcj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:36:51 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)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:36:51 INFO - Running setup.py (path:/tmp/pip-dpBRsd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:36:51 INFO - Running setup.py (path:/tmp/pip-xx_UYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:36:51 INFO - Running setup.py (path:/tmp/pip-kJ_qmW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:36:51 INFO - Running setup.py (path:/tmp/pip-0w_b2P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:36:51 INFO - Running setup.py (path:/tmp/pip-RC1iTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:36:51 INFO - Running setup.py (path:/tmp/pip-_Jm7me-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:36:51 INFO - Running setup.py (path:/tmp/pip-47IZcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:36:51 INFO - Running setup.py (path:/tmp/pip-D32s22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:36:51 INFO - Running setup.py (path:/tmp/pip-Xt7gfB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:36:52 INFO - Running setup.py (path:/tmp/pip-BIF59n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:36:52 INFO - Running setup.py (path:/tmp/pip-hKgJu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:36:52 INFO - Running setup.py (path:/tmp/pip-1PXd_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:36:52 INFO - Running setup.py (path:/tmp/pip-NGnBIM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:36:52 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)) 16:36:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:36:52 INFO - Running setup.py (path:/tmp/pip-P37nJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:36:52 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)) 16:36:52 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)) 16:36:52 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)) 16:36:52 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)) 16:36:52 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)) 16:36:52 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)) 16:36:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:52 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 16:36:52 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 16:36:52 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 16:36:52 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 16:36:52 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 16:36:52 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 16:36:54 INFO - Downloading blessings-1.5.1.tar.gz 16:36:54 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 16:36:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:54 INFO - Installing collected packages: blessings 16:36:54 INFO - Running setup.py install for blessings 16:36:54 INFO - Successfully installed blessings 16:36:54 INFO - Cleaning up... 16:36:54 INFO - Return code: 0 16:36:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:36:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:36:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:36:54 INFO - Reading from file tmpfile_stdout 16:36:54 INFO - Current package versions: 16:36:54 INFO - argparse == 1.2.1 16:36:54 INFO - blessings == 1.5.1 16:36:54 INFO - blobuploader == 1.2.4 16:36:54 INFO - docopt == 0.6.1 16:36:54 INFO - manifestparser == 1.1 16:36:54 INFO - mozInstall == 1.12 16:36:54 INFO - mozcrash == 0.16 16:36:54 INFO - mozdebug == 0.1 16:36:54 INFO - mozdevice == 0.46 16:36:54 INFO - mozfile == 1.2 16:36:54 INFO - mozhttpd == 0.7 16:36:54 INFO - mozinfo == 0.8 16:36:54 INFO - mozleak == 0.1 16:36:54 INFO - mozlog == 3.0 16:36:54 INFO - moznetwork == 0.27 16:36:54 INFO - mozprocess == 0.22 16:36:54 INFO - mozprofile == 0.27 16:36:54 INFO - mozrunner == 6.10 16:36:54 INFO - mozscreenshot == 0.1 16:36:54 INFO - mozsystemmonitor == 0.0 16:36:54 INFO - moztest == 0.7 16:36:54 INFO - mozversion == 1.4 16:36:54 INFO - psutil == 3.1.1 16:36:54 INFO - requests == 1.2.3 16:36:54 INFO - wsgiref == 0.1.2 16:36:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09c37c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a807b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b454a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', '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 16:36:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:36:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:36:54 INFO - Using env: {'DISPLAY': ':0', 16:36:54 INFO - 'HOME': '/home/cltbld', 16:36:54 INFO - 'LANG': 'en_US.UTF-8', 16:36:54 INFO - 'LANGUAGE': 'en_US:en', 16:36:54 INFO - 'LOGNAME': 'cltbld', 16:36:54 INFO - 'MAIL': '/var/mail/cltbld', 16:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:54 INFO - 'MOZ_NO_REMOTE': '1', 16:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:54 INFO - 'NO_EM_RESTART': '1', 16:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:36:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:36:54 INFO - 'SHELL': '/bin/bash', 16:36:54 INFO - 'SHLVL': '1', 16:36:54 INFO - 'TERM': 'linux', 16:36:54 INFO - 'TMOUT': '86400', 16:36:54 INFO - 'USER': 'cltbld', 16:36:54 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:54 INFO - '_': '/tools/buildbot/bin/python'} 16:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:36:54 INFO - Cleaning up... 16:36:54 INFO - Return code: 0 16:36:54 INFO - Running post-action listener: _resource_record_post_action 16:36:54 INFO - Running post-action listener: _start_resource_monitoring 16:36:54 INFO - Starting resource monitoring. 16:36:54 INFO - ##### 16:36:54 INFO - ##### Running install step. 16:36:54 INFO - ##### 16:36:54 INFO - Running pre-action listener: _resource_record_pre_action 16:36:54 INFO - Running main action method: install 16:36:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:36:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:36:55 INFO - Reading from file tmpfile_stdout 16:36:55 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:36:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:36:55 INFO - Reading from file tmpfile_stdout 16:36:55 INFO - Output received: 16:36:55 INFO - Usage: mozinstall [options] installer 16:36:55 INFO - Options: 16:36:55 INFO - -h, --help show this help message and exit 16:36:55 INFO - -d DEST, --destination=DEST 16:36:55 INFO - Directory to install application into. [default: 16:36:55 INFO - "/builds/slave/test-pgo"] 16:36:55 INFO - --app=APP Application being installed. [default: firefox] 16:36:55 INFO - mkdir: /builds/slave/test-pgo/build/application 16:36:55 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'] 16:36:55 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 16:37:09 INFO - Reading from file tmpfile_stdout 16:37:09 INFO - Output received: 16:37:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:37:09 INFO - Running post-action listener: _resource_record_post_action 16:37:09 INFO - ##### 16:37:09 INFO - ##### Running run-tests step. 16:37:09 INFO - ##### 16:37:09 INFO - Running pre-action listener: _resource_record_pre_action 16:37:09 INFO - Running main action method: run_tests 16:37:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:37:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:37:09 INFO - Python 2.7.3 16:37:09 INFO - Return code: 0 16:37:09 INFO - grabbing minidump binary from tooltool 16:37: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')]} 16:37:09 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 0x28d7bf0>, '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 0x2bd54f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd59a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:37:09 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 16:37:09 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 16:37:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:37:09 INFO - Return code: 0 16:37:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:37:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:37:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:37:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:37:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:37:09 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/6hcExAXQSp2yNGOiSWvz-Q/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-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:37:09 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/6hcExAXQSp2yNGOiSWvz-Q/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-058 --webServer localhost 16:37:09 INFO - Using env: {'DISPLAY': ':0', 16:37:09 INFO - 'HOME': '/home/cltbld', 16:37:09 INFO - 'LANG': 'en_US.UTF-8', 16:37:09 INFO - 'LANGUAGE': 'en_US:en', 16:37:09 INFO - 'LOGNAME': 'cltbld', 16:37:09 INFO - 'MAIL': '/var/mail/cltbld', 16:37:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:37:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:09 INFO - 'MOZ_NO_REMOTE': '1', 16:37:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:09 INFO - 'NO_EM_RESTART': '1', 16:37:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:37:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:37:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:37:09 INFO - 'SHELL': '/bin/bash', 16:37:09 INFO - 'SHLVL': '1', 16:37:09 INFO - 'TERM': 'linux', 16:37:09 INFO - 'TMOUT': '86400', 16:37:09 INFO - 'USER': 'cltbld', 16:37:09 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761', 16:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:09 INFO - '_': '/tools/buildbot/bin/python'} 16:37:09 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/6hcExAXQSp2yNGOiSWvz-Q/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-058', '--webServer', 'localhost'] with output_timeout 3600 16:37:09 INFO - mozversion INFO | application_buildid: 20151027142931 16:37:09 INFO - mozversion INFO | application_changeset: c017ca15c40c99776c84f40c100cb5c578b8ae66 16:37:09 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:37:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:37:09 INFO - mozversion INFO | application_name: Firefox 16:37:09 INFO - mozversion INFO | application_remotingname: firefox-dev 16:37:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:37:09 INFO - mozversion INFO | application_vendor: Mozilla 16:37:09 INFO - mozversion INFO | application_version: 43.0a2 16:37:09 INFO - mozversion INFO | platform_buildid: 20151027142931 16:37:09 INFO - mozversion INFO | platform_changeset: c017ca15c40c99776c84f40c100cb5c578b8ae66 16:37:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:37:09 INFO - mozversion INFO | platform_version: 43.0a2 16:37:09 INFO - 2015-10-27 16:37:09,716 DEBUG : using testdate: 1445989029 16:37:09 INFO - 2015-10-27 16:37:09,717 DEBUG : actual date: 1445989029 16:37:09 INFO - 2015-10-27 16:37:09,725 INFO : Starting test suite talos-linux64-ix-058 16:37:09 INFO - 2015-10-27 16:37:09,725 INFO : Starting test dromaeo_css 16:37:09 INFO - 2015-10-27 16:37:09,725 DEBUG : operating with platform_type : linux_ 16:37:09 INFO - 2015-10-27 16:37:09,725 INFO : Initialising browser for dromaeo_css test... 16:37:09 INFO - 2015-10-27 16:37:09,744 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsYZ13I/profile http://localhost/getInfo.html 16:37:14 INFO - 2015-10-27 16:37:14,575 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:37:14 INFO - 2015-10-27 16:37:14,575 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:37:14 INFO - 2015-10-27 16:37:14,575 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:37:14 INFO - 2015-10-27 16:37:14,575 DEBUG : BROWSER_OUTPUT: __metrics 16:37:14 INFO - 2015-10-27 16:37:14,732 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:37:15 INFO - 2015-10-27 16:37:15,963 INFO : Browser initialized. 16:37:15 INFO - 2015-10-27 16:37:15,964 INFO : Running cycle 1/1 for dromaeo_css test... 16:37:15 INFO - 2015-10-27 16:37:15,964 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsYZ13I/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:37:27 INFO - 2015-10-27 16:37:27,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 132026368 16:37:27 INFO - 2015-10-27 16:37:27,679 DEBUG : BROWSER_OUTPUT: 16:40:26 INFO - 2015-10-27 16:40:26,750 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) 16:40:27 INFO - 2015-10-27 16:40:27,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 247316480 16:40:27 INFO - 2015-10-27 16:40:27,860 DEBUG : BROWSER_OUTPUT: 16:43:30 INFO - 2015-10-27 16:43:30,046 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) 16:43:30 INFO - 2015-10-27 16:43:30,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 213753856 16:43:30 INFO - 2015-10-27 16:43:30,612 DEBUG : BROWSER_OUTPUT: 16:46:32 INFO - 2015-10-27 16:46:32,375 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) 16:46:32 INFO - 2015-10-27 16:46:32,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 206655488 16:46:32 INFO - 2015-10-27 16:46:32,937 DEBUG : BROWSER_OUTPUT: 16:49:34 INFO - 2015-10-27 16:49:34,690 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) 16:49:35 INFO - 2015-10-27 16:49:35,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 195801088 16:49:35 INFO - 2015-10-27 16:49:35,264 DEBUG : BROWSER_OUTPUT: 16:52:37 INFO - 2015-10-27 16:52:37,624 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) 16:52:38 INFO - 2015-10-27 16:52:38,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 196636672 16:52:38 INFO - 2015-10-27 16:52:38,185 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,241 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) 16:55:40 INFO - 2015-10-27 16:55:40,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 239329280 16:55:40 INFO - 2015-10-27 16:55:40,485 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,487 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:55:40 INFO - 2015-10-27 16:55:40,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:55:40 INFO - 2015-10-27 16:55:40,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:55:40 INFO - 2015-10-27 16:55:40,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:55:40 INFO - 2015-10-27 16:55:40,488 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3318.0709401367612;3376.6285708572036;3406.6252712201654;3408.9943466677328;3430.4511278195496;5658.74535645897;5659.037963546197;5677.517411020063;5688.232088668028;5702.629329093606;5712.11462223355;5723.627964182325;5734.340550836655;5737.426257374261;5755.194272801811;5090.9236361454605;5132.076226279269;5172.353455818023;5187.299714538527;5255.395629502599;4992.276119962621;5088.720120393377;5101.7194054327;5204.713740744258;5239.895202095956;5198.168293073109;5214.530692237698;5217.243499692542;5225.451327610604;5246.291750613656;5070.847874563769;5130.4356520782685;5146.485351464861;5180.611454140917;5227.47725227478;5005.974970125126;5129.9743501282255;5145.434002259748;5148.433672296044;5163.66436181647;5567.860803479945;5581.776728930838;5585.273914391144;5603.131514615241;5616.185653080281;5936.079907614327;6027.819165425044;6047.274327080734;6189.535784816157;6195.1946246988055;6154.199954005995;6247.125402443661;6254.655993920333;6256.343083976162;6259.937400625981;5806.303243610751;5821.330546987066;5824.88350232993;5826.796062137847;5827.533797296206;5996.760129594767;6076.605020673642;6123.989541725566;6204.875902481925;6279.623222606659;6016.067509536029;6017.789377371771;6018.729157187937;6021.849453763603;6039.63762174271;6150.692465376714;6156.569040167145;6156.953317935961;6160.414760597736;6164.291106522717;5929.110633404937;6029.517638588903;6044.24446944132;6117.83455351355;6123.640646600492;6098.634081955008;6115;6118.082287656798;6124.418180272867;6127.234095738033;4539.273716205391;4610.446746390455;4628.675992680547;4629.67592268538;4648.721076735406;4101.7744024078365;4138.52406973196;4147.3986271991;4152.4601801765575;4194.3918131870705;5774.364819869811;5865.794697185578;5871.64770113786;5882.499987501024;5884.823455296262;5953.107033944856;6063.6664983426335;6225.782097626561;6236.376362363727;6244.875102497925;5774.451427114417;5842.474177324061;5876.382979787061;5883.411658834082;5893.233879595625;5308.734563271821;5319.734013299397;5328.706921119298;5330.466953304716;5335.67985920846;6113.0627600468215;6200.286966998853;6224.439800417984;6320.462760665303;6357.523185760994;6125.84685382869;6258.749650014131;6263.906041409474;6267.373262673696;6273.1844860167885;6329.715162817776;6406.1031455597185;6414.358564143548;6416.390442907917;6428.742850285937;5890.4698577128265;5934.881302374015;5976.760929562943;6094.481969032505;6146.569740118149;6118.694065296629;6140.293866205444;6150.415710507495;6150.427929498661;6155.569110162246;5961.463468287701;5973.223480947449;6007.738374941311;6008;6044.214252147192;5753.597248192586;5847.561432892635;5895.233619629421;5944.464998150187;5965.224520812267;5830.154627579062;5913.2608423947;5925.4370834770625;5928.644281343133;5930.495907847881;5890.293164820249;5991.580589358878;6020.789272375446;6065.211522502046;6067.969660151671;5867.618604790675;5893.410658934244;6014.8195554133445;6015.729292181775;6038.667873266837 16:55:40 INFO - 2015-10-27 16:55:40,490 DEBUG : BROWSER_OUTPUT: |1;ext.html;588.7556663984446;604.4439116013267;634.400491535499;634.8698516804055;640.0623087177287;35624;45558.316625250605;46237.07525849481;46238.76880615597;46252.76873615636;49406.50593494064;50075.49924500754;50083.74958125204;50137.49862501374;50233;8137.104918458995;8275.875861862047;9297.814043719138;9476.71569852902;9477.38397004196;11102.944485277561;11381.2033157679;11421.942890285536;11432.142589305793;11439.5424183033;10887.455627218647;10887.891121088807;10971.23201375904;10973.067289280421;10989.725256868562;8401.831963360759;8556.572171391406;10990.395528245943;11094.55621775128;11098;10920.617778377798;11119.833202501968;11122;11134.888651113548;11136.944315278372;42294.788526057484;42397;42566.36150457746;42755.35866961998;42848.57151428477;3744.6068162843053;4169.854055108057;4179.749215047107;4400.823967041314;4590.173768721629;34001.48997765035;34030.48954265688;34206.94045215373;34281.48577771335;34510.48234276488;3902.9219415611815;3951.269015232191;3953.42675312081;3964.2864284428792;3986.362182050887;342900;347456;348090.25954870315;349796;350549;57790.711046445336;58711;66064.66967665227;66860;72180.63909680418;68473;68970;69262;69474.65262673654;69671.3032869675;19367.225310987684;19420.708689369672;19551.21795128179;19570.60858782845;19580.118894649775;12596.370181490889;12774.552890648783;15189.696206076038;15548.92225538865;15606.921965390327;21183.258585949727;21312;21333.46666333354;21375.251866184608;21386.679199812017;8339.374546909006;8763.737087887373;8810.955945220232;8887.644494220289;8888.466786965684;1059.4808543813476;1082.3224002795635;1132.8841091524841;1144.2047776795214;1187.3410257307105;31818.68181318157;31937.361252774816;32253;32926.67073329284;33068.83465582657;1206.7313450712604;1230.870758570355;1260.350919276555;1271.5486002469174;1326.5091915991145;15193.544193673986;15653.295601697951;15731.44939927097;17242.224099915533;17258.741118883227;456363;461684;463049;463543;464195;60195;60495;60507;60546.69726651427;60606;1397.4200706706806;1439.755241608929;1539.6150962259435;1560.3212602518167;1568.5921660368385;29992.25019374533;30255.69744302529;30654.233644159074;30694.0048896821;33165;48952.75523622359;49920.750396247786;50850.23724644207;50858.74570627271;51136.74431627818;536710;546698;549552.0089598265;550977;556714;34479.31041379208;34981;35125.12187195341;35127.64872351346;35351.46972795359;48737.2689409652;48871;49119.754401227765;49493.752531237114;49790;40623.39064913969;41256;41438.79280603577;41781.79109104435;42416.787916060224;40338.798306009456;40466;40518.59481405266;40658.79670601628;41277.38083928683;42317.78841105775;42327.788361057996;42876.78561607172;42993.570064298954;43059.569404305556;35901.28197436089;36669.816650916575;37356;37814.43278350882;37897.81051094727;28532;28623.713762862106;28696.426071478872;28769.280767980967;28824 16:55:40 INFO - 2015-10-27 16:55:40,491 DEBUG : BROWSER_OUTPUT: |2;jquery.html;420.09259998403456;424.70695220297995;426.6821218192447;429.6648614081016;432.9675274354424;14847.480338188165;15319.92340038301;18389.44831655049;18459.907700461496;18887.15007824648;17265.913670431662;17699.292028318883;18234.452966410994;18816.435506934813;18859.24563017481;5612.943870561293;5773.971130144364;5777.508911742507;5781.248437703092;5788.102844059177;4290.978545107286;4412.624926881203;5810.535157187415;6254.030625253093;6454.903176452357;6263.436290733833;6347.492200623939;6369.235691717;6395.872082558346;6401.967990160043;6382.457491113261;6402.231732192144;6408.327125651833;6410.102585637967;6415.582987105847;2921.2258751430886;4453.309736990772;5742.655440673531;5744.425557444264;5751.712414379264;23466.64800028001;23564.882175589013;23743.525129497488;23751;23800.642990355158;2424.3090719145134;2508.4356019895376;2510.79913606911;2584.3151564835334;2615.5292047431453;11125.443727813657;11282.379469129195;11466.541338346457;14662.8236346469;15296.388144474207;1799.3342463288536;1826.4520643806804;1877.220953304377;1902.6955687089999;1945.7665080190468;67481;69329.14203028685;69357;69428;69581;7909.52542847431;7957.880631790527;7963.920360796318;8016;8027.277545020859;9636.951815240878;9649.903500965042;9654.27592930533;9659.565319560637;9661.806763864824;6435.517336199804;6482.189726284215;6533.150690410312;6541.443977261891;6542.672866356663;6701.765438209737;6734.56225345351;6743.730250790011;6745.325467453314;6758.391744742997;3655.981720091436;3672.3389789838084;3680.190358121209;3689.9262014759556;3707.258548290353;1257.735875466144;1292.5476083370745;1292.702678383977;1294.9158304710163;1344.247221555932;483.7194427232197;491.44466752569366;506.9467705890902;506.9771860266297;513.1302442360238;11131.220814543067;12675.429605667583;13136;13304.800427993589;13510.256935868621;517.8964207158583;539.754411742664;549.4505494505495;561.2871653000666;566.6486778197544;7061.717531298793;7116.608586527687;7181.389581885598;7225.710971561184;7283.890741638879;431045;432222;434238;436222;614399;88066;89870;91384;92354.53822730844;92407;548.298178331736;572.8739677270994;577.3389469057989;578.109711044986;578.3233616668508;12448.31534265624;12460.439280232593;12590.811137833123;12712.491500339884;12808.551700690432;39560.40659390054;40128.197436050534;40450.59549404586;40940.38589421221;41925.37111943385;50507.24239136343;55256.17115743187;56380.43619563916;56600;57149.71425142848;7585.241475852371;7690.538567685957;7750.806229844299;7758.340541054074;7777.805554861174;13145.868541314847;13227.3386330685;13306.401211945293;13360.465581376637;13503.324833758077;12101.273923564615;12212.57255996036;12229.205101668364;12335.259884406963;12342.197757145757;11728.941355293511;12004.39978001079;12105.818412723993;12237.755244894874;12240.143189976616;9207.86188207164;11241.831372529256;11951.163418560618;12111.697207569881;12138.33239171854;7438.144613369532;7614.8096297593;7615.048118985127;7637.770866874002;7639.350655194371;11938.22401543897;12091.334976576372;12130.696732581757;12177.878221217674;12297.44661490253 16:55:40 INFO - 2015-10-27 16:55:40,495 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1496.7006598680252;1644.1696943043758;1840.7054871220605;2052.9794702052973;2072.906719197636;8886.333524985619;10109.494525273734;10226.590936362556;10246.590136394536;10249.795004099922;9971.501424928761;10000.099991000809;10007.74980625483;10141.188704903609;10147.49262536872;2183.465051062484;2210.5910406574753;2457.7542245775458;2492.439201179738;2496.438301382188;2534.252395543319;2565.3714839864165;2567.9871600642064;2571.2671888511777;2576.433184699363;2478.1698131126095;2501.374656335916;2504.5992641177413;2506.4485813121173;2509.2848538166627;2033.6949457581334;2089.9791002089937;2450.277168235375;2532.7087384950783;2556.7315431879756;2473.579491486452;2492.2024952015363;2496.862672553009;2550.2094350751327;2565.910193143231;10513.579456821719;10585.78828423435;10591.682249532527;10625.84061239082;10632.734181645443;5814.360420353758;5901.616394934315;5911.320198177222;5917.408259174048;5921.911171332434;3851.9422208666892;3859.787711675857;3860.536735591747;3886.5724770275247;3917.98041009796;1204.9578264760692;1245.2341809786915;1258.6538701857062;1267.8795514426115;1270.1553466944472;15555.222238888124;15560.92219538895;15562.377504899903;15569.92215038929;15582.298796554182;5267.473252674702;5291.973540132275;5296.364436267596;5302.469753024667;5321.494458026481;12302.261864288172;12330;12343;12348.876511234952;12381.690457738448;5848.122781582797;5858.47273745365;5859.472647461664;5859.5019423349495;5862.120681897664;5285.180796976475;5301.045811753845;5304;5311.707856067954;5314.1497360422145;4267.0825772459075;4276.123394704078;4297.076128632297;4299.591538803808;4331.935020974688;1156.5200441816721;1171.0982543441503;1179.3101035893926;1181.5510106159777;1191.3447603817865;1005.6128390569684;1136.778328225988;1163.5811108001112;1164.6098556983336;1174.2074099982478;9591.616335346647;9630.32587718867;9634.373765705206;9751.21990240779;9947;1288.6327396691897;1291.0053966621592;1295.863934286905;1298.6169080121388;1307.941142648564;6792.694328755119;6830.248672646005;6834.384905358442;6843.213030501456;6851.109355783717;13524.391402386917;13707;13713;13734.175949443066;13754.243516606482;13308.068435209443;13585.59243222705;13597.932010340082;13598;13675;9567.9043209567;9852.310338276251;9866.45734484596;9911.900880991097;9920.900790992142;9312.767180820534;9321.067893210624;9346.15884570392;9347.345685801929;9376.343655944018;11431.314121152758;11433.942830285796;11691.649250522158;11708.88291117112;11713.062954963412;11662.766744665229;11819.881801182222;11844.763104737685;11897.940510297392;11933;8632.352573557135;8663.95668021656;8666.566671666265;8673.522956237468;8682.218600325748;10104.444255566015;10237.488125593542;10300.639477618248;10333;10335.483225838829;9232.169104780602;9245.953770231106;9252;9271.258299336172;9369.484678342757;9099.317551183556;9258.53707314645;9267.814643706954;9358.344915855825;9381.249500040118;8228.01263848342;8463.53450560225;9105.04397038328;9273.443593384418;9276.72169834906;8213.425060245725;8406;8430.325573954191;8439.156084391512;8470.237678608955;8501.914980850112;8617.267532259828;8646.394752367525;8648.956755216184;8651.134886511298 16:55:40 INFO - 2015-10-27 16:55:40,496 DEBUG : BROWSER_OUTPUT: |4;prototype.html;370.7830918912436;373.15852752044145;373.16783572633017;373.40628400842655;383.59339100553416;5888.5877988540815;5962.284525856898;5982.222311099551;5997.850053748659;6014.8797024059495;5871.500922421599;5924.348321684612;5933.376995415484;5949.791757288495;5976.19321391612;4669.159551280768;4687.859364219062;4690.29645553168;4692.835750748707;4700.811967521295;4538.727676339414;4559.886002849922;4635.466921304042;4688.624910007208;4690.413698287714;4637.605803506689;4658.813647454114;4665.2768820832825;4677.4854765975715;4688.390509233795;4647.186742320097;4664.183767840615;4664.953350466486;4668.393108895839;4681.227597446417;4191.077962848169;4195.181939521794;4198.3702444633245;4199.4120823084795;4206.705530612859;5550.91673624896;5640.464155905182;5656;5665.8583535411535;5738.454846789548;5468.945310546923;5469.480399362054;5470.890582188374;5473.397926228112;5478.561715062785;6400.647964361959;6409.3590640936;6411.198600174978;6416.486681065504;6425.61446313218;4469.709468884512;4522.68341216115;4591.242444996572;4646.930296045562;4647.86056418308;6454.386833250834;6479.546431749779;6497.837554061186;6501.0573466847045;6502.447291980187;4723.763811809465;4761.142994260997;4766.928496072562;4767.284907263869;4768.356271903249;4636.814527418933;4729.266963620645;4829.227323628203;4830.661853670209;4834.419869615669;5374.059539580558;5374.328208973879;5378.9462105379225;5381;5381;6312.715927783169;6315.621062736251;6363.045543168561;6365.2998170201245;6372.426481616677;1676.857467115309;1695.3981336625568;1695.626962068343;1697.7283634618402;1700.2943778331853;1130.2879186112696;1161.8431511745976;1174.3775798826637;1182.1606659272013;1187.6199616122758;6138;6140.754369825247;6141.355157708465;6146.969265153735;6151.6001459904965;6519.3154718754795;6535.248446428626;6538.509611779041;6550.836229094215;6553.279139294674;6008.639481631116;6132.78535251264;6136.20229370179;6137.3862613738265;6139.662318572521;3597.6042635310096;3627.4558816177255;3634.6547078027547;3635.8000309982676;3639.47227651989;6721.630310332978;6721.6975236114495;6725.361090696376;6728.428083612947;6733.225679046875;6645.468362531083;6729.663516824237;6739.730410783612;6747.156605424322;6751.324867513209;6679.632620205838;6689.6989635466525;6726.495512836557;6739.359760822714;6746.4265537429865;6317.115603815561;6394.104825324365;6551.574147680385;6560.245571759308;6569.080328753883;6367.42693157618;6452.935470645421;6456.2575303838785;6494.772682956074;6497.02544618311;6697.531172817856;6705.564138330993;6706.429953453816;6712.093867327848;6724.092247546714;4601.608863246528;4620.075984802986;4660.1145782301255;4669.883252918704;4670.136024835417;6491.253505846888;6492.870142597216;6501.772437964649;6504.1869766279215;6507.349265073455;6338.271098823509;6338.397852204033;6338.651374174465;6343.492520598434;6343.555951083565;6235.127082208585;6302.716377763103;6325.936740632535;6336.144620476177;6339.651319177305;6217.285012223652;6229.12792209082;6303.401176888188;6308.116863639002;6311.084892690626;6416.422521973045;6422;6424.807255782334;6427.485801135805;6432.935670643421;6165.290991536031;6228.719707613078;6263.530235232467;6286.151369565233;6287.591306565058 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: |5;yui.html;927.6474939522981;931.8136372725453;933.6405483888705;936.8688383626293;951.7030606810249;13936.233507157101;13992.930035349822;14056.016078874483;14178.78731819021;14343.067700599468;14671.706565868677;14699.338529766159;14715.779263311058;14747.262636868167;14783.334749936252;752.3041186902121;756.4666909828558;902.2826852652124;906.5557876640448;920.8894932608097;920.9355345125844;922.3727865051762;930.6417029443645;930.9813803723921;932;951.4196340232453;956.0726095687172;965.5606698951996;965.599276300338;965.6185806606386;783.5337973905517;792.2077922077922;987.4865070163474;1004.3622299839582;1008.037324355239;711.1785887300176;713.0979311171373;717.5479447947812;720.585663243637;720.6901032555999;14258.358373873098;14519.20144392058;14563.70872582553;14623;14638;11657.475413606324;12156.574519891761;12210.57262995791;12831.615051548468;13355.599332020054;10300.896991030144;10622.468876556219;10667.946660266727;10724.73188170302;10754.462276886125;3665.6334366563397;3699.6300369963055;3726.81365931705;3730.626937306248;3735.2156047230114;41795.7910210447;42452.78773606143;42554.78722606398;47032.76483617594;47439.28841067387;9815.558299876522;9871.160951319218;9936.056074672895;10069.496525173858;10314.381137131797;18938.526536836413;18985.525361865788;19114.426567203005;19952.60094798125;20005.699914501292;7872.527648341118;7900.130985591581;7957.641906114239;8160.143184965612;8398.538080405515;4543.409356783597;4590.127875703605;4648.581627653527;4663.370444989951;4672.5327467253;3315.3203593263324;3335.182880194368;3343.348047130835;3343.7993720376853;3345.3142105868237;517.9119549676564;527.6359312074657;532.6777299733683;540.4541413172724;541.7264281537798;520.4327283261264;575.7783253447369;645.2515082504273;697.2957313113792;736.6353654940839;8471.152884711479;8675.219230269306;8704.086070962585;9048.095190481032;9413.435193888388;556.4880310114704;567.5317862763237;611.8317462697705;647.4949539359308;692.5879101934341;3955.3275943089743;4140.3375459926265;4185.22573323936;4221.290114417637;4231.196072746168;52890;53124.46875531272;53140.46859531433;53273;53428.46571534235;45097;46184;48498;48744.51255487471;48804.511954880705;41265.79367103145;41792.37311440331;41822;41909;41988;8672.826543469222;8942.50816205115;9004.729858104267;9080.091990800867;9169.899612046596;28600.856995714887;29260.853695731385;29502.85248573829;29676.40647187001;29705.70294297116;38239.42640860445;38824.223515530095;38951.80524097361;39000.41499377568;40827.7958610205;8339.374546908884;8441.915580844114;8487.236148746642;8537.53043582609;8568;12143;12253.081018923795;12342.629721108382;12527.060470464568;12589.055820813659;10187.541560629938;10889.509972051435;11088.112950963743;11446.37044962535;11449.656510304705;10926.836097458703;11066.28069175501;11642.476088575864;11681.357525336189;11825;9053.864192037256;11219.607313744305;11902.166848320881;12132.696682582653;12297;10055.849162262426;10397.556554344377;10471.42407167613;10555;10716.35701857891;10056.849147262943;10315.865254821814;10360.430176340073;10399.1160751337;10470.842937355794 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,870 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: __startTimestamp1445990140485__endTimestamp 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,498 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:55:40 INFO - 2015-10-27 16:55:40,499 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:55:40 INFO - 2015-10-27 16:55:40,499 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,499 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5682.36 Median:5895.23 stddev:649.97 (11.0%) stddev-sans-first:624.94 16:55:40 INFO - 2015-10-27 16:55:40,499 DEBUG : BROWSER_OUTPUT: Values: 3318.1 3376.6 3406.6 3409.0 3430.5 5658.7 5659.0 5677.5 5688.2 5702.6 5712.1 5723.6 5734.3 5737.4 5755.2 5090.9 5132.1 5172.4 5187.3 5255.4 4992.3 5088.7 5101.7 5204.7 5239.9 5198.2 5214.5 5217.2 5225.5 5246.3 5070.8 5130.4 5146.5 5180.6 5227.5 5006.0 5130.0 5145.4 5148.4 5163.7 5567.9 5581.8 5585.3 5603.1 5616.2 5936.1 6027.8 6047.3 6189.5 6195.2 6154.2 6247.1 6254.7 6256.3 6259.9 5806.3 5821.3 5824.9 5826.8 5827.5 5996.8 6076.6 6124.0 6204.9 6279.6 6016.1 6017.8 6018.7 6021.8 6039.6 6150.7 6156.6 6157.0 6160.4 6164.3 5929.1 6029.5 6044.2 6117.8 6123.6 6098.6 6115.0 6118.1 6124.4 6127.2 4539.3 4610.4 4628.7 4629.7 4648.7 4101.8 4138.5 4147.4 4152.5 4194.4 5774.4 5865.8 5871.6 5882.5 5884.8 5953.1 6063.7 6225.8 6236.4 6244.9 5774.5 5842.5 5876.4 5883.4 5893.2 5308.7 5319.7 5328.7 5330.5 5335.7 6113.1 6200.3 6224.4 6320.5 6357.5 6125.8 6258.7 6263.9 6267.4 6273.2 6329.7 6406.1 6414.4 6416.4 6428.7 5890.5 5934.9 5976.8 6094.5 6146.6 6118.7 6140.3 6150.4 6150.4 6155.6 5961.5 5973.2 6007.7 6008.0 6044.2 5753.6 5847.6 5895.2 5944.5 5965.2 5830.2 5913.3 5925.4 5928.6 5930.5 5890.3 5991.6 6020.8 6065.2 6068.0 5867.6 5893.4 6014.8 6015.7 6038.7 16:55:40 INFO - 2015-10-27 16:55:40,499 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,499 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62669.28 Median:3927.10 stddev:121775.95 (3100.9%) stddev-sans-first:122028.36 16:55:40 INFO - 2015-10-27 16:55:40,500 DEBUG : BROWSER_OUTPUT: Values: 588.8 604.4 634.4 634.9 640.1 35624.0 45558.3 46237.1 46238.8 46252.8 49406.5 50075.5 50083.7 50137.5 50233.0 8137.1 8275.9 9297.8 9476.7 9477.4 11102.9 11381.2 11421.9 11432.1 11439.5 10887.5 10887.9 10971.2 10973.1 10989.7 8401.8 8556.6 10990.4 11094.6 11098.0 10920.6 11119.8 11122.0 11134.9 11136.9 42294.8 42397.0 42566.4 42755.4 42848.6 3744.6 4169.9 4179.7 4400.8 4590.2 34001.5 34030.5 34206.9 34281.5 34510.5 3902.9 3951.3 3953.4 3964.3 3986.4 342900.0 347456.0 348090.3 349796.0 350549.0 57790.7 58711.0 66064.7 66860.0 72180.6 68473.0 68970.0 69262.0 69474.7 69671.3 19367.2 19420.7 19551.2 19570.6 19580.1 12596.4 12774.6 15189.7 15548.9 15606.9 21183.3 21312.0 21333.5 21375.3 21386.7 8339.4 8763.7 8811.0 8887.6 8888.5 1059.5 1082.3 1132.9 1144.2 1187.3 31818.7 31937.4 32253.0 32926.7 33068.8 1206.7 1230.9 1260.4 1271.5 1326.5 15193.5 15653.3 15731.4 17242.2 17258.7 456363.0 461684.0 463049.0 463543.0 464195.0 60195.0 60495.0 60507.0 60546.7 60606.0 1397.4 1439.8 1539.6 1560.3 1568.6 29992.3 30255.7 30654.2 30694.0 33165.0 48952.8 49920.8 50850.2 50858.7 51136.7 536710.0 546698.0 549552.0 550977.0 556714.0 34479.3 34981.0 35125.1 35127.6 35351.5 48737.3 48871.0 49119.8 49493.8 49790.0 40623.4 41256.0 41438.8 41781.8 42416.8 40338.8 40466.0 40518.6 40658.8 41277.4 42317.8 42327.8 42876.8 42993.6 43059.6 35901.3 36669.8 37356.0 37814.4 37897.8 28532.0 28623.7 28696.4 28769.3 28824.0 16:55:40 INFO - 2015-10-27 16:55:40,501 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,501 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27142.09 Median:4432.97 stddev:78395.70 (1768.5%) stddev-sans-first:78589.94 16:55:40 INFO - 2015-10-27 16:55:40,502 DEBUG : BROWSER_OUTPUT: Values: 420.1 424.7 426.7 429.7 433.0 14847.5 15319.9 18389.4 18459.9 18887.2 17265.9 17699.3 18234.5 18816.4 18859.2 5612.9 5774.0 5777.5 5781.2 5788.1 4291.0 4412.6 5810.5 6254.0 6454.9 6263.4 6347.5 6369.2 6395.9 6402.0 6382.5 6402.2 6408.3 6410.1 6415.6 2921.2 4453.3 5742.7 5744.4 5751.7 23466.6 23564.9 23743.5 23751.0 23800.6 2424.3 2508.4 2510.8 2584.3 2615.5 11125.4 11282.4 11466.5 14662.8 15296.4 1799.3 1826.5 1877.2 1902.7 1945.8 67481.0 69329.1 69357.0 69428.0 69581.0 7909.5 7957.9 7963.9 8016.0 8027.3 9637.0 9649.9 9654.3 9659.6 9661.8 6435.5 6482.2 6533.2 6541.4 6542.7 6701.8 6734.6 6743.7 6745.3 6758.4 3656.0 3672.3 3680.2 3689.9 3707.3 1257.7 1292.5 1292.7 1294.9 1344.2 483.7 491.4 506.9 507.0 513.1 11131.2 12675.4 13136.0 13304.8 13510.3 517.9 539.8 549.5 561.3 566.6 7061.7 7116.6 7181.4 7225.7 7283.9 431045.0 432222.0 434238.0 436222.0 614399.0 88066.0 89870.0 91384.0 92354.5 92407.0 548.3 572.9 577.3 578.1 578.3 12448.3 12460.4 12590.8 12712.5 12808.6 39560.4 40128.2 40450.6 40940.4 41925.4 50507.2 55256.2 56380.4 56600.0 57149.7 7585.2 7690.5 7750.8 7758.3 7777.8 13145.9 13227.3 13306.4 13360.5 13503.3 12101.3 12212.6 12229.2 12335.3 12342.2 11728.9 12004.4 12105.8 12237.8 12240.1 9207.9 11241.8 11951.2 12111.7 12138.3 7438.1 7614.8 7615.0 7637.8 7639.4 11938.2 12091.3 12130.7 12177.9 12297.4 16:55:40 INFO - 2015-10-27 16:55:40,502 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,502 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7157.96 Median:2542.23 stddev:4117.11 (161.9%) stddev-sans-first:4106.68 16:55:40 INFO - 2015-10-27 16:55:40,502 DEBUG : BROWSER_OUTPUT: Values: 1496.7 1644.2 1840.7 2053.0 2072.9 8886.3 10109.5 10226.6 10246.6 10249.8 9971.5 10000.1 10007.7 10141.2 10147.5 2183.5 2210.6 2457.8 2492.4 2496.4 2534.3 2565.4 2568.0 2571.3 2576.4 2478.2 2501.4 2504.6 2506.4 2509.3 2033.7 2090.0 2450.3 2532.7 2556.7 2473.6 2492.2 2496.9 2550.2 2565.9 10513.6 10585.8 10591.7 10625.8 10632.7 5814.4 5901.6 5911.3 5917.4 5921.9 3851.9 3859.8 3860.5 3886.6 3918.0 1205.0 1245.2 1258.7 1267.9 1270.2 15555.2 15560.9 15562.4 15569.9 15582.3 5267.5 5292.0 5296.4 5302.5 5321.5 12302.3 12330.0 12343.0 12348.9 12381.7 5848.1 5858.5 5859.5 5859.5 5862.1 5285.2 5301.0 5304.0 5311.7 5314.1 4267.1 4276.1 4297.1 4299.6 4331.9 1156.5 1171.1 1179.3 1181.6 1191.3 1005.6 1136.8 1163.6 1164.6 1174.2 9591.6 9630.3 9634.4 9751.2 9947.0 1288.6 1291.0 1295.9 1298.6 1307.9 6792.7 6830.2 6834.4 6843.2 6851.1 13524.4 13707.0 13713.0 13734.2 13754.2 13308.1 13585.6 13597.9 13598.0 13675.0 9567.9 9852.3 9866.5 9911.9 9920.9 9312.8 9321.1 9346.2 9347.3 9376.3 11431.3 11433.9 11691.6 11708.9 11713.1 11662.8 11819.9 11844.8 11897.9 11933.0 8632.4 8664.0 8666.6 8673.5 8682.2 10104.4 10237.5 10300.6 10333.0 10335.5 9232.2 9246.0 9252.0 9271.3 9369.5 9099.3 9258.5 9267.8 9358.3 9381.2 8228.0 8463.5 9105.0 9273.4 9276.7 8213.4 8406.0 8430.3 8439.2 8470.2 8501.9 8617.3 8646.4 8649.0 8651.1 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5355.30 Median:6073.83 stddev:1554.68 (25.6%) stddev-sans-first:1513.36 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: Values: 370.8 373.2 373.2 373.4 383.6 5888.6 5962.3 5982.2 5997.9 6014.9 5871.5 5924.3 5933.4 5949.8 5976.2 4669.2 4687.9 4690.3 4692.8 4700.8 4538.7 4559.9 4635.5 4688.6 4690.4 4637.6 4658.8 4665.3 4677.5 4688.4 4647.2 4664.2 4665.0 4668.4 4681.2 4191.1 4195.2 4198.4 4199.4 4206.7 5550.9 5640.5 5656.0 5665.9 5738.5 5468.9 5469.5 5470.9 5473.4 5478.6 6400.6 6409.4 6411.2 6416.5 6425.6 4469.7 4522.7 4591.2 4646.9 4647.9 6454.4 6479.5 6497.8 6501.1 6502.4 4723.8 4761.1 4766.9 4767.3 4768.4 4636.8 4729.3 4829.2 4830.7 4834.4 5374.1 5374.3 5378.9 5381.0 5381.0 6312.7 6315.6 6363.0 6365.3 6372.4 1676.9 1695.4 1695.6 1697.7 1700.3 1130.3 1161.8 1174.4 1182.2 1187.6 6138.0 6140.8 6141.4 6147.0 6151.6 6519.3 6535.2 6538.5 6550.8 6553.3 6008.6 6132.8 6136.2 6137.4 6139.7 3597.6 3627.5 3634.7 3635.8 3639.5 6721.6 6721.7 6725.4 6728.4 6733.2 6645.5 6729.7 6739.7 6747.2 6751.3 6679.6 6689.7 6726.5 6739.4 6746.4 6317.1 6394.1 6551.6 6560.2 6569.1 6367.4 6452.9 6456.3 6494.8 6497.0 6697.5 6705.6 6706.4 6712.1 6724.1 4601.6 4620.1 4660.1 4669.9 4670.1 6491.3 6492.9 6501.8 6504.2 6507.3 6338.3 6338.4 6338.7 6343.5 6343.6 6235.1 6302.7 6325.9 6336.1 6339.7 6217.3 6229.1 6303.4 6308.1 6311.1 6416.4 6422.0 6424.8 6427.5 6432.9 6165.3 6228.7 6263.5 6286.2 6287.6 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13198.18 Median:41948.50 stddev:14380.11 (34.3%) stddev-sans-first:14390.92 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: Values: 927.6 931.8 933.6 936.9 951.7 13936.2 13992.9 14056.0 14178.8 14343.1 14671.7 14699.3 14715.8 14747.3 14783.3 752.3 756.5 902.3 906.6 920.9 920.9 922.4 930.6 931.0 932.0 951.4 956.1 965.6 965.6 965.6 783.5 792.2 987.5 1004.4 1008.0 711.2 713.1 717.5 720.6 720.7 14258.4 14519.2 14563.7 14623.0 14638.0 11657.5 12156.6 12210.6 12831.6 13355.6 10300.9 10622.5 10667.9 10724.7 10754.5 3665.6 3699.6 3726.8 3730.6 3735.2 41795.8 42452.8 42554.8 47032.8 47439.3 9815.6 9871.2 9936.1 10069.5 10314.4 18938.5 18985.5 19114.4 19952.6 20005.7 7872.5 7900.1 7957.6 8160.1 8398.5 4543.4 4590.1 4648.6 4663.4 4672.5 3315.3 3335.2 3343.3 3343.8 3345.3 517.9 527.6 532.7 540.5 541.7 520.4 575.8 645.3 697.3 736.6 8471.2 8675.2 8704.1 9048.1 9413.4 556.5 567.5 611.8 647.5 692.6 3955.3 4140.3 4185.2 4221.3 4231.2 52890.0 53124.5 53140.5 53273.0 53428.5 45097.0 46184.0 48498.0 48744.5 48804.5 41265.8 41792.4 41822.0 41909.0 41988.0 8672.8 8942.5 9004.7 9080.1 9169.9 28600.9 29260.9 29502.9 29676.4 29705.7 38239.4 38824.2 38951.8 39000.4 40827.8 8339.4 8441.9 8487.2 8537.5 8568.0 12143.0 12253.1 12342.6 12527.1 12589.1 10187.5 10889.5 11088.1 11446.4 11449.7 10926.8 11066.3 11642.5 11681.4 11825.0 9053.9 11219.6 11902.2 12132.7 12297.0 10055.8 10397.6 10471.4 10555.0 10716.4 10056.8 10315.9 10360.4 10399.1 10470.8 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:55:40 INFO - 2015-10-27 16:55:40,503 DEBUG : BROWSER_OUTPUT: 16:55:41 INFO - 2015-10-27 16:55:41,041 INFO : Browser exited with error code: 0 16:55:41 INFO - 2015-10-27 16:55:41,058 INFO : Completed test dromaeo_css (00:18:31) 16:55:41 INFO - 2015-10-27 16:55:41,058 INFO : Starting test kraken 16:55:41 INFO - 2015-10-27 16:55:41,058 DEBUG : operating with platform_type : linux_ 16:55:41 INFO - 2015-10-27 16:55:41,058 INFO : Initialising browser for kraken test... 16:55:41 INFO - 2015-10-27 16:55:41,064 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsfdFpJ/profile http://localhost/getInfo.html 16:55:44 INFO - 2015-10-27 16:55:44,623 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:55:44 INFO - 2015-10-27 16:55:44,623 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:55:44 INFO - 2015-10-27 16:55:44,623 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:55:44 INFO - 2015-10-27 16:55:44,623 DEBUG : BROWSER_OUTPUT: __metrics 16:55:44 INFO - 2015-10-27 16:55:44,788 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:46 INFO - 2015-10-27 16:55:46,034 INFO : Browser initialized. 16:55:46 INFO - 2015-10-27 16:55:46,035 INFO : Running cycle 1/1 for kraken test... 16:55:46 INFO - 2015-10-27 16:55:46,035 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsfdFpJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:55:57 INFO - 2015-10-27 16:55:57,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 131698688 16:55:57 INFO - 2015-10-27 16:55:57,756 DEBUG : BROWSER_OUTPUT: 16:56:00 INFO - 2015-10-27 16:56:00,659 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) 16:56:01 INFO - 2015-10-27 16:56:01,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 167038976 16:56:01 INFO - 2015-10-27 16:56:01,233 DEBUG : BROWSER_OUTPUT: 16:56:03 INFO - 2015-10-27 16:56:03,755 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) 16:56:04 INFO - 2015-10-27 16:56:04,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 162951168 16:56:04 INFO - 2015-10-27 16:56:04,324 DEBUG : BROWSER_OUTPUT: 16:56:07 INFO - 2015-10-27 16:56:07,115 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) 16:56:07 INFO - 2015-10-27 16:56:07,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 162476032 16:56:07 INFO - 2015-10-27 16:56:07,688 DEBUG : BROWSER_OUTPUT: 16:56:09 INFO - 2015-10-27 16:56:09,640 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) 16:56:10 INFO - 2015-10-27 16:56:10,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 160382976 16:56:10 INFO - 2015-10-27 16:56:10,201 DEBUG : BROWSER_OUTPUT: 16:56:12 INFO - 2015-10-27 16:56:12,299 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) 16:56:12 INFO - 2015-10-27 16:56:12,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 155963392 16:56:12 INFO - 2015-10-27 16:56:12,861 DEBUG : BROWSER_OUTPUT: 16:56:15 INFO - 2015-10-27 16:56:15,658 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) 16:56:16 INFO - 2015-10-27 16:56:16,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 155389952 16:56:16 INFO - 2015-10-27 16:56:16,220 DEBUG : BROWSER_OUTPUT: 16:56:19 INFO - 2015-10-27 16:56:19,508 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) 16:56:20 INFO - 2015-10-27 16:56:20,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 155516928 16:56:20 INFO - 2015-10-27 16:56:20,083 DEBUG : BROWSER_OUTPUT: 16:56:22 INFO - 2015-10-27 16:56:22,760 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) 16:56:23 INFO - 2015-10-27 16:56:23,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 155963392 16:56:23 INFO - 2015-10-27 16:56:23,342 DEBUG : BROWSER_OUTPUT: 16:56:24 INFO - 2015-10-27 16:56:24,823 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) 16:56:25 INFO - 2015-10-27 16:56:25,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 165543936 16:56:25 INFO - 2015-10-27 16:56:25,376 DEBUG : BROWSER_OUTPUT: 16:56:27 INFO - 2015-10-27 16:56:27,333 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) 16:56:27 INFO - 2015-10-27 16:56:27,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 163618816 16:56:27 INFO - 2015-10-27 16:56:27,935 DEBUG : BROWSER_OUTPUT: 16:56:29 INFO - 2015-10-27 16:56:29,907 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) 16:56:30 INFO - 2015-10-27 16:56:30,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 168165376 16:56:30 INFO - 2015-10-27 16:56:30,474 DEBUG : BROWSER_OUTPUT: 16:56:32 INFO - 2015-10-27 16:56:32,768 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) 16:56:33 INFO - 2015-10-27 16:56:33,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 174051328 16:56:33 INFO - 2015-10-27 16:56:33,341 DEBUG : BROWSER_OUTPUT: 16:56:35 INFO - 2015-10-27 16:56:35,736 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) 16:56:36 INFO - 2015-10-27 16:56:36,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 173137920 16:56:36 INFO - 2015-10-27 16:56:36,303 DEBUG : BROWSER_OUTPUT: 16:56:37 INFO - 2015-10-27 16:56:37,896 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) 16:56:38 INFO - 2015-10-27 16:56:38,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 231309312 16:56:38 INFO - 2015-10-27 16:56:38,155 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,155 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:56:38 INFO - 2015-10-27 16:56:38,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:56:38 INFO - 2015-10-27 16:56:38,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:56:38 INFO - 2015-10-27 16:56:38,155 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:56:38 INFO - 2015-10-27 16:56:38,156 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;110;110;111;109;117;110;109;108 16:56:38 INFO - 2015-10-27 16:56:38,156 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;120;141;164;123;155;142;122;155;122 16:56:38 INFO - 2015-10-27 16:56:38,156 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;162;162;163;161;162;161;159;163 16:56:38 INFO - 2015-10-27 16:56:38,156 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;70;147;72;73;70;72;160;71 16:56:38 INFO - 2015-10-27 16:56:38,156 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;87;131;88;88;88;127;87;88;130 16:56:38 INFO - 2015-10-27 16:56:38,156 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;109;110;110;109;109 16:56:38 INFO - 2015-10-27 16:56:38,156 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;147;144;146;145;145;145;146 16:56:38 INFO - 2015-10-27 16:56:38,157 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;96;96;96;95;96;95 16:56:38 INFO - 2015-10-27 16:56:38,157 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;53;52;53;53;53;56;52;60;52 16:56:38 INFO - 2015-10-27 16:56:38,157 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;61;61;60;61;61;61;60;60;61 16:56:38 INFO - 2015-10-27 16:56:38,157 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;90;79;80;79;79;80;87;79;81 16:56:38 INFO - 2015-10-27 16:56:38,157 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;109;112;110;112;131;115;116;106;107;114 16:56:38 INFO - 2015-10-27 16:56:38,157 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;140;133;137;135;135;140;134;134;134 16:56:38 INFO - 2015-10-27 16:56:38,157 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;61;62;60;61;60;60;60;63;60 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,899 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: __startTimestamp1445990198150__endTimestamp 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,158 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:2.69 (2.4%) stddev-sans-first:2.60 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 110.0 110.0 111.0 109.0 117.0 110.0 109.0 108.0 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.60 Median:147.00 stddev:16.70 (11.4%) stddev-sans-first:17.10 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: Values: 152.0 120.0 141.0 164.0 123.0 155.0 142.0 122.0 155.0 122.0 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.24 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 162.0 162.0 163.0 161.0 162.0 161.0 159.0 163.0 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,159 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.60 Median:71.00 stddev:34.88 (49.1%) stddev-sans-first:36.48 16:56:38 INFO - 2015-10-27 16:56:38,160 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 147.0 72.0 73.0 70.0 72.0 160.0 71.0 16:56:38 INFO - 2015-10-27 16:56:38,160 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,160 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.30 Median:88.00 stddev:20.07 (22.8%) stddev-sans-first:20.86 16:56:38 INFO - 2015-10-27 16:56:38,160 DEBUG : BROWSER_OUTPUT: Values: 89.0 87.0 131.0 88.0 88.0 88.0 127.0 87.0 88.0 130.0 16:56:38 INFO - 2015-10-27 16:56:38,160 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 147.0 144.0 146.0 145.0 145.0 145.0 146.0 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,162 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.00 stddev:2.51 (4.7%) stddev-sans-first:2.64 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: Values: 55.0 53.0 52.0 53.0 53.0 53.0 56.0 52.0 60.0 52.0 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 60.0 61.0 61.0 61.0 60.0 60.0 61.0 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:3.99 (5.0%) stddev-sans-first:4.07 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: Values: 78.0 90.0 79.0 80.0 79.0 79.0 80.0 87.0 79.0 81.0 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:113.00 stddev:7.07 (6.3%) stddev-sans-first:7.33 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 110.0 112.0 131.0 115.0 116.0 106.0 107.0 114.0 16:56:38 INFO - 2015-10-27 16:56:38,163 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,164 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:136.00 stddev:2.51 (1.8%) stddev-sans-first:2.64 16:56:38 INFO - 2015-10-27 16:56:38,164 DEBUG : BROWSER_OUTPUT: Values: 137.0 140.0 133.0 137.0 135.0 135.0 140.0 134.0 134.0 134.0 16:56:38 INFO - 2015-10-27 16:56:38,164 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,164 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:1.45 (2.4%) stddev-sans-first:1.09 16:56:38 INFO - 2015-10-27 16:56:38,164 DEBUG : BROWSER_OUTPUT: Values: 64.0 61.0 62.0 60.0 61.0 60.0 60.0 60.0 63.0 60.0 16:56:38 INFO - 2015-10-27 16:56:38,164 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:56:38 INFO - 2015-10-27 16:56:38,164 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-10-27 16:56:38,969 INFO : Browser exited with error code: 0 16:56:39 INFO - 2015-10-27 16:56:39,020 INFO : Completed test kraken (00:00:57) 16:56:39 INFO - 2015-10-27 16:56:39,020 INFO : Starting test v8_7 16:56:39 INFO - 2015-10-27 16:56:39,020 DEBUG : operating with platform_type : linux_ 16:56:39 INFO - 2015-10-27 16:56:39,020 INFO : Initialising browser for v8_7 test... 16:56:39 INFO - 2015-10-27 16:56:39,027 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHI9koF/profile http://localhost/getInfo.html 16:56:42 INFO - 2015-10-27 16:56:42,476 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:56:42 INFO - 2015-10-27 16:56:42,476 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:56:42 INFO - 2015-10-27 16:56:42,476 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:56:42 INFO - 2015-10-27 16:56:42,477 DEBUG : BROWSER_OUTPUT: __metrics 16:56:42 INFO - 2015-10-27 16:56:42,553 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:43 INFO - 2015-10-27 16:56:43,897 INFO : Browser initialized. 16:56:43 INFO - 2015-10-27 16:56:43,898 INFO : Running cycle 1/1 for v8_7 test... 16:56:43 INFO - 2015-10-27 16:56:43,898 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHI9koF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:56:55 INFO - 2015-10-27 16:56:55,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 132673536 16:56:55 INFO - 2015-10-27 16:56:55,587 DEBUG : BROWSER_OUTPUT: 16:57:16 INFO - 2015-10-27 16:57:16,926 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) 16:57:17 INFO - 2015-10-27 16:57:17,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 425553920 16:57:17 INFO - 2015-10-27 16:57:17,172 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,173 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:57:17 INFO - 2015-10-27 16:57:17,173 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:57:17 INFO - 2015-10-27 16:57:17,174 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:57:17 INFO - 2015-10-27 16:57:17,174 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:57:17 INFO - 2015-10-27 16:57:17,174 DEBUG : BROWSER_OUTPUT: |0;Richards;168.37851490149856 16:57:17 INFO - 2015-10-27 16:57:17,174 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.33853738701725 16:57:17 INFO - 2015-10-27 16:57:17,175 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 16:57:17 INFO - 2015-10-27 16:57:17,175 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 16:57:17 INFO - 2015-10-27 16:57:17,175 DEBUG : BROWSER_OUTPUT: |4;RayTrace;946.969696969697 16:57:17 INFO - 2015-10-27 16:57:17,175 DEBUG : BROWSER_OUTPUT: |5;Earley;541.7118093174431 16:57:17 INFO - 2015-10-27 16:57:17,175 DEBUG : BROWSER_OUTPUT: |6;Boyer;10224.489795918367 16:57:17 INFO - 2015-10-27 16:57:17,176 DEBUG : BROWSER_OUTPUT: |7;RegExp;25375 16:57:17 INFO - 2015-10-27 16:57:17,176 DEBUG : BROWSER_OUTPUT: |8;Splay;530.2226935312831 16:57:17 INFO - 2015-10-27 16:57:17,176 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 16:57:17 INFO - 2015-10-27 16:57:17,177 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:57:17 INFO - 2015-10-27 16:57:17,177 DEBUG : BROWSER_OUTPUT: __startTimestamp1445990237172__endTimestamp 16:57:17 INFO - 2015-10-27 16:57:17,177 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,177 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:57:17 INFO - 2015-10-27 16:57:17,178 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:57:17 INFO - 2015-10-27 16:57:17,178 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,178 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.38 Median:168.38 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,179 DEBUG : BROWSER_OUTPUT: Values: 168.4 16:57:17 INFO - 2015-10-27 16:57:17,179 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,179 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.34 Median:164.34 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,179 DEBUG : BROWSER_OUTPUT: Values: 164.3 16:57:17 INFO - 2015-10-27 16:57:17,180 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,180 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,180 DEBUG : BROWSER_OUTPUT: Values: 281.4 16:57:17 INFO - 2015-10-27 16:57:17,180 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,181 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,181 DEBUG : BROWSER_OUTPUT: Values: 5112.2 16:57:17 INFO - 2015-10-27 16:57:17,181 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,181 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:946.97 Median:946.97 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,182 DEBUG : BROWSER_OUTPUT: Values: 947.0 16:57:17 INFO - 2015-10-27 16:57:17,182 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,182 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:541.71 Median:541.71 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,183 DEBUG : BROWSER_OUTPUT: Values: 541.7 16:57:17 INFO - 2015-10-27 16:57:17,183 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,183 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10224.49 Median:10224.49 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,183 DEBUG : BROWSER_OUTPUT: Values: 10224.5 16:57:17 INFO - 2015-10-27 16:57:17,183 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25375.00 Median:25375.00 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: Values: 25375.0 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:530.22 Median:530.22 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: Values: 530.2 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: Values: 4826.9 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:57:17 INFO - 2015-10-27 16:57:17,184 DEBUG : BROWSER_OUTPUT: 16:57:17 INFO - 2015-10-27 16:57:17,997 INFO : Browser exited with error code: 0 16:57:18 INFO - 2015-10-27 16:57:18,012 INFO : Completed test v8_7 (00:00:38) 16:57:18 INFO - 2015-10-27 16:57:18,012 INFO : Completed test suite (00:20:08) 16:57:18 INFO - 2015-10-27 16:57:18,012 DEBUG : Working with test: dromaeo_css 16:57:18 INFO - 2015-10-27 16:57:18,012 DEBUG : Generating results file: dromaeo_css 16:57:18 INFO - 2015-10-27 16:57:18,013 DEBUG : Working with test: kraken 16:57:18 INFO - 2015-10-27 16:57:18,013 DEBUG : Generating results file: kraken 16:57:18 INFO - 2015-10-27 16:57:18,013 INFO : javascript benchmark 16:57:18 INFO - 2015-10-27 16:57:18,013 DEBUG : Working with test: v8_7 16:57:18 INFO - 2015-10-27 16:57:18,013 DEBUG : Generating results file: v8_7 16:57:18 INFO - 2015-10-27 16:57:18,014 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:18 INFO - 2015-10-27 16:57:18,067 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 16:57:18 INFO - 2015-10-27 16:57:18,068 DEBUG : process_Request line: dromaeo_css 7446.60 graph.html#tests=[[72,52,35]] 16:57:18 INFO - 2015-10-27 16:57:18,068 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:18 INFO - 2015-10-27 16:57:18,097 DEBUG : process_Request line: kraken 1455.80 graph.html#tests=[[232,52,35]] 16:57:18 INFO - 2015-10-27 16:57:18,097 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:18 INFO - 2015-10-27 16:57:18,132 DEBUG : process_Request line: v8_7 23238.07 graph.html#tests=[[230,52,35]] 16:57:18 INFO - 2015-10-27 16:57:18,135 INFO : javascript benchmark 16:57:18 INFO - 2015-10-27 16:57:18,139 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [420.09259998403456, 424.70695220297995, 426.6821218192447, 429.6648614081016, 432.9675274354424, 14847.480338188165, 15319.92340038301, 18389.44831655049, 18459.907700461496, 18887.15007824648, 17265.913670431662, 17699.292028318883, 18234.452966410994, 18816.435506934813, 18859.24563017481, 5612.943870561293, 5773.971130144364, 5777.508911742507, 5781.248437703092, 5788.102844059177, 4290.978545107286, 4412.624926881203, 5810.535157187415, 6254.030625253093, 6454.903176452357, 6263.436290733833, 6347.492200623939, 6369.235691717, 6395.872082558346, 6401.967990160043, 6382.457491113261, 6402.231732192144, 6408.327125651833, 6410.102585637967, 6415.582987105847, 2921.2258751430886, 4453.309736990772, 5742.655440673531, 5744.425557444264, 5751.712414379264, 23466.64800028001, 23564.882175589013, 23743.525129497488, 23751.0, 23800.642990355158, 2424.3090719145134, 2508.4356019895376, 2510.79913606911, 2584.3151564835334, 2615.5292047431453, 11125.443727813657, 11282.379469129195, 11466.541338346457, 14662.8236346469, 15296.388144474207, 1799.3342463288536, 1826.4520643806804, 1877.220953304377, 1902.6955687089999, 1945.7665080190468, 67481.0, 69329.14203028685, 69357.0, 69428.0, 69581.0, 7909.52542847431, 7957.880631790527, 7963.920360796318, 8016.0, 8027.277545020859, 9636.951815240878, 9649.903500965042, 9654.27592930533, 9659.565319560637, 9661.806763864824, 6435.517336199804, 6482.189726284215, 6533.150690410312, 6541.443977261891, 6542.672866356663, 6701.765438209737, 6734.56225345351, 6743.730250790011, 6745.325467453314, 6758.391744742997, 3655.981720091436, 3672.3389789838084, 3680.190358121209, 3689.9262014759556, 3707.258548290353, 1257.735875466144, 1292.5476083370745, 1292.702678383977, 1294.9158304710163, 1344.247221555932, 483.7194427232197, 491.44466752569366, 506.9467705890902, 506.9771860266297, 513.1302442360238, 11131.220814543067, 12675.429605667583, 13136.0, 13304.800427993589, 13510.256935868621, 517.8964207158583, 539.754411742664, 549.4505494505495, 561.2871653000666, 566.6486778197544, 7061.717531298793, 7116.608586527687, 7181.389581885598, 7225.710971561184, 7283.890741638879, 431045.0, 432222.0, 434238.0, 436222.0, 614399.0, 88066.0, 89870.0, 91384.0, 92354.53822730844, 92407.0, 548.298178331736, 572.8739677270994, 577.3389469057989, 578.109711044986, 578.3233616668508, 12448.31534265624, 12460.439280232593, 12590.811137833123, 12712.491500339884, 12808.551700690432, 39560.40659390054, 40128.197436050534, 40450.59549404586, 40940.38589421221, 41925.37111943385, 50507.24239136343, 55256.17115743187, 56380.43619563916, 56600.0, 57149.71425142848, 7585.241475852371, 7690.538567685957, 7750.806229844299, 7758.340541054074, 7777.805554861174, 13145.868541314847, 13227.3386330685, 13306.401211945293, 13360.465581376637, 13503.324833758077, 12101.273923564615, 12212.57255996036, 12229.205101668364, 12335.259884406963, 12342.197757145757, 11728.941355293511, 12004.39978001079, 12105.818412723993, 12237.755244894874, 12240.143189976616, 9207.86188207164, 11241.831372529256, 11951.163418560618, 12111.697207569881, 12138.33239171854, 7438.144613369532, 7614.8096297593, 7615.048118985127, 7637.770866874002, 7639.350655194371, 11938.22401543897, 12091.334976576372, 12130.696732581757, 12177.878221217674, 12297.44661490253], "dojo.html": [3318.0709401367612, 3376.6285708572036, 3406.6252712201654, 3408.9943466677328, 3430.4511278195496, 5658.74535645897, 5659.037963546197, 5677.517411020063, 5688.232088668028, 5702.629329093606, 5712.11462223355, 5723.627964182325, 5734.340550836655, 5737.426257374261, 5755.194272801811, 5090.9236361454605, 5132.076226279269, 5172.353455818023, 5187.299714538527, 5255.395629502599, 4992.276119962621, 5088.720120393377, 5101.7194054327, 5204.713740744258, 5239.895202095956, 5198.168293073109, 5214.530692237698, 5217.243499692542, 5225.451327610604, 5246.291750613656, 5070.847874563769, 5130.4356520782685, 5146.485351464861, 5180.611454140917, 5227.47725227478, 5005.974970125126, 5129.9743501282255, 5145.434002259748, 5148.433672296044, 5163.66436181647, 5567.860803479945, 5581.776728930838, 5585.273914391144, 5603.131514615241, 5616.185653080281, 5936.079907614327, 6027.819165425044, 6047.274327080734, 6189.535784816157, 6195.1946246988055, 6154.199954005995, 6247.125402443661, 6254.655993920333, 6256.343083976162, 6259.937400625981, 5806.303243610751, 5821.330546987066, 5824.88350232993, 5826.796062137847, 5827.533797296206, 5996.760129594767, 6076.605020673642, 6123.989541725566, 6204.875902481925, 6279.623222606659, 6016.067509536029, 6017.789377371771, 6018.729157187937, 6021.849453763603, 6039.63762174271, 6150.692465376714, 6156.569040167145, 6156.953317935961, 6160.414760597736, 6164.291106522717, 5929.110633404937, 6029.517638588903, 6044.24446944132, 6117.83455351355, 6123.640646600492, 6098.634081955008, 6115.0, 6118.082287656798, 6124.418180272867, 6127.234095738033, 4539.273716205391, 4610.446746390455, 4628.675992680547, 4629.67592268538, 4648.721076735406, 4101.7744024078365, 4138.52406973196, 4147.3986271991, 4152.4601801765575, 4194.3918131870705, 5774.364819869811, 5865.794697185578, 5871.64770113786, 5882.499987501024, 5884.823455296262, 5953.107033944856, 6063.6664983426335, 6225.782097626561, 6236.376362363727, 6244.875102497925, 5774.451427114417, 5842.474177324061, 5876.382979787061, 5883.411658834082, 5893.233879595625, 5308.734563271821, 5319.734013299397, 5328.706921119298, 5330.466953304716, 5335.67985920846, 6113.0627600468215, 6200.286966998853, 6224.439800417984, 6320.462760665303, 6357.523185760994, 6125.84685382869, 6258.749650014131, 6263.906041409474, 6267.373262673696, 6273.1844860167885, 6329.715162817776, 6406.1031455597185, 6414.358564143548, 6416.390442907917, 6428.742850285937, 5890.4698577128265, 5934.881302374015, 5976.760929562943, 6094.481969032505, 6146.569740118149, 6118.694065296629, 6140.293866205444, 6150.415710507495, 6150.427929498661, 6155.569110162246, 5961.463468287701, 5973.223480947449, 6007.738374941311, 6008.0, 6044.214252147192, 5753.597248192586, 5847.561432892635, 5895.233619629421, 5944.464998150187, 5965.224520812267, 5830.154627579062, 5913.2608423947, 5925.4370834770625, 5928.644281343133, 5930.495907847881, 5890.293164820249, 5991.580589358878, 6020.789272375446, 6065.211522502046, 6067.969660151671, 5867.618604790675, 5893.410658934244, 6014.8195554133445, 6015.729292181775, 6038.667873266837], "mootools.html": [1496.7006598680252, 1644.1696943043758, 1840.7054871220605, 2052.9794702052973, 2072.906719197636, 8886.333524985619, 10109.494525273734, 10226.590936362556, 10246.590136394536, 10249.795004099922, 9971.501424928761, 10000.099991000809, 10007.74980625483, 10141.188704903609, 10147.49262536872, 2183.465051062484, 2210.5910406574753, 2457.7542245775458, 2492.439201179738, 2496.438301382188, 2534.252395543319, 2565.3714839864165, 2567.9871600642064, 2571.2671888511777, 2576.433184699363, 2478.1698131126095, 2501.374656335916, 2504.5992641177413, 2506.4485813121173, 2509.2848538166627, 2033.6949457581334, 2089.9791002089937, 2450.277168235375, 2532.7087384950783, 2556.7315431879756, 2473.579491486452, 2492.2024952015363, 2496.862672553009, 2550.2094350751327, 2565.910193143231, 10513.579456821719, 10585.78828423435, 10591.682249532527, 10625.84061239082, 10632.734181645443, 5814.360420353758, 5901.616394934315, 5911.320198177222, 5917.408259174048, 5921.911171332434, 3851.9422208666892, 3859.787711675857, 3860.536735591747, 3886.5724770275247, 3917.98041009796, 1204.9578264760692, 1245.2341809786915, 1258.6538701857062, 1267.8795514426115, 1270.1553466944472, 15555.222238888124, 15560.92219538895, 15562.377504899903, 15569.92215038929, 15582.298796554182, 5267.473252674702, 5291.973540132275, 5296.364436267596, 5302.469753024667, 5321.494458026481, 12302.261864288172, 12330.0, 12343.0, 12348.876511234952, 12381.690457738448, 5848.122781582797, 5858.47273745365, 5859.472647461664, 5859.5019423349495, 5862.120681897664, 5285.180796976475, 5301.045811753845, 5304.0, 5311.707856067954, 5314.1497360422145, 4267.0825772459075, 4276.123394704078, 4297.076128632297, 4299.591538803808, 4331.935020974688, 1156.5200441816721, 1171.0982543441503, 1179.3101035893926, 1181.5510106159777, 1191.3447603817865, 1005.6128390569684, 1136.778328225988, 1163.5811108001112, 1164.6098556983336, 1174.2074099982478, 9591.616335346647, 9630.32587718867, 9634.373765705206, 9751.21990240779, 9947.0, 1288.6327396691897, 1291.0053966621592, 1295.863934286905, 1298.6169080121388, 1307.941142648564, 6792.694328755119, 6830.248672646005, 6834.384905358442, 6843.213030501456, 6851.109355783717, 13524.391402386917, 13707.0, 13713.0, 13734.175949443066, 13754.243516606482, 13308.068435209443, 13585.59243222705, 13597.932010340082, 13598.0, 13675.0, 9567.9043209567, 9852.310338276251, 9866.45734484596, 9911.900880991097, 9920.900790992142, 9312.767180820534, 9321.067893210624, 9346.15884570392, 9347.345685801929, 9376.343655944018, 11431.314121152758, 11433.942830285796, 11691.649250522158, 11708.88291117112, 11713.062954963412, 11662.766744665229, 11819.881801182222, 11844.763104737685, 11897.940510297392, 11933.0, 8632.352573557135, 8663.95668021656, 8666.566671666265, 8673.522956237468, 8682.218600325748, 10104.444255566015, 10237.488125593542, 10300.639477618248, 10333.0, 10335.483225838829, 9232.169104780602, 9245.953770231106, 9252.0, 9271.258299336172, 9369.484678342757, 9099.317551183556, 9258.53707314645, 9267.814643706954, 9358.344915855825, 9381.249500040118, 8228.01263848342, 8463.53450560225, 9105.04397038328, 9273.443593384418, 9276.72169834906, 8213.425060245725, 8406.0, 8430.325573954191, 8439.156084391512, 8470.237678608955, 8501.914980850112, 8617.267532259828, 8646.394752367525, 8648.956755216184, 8651.134886511298], "ext.html": [588.7556663984446, 604.4439116013267, 634.400491535499, 634.8698516804055, 640.0623087177287, 35624.0, 45558.316625250605, 46237.07525849481, 46238.76880615597, 46252.76873615636, 49406.50593494064, 50075.49924500754, 50083.74958125204, 50137.49862501374, 50233.0, 8137.104918458995, 8275.875861862047, 9297.814043719138, 9476.71569852902, 9477.38397004196, 11102.944485277561, 11381.2033157679, 11421.942890285536, 11432.142589305793, 11439.5424183033, 10887.455627218647, 10887.891121088807, 10971.23201375904, 10973.067289280421, 10989.725256868562, 8401.831963360759, 8556.572171391406, 10990.395528245943, 11094.55621775128, 11098.0, 10920.617778377798, 11119.833202501968, 11122.0, 11134.888651113548, 11136.944315278372, 42294.788526057484, 42397.0, 42566.36150457746, 42755.35866961998, 42848.57151428477, 3744.6068162843053, 4169.854055108057, 4179.749215047107, 4400.823967041314, 4590.173768721629, 34001.48997765035, 34030.48954265688, 34206.94045215373, 34281.48577771335, 34510.48234276488, 3902.9219415611815, 3951.269015232191, 3953.42675312081, 3964.2864284428792, 3986.362182050887, 342900.0, 347456.0, 348090.25954870315, 349796.0, 350549.0, 57790.711046445336, 58711.0, 66064.66967665227, 66860.0, 72180.63909680418, 68473.0, 68970.0, 69262.0, 69474.65262673654, 69671.3032869675, 19367.225310987684, 19420.708689369672, 19551.21795128179, 19570.60858782845, 19580.118894649775, 12596.370181490889, 12774.552890648783, 15189.696206076038, 15548.92225538865, 15606.921965390327, 21183.258585949727, 21312.0, 21333.46666333354, 21375.251866184608, 21386.679199812017, 8339.374546909006, 8763.737087887373, 8810.955945220232, 8887.644494220289, 8888.466786965684, 1059.4808543813476, 1082.3224002795635, 1132.8841091524841, 1144.2047776795214, 1187.3410257307105, 31818.68181318157, 31937.361252774816, 32253.0, 32926.67073329284, 33068.83465582657, 1206.7313450712604, 1230.870758570355, 1260.350919276555, 1271.5486002469174, 1326.5091915991145, 15193.544193673986, 15653.295601697951, 15731.44939927097, 17242.224099915533, 17258.741118883227, 456363.0, 461684.0, 463049.0, 463543.0, 464195.0, 60195.0, 60495.0, 60507.0, 60546.69726651427, 60606.0, 1397.4200706706806, 1439.755241608929, 1539.6150962259435, 1560.3212602518167, 1568.5921660368385, 29992.25019374533, 30255.69744302529, 30654.233644159074, 30694.0048896821, 33165.0, 48952.75523622359, 49920.750396247786, 50850.23724644207, 50858.74570627271, 51136.74431627818, 536710.0, 546698.0, 549552.0089598265, 550977.0, 556714.0, 34479.31041379208, 34981.0, 35125.12187195341, 35127.64872351346, 35351.46972795359, 48737.2689409652, 48871.0, 49119.754401227765, 49493.752531237114, 49790.0, 40623.39064913969, 41256.0, 41438.79280603577, 41781.79109104435, 42416.787916060224, 40338.798306009456, 40466.0, 40518.59481405266, 40658.79670601628, 41277.38083928683, 42317.78841105775, 42327.788361057996, 42876.78561607172, 42993.570064298954, 43059.569404305556, 35901.28197436089, 36669.816650916575, 37356.0, 37814.43278350882, 37897.81051094727, 28532.0, 28623.713762862106, 28696.426071478872, 28769.280767980967, 28824.0], "prototype.html": [370.7830918912436, 373.15852752044145, 373.16783572633017, 373.40628400842655, 383.59339100553416, 5888.5877988540815, 5962.284525856898, 5982.222311099551, 5997.850053748659, 6014.8797024059495, 5871.500922421599, 5924.348321684612, 5933.376995415484, 5949.791757288495, 5976.19321391612, 4669.159551280768, 4687.859364219062, 4690.29645553168, 4692.835750748707, 4700.811967521295, 4538.727676339414, 4559.886002849922, 4635.466921304042, 4688.624910007208, 4690.413698287714, 4637.605803506689, 4658.813647454114, 4665.2768820832825, 4677.4854765975715, 4688.390509233795, 4647.186742320097, 4664.183767840615, 4664.953350466486, 4668.393108895839, 4681.227597446417, 4191.077962848169, 4195.181939521794, 4198.3702444633245, 4199.4120823084795, 4206.705530612859, 5550.91673624896, 5640.464155905182, 5656.0, 5665.8583535411535, 5738.454846789548, 5468.945310546923, 5469.480399362054, 5470.890582188374, 5473.397926228112, 5478.561715062785, 6400.647964361959, 6409.3590640936, 6411.198600174978, 6416.486681065504, 6425.61446313218, 4469.709468884512, 4522.68341216115, 4591.242444996572, 4646.930296045562, 4647.86056418308, 6454.386833250834, 6479.546431749779, 6497.837554061186, 6501.0573466847045, 6502.447291980187, 4723.763811809465, 4761.142994260997, 4766.928496072562, 4767.284907263869, 4768.356271903249, 4636.814527418933, 4729.266963620645, 4829.227323628203, 4830.661853670209, 4834.419869615669, 5374.059539580558, 5374.328208973879, 5378.9462105379225, 5381.0, 5381.0, 6312.715927783169, 6315.621062736251, 6363.045543168561, 6365.2998170201245, 6372.426481616677, 1676.857467115309, 1695.3981336625568, 1695.626962068343, 1697.7283634618402, 1700.2943778331853, 1130.2879186112696, 1161.8431511745976, 1174.3775798826637, 1182.1606659272013, 1187.6199616122758, 6138.0, 6140.754369825247, 6141.355157708465, 6146.969265153735, 6151.6001459904965, 6519.3154718754795, 6535.248446428626, 6538.509611779041, 6550.836229094215, 6553.279139294674, 6008.639481631116, 6132.78535251264, 6136.20229370179, 6137.3862613738265, 6139.662318572521, 3597.6042635310096, 3627.4558816177255, 3634.6547078027547, 3635.8000309982676, 3639.47227651989, 6721.630310332978, 6721.6975236114495, 6725.361090696376, 6728.428083612947, 6733.225679046875, 6645.468362531083, 6729.663516824237, 6739.730410783612, 6747.156605424322, 6751.324867513209, 6679.632620205838, 6689.6989635466525, 6726.495512836557, 6739.359760822714, 6746.4265537429865, 6317.115603815561, 6394.104825324365, 6551.574147680385, 6560.245571759308, 6569.080328753883, 6367.42693157618, 6452.935470645421, 6456.2575303838785, 6494.772682956074, 6497.02544618311, 6697.531172817856, 6705.564138330993, 6706.429953453816, 6712.093867327848, 6724.092247546714, 4601.608863246528, 4620.075984802986, 4660.1145782301255, 4669.883252918704, 4670.136024835417, 6491.253505846888, 6492.870142597216, 6501.772437964649, 6504.1869766279215, 6507.349265073455, 6338.271098823509, 6338.397852204033, 6338.651374174465, 6343.492520598434, 6343.555951083565, 6235.127082208585, 6302.716377763103, 6325.936740632535, 6336.144620476177, 6339.651319177305, 6217.285012223652, 6229.12792209082, 6303.401176888188, 6308.116863639002, 6311.084892690626, 6416.422521973045, 6422.0, 6424.807255782334, 6427.485801135805, 6432.935670643421, 6165.290991536031, 6228.719707613078, 6263.530235232467, 6286.151369565233, 6287.591306565058], "yui.html": [927.6474939522981, 931.8136372725453, 933.6405483888705, 936.8688383626293, 951.7030606810249, 13936.233507157101, 13992.930035349822, 14056.016078874483, 14178.78731819021, 14343.067700599468, 14671.706565868677, 14699.338529766159, 14715.779263311058, 14747.262636868167, 14783.334749936252, 752.3041186902121, 756.4666909828558, 902.2826852652124, 906.5557876640448, 920.8894932608097, 920.9355345125844, 922.3727865051762, 930.6417029443645, 930.9813803723921, 932.0, 951.4196340232453, 956.0726095687172, 965.5606698951996, 965.599276300338, 965.6185806606386, 783.5337973905517, 792.2077922077922, 987.4865070163474, 1004.3622299839582, 1008.037324355239, 711.1785887300176, 713.0979311171373, 717.5479447947812, 720.585663243637, 720.6901032555999, 14258.358373873098, 14519.20144392058, 14563.70872582553, 14623.0, 14638.0, 11657.475413606324, 12156.574519891761, 12210.57262995791, 12831.615051548468, 13355.599332020054, 10300.896991030144, 10622.468876556219, 10667.946660266727, 10724.73188170302, 10754.462276886125, 3665.6334366563397, 3699.6300369963055, 3726.81365931705, 3730.626937306248, 3735.2156047230114, 41795.7910210447, 42452.78773606143, 42554.78722606398, 47032.76483617594, 47439.28841067387, 9815.558299876522, 9871.160951319218, 9936.056074672895, 10069.496525173858, 10314.381137131797, 18938.526536836413, 18985.525361865788, 19114.426567203005, 19952.60094798125, 20005.699914501292, 7872.527648341118, 7900.130985591581, 7957.641906114239, 8160.143184965612, 8398.538080405515, 4543.409356783597, 4590.127875703605, 4648.581627653527, 4663.370444989951, 4672.5327467253, 3315.3203593263324, 3335.182880194368, 3343.348047130835, 3343.7993720376853, 3345.3142105868237, 517.9119549676564, 527.6359312074657, 532.6777299733683, 540.4541413172724, 541.7264281537798, 520.4327283261264, 575.7783253447369, 645.2515082504273, 697.2957313113792, 736.6353654940839, 8471.152884711479, 8675.219230269306, 8704.086070962585, 9048.095190481032, 9413.435193888388, 556.4880310114704, 567.5317862763237, 611.8317462697705, 647.4949539359308, 692.5879101934341, 3955.3275943089743, 4140.3375459926265, 4185.22573323936, 4221.290114417637, 4231.196072746168, 52890.0, 53124.46875531272, 53140.46859531433, 53273.0, 53428.46571534235, 45097.0, 46184.0, 48498.0, 48744.51255487471, 48804.511954880705, 41265.79367103145, 41792.37311440331, 41822.0, 41909.0, 41988.0, 8672.826543469222, 8942.50816205115, 9004.729858104267, 9080.091990800867, 9169.899612046596, 28600.856995714887, 29260.853695731385, 29502.85248573829, 29676.40647187001, 29705.70294297116, 38239.42640860445, 38824.223515530095, 38951.80524097361, 39000.41499377568, 40827.7958610205, 8339.374546908884, 8441.915580844114, 8487.236148746642, 8537.53043582609, 8568.0, 12143.0, 12253.081018923795, 12342.629721108382, 12527.060470464568, 12589.055820813659, 10187.541560629938, 10889.509972051435, 11088.112950963743, 11446.37044962535, 11449.656510304705, 10926.836097458703, 11066.28069175501, 11642.476088575864, 11681.357525336189, 11825.0, 9053.864192037256, 11219.607313744305, 11902.166848320881, 12132.696682582653, 12297.0, 10055.849162262426, 10397.556554344377, 10471.42407167613, 10555.0, 10716.35701857891, 10056.849147262943, 10315.865254821814, 10360.430176340073, 10399.1160751337, 10470.842937355794]}, "summary": {"suite": 7446.597547412492, "subtests": {"jquery.html": {"std": 78177.63018365049, "min": 420.09259998403456, "max": 614399.0, "median": 7843.665491667742, "filtered": 8025.701510260191, "mean": 27142.09113591668}, "dojo.html": {"std": 647.998815591175, "min": 3318.0709401367612, "max": 6428.742850285937, "median": 5895.233619629421, "filtered": 5638.735084586368, "mean": 5682.357035979453}, "mootools.html": {"std": 4105.659924966099, "min": 1005.6128390569684, "max": 15582.298796554182, "median": 8451.345294996881, "filtered": 5601.940081614673, "mean": 7157.956666687988}, "ext.html": {"std": 121437.21142404657, "min": 588.7556663984446, "max": 556714.0, "median": 31878.021532978193, "filtered": 21633.97974727347, "mean": 62669.27806840464}, "prototype.html": {"std": 1550.3573363985063, "min": 370.7830918912436, "max": 6751.324867513209, "median": 6011.759592018532, "filtered": 4866.060087629167, "mean": 5355.301120520142}, "yui.html": {"std": 14340.106885270146, "min": 517.9119549676564, "max": 53428.46571534235, "median": 10056.349154762684, "filtered": 6388.4313001639985, "mean": 13198.175838833045}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-058"}, "testrun": {"date": 1445989029, "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": "20151027142931", "branch": "Mozilla-Aurora", "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 161.0, 159.0, 163.0], "ai-astar": [107.0, 110.0, 110.0, 110.0, 111.0, 109.0, 117.0, 110.0, 109.0, 108.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0], "audio-beat-detection": [152.0, 120.0, 141.0, 164.0, 123.0, 155.0, 142.0, 122.0, 155.0, 122.0], "json-stringify-tinderbox": [61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0], "stanford-crypto-pbkdf2": [137.0, 140.0, 133.0, 137.0, 135.0, 135.0, 140.0, 134.0, 134.0, 134.0], "json-parse-financial": [55.0, 53.0, 52.0, 53.0, 53.0, 53.0, 56.0, 52.0, 60.0, 52.0], "stanford-crypto-sha256-iterative": [64.0, 61.0, 62.0, 60.0, 61.0, 60.0, 60.0, 60.0, 63.0, 60.0], "audio-fft": [71.0, 70.0, 70.0, 147.0, 72.0, 73.0, 70.0, 72.0, 160.0, 71.0], "imaging-darkroom": [145.0, 145.0, 146.0, 147.0, 144.0, 146.0, 145.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [109.0, 112.0, 110.0, 112.0, 131.0, 115.0, 116.0, 106.0, 107.0, 114.0], "audio-oscillator": [89.0, 87.0, 131.0, 88.0, 88.0, 88.0, 127.0, 87.0, 88.0, 130.0], "stanford-crypto-aes": [78.0, 90.0, 79.0, 80.0, 79.0, 79.0, 80.0, 87.0, 79.0, 81.0], "imaging-desaturate": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"suite": 1455.8, "subtests": {"audio-fft": {"std": 33.0913886079143, "min": 70.0, "max": 160.0, "median": 71.5, "filtered": 87.6, "mean": 87.6}, "stanford-crypto-pbkdf2": {"std": 2.3853720883753127, "min": 133.0, "max": 140.0, "median": 135.0, "filtered": 135.9, "mean": 135.9}, "audio-beat-detection": {"std": 15.844241856270688, "min": 120.0, "max": 164.0, "median": 141.5, "filtered": 139.6, "mean": 139.6}, "stanford-crypto-ccm": {"std": 6.705221845696084, "min": 106.0, "max": 131.0, "median": 112.0, "filtered": 113.2, "mean": 113.2}, "imaging-darkroom": {"std": 0.8, "min": 144.0, "max": 147.0, "median": 145.0, "filtered": 145.4, "mean": 145.4}, "json-parse-financial": {"std": 2.3853720883753127, "min": 52.0, "max": 60.0, "median": 53.0, "filtered": 53.9, "mean": 53.9}, "audio-oscillator": {"std": 19.0370691021491, "min": 87.0, "max": 131.0, "median": 88.0, "filtered": 100.3, "mean": 100.3}, "ai-astar": {"std": 2.5475478405713994, "min": 107.0, "max": 117.0, "median": 110.0, "filtered": 110.1, "mean": 110.1}, "audio-dft": {"std": 1.1874342087037917, "min": 159.0, "max": 163.0, "median": 162.0, "filtered": 161.7, "mean": 161.7}, "stanford-crypto-sha256-iterative": {"std": 1.374772708486752, "min": 60.0, "max": 64.0, "median": 60.5, "filtered": 61.1, "mean": 61.1}, "json-stringify-tinderbox": {"std": 0.45825756949558394, "min": 60.0, "max": 61.0, "median": 61.0, "filtered": 60.7, "mean": 60.7}, "imaging-gaussian-blur": {"std": 0.5, "min": 109.0, "max": 110.0, "median": 109.5, "filtered": 109.5, "mean": 109.5}, "stanford-crypto-aes": {"std": 3.7894590642992836, "min": 78.0, "max": 90.0, "median": 79.5, "filtered": 81.2, "mean": 81.2}, "imaging-desaturate": {"std": 0.4898979485566356, "min": 95.0, "max": 96.0, "median": 96.0, "filtered": 95.6, "mean": 95.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-058"}, "testrun": {"date": 1445989029, "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": "20151027142931", "branch": "Mozilla-Aurora", "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.33853738701725], "Encrypt": [281.37310073157005], "NavierStokes": [4826.923076923077], "Decrypt": [5112.244897959184], "Splay": [530.2226935312831], "Richards": [168.37851490149856], "RegExp": [25375.0], "Earley": [541.7118093174431], "Boyer": [10224.489795918367], "RayTrace": [946.969696969697]}, "summary": {"suite": 23238.065052992413, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.33853738701725, "max": 164.33853738701725, "median": 164.33853738701725, "value": 402.3280300000001, "filtered": 402.3280300000001, "mean": 164.33853738701725}, "Encrypt": {"std": 0.0, "min": 281.37310073157005, "max": 281.37310073157005, "median": 281.37310073157005, "value": 946.0072739999998, "filtered": 946.0072739999998, "mean": 281.37310073157005}, "NavierStokes": {"std": 0.0, "min": 4826.923076923077, "max": 4826.923076923077, "median": 4826.923076923077, "value": 307.4422310756973, "filtered": 307.4422310756973, "mean": 4826.923076923077}, "Decrypt": {"std": 0.0, "min": 5112.244897959184, "max": 5112.244897959184, "median": 5112.244897959184, "value": 52.067341317365305, "filtered": 52.067341317365305, "mean": 5112.244897959184}, "Splay": {"std": 0.0, "min": 530.2226935312831, "max": 530.2226935312831, "median": 530.2226935312831, "value": 153.69202600000006, "filtered": 153.69202600000006, "mean": 530.2226935312831}, "RegExp": {"std": 0.0, "min": 25375.0, "max": 25375.0, "median": 25375.0, "value": 35.90088669950742, "filtered": 35.90088669950742, "mean": 25375.0}, "Richards": {"std": 0.0, "min": 168.37851490149856, "max": 168.37851490149856, "median": 168.37851490149856, "value": 209.65857799999998, "filtered": 209.65857799999998, "mean": 168.37851490149856}, "Earley": {"std": 0.0, "min": 541.7118093174431, "max": 541.7118093174431, "median": 541.7118093174431, "value": 1230.2906979999998, "filtered": 1230.2906979999998, "mean": 541.7118093174431}, "Boyer": {"std": 0.0, "min": 10224.489795918367, "max": 10224.489795918367, "median": 10224.489795918367, "value": 65.18300798403193, "filtered": 65.18300798403193, "mean": 10224.489795918367}, "RayTrace": {"std": 0.0, "min": 946.969696969697, "max": 946.969696969697, "median": 946.969696969697, "value": 781.4283840000004, "filtered": 781.4283840000004, "mean": 946.969696969697}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-058"}, "testrun": {"date": 1445989029, "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": "20151027142931", "branch": "Mozilla-Aurora", "revision": "c017ca15c40c99776c84f40c100cb5c578b8ae66"}}] 16:57:18 INFO - RETURN: dromaeo_css: 7446.60 16:57:18 INFO - RETURN: kraken: 1455.80 16:57:18 INFO - RETURN: v8_7: 23238.07 16:57:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23238.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1455.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7446.60"}}} 16:57:18 INFO - Return code: 0 16:57:18 INFO - # TBPL SUCCESS # 16:57:18 INFO - Running post-action listener: _resource_record_post_action 16:57:18 INFO - Running post-run listener: _resource_record_post_run 16:57:19 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 7581696; Write bytes: 388988928; Read time: 2272; Write time: 322516 16:57:19 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 495616; Read time: 0; Write time: 56 16:57:19 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 5246976; Write bytes: 388493312; Read time: 1836; Write time: 322460 16:57:19 INFO - Running post-run listener: _upload_blobber_files 16:57:19 INFO - Blob upload gear active. 16:57:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:57:19 INFO - Copying logs to upload dir... 16:57:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.382388 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-10-27 16:57:19.373362) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 16:57:19.377318) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009966 build_url: 'https://queue.taskcluster.net/v1/task/6hcExAXQSp2yNGOiSWvz-Q/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-27 16:57:19.427831) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:57:19.428265) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1445986800.852301-1922531761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 16:57:19.477908) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-27 16:57:19.478289) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-27 16:57:23.765709) =========