builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1445969828.0 results: success (0) buildid: 20151027085421 builduid: 9472bc65d292408ab7c5309f4b680966 revision: b5c8da05bef9d38b67b6e27d83035af210c58e23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:07.998170) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:07.998644) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:07.999074) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007814 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.079070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.079507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.148630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.149039) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.046577 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.207597) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.211048) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.211479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.211798) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-27 11:17:08-- 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% 233M=0s 2015-10-27 11:17:08 (233 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.265558 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.499041) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.499620) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.165515 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.680984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:08.681369) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b5c8da05bef9d38b67b6e27d83035af210c58e23 --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 b5c8da05bef9d38b67b6e27d83035af210c58e23 --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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-27 11:17:08,954 truncating revision to first 12 chars 2015-10-27 11:17:08,954 Setting DEBUG logging. 2015-10-27 11:17:08,954 attempt 1/10 2015-10-27 11:17:08,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b5c8da05bef9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 11:17:09,190 unpacking tar archive at: mozilla-aurora-b5c8da05bef9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537086 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:09.232000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:09.232361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:09.293187) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:09.293603) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 11:17:09.294067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-10-27 11:17:09.294354) ========= /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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:09 INFO - MultiFileLogger online at 20151027 11:17:09 in /builds/slave/test-pgo 11:17:09 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 11:17:09 INFO - Guessing talos json url... 11:17:09 INFO - Using buildbot properties: 11:17:09 INFO - { 11:17:09 INFO - "properties": { 11:17:09 INFO - "buildnumber": 1, 11:17:09 INFO - "product": "firefox", 11:17:09 INFO - "script_repo_revision": "production", 11:17:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:17:09 INFO - "repository": "", 11:17:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:17:09 INFO - "buildid": "20151027085421", 11:17:09 INFO - "slavename": "talos-linux64-ix-011", 11:17:09 INFO - "pgo_build": "True", 11:17:09 INFO - "basedir": "/builds/slave/test-pgo", 11:17:09 INFO - "project": "", 11:17:09 INFO - "platform": "ubuntu64_hw", 11:17:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:17:09 INFO - "slavebuilddir": "test", 11:17:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:17:09 INFO - "branch": "mozilla-aurora", 11:17:09 INFO - "repo_path": "releases/mozilla-aurora", 11:17:09 INFO - "stage_platform": "linux64-pgo", 11:17:09 INFO - "builduid": "9472bc65d292408ab7c5309f4b680966", 11:17:09 INFO - "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23" 11:17:09 INFO - }, 11:17:09 INFO - "sourcestamp": { 11:17:09 INFO - "repository": "", 11:17:09 INFO - "hasPatch": false, 11:17:09 INFO - "project": "", 11:17:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:17:09 INFO - "changes": [ 11:17:09 INFO - { 11:17:09 INFO - "category": null, 11:17:09 INFO - "files": [ 11:17:09 INFO - { 11:17:09 INFO - "url": null, 11:17:09 INFO - "name": "https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 11:17:09 INFO - } 11:17:09 INFO - ], 11:17:09 INFO - "repository": "", 11:17:09 INFO - "rev": "b5c8da05bef9d38b67b6e27d83035af210c58e23", 11:17:09 INFO - "who": "cbook@mozilla.com", 11:17:09 INFO - "when": 1445969810, 11:17:09 INFO - "number": 6581302, 11:17:09 INFO - "comments": "Backed out changeset 7dae7fa6eb01 (bug 1211967) for bustage", 11:17:09 INFO - "project": "", 11:17:09 INFO - "at": "Tue 27 Oct 2015 11:16:50", 11:17:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:17:09 INFO - "revlink": "", 11:17:09 INFO - "properties": [ 11:17:09 INFO - [ 11:17:09 INFO - "buildid", 11:17:09 INFO - "20151027085421", 11:17:09 INFO - "Change" 11:17:09 INFO - ], 11:17:09 INFO - [ 11:17:09 INFO - "builduid", 11:17:09 INFO - "9472bc65d292408ab7c5309f4b680966", 11:17:09 INFO - "Change" 11:17:09 INFO - ], 11:17:09 INFO - [ 11:17:09 INFO - "pgo_build", 11:17:09 INFO - "True", 11:17:09 INFO - "Change" 11:17:09 INFO - ] 11:17:09 INFO - ], 11:17:09 INFO - "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23" 11:17:09 INFO - } 11:17:09 INFO - ], 11:17:09 INFO - "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23" 11:17:09 INFO - } 11:17:09 INFO - } 11:17:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 11:17: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')]} 11:17:09 INFO - https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 11:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 11:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 11:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:09 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:14 INFO - Downloaded 107 bytes. 11:17:14 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 11:17:14 INFO - Contents: 11:17:14 INFO - 20151027085421 11:17:14 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/b5c8da05bef9d38b67b6e27d83035af210c58e23 11:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:14 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b5c8da05be/testing/talos/talos.json 11:17:14 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b5c8da05be/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 11:17:14 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b5c8da05be/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 11:17:14 INFO - Downloaded 6818 bytes. 11:17:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:14 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:17:14 INFO - '../fennec_ids.txt'], 11:17:14 INFO - 'tests': ['tcheck2']}, 11:17:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:14 INFO - '--tppagecycles', 11:17:14 INFO - '7'], 11:17:14 INFO - 'tests': ['tsvgm']}}, 11:17:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:17:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:17:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:17:14 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 11:17:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 11:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:14 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 11:17:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 11:17:14 INFO - 'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:14 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'tests': ['damp', 'tps']}, 11:17:14 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['damp', 'tps']}, 11:17:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:17:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:14 INFO - 'other': {'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other_l64': {'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'other_nol64': {'tests': ['a11yr', 11:17:14 INFO - 'ts_paint', 11:17:14 INFO - 'tpaint', 11:17:14 INFO - 'sessionrestore', 11:17:14 INFO - 'sessionrestore_no_auto_restore']}, 11:17:14 INFO - 'svgr': {'tests': ['tsvgx', 11:17:14 INFO - 'tsvgr_opacity', 11:17:14 INFO - 'tart', 11:17:14 INFO - 'tscrollx', 11:17:14 INFO - 'cart']}, 11:17:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tsvgx', 11:17:14 INFO - 'tsvgr_opacity', 11:17:14 INFO - 'tart', 11:17:14 INFO - 'tscrollx', 11:17:14 INFO - 'cart']}, 11:17:14 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 11:17:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 11:17:14 INFO - 'tests': ['tp5o']}, 11:17:14 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 11:17:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 11:17:14 INFO - 'talos_options': ['--e10s'], 11:17:14 INFO - 'tests': ['tp5o']}, 11:17:14 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 11:17:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 11:17:14 INFO - 'talos_options': ['--xperf_path', 11:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:14 INFO - 'tests': ['tp5n']}, 11:17:14 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 11:17:14 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 11:17:14 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:14 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 11:17:14 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 11:17:14 INFO - 'talos_options': ['--e10s', 11:17:14 INFO - '--xperf_path', 11:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 11:17:14 INFO - 'C:/slave/talos-data/talos/xperf.config'], 11:17:14 INFO - 'tests': ['tp5n']}}, 11:17:14 INFO - 'talos.zip': {'path': '', 11:17:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:17:14 INFO - {'append_to_log': False, 11:17:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:17:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:17:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:17:14 INFO - 'branch': 'Mozilla-Aurora', 11:17:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:14 INFO - 'config_files': ('talos/linux_config.py',), 11:17:14 INFO - 'default_actions': ('clobber', 11:17:14 INFO - 'read-buildbot-config', 11:17:14 INFO - 'download-and-extract', 11:17:14 INFO - 'populate-webroot', 11:17:14 INFO - 'create-virtualenv', 11:17:14 INFO - 'install', 11:17:14 INFO - 'run-tests'), 11:17:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:14 INFO - 'download_minidump_stackwalk': True, 11:17:14 INFO - 'download_symbols': 'ondemand', 11:17:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:14 INFO - 'installer_path': 'installer.exe', 11:17:14 INFO - 'log_level': 'info', 11:17:14 INFO - 'log_name': 'talos', 11:17:14 INFO - 'log_to_console': True, 11:17:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:14 INFO - 'opt_config_files': (), 11:17:14 INFO - 'pip_index': False, 11:17:14 INFO - 'python_webserver': False, 11:17:14 INFO - 'sps_profile': False, 11:17:14 INFO - 'sps_profile_interval': 0, 11:17:14 INFO - 'suite': 'dromaeojs', 11:17:14 INFO - 'system_bits': '64', 11:17:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:14 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 11:17:14 INFO - 'tests': (), 11:17:14 INFO - 'title': 'talos-linux64-ix-011', 11:17:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:14 INFO - 'use_talos_json': True, 11:17:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:17:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:14 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 11:17:14 INFO - 'work_dir': 'build'} 11:17:14 INFO - ##### 11:17:14 INFO - ##### Running clobber step. 11:17:14 INFO - ##### 11:17:14 INFO - Running pre-action listener: _resource_record_pre_action 11:17:14 INFO - Running main action method: clobber 11:17:14 INFO - rmtree: /builds/slave/test-pgo/build 11:17:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:17:15 INFO - Running post-action listener: _resource_record_post_action 11:17:15 INFO - ##### 11:17:15 INFO - ##### Running read-buildbot-config step. 11:17:15 INFO - ##### 11:17:15 INFO - Running pre-action listener: _resource_record_pre_action 11:17:15 INFO - Running main action method: read_buildbot_config 11:17:15 INFO - Using buildbot properties: 11:17:15 INFO - { 11:17:15 INFO - "properties": { 11:17:15 INFO - "buildnumber": 1, 11:17:15 INFO - "product": "firefox", 11:17:15 INFO - "script_repo_revision": "production", 11:17:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:17:15 INFO - "repository": "", 11:17:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:17:15 INFO - "buildid": "20151027085421", 11:17:15 INFO - "slavename": "talos-linux64-ix-011", 11:17:15 INFO - "pgo_build": "True", 11:17:15 INFO - "basedir": "/builds/slave/test-pgo", 11:17:15 INFO - "project": "", 11:17:15 INFO - "platform": "ubuntu64_hw", 11:17:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:17:15 INFO - "slavebuilddir": "test", 11:17:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:17:15 INFO - "branch": "mozilla-aurora", 11:17:15 INFO - "repo_path": "releases/mozilla-aurora", 11:17:15 INFO - "stage_platform": "linux64-pgo", 11:17:15 INFO - "builduid": "9472bc65d292408ab7c5309f4b680966", 11:17:15 INFO - "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23" 11:17:15 INFO - }, 11:17:15 INFO - "sourcestamp": { 11:17:15 INFO - "repository": "", 11:17:15 INFO - "hasPatch": false, 11:17:15 INFO - "project": "", 11:17:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:17:15 INFO - "changes": [ 11:17:15 INFO - { 11:17:15 INFO - "category": null, 11:17:15 INFO - "files": [ 11:17:15 INFO - { 11:17:15 INFO - "url": null, 11:17:15 INFO - "name": "https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 11:17:15 INFO - } 11:17:15 INFO - ], 11:17:15 INFO - "repository": "", 11:17:15 INFO - "rev": "b5c8da05bef9d38b67b6e27d83035af210c58e23", 11:17:15 INFO - "who": "cbook@mozilla.com", 11:17:15 INFO - "when": 1445969810, 11:17:15 INFO - "number": 6581302, 11:17:15 INFO - "comments": "Backed out changeset 7dae7fa6eb01 (bug 1211967) for bustage", 11:17:15 INFO - "project": "", 11:17:15 INFO - "at": "Tue 27 Oct 2015 11:16:50", 11:17:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:17:15 INFO - "revlink": "", 11:17:15 INFO - "properties": [ 11:17:15 INFO - [ 11:17:15 INFO - "buildid", 11:17:15 INFO - "20151027085421", 11:17:15 INFO - "Change" 11:17:15 INFO - ], 11:17:15 INFO - [ 11:17:15 INFO - "builduid", 11:17:15 INFO - "9472bc65d292408ab7c5309f4b680966", 11:17:15 INFO - "Change" 11:17:15 INFO - ], 11:17:15 INFO - [ 11:17:15 INFO - "pgo_build", 11:17:15 INFO - "True", 11:17:15 INFO - "Change" 11:17:15 INFO - ] 11:17:15 INFO - ], 11:17:15 INFO - "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23" 11:17:15 INFO - } 11:17:15 INFO - ], 11:17:15 INFO - "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23" 11:17:15 INFO - } 11:17:15 INFO - } 11:17:15 INFO - Running post-action listener: _resource_record_post_action 11:17:15 INFO - ##### 11:17:15 INFO - ##### Running download-and-extract step. 11:17:15 INFO - ##### 11:17:15 INFO - Running pre-action listener: _resource_record_pre_action 11:17:15 INFO - Running main action method: download_and_extract 11:17:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:17: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')]} 11:17:15 INFO - https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/test_packages.json 11:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/test_packages.json 11:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:17:15 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 11:17:17 INFO - Downloaded 1302 bytes. 11:17:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:17:17 INFO - Using the following test package requirements: 11:17:17 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 11:17:17 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:17 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:17 INFO - u'jsshell-linux-x86_64.zip'], 11:17:17 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:17 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 11:17:17 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:17:17 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:17:17 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:17 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 11:17:17 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:17 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:17 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17: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')]} 11:17:17 INFO - https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 11:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 11:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:17 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:18 INFO - Downloaded 22908206 bytes. 11:17:18 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 11:17:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 11:17:18 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 11:17:20 INFO - Return code: 0 11:17: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 11:17: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')]} 11:17:20 INFO - https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 11:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 11:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:20 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:22 INFO - Downloaded 22908206 bytes. 11:17:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:17:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 11:17:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:17:23 INFO - Return code: 0 11:17:23 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')]} 11:17:23 INFO - https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 11:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 11:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:23 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:24 INFO - Downloaded 10881672 bytes. 11:17:24 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 11:17:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 11:17:24 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 11:17:24 INFO - Return code: 0 11:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:24 INFO - https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:17:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 11:17:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 11:17:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:24 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:17:26 INFO - Downloaded 56983670 bytes. 11:17:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 11:17:26 INFO - mkdir: /builds/slave/test-pgo/properties 11:17:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:17:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:17:26 INFO - Contents: 11:17:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 11:17:26 INFO - Running post-action listener: _resource_record_post_action 11:17:26 INFO - Running post-action listener: _set_extra_try_arguments 11:17:26 INFO - ##### 11:17:26 INFO - ##### Running populate-webroot step. 11:17:26 INFO - ##### 11:17:26 INFO - Running pre-action listener: _resource_record_pre_action 11:17:26 INFO - Running main action method: populate_webroot 11:17:26 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 11:17:26 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 11:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 11:17:26 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 11:17:26 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 11:17:26 INFO - Running post-action listener: _resource_record_post_action 11:17:26 INFO - ##### 11:17:26 INFO - ##### Running create-virtualenv step. 11:17:26 INFO - ##### 11:17:26 INFO - Running pre-action listener: _resource_record_pre_action 11:17:26 INFO - Running main action method: create_virtualenv 11:17:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:17:26 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 11:17:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:17:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:27 INFO - Using real prefix '/usr' 11:17:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:17:29 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:31 INFO - Installing pip.................done. 11:17:31 INFO - Return code: 0 11:17:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:17:31 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')]} 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:31 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')]} 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:31 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 0x7f8be118bb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe977b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', '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 11:17:31 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 11:17:31 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 11:17:31 INFO - Using env: {'DISPLAY': ':0', 11:17:31 INFO - 'HOME': '/home/cltbld', 11:17:31 INFO - 'LANG': 'en_US.UTF-8', 11:17:31 INFO - 'LANGUAGE': 'en_US:en', 11:17:31 INFO - 'LOGNAME': 'cltbld', 11:17:31 INFO - 'MAIL': '/var/mail/cltbld', 11:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:31 INFO - 'MOZ_NO_REMOTE': '1', 11:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:31 INFO - 'NO_EM_RESTART': '1', 11:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:17:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:17:31 INFO - 'SHELL': '/bin/bash', 11:17:31 INFO - 'SHLVL': '1', 11:17:31 INFO - 'TERM': 'linux', 11:17:31 INFO - 'TMOUT': '86400', 11:17:31 INFO - 'USER': 'cltbld', 11:17:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:31 INFO - '_': '/tools/buildbot/bin/python'} 11:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:31 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 11:17:31 INFO - Cleaning up... 11:17:31 INFO - Return code: 0 11:17:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:17:31 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')]} 11:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:31 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')]} 11:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:31 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 0x7f8be118bb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe977b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', '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 11:17:31 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 11:17:31 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 11:17:31 INFO - Using env: {'DISPLAY': ':0', 11:17:31 INFO - 'HOME': '/home/cltbld', 11:17:31 INFO - 'LANG': 'en_US.UTF-8', 11:17:31 INFO - 'LANGUAGE': 'en_US:en', 11:17:31 INFO - 'LOGNAME': 'cltbld', 11:17:31 INFO - 'MAIL': '/var/mail/cltbld', 11:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:31 INFO - 'MOZ_NO_REMOTE': '1', 11:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:31 INFO - 'NO_EM_RESTART': '1', 11:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:17:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:17:31 INFO - 'SHELL': '/bin/bash', 11:17:31 INFO - 'SHLVL': '1', 11:17:31 INFO - 'TERM': 'linux', 11:17:31 INFO - 'TMOUT': '86400', 11:17:31 INFO - 'USER': 'cltbld', 11:17:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:31 INFO - '_': '/tools/buildbot/bin/python'} 11:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:31 INFO - Downloading/unpacking psutil>=0.7.1 11:17:31 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 11:17:31 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 11:17:31 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 11:17:31 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 11:17:31 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 11:17:31 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 11:17:33 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:17:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:17:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:33 INFO - Installing collected packages: psutil 11:17:33 INFO - Running setup.py install for psutil 11:17:33 INFO - building 'psutil._psutil_linux' extension 11:17:33 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 11:17:36 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 11:17:36 INFO - building 'psutil._psutil_posix' extension 11:17:36 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 11:17:36 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 11:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:36 INFO - Successfully installed psutil 11:17:36 INFO - Cleaning up... 11:17:36 INFO - Return code: 0 11:17:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:17:36 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')]} 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 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')]} 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:36 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 0x7f8be118bb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe977b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', '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 11:17:36 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 11:17:36 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 11:17:36 INFO - Using env: {'DISPLAY': ':0', 11:17:36 INFO - 'HOME': '/home/cltbld', 11:17:36 INFO - 'LANG': 'en_US.UTF-8', 11:17:36 INFO - 'LANGUAGE': 'en_US:en', 11:17:36 INFO - 'LOGNAME': 'cltbld', 11:17:36 INFO - 'MAIL': '/var/mail/cltbld', 11:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:36 INFO - 'MOZ_NO_REMOTE': '1', 11:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:36 INFO - 'NO_EM_RESTART': '1', 11:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:17:36 INFO - 'PWD': '/builds/slave/test-pgo', 11:17:36 INFO - 'SHELL': '/bin/bash', 11:17:36 INFO - 'SHLVL': '1', 11:17:36 INFO - 'TERM': 'linux', 11:17:36 INFO - 'TMOUT': '86400', 11:17:36 INFO - 'USER': 'cltbld', 11:17:36 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:36 INFO - '_': '/tools/buildbot/bin/python'} 11:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:17:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:17:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:17:38 INFO - Installing collected packages: mozsystemmonitor 11:17:38 INFO - Running setup.py install for mozsystemmonitor 11:17:38 INFO - Successfully installed mozsystemmonitor 11:17:38 INFO - Cleaning up... 11:17:38 INFO - Return code: 0 11:17:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:17: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')]} 11:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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', '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 0x7f8be118bb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe977b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', '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 11:17: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:17: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 blobuploader==1.2.4 11:17:38 INFO - Using env: {'DISPLAY': ':0', 11:17:38 INFO - 'HOME': '/home/cltbld', 11:17:38 INFO - 'LANG': 'en_US.UTF-8', 11:17:38 INFO - 'LANGUAGE': 'en_US:en', 11:17:38 INFO - 'LOGNAME': 'cltbld', 11:17:38 INFO - 'MAIL': '/var/mail/cltbld', 11:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:38 INFO - 'MOZ_NO_REMOTE': '1', 11:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:38 INFO - 'NO_EM_RESTART': '1', 11:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:17:38 INFO - 'PWD': '/builds/slave/test-pgo', 11:17:38 INFO - 'SHELL': '/bin/bash', 11:17:38 INFO - 'SHLVL': '1', 11:17:38 INFO - 'TERM': 'linux', 11:17:38 INFO - 'TMOUT': '86400', 11:17:38 INFO - 'USER': 'cltbld', 11:17:38 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:38 INFO - '_': '/tools/buildbot/bin/python'} 11:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:39 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:39 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 11:17:39 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 11:17:39 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 11:17:39 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 11:17:39 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 11:17:39 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 11:17:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:17:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:17:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:17:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:41 INFO - Downloading docopt-0.6.1.tar.gz 11:17:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:17:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:41 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:41 INFO - Running setup.py install for blobuploader 11:17:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:17:41 INFO - Running setup.py install for requests 11:17:42 INFO - Running setup.py install for docopt 11:17:42 INFO - Successfully installed blobuploader requests docopt 11:17:42 INFO - Cleaning up... 11:17:42 INFO - Return code: 0 11:17:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:17: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')]} 11:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:42 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 0x7f8be118bb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe977b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', '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 11:17:42 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 11:17:42 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 11:17:42 INFO - Using env: {'DISPLAY': ':0', 11:17:42 INFO - 'HOME': '/home/cltbld', 11:17:42 INFO - 'LANG': 'en_US.UTF-8', 11:17:42 INFO - 'LANGUAGE': 'en_US:en', 11:17:42 INFO - 'LOGNAME': 'cltbld', 11:17:42 INFO - 'MAIL': '/var/mail/cltbld', 11:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:42 INFO - 'MOZ_NO_REMOTE': '1', 11:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:42 INFO - 'NO_EM_RESTART': '1', 11:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:17:42 INFO - 'PWD': '/builds/slave/test-pgo', 11:17:42 INFO - 'SHELL': '/bin/bash', 11:17:42 INFO - 'SHLVL': '1', 11:17:42 INFO - 'TERM': 'linux', 11:17:42 INFO - 'TMOUT': '86400', 11:17:42 INFO - 'USER': 'cltbld', 11:17:42 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:42 INFO - '_': '/tools/buildbot/bin/python'} 11:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:17:42 INFO - Running setup.py (path:/tmp/pip-dyY6er-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:17:42 INFO - Running setup.py (path:/tmp/pip-k4HRLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:17:42 INFO - Running setup.py (path:/tmp/pip-ElXqDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:17:42 INFO - Running setup.py (path:/tmp/pip-YpXKZe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:17:42 INFO - Running setup.py (path:/tmp/pip-jvso4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:17:42 INFO - Running setup.py (path:/tmp/pip-KlUENq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:17:42 INFO - Running setup.py (path:/tmp/pip-8Asrxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:17:42 INFO - Running setup.py (path:/tmp/pip-ovkyqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:17:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:17:42 INFO - Running setup.py (path:/tmp/pip-mZTLbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:17:43 INFO - Running setup.py (path:/tmp/pip-ERHbez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:17:43 INFO - Running setup.py (path:/tmp/pip-iDMWtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:17:43 INFO - Running setup.py (path:/tmp/pip-b7AS2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:17:43 INFO - Running setup.py (path:/tmp/pip-g6Sgmg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:17:43 INFO - Running setup.py (path:/tmp/pip-U41Lrj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:17:43 INFO - Running setup.py (path:/tmp/pip-kINu6h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:17:43 INFO - Running setup.py (path:/tmp/pip-3Sp9tP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:17:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:17:43 INFO - Running setup.py (path:/tmp/pip-uhiSKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:17:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:43 INFO - Running setup.py install for manifestparser 11:17:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:17:43 INFO - Running setup.py install for mozcrash 11:17:43 INFO - Running setup.py install for mozdebug 11:17:43 INFO - Running setup.py install for mozdevice 11:17:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Running setup.py install for mozfile 11:17:44 INFO - Running setup.py install for mozhttpd 11:17:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Running setup.py install for mozinfo 11:17:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Running setup.py install for mozInstall 11:17:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Running setup.py install for mozleak 11:17:44 INFO - Running setup.py install for mozlog 11:17:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Running setup.py install for moznetwork 11:17:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:17:44 INFO - Running setup.py install for mozprocess 11:17:44 INFO - Running setup.py install for mozprofile 11:17:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:17:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:17:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:17:45 INFO - Running setup.py install for mozrunner 11:17:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:17:45 INFO - Running setup.py install for mozscreenshot 11:17:45 INFO - Running setup.py install for moztest 11:17:45 INFO - Running setup.py install for mozversion 11:17:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:17:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:45 INFO - Cleaning up... 11:17:45 INFO - Return code: 0 11:17:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:17:45 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')]} 11:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:45 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')]} 11:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:45 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 0x7f8be118bb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe977b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', '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 11:17:45 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 11:17:45 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 11:17:45 INFO - Using env: {'DISPLAY': ':0', 11:17:45 INFO - 'HOME': '/home/cltbld', 11:17:45 INFO - 'LANG': 'en_US.UTF-8', 11:17:45 INFO - 'LANGUAGE': 'en_US:en', 11:17:45 INFO - 'LOGNAME': 'cltbld', 11:17:45 INFO - 'MAIL': '/var/mail/cltbld', 11:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:45 INFO - 'MOZ_NO_REMOTE': '1', 11:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:45 INFO - 'NO_EM_RESTART': '1', 11:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:17:45 INFO - 'PWD': '/builds/slave/test-pgo', 11:17:45 INFO - 'SHELL': '/bin/bash', 11:17:45 INFO - 'SHLVL': '1', 11:17:45 INFO - 'TERM': 'linux', 11:17:45 INFO - 'TMOUT': '86400', 11:17:45 INFO - 'USER': 'cltbld', 11:17:45 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:45 INFO - '_': '/tools/buildbot/bin/python'} 11:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:17:45 INFO - Running setup.py (path:/tmp/pip-u09Tak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:17:45 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)) 11:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:17:45 INFO - Running setup.py (path:/tmp/pip-vXqiw8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:17:45 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)) 11:17:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:17:45 INFO - Running setup.py (path:/tmp/pip-PuDm6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:17:46 INFO - Running setup.py (path:/tmp/pip-pu00C9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:17:46 INFO - Running setup.py (path:/tmp/pip-8wjRxF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:17:46 INFO - Running setup.py (path:/tmp/pip-vki59r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:17:46 INFO - Running setup.py (path:/tmp/pip-mtlmPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:17:46 INFO - Running setup.py (path:/tmp/pip-2TV_pD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:17:46 INFO - Running setup.py (path:/tmp/pip-t8Vtct-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:17:46 INFO - Running setup.py (path:/tmp/pip-FIVGYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:17:46 INFO - Running setup.py (path:/tmp/pip-DR02xY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:17:46 INFO - Running setup.py (path:/tmp/pip-AJm4c_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:17:46 INFO - Running setup.py (path:/tmp/pip-lPsI4q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:17:46 INFO - Running setup.py (path:/tmp/pip-W4pCbN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:17:46 INFO - Running setup.py (path:/tmp/pip-Qh6iu7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:17:46 INFO - Running setup.py (path:/tmp/pip-V3Xnr2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:17:46 INFO - Running setup.py (path:/tmp/pip-2u1TiY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:17:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:48 INFO - Downloading blessings-1.5.1.tar.gz 11:17:48 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 11:17:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:48 INFO - Installing collected packages: blessings 11:17:48 INFO - Running setup.py install for blessings 11:17:48 INFO - Successfully installed blessings 11:17:48 INFO - Cleaning up... 11:17:48 INFO - Return code: 0 11:17:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:17:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:17:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:17:49 INFO - Reading from file tmpfile_stdout 11:17:49 INFO - Current package versions: 11:17:49 INFO - argparse == 1.2.1 11:17:49 INFO - blessings == 1.5.1 11:17:49 INFO - blobuploader == 1.2.4 11:17:49 INFO - docopt == 0.6.1 11:17:49 INFO - manifestparser == 1.1 11:17:49 INFO - mozInstall == 1.12 11:17:49 INFO - mozcrash == 0.16 11:17:49 INFO - mozdebug == 0.1 11:17:49 INFO - mozdevice == 0.46 11:17:49 INFO - mozfile == 1.2 11:17:49 INFO - mozhttpd == 0.7 11:17:49 INFO - mozinfo == 0.8 11:17:49 INFO - mozleak == 0.1 11:17:49 INFO - mozlog == 3.0 11:17:49 INFO - moznetwork == 0.27 11:17:49 INFO - mozprocess == 0.22 11:17:49 INFO - mozprofile == 0.27 11:17:49 INFO - mozrunner == 6.10 11:17:49 INFO - mozscreenshot == 0.1 11:17:49 INFO - mozsystemmonitor == 0.0 11:17:49 INFO - moztest == 0.7 11:17:49 INFO - mozversion == 1.4 11:17:49 INFO - psutil == 3.1.1 11:17:49 INFO - requests == 1.2.3 11:17:49 INFO - wsgiref == 0.1.2 11:17:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8be118bb90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe977b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5c4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', '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 11:17:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:17:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:17:49 INFO - Using env: {'DISPLAY': ':0', 11:17:49 INFO - 'HOME': '/home/cltbld', 11:17:49 INFO - 'LANG': 'en_US.UTF-8', 11:17:49 INFO - 'LANGUAGE': 'en_US:en', 11:17:49 INFO - 'LOGNAME': 'cltbld', 11:17:49 INFO - 'MAIL': '/var/mail/cltbld', 11:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:49 INFO - 'MOZ_NO_REMOTE': '1', 11:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:49 INFO - 'NO_EM_RESTART': '1', 11:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:17:49 INFO - 'PWD': '/builds/slave/test-pgo', 11:17:49 INFO - 'SHELL': '/bin/bash', 11:17:49 INFO - 'SHLVL': '1', 11:17:49 INFO - 'TERM': 'linux', 11:17:49 INFO - 'TMOUT': '86400', 11:17:49 INFO - 'USER': 'cltbld', 11:17:49 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:49 INFO - '_': '/tools/buildbot/bin/python'} 11:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 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)) 11:17:49 INFO - Cleaning up... 11:17:49 INFO - Return code: 0 11:17:49 INFO - Running post-action listener: _resource_record_post_action 11:17:49 INFO - Running post-action listener: _start_resource_monitoring 11:17:49 INFO - Starting resource monitoring. 11:17:49 INFO - ##### 11:17:49 INFO - ##### Running install step. 11:17:49 INFO - ##### 11:17:49 INFO - Running pre-action listener: _resource_record_pre_action 11:17:49 INFO - Running main action method: install 11:17:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:17:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:17:49 INFO - Reading from file tmpfile_stdout 11:17:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:17:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:17:49 INFO - Reading from file tmpfile_stdout 11:17:49 INFO - Output received: 11:17:49 INFO - Usage: mozinstall [options] installer 11:17:49 INFO - Options: 11:17:49 INFO - -h, --help show this help message and exit 11:17:49 INFO - -d DEST, --destination=DEST 11:17:49 INFO - Directory to install application into. [default: 11:17:49 INFO - "/builds/slave/test-pgo"] 11:17:49 INFO - --app=APP Application being installed. [default: firefox] 11:17:49 INFO - mkdir: /builds/slave/test-pgo/build/application 11:17:49 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'] 11:17:49 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 11:18:04 INFO - Reading from file tmpfile_stdout 11:18:04 INFO - Output received: 11:18:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:18:04 INFO - Running post-action listener: _resource_record_post_action 11:18:04 INFO - ##### 11:18:04 INFO - ##### Running run-tests step. 11:18:04 INFO - ##### 11:18:04 INFO - Running pre-action listener: _resource_record_pre_action 11:18:04 INFO - Running main action method: run_tests 11:18:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:18:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:18:04 INFO - Python 2.7.3 11:18:04 INFO - Return code: 0 11:18:04 INFO - grabbing minidump binary from tooltool 11:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xceebf0>, '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 0xfec4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfec9a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:18:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:18:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:18:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:04 INFO - Return code: 0 11:18:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:18:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:18:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:18:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:18:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:18:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:18:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --symbolsPath https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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-011 --webServer localhost 11:18:04 INFO - Using env: {'DISPLAY': ':0', 11:18:04 INFO - 'HOME': '/home/cltbld', 11:18:04 INFO - 'LANG': 'en_US.UTF-8', 11:18:04 INFO - 'LANGUAGE': 'en_US:en', 11:18:04 INFO - 'LOGNAME': 'cltbld', 11:18:04 INFO - 'MAIL': '/var/mail/cltbld', 11:18:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:18:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:04 INFO - 'MOZ_NO_REMOTE': '1', 11:18:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:04 INFO - 'NO_EM_RESTART': '1', 11:18:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:18:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:18:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:18:04 INFO - 'SHELL': '/bin/bash', 11:18:04 INFO - 'SHLVL': '1', 11:18:04 INFO - 'TERM': 'linux', 11:18:04 INFO - 'TMOUT': '86400', 11:18:04 INFO - 'USER': 'cltbld', 11:18:04 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536', 11:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:04 INFO - '_': '/tools/buildbot/bin/python'} 11:18:04 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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-011', '--webServer', 'localhost'] with output_timeout 3600 11:18:05 INFO - mozversion INFO | application_buildid: 20151027085421 11:18:05 INFO - mozversion INFO | application_changeset: b5c8da05bef9d38b67b6e27d83035af210c58e23 11:18:05 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:18:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:05 INFO - mozversion INFO | application_name: Firefox 11:18:05 INFO - mozversion INFO | application_remotingname: firefox-dev 11:18:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:18:05 INFO - mozversion INFO | application_vendor: Mozilla 11:18:05 INFO - mozversion INFO | application_version: 43.0a2 11:18:05 INFO - mozversion INFO | platform_buildid: 20151027085421 11:18:05 INFO - mozversion INFO | platform_changeset: b5c8da05bef9d38b67b6e27d83035af210c58e23 11:18:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:18:05 INFO - mozversion INFO | platform_version: 43.0a2 11:18:05 INFO - 2015-10-27 11:18:05,015 DEBUG : using testdate: 1445969885 11:18:05 INFO - 2015-10-27 11:18:05,015 DEBUG : actual date: 1445969885 11:18:05 INFO - 2015-10-27 11:18:05,063 INFO : Starting test suite talos-linux64-ix-011 11:18:05 INFO - 2015-10-27 11:18:05,063 INFO : Starting test dromaeo_css 11:18:05 INFO - 2015-10-27 11:18:05,063 DEBUG : operating with platform_type : linux_ 11:18:05 INFO - 2015-10-27 11:18:05,063 INFO : Initialising browser for dromaeo_css test... 11:18:05 INFO - 2015-10-27 11:18:05,154 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMrJOs2/profile http://localhost/getInfo.html 11:18:10 INFO - 2015-10-27 11:18:10,769 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:18:10 INFO - 2015-10-27 11:18:10,769 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:18:10 INFO - 2015-10-27 11:18:10,769 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:18:10 INFO - 2015-10-27 11:18:10,769 DEBUG : BROWSER_OUTPUT: __metrics 11:18:10 INFO - 2015-10-27 11:18:10,846 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:12 INFO - 2015-10-27 11:18:12,190 INFO : Browser initialized. 11:18:12 INFO - 2015-10-27 11:18:12,191 INFO : Running cycle 1/1 for dromaeo_css test... 11:18:12 INFO - 2015-10-27 11:18:12,191 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMrJOs2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:18:23 INFO - 2015-10-27 11:18:23,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 133193728 11:18:23 INFO - 2015-10-27 11:18:23,835 DEBUG : BROWSER_OUTPUT: 11:21:23 INFO - 2015-10-27 11:21:23,275 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) 11:21:24 INFO - 2015-10-27 11:21:24,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 223252480 11:21:24 INFO - 2015-10-27 11:21:24,250 DEBUG : BROWSER_OUTPUT: 11:24:26 INFO - 2015-10-27 11:24:26,392 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) 11:24:26 INFO - 2015-10-27 11:24:26,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 206610432 11:24:26 INFO - 2015-10-27 11:24:26,955 DEBUG : BROWSER_OUTPUT: 11:27:28 INFO - 2015-10-27 11:27:28,706 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) 11:27:29 INFO - 2015-10-27 11:27:29,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 207740928 11:27:29 INFO - 2015-10-27 11:27:29,267 DEBUG : BROWSER_OUTPUT: 11:30:30 INFO - 2015-10-27 11:30:30,991 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) 11:30:31 INFO - 2015-10-27 11:30:31,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 198885376 11:30:31 INFO - 2015-10-27 11:30:31,560 DEBUG : BROWSER_OUTPUT: 11:33:33 INFO - 2015-10-27 11:33:33,853 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) 11:33:34 INFO - 2015-10-27 11:33:34,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 195330048 11:33:34 INFO - 2015-10-27 11:33:34,436 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,517 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) 11:36:36 INFO - 2015-10-27 11:36:36,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 236929024 11:36:36 INFO - 2015-10-27 11:36:36,767 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,769 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:36:36 INFO - 2015-10-27 11:36:36,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:36:36 INFO - 2015-10-27 11:36:36,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:36:36 INFO - 2015-10-27 11:36:36,769 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:36:36 INFO - 2015-10-27 11:36:36,771 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3319.4191016572095;3326.3347330533898;3359.2273777031282;3366.343563005215;3383.08656662701;5569.10894256919;5578.581606379527;5599.692016939067;5607.355154157268;5615.129654903497;5601.215829783823;5618.15727640854;5619.353774315955;5637.689927054011;5663.348714897788;5004.699718016931;5080.822171223989;5111.718855462957;5124.8206312778875;5180.378354597454;5172.844814655547;5178.171492561191;5192.584593232532;5193.922091168635;5194.298769666085;5100.056489549426;5103.464136265694;5127.7948882044675;5197.142471492218;5221.556167725748;5185.714785686804;5198.896022079575;5199.922001169985;5202.4277329493725;5221;4944.233643785219;5165.948340516585;5169.508896654812;5214.843554693365;5235.214717792323;5328.46715328468;5335.759890804923;5424.511793938565;5429.294191755086;5450.509454149106;6008.75964961401;6051.878962420771;6062.1209924561135;6065.909011364833;6087.756489740405;5894.58737888348;6005.849853753647;6106.3893610639025;6112.327643959161;6118.082287656843;5607.831765047055;5692.943070569324;5700.828975130753;5723.656580605136;5736.741846616912;6158.599691020069;6179.783707570214;6189.721462534197;6199.876002479925;6201.937980620136;5679.403662615448;5860.765569377178;5946.43508866657;6024.939750602438;6035.245594300713;6112.724927378279;6122.173506576644;6130.52043589939;6136.140940268366;6138.693065346804;6103.633781973096;6106.786262480792;6109.816705498843;6119.296280927751;6123.265208174958;5856.882862342729;5913.793017244376;5983.521318294526;6012.729427175787;6117.418845209698;4607.95392046082;4615.030843522831;4617.515160908057;4631.212693842055;4648.558386953302;4145.647619952278;4146.688998325138;4155.10665206982;4156.023334516386;4158.043649960526;5557.499825015768;5668.716564171775;5713.171590119409;5806.1581070744505;5811.912821307684;6028.758849645965;6178.289496707936;6179.443850053517;6184.5052395808225;6185.474234690102;5838.737256823453;5857.7949771757785;5868.295804503487;5874.030784920526;5882.147088672119;5037.3955125384455;5144.6913185209005;5254.133068043807;5340.8664783379945;5349.812756553502;6359.300476947532;6364.395382438661;6369.617822930639;6377.426031657174;6378.968105159537;5936.436038576328;6169.56813023084;6175.44421002112;6187.969060154671;6194.318624951342;6111.755529778937;6113.266408031065;6192.287886893065;6215.409536094064;6228.346023667631;5929.080992446177;6101.60339577926;6106.236720409949;6107.480864126599;6122.204113465221;5927.347991720821;6015.39846015395;6150.446459818638;6154.323024467216;6164.4760195382105;5906.645601263938;5988.311344195299;5988.970055149871;6001;6013.037913933749;5961.314448838439;5975.820725378246;5985.25184351956;6012.188354572077;6021.578489505868;5628.85927851807;5654.264945557051;5737.02470579994;5915.08316210988;5917.585768996301;6008.54935879802;6029.517638588814;6033.396660333931;6039.486643635164;6074.969625151846;5899.085641725368;5899.557533184942;5908.409159084057;5908.793192238251;5924.674142922008 11:36:36 INFO - 2015-10-27 11:36:36,772 DEBUG : BROWSER_OUTPUT: |1;ext.html;596.5466245653305;650.8958566629341;651.3258777165629;652.1880259077449;657.503584793481;36064.098397540074;43473.565264347344;44234.77882610587;44276.99999999992;44350;46983.765081174635;47248.76375618126;47431.762841185744;47532.524674753244;47538.0492390152;8262.958685206595;8361.03848057472;9359.438433694;9449.385789923634;9534.189593884528;11106.555737770479;11373.772524549504;11426.600068997586;11438.084953203765;11440.370779607118;11065;11236.606718764844;11240.100791936626;11244.606438774645;11244.662660120168;8593.699220527284;8801.911980880206;11067.72330691731;11284.153688473398;11514.19400641947;10751.301165424222;10881.673549793519;10901.727456813564;10908.727281817939;10910.072643825284;45297.54702452966;45622.54377456216;45775.313370299475;45908;45920.54079459229;3783.791891445969;3920.9803950980063;4049.311617025113;4122.876313710593;4193.433886425354;34084;34253.486197707054;34621;34640.307193856235;34754.30491390183;3684.7236457265813;3695.63043695631;3701.3152566775234;3734.178480734234;3773.8301776420126;328398;330672.9999999976;330703;331809;331815;56421;57387.71306143443;67486.32513674899;72492;74346;68073.3192668077;68195.65902170457;68442.3155768436;68446.315536845;68501.31498685048;17290.740638890427;18902.621947560972;19084.90457547731;19095.80904190968;19105.522361941064;13029.869701302865;14856.851431485762;15100.471483498024;15118.773218401733;15131.394744210329;21767;21990.340289791333;22138.667919981213;22142.446438839157;22243;8046.195380462024;8263.834723305621;8392.370572207108;8397.370197235232;8446.113158118433;1137.4426530999751;1179.4161889864401;1195.2926621202982;1227.7053507158219;1274.7769140400578;31326.216844579067;31811.449546010397;31968.680313197037;31978.680213198037;32072.198195045312;1222.6821026533166;1246.046774217724;1259.1689484939895;1266.2972050512055;1279.59053103008;14726.484573039892;16489.422870199487;16941.576460588338;17333.046682432334;17495.212715427835;423380;427071;431802;432809;434682;60277.39722602718;60284.69857650684;60569.394306056376;60650.69674651598;60654;1541.2601951063327;1549.5893588199363;1554.0908568487334;1559.766035094745;1665.8001039875292;31893.362132756753;32346.35307293888;33133.66866331402;33234.83382583072;33581.664183357854;50666.240006399195;50798;50828.49171508385;50839.49160508347;50871.745641271555;341301;357258;362501;519624.80375195766;528791;35393.82303088571;35615.82192089023;35668.46497302595;35678.286434271686;36137;49968;50403.243951341494;50694.23958640697;50790.238146427095;51109.23336149886;41283.38074928818;41427.7928610355;41643.37534937039;41660;42737.78631106949;42073.78963105165;42276.78861605795;42632.36051459169;43067.35398968955;43088.569114308455;42329.365059523516;42565.36151957785;43117.568824311355;43181.56818431775;43222.78388608037;37354.43968340423;38445;38517;38708.61291387163;38746.80626596849;28316.43367132687;28792.424151517273;28804.279893002844;29134.56298155487;29144.417111658073 11:36:36 INFO - 2015-10-27 11:36:36,773 DEBUG : BROWSER_OUTPUT: |2;jquery.html;423.8897886549496;429.3071022755245;432.05164663563454;432.1551367077363;440.6584896705054;12187.207831490969;12567;14065.226412547294;20019.59960800783;20506.179752809887;13380.264085475295;13719.93140034301;13750.587482375544;14102.78845817311;14119.858801411983;4265.936010959838;4961.37982752155;5094.184930411135;5095.79616815327;5507.256520369739;3727.664510194082;3864.80675966202;5330.760115794779;5413.079776438015;5488.121900495921;5383.730813459331;5416.187571864232;5417.10617748073;5430.56555475561;5433.483819037185;5282.022825777224;5400.918986215191;5429.755660995264;5439.238506609078;5439.83680489584;4727.432708075019;4729.337892695025;4742.075295317414;4743.051389722069;4748.786304616266;14230.85769142316;14242.359093840802;14244.857551424457;14247.145171289756;14494.56516304502;2239.1603148819195;2280.7947284744287;2286.8627882327114;2300.919467818618;2421.2373102472666;11135.72160695989;11208.943955280252;11211.439428028565;11445.427728613618;11502.654920352403;1870.3827736846945;1879.6804543227684;1904.7523821903064;1935.283944940367;1944.8735832171005;69777.30222697758;70521.99999999949;72198;72231;72353;7897.289243968071;8105.594720264081;8121.147279535682;8133.14601966785;8168.673253069929;9753.366031207948;9876.259280553988;9878.604855805832;9879.456629885426;9889.406635601887;6478.930976388937;6482.870342593216;6508.837279067967;6525.4453371463005;6548.083268342436;6716.971734528701;6752.426043786333;6755.594664320157;6880.724771009103;6901.275366086589;3711.6659500645073;3754.1740817020213;3773.8301776420126;3779.338615742234;3789.6020917803785;1269.435101379877;1282.0576875996135;1305.9151155174884;1320.735852829438;1347.7439286535528;513.0380536494074;526.1292560811862;548.180470197058;549.2971787458846;572.5591294703055;13406.195628262336;13631.182129072287;13853.861461385459;13909.234992075331;13921.095128816594;539.5926075812815;579.4726798613326;590.1560768101656;591.2675859730944;603.6951339573575;7444.516106453063;7516.774496764996;7539.8115047123165;7643.121041080236;7749.225077492206;576097;587737;591206;595609;600148;90806.54596726975;92096.53951730198;92908.53545732229;93206;93597;610.4109534299333;619.7118339971935;620.2959640807716;620.9130721698966;624.2696045626627;12030;12128;12384.31886246229;12563.497460101493;12886.226826390446;40796.59203407928;40848.79575602103;40925;41394.58605413907;42038.15923681571;55921.72039139778;55951.44048559462;56170;57019.144712828514;57251.14123288237;7828.2954534092205;7906.7627971160955;7912.9208707912185;7919.643616037177;7926.762197134095;13307.46770129184;13321.600351989457;13403.396847142098;13636.79544806809;13648.317584120952;12457.937710311391;12471;12484.875151248734;12511.874881251071;12839.293838838954;12178.634640960785;12362.690932726395;12502.43739031764;12507.56223532172;12579.433925473559;10447.111995480469;10969.83545246806;12122.75754484923;12350.81473777876;12707.618771436872;7496.887546686913;7530.811729706801;7583.924160758322;7612.505187162817;7628.504147230412;12001.81997270059;12325.075619328407;12513.499460021498;12726.109172357847;12750.171238869443 11:36:36 INFO - 2015-10-27 11:36:36,775 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1631.779709739185;1662.900225986441;1833.936316936177;2046.6111438826622;2067.7845949548446;8783.780405489859;9553.23574114071;9668.758281042978;9719.902800971988;9720.951395243013;9734.561944712486;9909.702708918743;9961.402315861053;10006.59973601055;10035.498225088753;2167.804897559219;2199.351191398533;2459.1270099114827;2510.6234064890277;2535.784458321045;2454.7299797022315;2456.152627343564;2468.8518688878726;2475.554400207962;2484.2050543825985;2515.408878913454;2536.074332868499;2536.2898388451263;2539.898404063835;2540.5554028045112;2179.3353027326657;2218.8557743746687;2466.3710753757855;2512.937176570582;2513.912013079552;2503.824732268742;2531.6835395575554;2531.936701582457;2599.272203782944;2602.44047529782;10114.342567733147;10133.530638057515;10180.898191018143;10232.334898231591;10235.488225588766;5798.3911689272445;5916.230889984275;5940.34656187819;5957;5965.642061476326;3732.048327676452;3762.9059273518105;3779.622037796226;3811.6760075393627;3828.3683192273243;1144.9713757156137;1154.8440960470398;1168.6026750904648;1177.0583533173512;1197.1560050164612;16221.351145954266;16227.91886040574;16243.619292360045;16245.431409900597;16247.83752162487;5237.711925844039;5252.842414727565;5266.683998960075;5363.651362661414;5428.864278392993;12660.17708848922;12667.429965651569;12675;12679.366031698379;12689.619311420673;5914.970425147847;5919.230500034968;5923.637563360365;5923.644581325134;5928.3775203603;5306.416294207711;5321.707306098125;5324.281222035053;5325.840224793263;5330.067238233293;4332.155229730172;4350.434443522322;4369.300911854088;4421.53573874745;4427.623651989553;1331.4407948661585;1335.7595632786192;1353.4247944623496;1379.0760190672274;1391.9373628186554;1491.2767307855897;1520.293063725373;1526.2292542266307;1541.7841502189704;1558.2676142213143;10041.748956276151;10076.949615251877;10095.697129086138;10101.44442055694;10105.44420056904;602.686602966455;604.6644112517507;1368.4115830193114;1370.280602683599;1413.7313910357;7520.661570229353;7542.057242844645;7601.885971710429;7622.161562228151;7734.497257678233;13422.194668319931;13583.86416135826;13589.592312230649;13592.252426116658;13606.115602485806;13312.534061307808;13739.24434156111;13755.10591811529;13758.93120534411;13759.449622015207;9752.951235243778;9800.26498012652;9838.16375608067;9919.851202231972;9925.1067403934;9424.670136545188;9483.66807161746;9492.525373731423;9513.524323783644;9513.809723805623;11493.367864767184;11754;11802.82295765547;11843;11871.881281187078;11795.528178873092;12037.217580857216;12054;12059.819102713642;12073.215241009306;8961.372703910663;9285.814283714422;9412.388194767318;9421.340506164503;9430.3398762086;10112.443815590213;10188.388696678223;10215.94892025535;10227.130693891102;10262.794744105226;8125.268725814705;8728;9507.049295070437;9542.809143817223;9685.225181985565;9155.359124861196;9157.816843663222;9286.099838068163;9321.207697345802;9375.953120234355;9463.952680236831;9523.952380238054;9546.379485333431;9559.904400955902;9560.760980975254;8466.872996905175;8500.914990850013;8503.532305723245;8511.829763404574;8519.701810436605;8640.308775297835;8693.869591956;8704.78238044054;8718.520481373585;8749.343799214957 11:36:36 INFO - 2015-10-27 11:36:36,775 DEBUG : BROWSER_OUTPUT: |4;prototype.html;401.17358242021436;407.12671320018563;408.5057080932072;411.43222353152646;416.44612665155347;5962.672053037081;6035;6039.5772295939305;6057.242844644419;6070.271567411917;5778.653280803144;5854.677992710399;5965.015772397549;5997.790077347294;6010.647604289033;4655.580997710205;4661.09108723799;4740.549647783472;4765.594924431428;4780.043991201756;4727.409073865767;4739.549742774431;4740.431148262213;4741.739204343759;4764.547368000051;4561.156186105581;4622.930656040162;4656.767161641921;4726.71639701619;4730.101280756662;4715.292706094079;4715.43414790224;4729.503402142795;4732.219183834681;4734.289856521515;4182.707210495267;4203.117345357478;4207.074443622429;4209.473815773028;4215.852445164404;5706.343770466408;5707.828765137053;5719.513841323493;5719.885602287973;5721.9986502362335;5434.701091439969;5465.262189604432;5497.5601951843755;5528.723563821793;5539.612227144102;6340.461060809836;6345.841353966188;6346.0798184263485;6346.6509341986175;6348.523860710419;4675.836345727917;4692.366530518405;4692.7653617319;4693.155232058228;4693.296005599153;6499.38255865692;6518.9895566187315;6541.411272985407;6584.670766461706;6588.24235212947;4756.833510827105;4797.832075877397;4798.616110711205;4801.5438533339275;4804.591609713144;4860.635452341018;4864.756762161877;4865.6107511399005;4866.9513304867205;4871.29366241893;5484.177373393943;5484.287042684506;5487.807926722546;5493.395726470085;5498.230247765236;6285.434310911948;6391.96804015977;6391.9680401598625;6397.776077837253;6478.870422591522;1753.0358302933337;1769.1773325403492;1770.3803668716105;1772.0430967277784;1773.725072613747;1201.3092471828734;1205.8372119763894;1220.3227208898968;1229.6188181663713;1238.7646347194004;6238;6238.65687387189;6238.781642642576;6249.875002499924;6255.530835187379;6614.768483103068;6646.468282537482;6647.169103862017;6647.833804154935;6659.766908158192;6059.757609695563;6081.148639190517;6142;6257.436830685169;6260.24877014752;3645.1069487975615;3670.155864151207;3679.2089700714473;3686.594474607791;3691.667749902522;6816.352446517573;6816.659167041727;6817.5909445433435;6821.795346139525;6827.726890924308;6701.698423570853;6772.390484856288;6779.084823548857;6868.8322985092655;6874.175098988054;6855.760048398282;6887.793366199022;6891.27641597635;6901.62041087745;6905.067815844897;6645.468362530889;6647.867042659023;6686.264510903699;6694.464442844658;6699.39705426514;6516.771912983023;6613.900791488228;6615.040819081302;6617.503687223381;6622.735090596322;6874.381305682313;6885.862282754417;6890.44876409896;6893.620850853251;6893.620850853251;4813.614910807197;4814.061258054646;4824.903501930012;4829.44461386945;4836.782344794563;6475.902861456988;6668.099806526056;6672.799816005528;6677.165354330708;6682.832929176615;6428.6785660717715;6450.064740612491;6460.224773027267;6475.417212450902;6479.902801457888;6406.807795766134;6441.645709486023;6444.516661250331;6450.677466126769;6463.709133089116;6241.563090583797;6337.65142917144;6371.713272902638;6374.74501019954;6382.6170429774365;6492.188476440445;6494.935050649622;6525.706343214471;6529.151210342625;6530.444912182327;6306.558540902093;6369.9681501592195;6375.713092910923;6375.713092910923;6378.394052564999 11:36:36 INFO - 2015-10-27 11:36:36,776 DEBUG : BROWSER_OUTPUT: |5;yui.html;824.0729179672868;886.8758373827666;903.31799491384;904.7240591619556;953.6137864165015;12955.09314347996;13128.934355328234;13137.540186093489;13139.343032848366;13166.407511661962;13457.327133643328;13567.72864542711;13569.796453053188;13577.456901723945;13584.660383490393;771.3713323641242;781.03932163439;936.5504557812254;955.7753927826955;960.490939801906;935.4106912645024;945.6312038305032;953.7281874665722;954.1508057828538;954.1841725324851;806.7741032510907;984.8571957066221;988.4859872866106;988.6490295944908;990.5691024404371;809.0776514773163;968.3608818180003;992.3648864726581;994.2195376629347;994.5623925472769;727.4980263618139;728.4609389052116;731.9780406587811;732.9890051649229;733.9376153026999;13885.722285554333;14019.579412617535;14067.71864562703;14095.50665726705;14121.505747298796;12577.874221257762;12696.6825829355;12908.483660653563;12958.935205324007;13178.538751143664;10240.897591024144;10419.166466682647;10429;10431.165506759517;10458.790824183474;3876.5154355705536;3916.2754890345377;3918.1771827916173;3924.2151569685893;3924.3132451820816;45022.32466513005;45112.548874511165;45113.548864511264;45645.999999999665;45677.314840277424;10379.84430233547;10492.108170805413;10577.524011419504;10647.84028239577;10710.73223169427;20027.799722002594;20044;20075;20097.59804803896;20098.598028039356;7444.516106453063;7451.925480745232;7837.804054898673;7901.525908445512;8084.3936704747375;4434.17967675981;4453.35426363182;4543.136804007228;4571.702839315434;4620.306953956933;3356.714679252291;3381.5773028371455;3385.441402168615;3396.728261739055;3397.3205358928312;504.0448350376017;504.45014933722416;524.4178961352895;525.7686617888118;544.311446020784;637.6461064109463;639.2616527910271;649.4706813946618;694.9513534052568;735.6652723011017;8097.109317975018;8128.349732021424;8183.222593853575;8383.413161078666;8974.68588599409;586.9236999190164;620.525298146918;644.9000404937242;677.502036003537;720.3049057659384;4029.778362190049;4196.349565817242;4295.849645262463;4318.913621727548;4319.97840010798;53673.1949020765;53958;54032.189517157276;54130.729346353015;54217;44211.33682994758;44272.11455770931;44957.32564011542;45014;47296.5270347299;37295.62704372976;37473.62526374702;39617.20765584672;39768.21622486398;39787.20425591472;8664.176903194186;8877.467351958903;8972.955135224282;8976.281897448058;9026.729198124067;27816.72183278141;27989;28429.431411372072;28440.288992775346;28468;36476.27047459089;36658.26683466369;37117.443238350905;37187.628123718416;37632;8608.91391086081;8887.688930887389;8917.821643567222;9086.772830679285;9202.815943680955;12275.877241227474;12351.629451116482;12386.071044671506;12644.431000605178;13219.140755850838;11302.943485282522;11897.940510297392;12260.32568208757;12417;12620.747585048432;11409.144314176636;11477.655670329903;11759.47082381312;11912.821307680566;11998.58004969822;11264.38045907483;11522.827157592475;11835.230710003822;11843.58547450835;11954.462049207632;10277.640282590073;10502.317349372266;10739.46302684847;10798.460076996276;10869.359615719592;9274.675386361714;9841.261905356983;10084.647037353658;10196.235282354002;10225.386476811414 11:36:36 INFO - 2015-10-27 11:36:36,776 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:36:36 INFO - 2015-10-27 11:36:36,776 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:36:36 INFO - 2015-10-27 11:36:36,776 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,728 11:36:36 INFO - 2015-10-27 11:36:36,776 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:36:36 INFO - 2015-10-27 11:36:36,776 DEBUG : BROWSER_OUTPUT: __startTimestamp1445970996768__endTimestamp 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5639.54 Median:5899.09 stddev:642.82 (10.9%) stddev-sans-first:618.48 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: Values: 3319.4 3326.3 3359.2 3366.3 3383.1 5569.1 5578.6 5599.7 5607.4 5615.1 5601.2 5618.2 5619.4 5637.7 5663.3 5004.7 5080.8 5111.7 5124.8 5180.4 5172.8 5178.2 5192.6 5193.9 5194.3 5100.1 5103.5 5127.8 5197.1 5221.6 5185.7 5198.9 5199.9 5202.4 5221.0 4944.2 5165.9 5169.5 5214.8 5235.2 5328.5 5335.8 5424.5 5429.3 5450.5 6008.8 6051.9 6062.1 6065.9 6087.8 5894.6 6005.8 6106.4 6112.3 6118.1 5607.8 5692.9 5700.8 5723.7 5736.7 6158.6 6179.8 6189.7 6199.9 6201.9 5679.4 5860.8 5946.4 6024.9 6035.2 6112.7 6122.2 6130.5 6136.1 6138.7 6103.6 6106.8 6109.8 6119.3 6123.3 5856.9 5913.8 5983.5 6012.7 6117.4 4608.0 4615.0 4617.5 4631.2 4648.6 4145.6 4146.7 4155.1 4156.0 4158.0 5557.5 5668.7 5713.2 5806.2 5811.9 6028.8 6178.3 6179.4 6184.5 6185.5 5838.7 5857.8 5868.3 5874.0 5882.1 5037.4 5144.7 5254.1 5340.9 5349.8 6359.3 6364.4 6369.6 6377.4 6379.0 5936.4 6169.6 6175.4 6188.0 6194.3 6111.8 6113.3 6192.3 6215.4 6228.3 5929.1 6101.6 6106.2 6107.5 6122.2 5927.3 6015.4 6150.4 6154.3 6164.5 5906.6 5988.3 5989.0 6001.0 6013.0 5961.3 5975.8 5985.3 6012.2 6021.6 5628.9 5654.3 5737.0 5915.1 5917.6 6008.5 6029.5 6033.4 6039.5 6075.0 5899.1 5899.6 5908.4 5908.8 5924.7 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,777 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:58016.08 Median:20544.31 stddev:105214.88 (512.1%) stddev-sans-first:105421.71 11:36:36 INFO - 2015-10-27 11:36:36,778 DEBUG : BROWSER_OUTPUT: Values: 596.5 650.9 651.3 652.2 657.5 36064.1 43473.6 44234.8 44277.0 44350.0 46983.8 47248.8 47431.8 47532.5 47538.0 8263.0 8361.0 9359.4 9449.4 9534.2 11106.6 11373.8 11426.6 11438.1 11440.4 11065.0 11236.6 11240.1 11244.6 11244.7 8593.7 8801.9 11067.7 11284.2 11514.2 10751.3 10881.7 10901.7 10908.7 10910.1 45297.5 45622.5 45775.3 45908.0 45920.5 3783.8 3921.0 4049.3 4122.9 4193.4 34084.0 34253.5 34621.0 34640.3 34754.3 3684.7 3695.6 3701.3 3734.2 3773.8 328398.0 330673.0 330703.0 331809.0 331815.0 56421.0 57387.7 67486.3 72492.0 74346.0 68073.3 68195.7 68442.3 68446.3 68501.3 17290.7 18902.6 19084.9 19095.8 19105.5 13029.9 14856.9 15100.5 15118.8 15131.4 21767.0 21990.3 22138.7 22142.4 22243.0 8046.2 8263.8 8392.4 8397.4 8446.1 1137.4 1179.4 1195.3 1227.7 1274.8 31326.2 31811.4 31968.7 31978.7 32072.2 1222.7 1246.0 1259.2 1266.3 1279.6 14726.5 16489.4 16941.6 17333.0 17495.2 423380.0 427071.0 431802.0 432809.0 434682.0 60277.4 60284.7 60569.4 60650.7 60654.0 1541.3 1549.6 1554.1 1559.8 1665.8 31893.4 32346.4 33133.7 33234.8 33581.7 50666.2 50798.0 50828.5 50839.5 50871.7 341301.0 357258.0 362501.0 519624.8 528791.0 35393.8 35615.8 35668.5 35678.3 36137.0 49968.0 50403.2 50694.2 50790.2 51109.2 41283.4 41427.8 41643.4 41660.0 42737.8 42073.8 42276.8 42632.4 43067.4 43088.6 42329.4 42565.4 43117.6 43181.6 43222.8 37354.4 38445.0 38517.0 38708.6 38746.8 28316.4 28792.4 28804.3 29134.6 29144.4 11:36:36 INFO - 2015-10-27 11:36:36,779 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,779 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30190.59 Median:4742.56 stddev:96963.99 (2044.5%) stddev-sans-first:97210.23 11:36:36 INFO - 2015-10-27 11:36:36,779 DEBUG : BROWSER_OUTPUT: Values: 423.9 429.3 432.1 432.2 440.7 12187.2 12567.0 14065.2 20019.6 20506.2 13380.3 13719.9 13750.6 14102.8 14119.9 4265.9 4961.4 5094.2 5095.8 5507.3 3727.7 3864.8 5330.8 5413.1 5488.1 5383.7 5416.2 5417.1 5430.6 5433.5 5282.0 5400.9 5429.8 5439.2 5439.8 4727.4 4729.3 4742.1 4743.1 4748.8 14230.9 14242.4 14244.9 14247.1 14494.6 2239.2 2280.8 2286.9 2300.9 2421.2 11135.7 11208.9 11211.4 11445.4 11502.7 1870.4 1879.7 1904.8 1935.3 1944.9 69777.3 70522.0 72198.0 72231.0 72353.0 7897.3 8105.6 8121.1 8133.1 8168.7 9753.4 9876.3 9878.6 9879.5 9889.4 6478.9 6482.9 6508.8 6525.4 6548.1 6717.0 6752.4 6755.6 6880.7 6901.3 3711.7 3754.2 3773.8 3779.3 3789.6 1269.4 1282.1 1305.9 1320.7 1347.7 513.0 526.1 548.2 549.3 572.6 13406.2 13631.2 13853.9 13909.2 13921.1 539.6 579.5 590.2 591.3 603.7 7444.5 7516.8 7539.8 7643.1 7749.2 576097.0 587737.0 591206.0 595609.0 600148.0 90806.5 92096.5 92908.5 93206.0 93597.0 610.4 619.7 620.3 620.9 624.3 12030.0 12128.0 12384.3 12563.5 12886.2 40796.6 40848.8 40925.0 41394.6 42038.2 55921.7 55951.4 56170.0 57019.1 57251.1 7828.3 7906.8 7912.9 7919.6 7926.8 13307.5 13321.6 13403.4 13636.8 13648.3 12457.9 12471.0 12484.9 12511.9 12839.3 12178.6 12362.7 12502.4 12507.6 12579.4 10447.1 10969.8 12122.8 12350.8 12707.6 7496.9 7530.8 7583.9 7612.5 7628.5 12001.8 12325.1 12513.5 12726.1 12750.2 11:36:36 INFO - 2015-10-27 11:36:36,779 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,779 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7251.14 Median:2538.09 stddev:4170.35 (164.3%) stddev-sans-first:4160.67 11:36:36 INFO - 2015-10-27 11:36:36,780 DEBUG : BROWSER_OUTPUT: Values: 1631.8 1662.9 1833.9 2046.6 2067.8 8783.8 9553.2 9668.8 9719.9 9721.0 9734.6 9909.7 9961.4 10006.6 10035.5 2167.8 2199.4 2459.1 2510.6 2535.8 2454.7 2456.2 2468.9 2475.6 2484.2 2515.4 2536.1 2536.3 2539.9 2540.6 2179.3 2218.9 2466.4 2512.9 2513.9 2503.8 2531.7 2531.9 2599.3 2602.4 10114.3 10133.5 10180.9 10232.3 10235.5 5798.4 5916.2 5940.3 5957.0 5965.6 3732.0 3762.9 3779.6 3811.7 3828.4 1145.0 1154.8 1168.6 1177.1 1197.2 16221.4 16227.9 16243.6 16245.4 16247.8 5237.7 5252.8 5266.7 5363.7 5428.9 12660.2 12667.4 12675.0 12679.4 12689.6 5915.0 5919.2 5923.6 5923.6 5928.4 5306.4 5321.7 5324.3 5325.8 5330.1 4332.2 4350.4 4369.3 4421.5 4427.6 1331.4 1335.8 1353.4 1379.1 1391.9 1491.3 1520.3 1526.2 1541.8 1558.3 10041.7 10076.9 10095.7 10101.4 10105.4 602.7 604.7 1368.4 1370.3 1413.7 7520.7 7542.1 7601.9 7622.2 7734.5 13422.2 13583.9 13589.6 13592.3 13606.1 13312.5 13739.2 13755.1 13758.9 13759.4 9753.0 9800.3 9838.2 9919.9 9925.1 9424.7 9483.7 9492.5 9513.5 9513.8 11493.4 11754.0 11802.8 11843.0 11871.9 11795.5 12037.2 12054.0 12059.8 12073.2 8961.4 9285.8 9412.4 9421.3 9430.3 10112.4 10188.4 10215.9 10227.1 10262.8 8125.3 8728.0 9507.0 9542.8 9685.2 9155.4 9157.8 9286.1 9321.2 9376.0 9464.0 9524.0 9546.4 9559.9 9560.8 8466.9 8500.9 8503.5 8511.8 8519.7 8640.3 8693.9 8704.8 8718.5 8749.3 11:36:36 INFO - 2015-10-27 11:36:36,780 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,780 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5435.95 Median:6075.71 stddev:1571.76 (25.9%) stddev-sans-first:1530.06 11:36:36 INFO - 2015-10-27 11:36:36,780 DEBUG : BROWSER_OUTPUT: Values: 401.2 407.1 408.5 411.4 416.4 5962.7 6035.0 6039.6 6057.2 6070.3 5778.7 5854.7 5965.0 5997.8 6010.6 4655.6 4661.1 4740.5 4765.6 4780.0 4727.4 4739.5 4740.4 4741.7 4764.5 4561.2 4622.9 4656.8 4726.7 4730.1 4715.3 4715.4 4729.5 4732.2 4734.3 4182.7 4203.1 4207.1 4209.5 4215.9 5706.3 5707.8 5719.5 5719.9 5722.0 5434.7 5465.3 5497.6 5528.7 5539.6 6340.5 6345.8 6346.1 6346.7 6348.5 4675.8 4692.4 4692.8 4693.2 4693.3 6499.4 6519.0 6541.4 6584.7 6588.2 4756.8 4797.8 4798.6 4801.5 4804.6 4860.6 4864.8 4865.6 4867.0 4871.3 5484.2 5484.3 5487.8 5493.4 5498.2 6285.4 6392.0 6392.0 6397.8 6478.9 1753.0 1769.2 1770.4 1772.0 1773.7 1201.3 1205.8 1220.3 1229.6 1238.8 6238.0 6238.7 6238.8 6249.9 6255.5 6614.8 6646.5 6647.2 6647.8 6659.8 6059.8 6081.1 6142.0 6257.4 6260.2 3645.1 3670.2 3679.2 3686.6 3691.7 6816.4 6816.7 6817.6 6821.8 6827.7 6701.7 6772.4 6779.1 6868.8 6874.2 6855.8 6887.8 6891.3 6901.6 6905.1 6645.5 6647.9 6686.3 6694.5 6699.4 6516.8 6613.9 6615.0 6617.5 6622.7 6874.4 6885.9 6890.4 6893.6 6893.6 4813.6 4814.1 4824.9 4829.4 4836.8 6475.9 6668.1 6672.8 6677.2 6682.8 6428.7 6450.1 6460.2 6475.4 6479.9 6406.8 6441.6 6444.5 6450.7 6463.7 6241.6 6337.7 6371.7 6374.7 6382.6 6492.2 6494.9 6525.7 6529.2 6530.4 6306.6 6370.0 6375.7 6375.7 6378.4 11:36:36 INFO - 2015-10-27 11:36:36,780 DEBUG : BROWSER_OUTPUT: 11:36:36 INFO - 2015-10-27 11:36:36,781 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13025.29 Median:4307.38 stddev:14049.09 (326.2%) stddev-sans-first:14058.62 11:36:36 INFO - 2015-10-27 11:36:36,782 DEBUG : BROWSER_OUTPUT: Values: 824.1 886.9 903.3 904.7 953.6 12955.1 13128.9 13137.5 13139.3 13166.4 13457.3 13567.7 13569.8 13577.5 13584.7 771.4 781.0 936.6 955.8 960.5 935.4 945.6 953.7 954.2 954.2 806.8 984.9 988.5 988.6 990.6 809.1 968.4 992.4 994.2 994.6 727.5 728.5 732.0 733.0 733.9 13885.7 14019.6 14067.7 14095.5 14121.5 12577.9 12696.7 12908.5 12958.9 13178.5 10240.9 10419.2 10429.0 10431.2 10458.8 3876.5 3916.3 3918.2 3924.2 3924.3 45022.3 45112.5 45113.5 45646.0 45677.3 10379.8 10492.1 10577.5 10647.8 10710.7 20027.8 20044.0 20075.0 20097.6 20098.6 7444.5 7451.9 7837.8 7901.5 8084.4 4434.2 4453.4 4543.1 4571.7 4620.3 3356.7 3381.6 3385.4 3396.7 3397.3 504.0 504.5 524.4 525.8 544.3 637.6 639.3 649.5 695.0 735.7 8097.1 8128.3 8183.2 8383.4 8974.7 586.9 620.5 644.9 677.5 720.3 4029.8 4196.3 4295.8 4318.9 4320.0 53673.2 53958.0 54032.2 54130.7 54217.0 44211.3 44272.1 44957.3 45014.0 47296.5 37295.6 37473.6 39617.2 39768.2 39787.2 8664.2 8877.5 8973.0 8976.3 9026.7 27816.7 27989.0 28429.4 28440.3 28468.0 36476.3 36658.3 37117.4 37187.6 37632.0 8608.9 8887.7 8917.8 9086.8 9202.8 12275.9 12351.6 12386.1 12644.4 13219.1 11302.9 11897.9 12260.3 12417.0 12620.7 11409.1 11477.7 11759.5 11912.8 11998.6 11264.4 11522.8 11835.2 11843.6 11954.5 10277.6 10502.3 10739.5 10798.5 10869.4 9274.7 9841.3 10084.6 10196.2 10225.4 11:36:36 INFO - 2015-10-27 11:36:36,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:36:36 INFO - 2015-10-27 11:36:36,782 DEBUG : BROWSER_OUTPUT: 11:36:37 INFO - 2015-10-27 11:36:37,401 INFO : Browser exited with error code: 0 11:36:37 INFO - 2015-10-27 11:36:37,420 INFO : Completed test dromaeo_css (00:18:32) 11:36:37 INFO - 2015-10-27 11:36:37,420 INFO : Starting test kraken 11:36:37 INFO - 2015-10-27 11:36:37,420 DEBUG : operating with platform_type : linux_ 11:36:37 INFO - 2015-10-27 11:36:37,420 INFO : Initialising browser for kraken test... 11:36:37 INFO - 2015-10-27 11:36:37,426 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8qehh/profile http://localhost/getInfo.html 11:36:41 INFO - 2015-10-27 11:36:41,041 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:36:41 INFO - 2015-10-27 11:36:41,041 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:36:41 INFO - 2015-10-27 11:36:41,041 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:36:41 INFO - 2015-10-27 11:36:41,041 DEBUG : BROWSER_OUTPUT: __metrics 11:36:41 INFO - 2015-10-27 11:36:41,138 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:42 INFO - 2015-10-27 11:36:42,462 INFO : Browser initialized. 11:36:42 INFO - 2015-10-27 11:36:42,463 INFO : Running cycle 1/1 for kraken test... 11:36:42 INFO - 2015-10-27 11:36:42,463 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8qehh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:36:54 INFO - 2015-10-27 11:36:54,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 132665344 11:36:54 INFO - 2015-10-27 11:36:54,121 DEBUG : BROWSER_OUTPUT: 11:36:57 INFO - 2015-10-27 11:36:57,000 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) 11:36:57 INFO - 2015-10-27 11:36:57,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 166584320 11:36:57 INFO - 2015-10-27 11:36:57,582 DEBUG : BROWSER_OUTPUT: 11:37:00 INFO - 2015-10-27 11:37:00,077 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) 11:37:00 INFO - 2015-10-27 11:37:00,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 162324480 11:37:00 INFO - 2015-10-27 11:37:00,639 DEBUG : BROWSER_OUTPUT: 11:37:03 INFO - 2015-10-27 11:37:03,400 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) 11:37:03 INFO - 2015-10-27 11:37:03,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 162127872 11:37:03 INFO - 2015-10-27 11:37:03,967 DEBUG : BROWSER_OUTPUT: 11:37:05 INFO - 2015-10-27 11:37:05,890 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) 11:37:06 INFO - 2015-10-27 11:37:06,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 161452032 11:37:06 INFO - 2015-10-27 11:37:06,456 DEBUG : BROWSER_OUTPUT: 11:37:08 INFO - 2015-10-27 11:37:08,536 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) 11:37:09 INFO - 2015-10-27 11:37:09,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 155615232 11:37:09 INFO - 2015-10-27 11:37:09,098 DEBUG : BROWSER_OUTPUT: 11:37:11 INFO - 2015-10-27 11:37:11,927 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) 11:37:12 INFO - 2015-10-27 11:37:12,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 154951680 11:37:12 INFO - 2015-10-27 11:37:12,493 DEBUG : BROWSER_OUTPUT: 11:37:15 INFO - 2015-10-27 11:37:15,793 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) 11:37:16 INFO - 2015-10-27 11:37:16,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 156905472 11:37:16 INFO - 2015-10-27 11:37:16,355 DEBUG : BROWSER_OUTPUT: 11:37:19 INFO - 2015-10-27 11:37:19,010 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) 11:37:19 INFO - 2015-10-27 11:37:19,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 158109696 11:37:19 INFO - 2015-10-27 11:37:19,575 DEBUG : BROWSER_OUTPUT: 11:37:21 INFO - 2015-10-27 11:37:21,063 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) 11:37:21 INFO - 2015-10-27 11:37:21,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 163512320 11:37:22 INFO - 2015-10-27 11:37:21,617 DEBUG : BROWSER_OUTPUT: 11:37:23 INFO - 2015-10-27 11:37:23,291 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) 11:37:23 INFO - 2015-10-27 11:37:23,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 161828864 11:37:23 INFO - 2015-10-27 11:37:23,879 DEBUG : BROWSER_OUTPUT: 11:37:25 INFO - 2015-10-27 11:37:25,821 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) 11:37:26 INFO - 2015-10-27 11:37:26,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 171462656 11:37:26 INFO - 2015-10-27 11:37:26,388 DEBUG : BROWSER_OUTPUT: 11:37:28 INFO - 2015-10-27 11:37:28,625 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) 11:37:29 INFO - 2015-10-27 11:37:29,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 176119808 11:37:29 INFO - 2015-10-27 11:37:29,192 DEBUG : BROWSER_OUTPUT: 11:37:31 INFO - 2015-10-27 11:37:31,627 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) 11:37:32 INFO - 2015-10-27 11:37:32,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 172892160 11:37:32 INFO - 2015-10-27 11:37:32,188 DEBUG : BROWSER_OUTPUT: 11:37:33 INFO - 2015-10-27 11:37:33,776 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) 11:37:34 INFO - 2015-10-27 11:37:34,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 231960576 11:37:34 INFO - 2015-10-27 11:37:34,022 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,024 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:37:34 INFO - 2015-10-27 11:37:34,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:37:34 INFO - 2015-10-27 11:37:34,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:37:34 INFO - 2015-10-27 11:37:34,024 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;110;109;110;110;109;116;108;109;110 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;121;146;155;122;147;143;126;161;122 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;159;161;158;160;157;158;157 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;71;145;71;71;71;71;151;70 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;88;133;88;88;88;128;88;89;129 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;110;109 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;144;145;147;145;146;144;145 11:37:34 INFO - 2015-10-27 11:37:34,025 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;97;96;95;96;96;96;96 11:37:34 INFO - 2015-10-27 11:37:34,026 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;53;53;52;52;55;55;68;50 11:37:34 INFO - 2015-10-27 11:37:34,026 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;61;60;66;61;61;61;61;61;61 11:37:34 INFO - 2015-10-27 11:37:34,026 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;85;78;79;79;78;77;79;87 11:37:34 INFO - 2015-10-27 11:37:34,026 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;111;106;104;108;107;112;113;115;106 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;135;136;146;141;134;132;144;133;135 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;60;60;60;61;60;60;60;59;61 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,856 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: __startTimestamp1445971054023__endTimestamp 11:37:34 INFO - 2015-10-27 11:37:34,027 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.72 (2.5%) stddev-sans-first:2.32 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: Values: 105.0 110.0 109.0 110.0 110.0 109.0 116.0 108.0 109.0 110.0 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.70 Median:145.00 stddev:14.77 (10.2%) stddev-sans-first:15.54 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: Values: 144.0 121.0 146.0 155.0 122.0 147.0 143.0 126.0 161.0 122.0 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.10 Median:160.00 stddev:1.52 (1.0%) stddev-sans-first:1.58 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 159.0 161.0 158.0 160.0 157.0 158.0 157.0 11:37:34 INFO - 2015-10-27 11:37:34,029 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.40 Median:71.00 stddev:32.50 (45.8%) stddev-sans-first:34.05 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 145.0 71.0 71.0 71.0 71.0 151.0 70.0 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.70 Median:88.00 stddev:20.26 (23.0%) stddev-sans-first:20.96 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: Values: 88.0 88.0 133.0 88.0 88.0 88.0 128.0 88.0 89.0 129.0 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.95 (0.7%) stddev-sans-first:1.00 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 144.0 145.0 147.0 145.0 146.0 144.0 145.0 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,030 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:37:34 INFO - 2015-10-27 11:37:34,031 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 11:37:34 INFO - 2015-10-27 11:37:34,031 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,031 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:4.95 (9.0%) stddev-sans-first:5.24 11:37:34 INFO - 2015-10-27 11:37:34,031 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 53.0 53.0 52.0 52.0 55.0 55.0 68.0 50.0 11:37:34 INFO - 2015-10-27 11:37:34,031 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,031 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 11:37:34 INFO - 2015-10-27 11:37:34,031 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 60.0 66.0 61.0 61.0 61.0 61.0 61.0 61.0 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:3.50 (4.4%) stddev-sans-first:3.59 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 85.0 78.0 79.0 79.0 78.0 77.0 79.0 87.0 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:109.40 Median:111.50 stddev:3.66 (3.3%) stddev-sans-first:3.76 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 106.0 104.0 108.0 107.0 112.0 113.0 115.0 106.0 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,032 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:135.50 stddev:4.82 (3.6%) stddev-sans-first:5.05 11:37:34 INFO - 2015-10-27 11:37:34,033 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 136.0 146.0 141.0 134.0 132.0 144.0 133.0 135.0 11:37:34 INFO - 2015-10-27 11:37:34,033 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,034 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.00 stddev:1.07 (1.8%) stddev-sans-first:0.60 11:37:34 INFO - 2015-10-27 11:37:34,034 DEBUG : BROWSER_OUTPUT: Values: 63.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 59.0 61.0 11:37:34 INFO - 2015-10-27 11:37:34,034 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:37:34 INFO - 2015-10-27 11:37:34,034 DEBUG : BROWSER_OUTPUT: 11:37:34 INFO - 2015-10-27 11:37:34,813 INFO : Browser exited with error code: 0 11:37:34 INFO - 2015-10-27 11:37:34,862 INFO : Completed test kraken (00:00:57) 11:37:34 INFO - 2015-10-27 11:37:34,862 INFO : Starting test v8_7 11:37:34 INFO - 2015-10-27 11:37:34,862 DEBUG : operating with platform_type : linux_ 11:37:34 INFO - 2015-10-27 11:37:34,862 INFO : Initialising browser for v8_7 test... 11:37:34 INFO - 2015-10-27 11:37:34,869 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMEt0yW/profile http://localhost/getInfo.html 11:37:38 INFO - 2015-10-27 11:37:38,754 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:37:38 INFO - 2015-10-27 11:37:38,754 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:37:38 INFO - 2015-10-27 11:37:38,754 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:37:38 INFO - 2015-10-27 11:37:38,754 DEBUG : BROWSER_OUTPUT: __metrics 11:37:38 INFO - 2015-10-27 11:37:38,896 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:40 INFO - 2015-10-27 11:37:40,338 INFO : Browser initialized. 11:37:40 INFO - 2015-10-27 11:37:40,338 INFO : Running cycle 1/1 for v8_7 test... 11:37:40 INFO - 2015-10-27 11:37:40,339 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMEt0yW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:37:51 INFO - 2015-10-27 11:37:51,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 133660672 11:37:51 INFO - 2015-10-27 11:37:51,999 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,379 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) 11:38:13 INFO - 2015-10-27 11:38:13,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 428998656 11:38:13 INFO - 2015-10-27 11:38:13,629 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,630 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:38:13 INFO - 2015-10-27 11:38:13,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:38:13 INFO - 2015-10-27 11:38:13,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:38:13 INFO - 2015-10-27 11:38:13,630 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:38:13 INFO - 2015-10-27 11:38:13,630 DEBUG : BROWSER_OUTPUT: |0;Richards;168.09547823163558 11:38:13 INFO - 2015-10-27 11:38:13,630 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.12549537648613 11:38:13 INFO - 2015-10-27 11:38:13,631 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.68794326241135 11:38:13 INFO - 2015-10-27 11:38:13,631 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 11:38:13 INFO - 2015-10-27 11:38:13,631 DEBUG : BROWSER_OUTPUT: |4;RayTrace;952.3809523809524 11:38:13 INFO - 2015-10-27 11:38:13,631 DEBUG : BROWSER_OUTPUT: |5;Earley;538.7931034482758 11:38:13 INFO - 2015-10-27 11:38:13,631 DEBUG : BROWSER_OUTPUT: |6;Boyer;10181.818181818182 11:38:13 INFO - 2015-10-27 11:38:13,631 DEBUG : BROWSER_OUTPUT: |7;RegExp;23348.837209302324 11:38:13 INFO - 2015-10-27 11:38:13,632 DEBUG : BROWSER_OUTPUT: |8;Splay;544.069640914037 11:38:13 INFO - 2015-10-27 11:38:13,632 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 11:38:13 INFO - 2015-10-27 11:38:13,632 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:38:13 INFO - 2015-10-27 11:38:13,632 DEBUG : BROWSER_OUTPUT: __startTimestamp1445971093627__endTimestamp 11:38:13 INFO - 2015-10-27 11:38:13,632 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,632 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:38:13 INFO - 2015-10-27 11:38:13,633 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:38:13 INFO - 2015-10-27 11:38:13,633 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,633 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.10 Median:168.10 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,633 DEBUG : BROWSER_OUTPUT: Values: 168.1 11:38:13 INFO - 2015-10-27 11:38:13,633 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,634 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.13 Median:165.13 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,634 DEBUG : BROWSER_OUTPUT: Values: 165.1 11:38:13 INFO - 2015-10-27 11:38:13,634 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,634 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.69 Median:283.69 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,634 DEBUG : BROWSER_OUTPUT: Values: 283.7 11:38:13 INFO - 2015-10-27 11:38:13,634 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,635 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,635 DEBUG : BROWSER_OUTPUT: Values: 5122.4 11:38:13 INFO - 2015-10-27 11:38:13,635 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,635 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:952.38 Median:952.38 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,635 DEBUG : BROWSER_OUTPUT: Values: 952.4 11:38:13 INFO - 2015-10-27 11:38:13,635 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,636 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:538.79 Median:538.79 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,636 DEBUG : BROWSER_OUTPUT: Values: 538.8 11:38:13 INFO - 2015-10-27 11:38:13,636 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,636 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10181.82 Median:10181.82 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,636 DEBUG : BROWSER_OUTPUT: Values: 10181.8 11:38:13 INFO - 2015-10-27 11:38:13,636 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23348.84 Median:23348.84 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: Values: 23348.8 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:544.07 Median:544.07 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: Values: 544.1 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: Values: 4817.3 11:38:13 INFO - 2015-10-27 11:38:13,637 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:38:13 INFO - 2015-10-27 11:38:13,638 DEBUG : BROWSER_OUTPUT: 11:38:14 INFO - 2015-10-27 11:38:14,490 INFO : Browser exited with error code: 0 11:38:14 INFO - 2015-10-27 11:38:14,504 INFO : Completed test v8_7 (00:00:39) 11:38:14 INFO - 2015-10-27 11:38:14,504 INFO : Completed test suite (00:20:09) 11:38:14 INFO - 2015-10-27 11:38:14,504 DEBUG : Working with test: dromaeo_css 11:38:14 INFO - 2015-10-27 11:38:14,504 DEBUG : Generating results file: dromaeo_css 11:38:14 INFO - 2015-10-27 11:38:14,505 DEBUG : Working with test: kraken 11:38:14 INFO - 2015-10-27 11:38:14,505 DEBUG : Generating results file: kraken 11:38:14 INFO - 2015-10-27 11:38:14,505 INFO : javascript benchmark 11:38:14 INFO - 2015-10-27 11:38:14,505 DEBUG : Working with test: v8_7 11:38:14 INFO - 2015-10-27 11:38:14,505 DEBUG : Generating results file: v8_7 11:38:14 INFO - 2015-10-27 11:38:14,506 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:14 INFO - 2015-10-27 11:38:14,558 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 11:38:14 INFO - 2015-10-27 11:38:14,558 DEBUG : process_Request line: dromaeo_css 7446.67 graph.html#tests=[[72,52,35]] 11:38:14 INFO - 2015-10-27 11:38:14,558 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:14 INFO - 2015-10-27 11:38:14,590 DEBUG : process_Request line: kraken 1447.60 graph.html#tests=[[232,52,35]] 11:38:14 INFO - 2015-10-27 11:38:14,590 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:38:14 INFO - 2015-10-27 11:38:14,620 DEBUG : process_Request line: v8_7 23350.41 graph.html#tests=[[230,52,35]] 11:38:14 INFO - 2015-10-27 11:38:14,623 INFO : javascript benchmark 11:38:14 INFO - 2015-10-27 11:38:14,628 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [423.8897886549496, 429.3071022755245, 432.05164663563454, 432.1551367077363, 440.6584896705054, 12187.207831490969, 12567.0, 14065.226412547294, 20019.59960800783, 20506.179752809887, 13380.264085475295, 13719.93140034301, 13750.587482375544, 14102.78845817311, 14119.858801411983, 4265.936010959838, 4961.37982752155, 5094.184930411135, 5095.79616815327, 5507.256520369739, 3727.664510194082, 3864.80675966202, 5330.760115794779, 5413.079776438015, 5488.121900495921, 5383.730813459331, 5416.187571864232, 5417.10617748073, 5430.56555475561, 5433.483819037185, 5282.022825777224, 5400.918986215191, 5429.755660995264, 5439.238506609078, 5439.83680489584, 4727.432708075019, 4729.337892695025, 4742.075295317414, 4743.051389722069, 4748.786304616266, 14230.85769142316, 14242.359093840802, 14244.857551424457, 14247.145171289756, 14494.56516304502, 2239.1603148819195, 2280.7947284744287, 2286.8627882327114, 2300.919467818618, 2421.2373102472666, 11135.72160695989, 11208.943955280252, 11211.439428028565, 11445.427728613618, 11502.654920352403, 1870.3827736846945, 1879.6804543227684, 1904.7523821903064, 1935.283944940367, 1944.8735832171005, 69777.30222697758, 70521.99999999949, 72198.0, 72231.0, 72353.0, 7897.289243968071, 8105.594720264081, 8121.147279535682, 8133.14601966785, 8168.673253069929, 9753.366031207948, 9876.259280553988, 9878.604855805832, 9879.456629885426, 9889.406635601887, 6478.930976388937, 6482.870342593216, 6508.837279067967, 6525.4453371463005, 6548.083268342436, 6716.971734528701, 6752.426043786333, 6755.594664320157, 6880.724771009103, 6901.275366086589, 3711.6659500645073, 3754.1740817020213, 3773.8301776420126, 3779.338615742234, 3789.6020917803785, 1269.435101379877, 1282.0576875996135, 1305.9151155174884, 1320.735852829438, 1347.7439286535528, 513.0380536494074, 526.1292560811862, 548.180470197058, 549.2971787458846, 572.5591294703055, 13406.195628262336, 13631.182129072287, 13853.861461385459, 13909.234992075331, 13921.095128816594, 539.5926075812815, 579.4726798613326, 590.1560768101656, 591.2675859730944, 603.6951339573575, 7444.516106453063, 7516.774496764996, 7539.8115047123165, 7643.121041080236, 7749.225077492206, 576097.0, 587737.0, 591206.0, 595609.0, 600148.0, 90806.54596726975, 92096.53951730198, 92908.53545732229, 93206.0, 93597.0, 610.4109534299333, 619.7118339971935, 620.2959640807716, 620.9130721698966, 624.2696045626627, 12030.0, 12128.0, 12384.31886246229, 12563.497460101493, 12886.226826390446, 40796.59203407928, 40848.79575602103, 40925.0, 41394.58605413907, 42038.15923681571, 55921.72039139778, 55951.44048559462, 56170.0, 57019.144712828514, 57251.14123288237, 7828.2954534092205, 7906.7627971160955, 7912.9208707912185, 7919.643616037177, 7926.762197134095, 13307.46770129184, 13321.600351989457, 13403.396847142098, 13636.79544806809, 13648.317584120952, 12457.937710311391, 12471.0, 12484.875151248734, 12511.874881251071, 12839.293838838954, 12178.634640960785, 12362.690932726395, 12502.43739031764, 12507.56223532172, 12579.433925473559, 10447.111995480469, 10969.83545246806, 12122.75754484923, 12350.81473777876, 12707.618771436872, 7496.887546686913, 7530.811729706801, 7583.924160758322, 7612.505187162817, 7628.504147230412, 12001.81997270059, 12325.075619328407, 12513.499460021498, 12726.109172357847, 12750.171238869443], "dojo.html": [3319.4191016572095, 3326.3347330533898, 3359.2273777031282, 3366.343563005215, 3383.08656662701, 5569.10894256919, 5578.581606379527, 5599.692016939067, 5607.355154157268, 5615.129654903497, 5601.215829783823, 5618.15727640854, 5619.353774315955, 5637.689927054011, 5663.348714897788, 5004.699718016931, 5080.822171223989, 5111.718855462957, 5124.8206312778875, 5180.378354597454, 5172.844814655547, 5178.171492561191, 5192.584593232532, 5193.922091168635, 5194.298769666085, 5100.056489549426, 5103.464136265694, 5127.7948882044675, 5197.142471492218, 5221.556167725748, 5185.714785686804, 5198.896022079575, 5199.922001169985, 5202.4277329493725, 5221.0, 4944.233643785219, 5165.948340516585, 5169.508896654812, 5214.843554693365, 5235.214717792323, 5328.46715328468, 5335.759890804923, 5424.511793938565, 5429.294191755086, 5450.509454149106, 6008.75964961401, 6051.878962420771, 6062.1209924561135, 6065.909011364833, 6087.756489740405, 5894.58737888348, 6005.849853753647, 6106.3893610639025, 6112.327643959161, 6118.082287656843, 5607.831765047055, 5692.943070569324, 5700.828975130753, 5723.656580605136, 5736.741846616912, 6158.599691020069, 6179.783707570214, 6189.721462534197, 6199.876002479925, 6201.937980620136, 5679.403662615448, 5860.765569377178, 5946.43508866657, 6024.939750602438, 6035.245594300713, 6112.724927378279, 6122.173506576644, 6130.52043589939, 6136.140940268366, 6138.693065346804, 6103.633781973096, 6106.786262480792, 6109.816705498843, 6119.296280927751, 6123.265208174958, 5856.882862342729, 5913.793017244376, 5983.521318294526, 6012.729427175787, 6117.418845209698, 4607.95392046082, 4615.030843522831, 4617.515160908057, 4631.212693842055, 4648.558386953302, 4145.647619952278, 4146.688998325138, 4155.10665206982, 4156.023334516386, 4158.043649960526, 5557.499825015768, 5668.716564171775, 5713.171590119409, 5806.1581070744505, 5811.912821307684, 6028.758849645965, 6178.289496707936, 6179.443850053517, 6184.5052395808225, 6185.474234690102, 5838.737256823453, 5857.7949771757785, 5868.295804503487, 5874.030784920526, 5882.147088672119, 5037.3955125384455, 5144.6913185209005, 5254.133068043807, 5340.8664783379945, 5349.812756553502, 6359.300476947532, 6364.395382438661, 6369.617822930639, 6377.426031657174, 6378.968105159537, 5936.436038576328, 6169.56813023084, 6175.44421002112, 6187.969060154671, 6194.318624951342, 6111.755529778937, 6113.266408031065, 6192.287886893065, 6215.409536094064, 6228.346023667631, 5929.080992446177, 6101.60339577926, 6106.236720409949, 6107.480864126599, 6122.204113465221, 5927.347991720821, 6015.39846015395, 6150.446459818638, 6154.323024467216, 6164.4760195382105, 5906.645601263938, 5988.311344195299, 5988.970055149871, 6001.0, 6013.037913933749, 5961.314448838439, 5975.820725378246, 5985.25184351956, 6012.188354572077, 6021.578489505868, 5628.85927851807, 5654.264945557051, 5737.02470579994, 5915.08316210988, 5917.585768996301, 6008.54935879802, 6029.517638588814, 6033.396660333931, 6039.486643635164, 6074.969625151846, 5899.085641725368, 5899.557533184942, 5908.409159084057, 5908.793192238251, 5924.674142922008], "mootools.html": [1631.779709739185, 1662.900225986441, 1833.936316936177, 2046.6111438826622, 2067.7845949548446, 8783.780405489859, 9553.23574114071, 9668.758281042978, 9719.902800971988, 9720.951395243013, 9734.561944712486, 9909.702708918743, 9961.402315861053, 10006.59973601055, 10035.498225088753, 2167.804897559219, 2199.351191398533, 2459.1270099114827, 2510.6234064890277, 2535.784458321045, 2454.7299797022315, 2456.152627343564, 2468.8518688878726, 2475.554400207962, 2484.2050543825985, 2515.408878913454, 2536.074332868499, 2536.2898388451263, 2539.898404063835, 2540.5554028045112, 2179.3353027326657, 2218.8557743746687, 2466.3710753757855, 2512.937176570582, 2513.912013079552, 2503.824732268742, 2531.6835395575554, 2531.936701582457, 2599.272203782944, 2602.44047529782, 10114.342567733147, 10133.530638057515, 10180.898191018143, 10232.334898231591, 10235.488225588766, 5798.3911689272445, 5916.230889984275, 5940.34656187819, 5957.0, 5965.642061476326, 3732.048327676452, 3762.9059273518105, 3779.622037796226, 3811.6760075393627, 3828.3683192273243, 1144.9713757156137, 1154.8440960470398, 1168.6026750904648, 1177.0583533173512, 1197.1560050164612, 16221.351145954266, 16227.91886040574, 16243.619292360045, 16245.431409900597, 16247.83752162487, 5237.711925844039, 5252.842414727565, 5266.683998960075, 5363.651362661414, 5428.864278392993, 12660.17708848922, 12667.429965651569, 12675.0, 12679.366031698379, 12689.619311420673, 5914.970425147847, 5919.230500034968, 5923.637563360365, 5923.644581325134, 5928.3775203603, 5306.416294207711, 5321.707306098125, 5324.281222035053, 5325.840224793263, 5330.067238233293, 4332.155229730172, 4350.434443522322, 4369.300911854088, 4421.53573874745, 4427.623651989553, 1331.4407948661585, 1335.7595632786192, 1353.4247944623496, 1379.0760190672274, 1391.9373628186554, 1491.2767307855897, 1520.293063725373, 1526.2292542266307, 1541.7841502189704, 1558.2676142213143, 10041.748956276151, 10076.949615251877, 10095.697129086138, 10101.44442055694, 10105.44420056904, 602.686602966455, 604.6644112517507, 1368.4115830193114, 1370.280602683599, 1413.7313910357, 7520.661570229353, 7542.057242844645, 7601.885971710429, 7622.161562228151, 7734.497257678233, 13422.194668319931, 13583.86416135826, 13589.592312230649, 13592.252426116658, 13606.115602485806, 13312.534061307808, 13739.24434156111, 13755.10591811529, 13758.93120534411, 13759.449622015207, 9752.951235243778, 9800.26498012652, 9838.16375608067, 9919.851202231972, 9925.1067403934, 9424.670136545188, 9483.66807161746, 9492.525373731423, 9513.524323783644, 9513.809723805623, 11493.367864767184, 11754.0, 11802.82295765547, 11843.0, 11871.881281187078, 11795.528178873092, 12037.217580857216, 12054.0, 12059.819102713642, 12073.215241009306, 8961.372703910663, 9285.814283714422, 9412.388194767318, 9421.340506164503, 9430.3398762086, 10112.443815590213, 10188.388696678223, 10215.94892025535, 10227.130693891102, 10262.794744105226, 8125.268725814705, 8728.0, 9507.049295070437, 9542.809143817223, 9685.225181985565, 9155.359124861196, 9157.816843663222, 9286.099838068163, 9321.207697345802, 9375.953120234355, 9463.952680236831, 9523.952380238054, 9546.379485333431, 9559.904400955902, 9560.760980975254, 8466.872996905175, 8500.914990850013, 8503.532305723245, 8511.829763404574, 8519.701810436605, 8640.308775297835, 8693.869591956, 8704.78238044054, 8718.520481373585, 8749.343799214957], "ext.html": [596.5466245653305, 650.8958566629341, 651.3258777165629, 652.1880259077449, 657.503584793481, 36064.098397540074, 43473.565264347344, 44234.77882610587, 44276.99999999992, 44350.0, 46983.765081174635, 47248.76375618126, 47431.762841185744, 47532.524674753244, 47538.0492390152, 8262.958685206595, 8361.03848057472, 9359.438433694, 9449.385789923634, 9534.189593884528, 11106.555737770479, 11373.772524549504, 11426.600068997586, 11438.084953203765, 11440.370779607118, 11065.0, 11236.606718764844, 11240.100791936626, 11244.606438774645, 11244.662660120168, 8593.699220527284, 8801.911980880206, 11067.72330691731, 11284.153688473398, 11514.19400641947, 10751.301165424222, 10881.673549793519, 10901.727456813564, 10908.727281817939, 10910.072643825284, 45297.54702452966, 45622.54377456216, 45775.313370299475, 45908.0, 45920.54079459229, 3783.791891445969, 3920.9803950980063, 4049.311617025113, 4122.876313710593, 4193.433886425354, 34084.0, 34253.486197707054, 34621.0, 34640.307193856235, 34754.30491390183, 3684.7236457265813, 3695.63043695631, 3701.3152566775234, 3734.178480734234, 3773.8301776420126, 328398.0, 330672.9999999976, 330703.0, 331809.0, 331815.0, 56421.0, 57387.71306143443, 67486.32513674899, 72492.0, 74346.0, 68073.3192668077, 68195.65902170457, 68442.3155768436, 68446.315536845, 68501.31498685048, 17290.740638890427, 18902.621947560972, 19084.90457547731, 19095.80904190968, 19105.522361941064, 13029.869701302865, 14856.851431485762, 15100.471483498024, 15118.773218401733, 15131.394744210329, 21767.0, 21990.340289791333, 22138.667919981213, 22142.446438839157, 22243.0, 8046.195380462024, 8263.834723305621, 8392.370572207108, 8397.370197235232, 8446.113158118433, 1137.4426530999751, 1179.4161889864401, 1195.2926621202982, 1227.7053507158219, 1274.7769140400578, 31326.216844579067, 31811.449546010397, 31968.680313197037, 31978.680213198037, 32072.198195045312, 1222.6821026533166, 1246.046774217724, 1259.1689484939895, 1266.2972050512055, 1279.59053103008, 14726.484573039892, 16489.422870199487, 16941.576460588338, 17333.046682432334, 17495.212715427835, 423380.0, 427071.0, 431802.0, 432809.0, 434682.0, 60277.39722602718, 60284.69857650684, 60569.394306056376, 60650.69674651598, 60654.0, 1541.2601951063327, 1549.5893588199363, 1554.0908568487334, 1559.766035094745, 1665.8001039875292, 31893.362132756753, 32346.35307293888, 33133.66866331402, 33234.83382583072, 33581.664183357854, 50666.240006399195, 50798.0, 50828.49171508385, 50839.49160508347, 50871.745641271555, 341301.0, 357258.0, 362501.0, 519624.80375195766, 528791.0, 35393.82303088571, 35615.82192089023, 35668.46497302595, 35678.286434271686, 36137.0, 49968.0, 50403.243951341494, 50694.23958640697, 50790.238146427095, 51109.23336149886, 41283.38074928818, 41427.7928610355, 41643.37534937039, 41660.0, 42737.78631106949, 42073.78963105165, 42276.78861605795, 42632.36051459169, 43067.35398968955, 43088.569114308455, 42329.365059523516, 42565.36151957785, 43117.568824311355, 43181.56818431775, 43222.78388608037, 37354.43968340423, 38445.0, 38517.0, 38708.61291387163, 38746.80626596849, 28316.43367132687, 28792.424151517273, 28804.279893002844, 29134.56298155487, 29144.417111658073], "prototype.html": [401.17358242021436, 407.12671320018563, 408.5057080932072, 411.43222353152646, 416.44612665155347, 5962.672053037081, 6035.0, 6039.5772295939305, 6057.242844644419, 6070.271567411917, 5778.653280803144, 5854.677992710399, 5965.015772397549, 5997.790077347294, 6010.647604289033, 4655.580997710205, 4661.09108723799, 4740.549647783472, 4765.594924431428, 4780.043991201756, 4727.409073865767, 4739.549742774431, 4740.431148262213, 4741.739204343759, 4764.547368000051, 4561.156186105581, 4622.930656040162, 4656.767161641921, 4726.71639701619, 4730.101280756662, 4715.292706094079, 4715.43414790224, 4729.503402142795, 4732.219183834681, 4734.289856521515, 4182.707210495267, 4203.117345357478, 4207.074443622429, 4209.473815773028, 4215.852445164404, 5706.343770466408, 5707.828765137053, 5719.513841323493, 5719.885602287973, 5721.9986502362335, 5434.701091439969, 5465.262189604432, 5497.5601951843755, 5528.723563821793, 5539.612227144102, 6340.461060809836, 6345.841353966188, 6346.0798184263485, 6346.6509341986175, 6348.523860710419, 4675.836345727917, 4692.366530518405, 4692.7653617319, 4693.155232058228, 4693.296005599153, 6499.38255865692, 6518.9895566187315, 6541.411272985407, 6584.670766461706, 6588.24235212947, 4756.833510827105, 4797.832075877397, 4798.616110711205, 4801.5438533339275, 4804.591609713144, 4860.635452341018, 4864.756762161877, 4865.6107511399005, 4866.9513304867205, 4871.29366241893, 5484.177373393943, 5484.287042684506, 5487.807926722546, 5493.395726470085, 5498.230247765236, 6285.434310911948, 6391.96804015977, 6391.9680401598625, 6397.776077837253, 6478.870422591522, 1753.0358302933337, 1769.1773325403492, 1770.3803668716105, 1772.0430967277784, 1773.725072613747, 1201.3092471828734, 1205.8372119763894, 1220.3227208898968, 1229.6188181663713, 1238.7646347194004, 6238.0, 6238.65687387189, 6238.781642642576, 6249.875002499924, 6255.530835187379, 6614.768483103068, 6646.468282537482, 6647.169103862017, 6647.833804154935, 6659.766908158192, 6059.757609695563, 6081.148639190517, 6142.0, 6257.436830685169, 6260.24877014752, 3645.1069487975615, 3670.155864151207, 3679.2089700714473, 3686.594474607791, 3691.667749902522, 6816.352446517573, 6816.659167041727, 6817.5909445433435, 6821.795346139525, 6827.726890924308, 6701.698423570853, 6772.390484856288, 6779.084823548857, 6868.8322985092655, 6874.175098988054, 6855.760048398282, 6887.793366199022, 6891.27641597635, 6901.62041087745, 6905.067815844897, 6645.468362530889, 6647.867042659023, 6686.264510903699, 6694.464442844658, 6699.39705426514, 6516.771912983023, 6613.900791488228, 6615.040819081302, 6617.503687223381, 6622.735090596322, 6874.381305682313, 6885.862282754417, 6890.44876409896, 6893.620850853251, 6893.620850853251, 4813.614910807197, 4814.061258054646, 4824.903501930012, 4829.44461386945, 4836.782344794563, 6475.902861456988, 6668.099806526056, 6672.799816005528, 6677.165354330708, 6682.832929176615, 6428.6785660717715, 6450.064740612491, 6460.224773027267, 6475.417212450902, 6479.902801457888, 6406.807795766134, 6441.645709486023, 6444.516661250331, 6450.677466126769, 6463.709133089116, 6241.563090583797, 6337.65142917144, 6371.713272902638, 6374.74501019954, 6382.6170429774365, 6492.188476440445, 6494.935050649622, 6525.706343214471, 6529.151210342625, 6530.444912182327, 6306.558540902093, 6369.9681501592195, 6375.713092910923, 6375.713092910923, 6378.394052564999], "yui.html": [824.0729179672868, 886.8758373827666, 903.31799491384, 904.7240591619556, 953.6137864165015, 12955.09314347996, 13128.934355328234, 13137.540186093489, 13139.343032848366, 13166.407511661962, 13457.327133643328, 13567.72864542711, 13569.796453053188, 13577.456901723945, 13584.660383490393, 771.3713323641242, 781.03932163439, 936.5504557812254, 955.7753927826955, 960.490939801906, 935.4106912645024, 945.6312038305032, 953.7281874665722, 954.1508057828538, 954.1841725324851, 806.7741032510907, 984.8571957066221, 988.4859872866106, 988.6490295944908, 990.5691024404371, 809.0776514773163, 968.3608818180003, 992.3648864726581, 994.2195376629347, 994.5623925472769, 727.4980263618139, 728.4609389052116, 731.9780406587811, 732.9890051649229, 733.9376153026999, 13885.722285554333, 14019.579412617535, 14067.71864562703, 14095.50665726705, 14121.505747298796, 12577.874221257762, 12696.6825829355, 12908.483660653563, 12958.935205324007, 13178.538751143664, 10240.897591024144, 10419.166466682647, 10429.0, 10431.165506759517, 10458.790824183474, 3876.5154355705536, 3916.2754890345377, 3918.1771827916173, 3924.2151569685893, 3924.3132451820816, 45022.32466513005, 45112.548874511165, 45113.548864511264, 45645.999999999665, 45677.314840277424, 10379.84430233547, 10492.108170805413, 10577.524011419504, 10647.84028239577, 10710.73223169427, 20027.799722002594, 20044.0, 20075.0, 20097.59804803896, 20098.598028039356, 7444.516106453063, 7451.925480745232, 7837.804054898673, 7901.525908445512, 8084.3936704747375, 4434.17967675981, 4453.35426363182, 4543.136804007228, 4571.702839315434, 4620.306953956933, 3356.714679252291, 3381.5773028371455, 3385.441402168615, 3396.728261739055, 3397.3205358928312, 504.0448350376017, 504.45014933722416, 524.4178961352895, 525.7686617888118, 544.311446020784, 637.6461064109463, 639.2616527910271, 649.4706813946618, 694.9513534052568, 735.6652723011017, 8097.109317975018, 8128.349732021424, 8183.222593853575, 8383.413161078666, 8974.68588599409, 586.9236999190164, 620.525298146918, 644.9000404937242, 677.502036003537, 720.3049057659384, 4029.778362190049, 4196.349565817242, 4295.849645262463, 4318.913621727548, 4319.97840010798, 53673.1949020765, 53958.0, 54032.189517157276, 54130.729346353015, 54217.0, 44211.33682994758, 44272.11455770931, 44957.32564011542, 45014.0, 47296.5270347299, 37295.62704372976, 37473.62526374702, 39617.20765584672, 39768.21622486398, 39787.20425591472, 8664.176903194186, 8877.467351958903, 8972.955135224282, 8976.281897448058, 9026.729198124067, 27816.72183278141, 27989.0, 28429.431411372072, 28440.288992775346, 28468.0, 36476.27047459089, 36658.26683466369, 37117.443238350905, 37187.628123718416, 37632.0, 8608.91391086081, 8887.688930887389, 8917.821643567222, 9086.772830679285, 9202.815943680955, 12275.877241227474, 12351.629451116482, 12386.071044671506, 12644.431000605178, 13219.140755850838, 11302.943485282522, 11897.940510297392, 12260.32568208757, 12417.0, 12620.747585048432, 11409.144314176636, 11477.655670329903, 11759.47082381312, 11912.821307680566, 11998.58004969822, 11264.38045907483, 11522.827157592475, 11835.230710003822, 11843.58547450835, 11954.462049207632, 10277.640282590073, 10502.317349372266, 10739.46302684847, 10798.460076996276, 10869.359615719592, 9274.675386361714, 9841.261905356983, 10084.647037353658, 10196.235282354002, 10225.386476811414]}, "summary": {"suite": 7446.667452165192, "subtests": {"jquery.html": {"std": 96694.26648710377, "min": 423.8897886549496, "max": 600148.0, "median": 7923.202906585636, "filtered": 7846.559488936351, "mean": 30190.591382893086}, "dojo.html": {"std": 640.8651562293174, "min": 3319.4191016572095, "max": 6378.968105159537, "median": 5899.085641725368, "filtered": 5596.705648703686, "mean": 5639.542069422457}, "mootools.html": {"std": 4158.749777407266, "min": 602.686602966455, "max": 16247.83752162487, "median": 8515.76578692059, "filtered": 5685.766544592153, "mean": 7251.135745797389}, "ext.html": {"std": 104922.21029838859, "min": 596.5466245653305, "max": 528791.0, "median": 32025.439204121674, "filtered": 21552.14780142197, "mean": 58016.08115680556}, "prototype.html": {"std": 1567.3842683322323, "min": 401.17358242021436, "max": 6905.067815844897, "median": 6065.01458855374, "filtered": 4953.71451142609, "mean": 5435.94981853094}, "yui.html": {"std": 14010.01362348152, "min": 504.0448350376017, "max": 54217.0, "median": 10233.142033917778, "filtered": 6396.086788752387, "mean": 13025.294231939926}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1445969885, "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": "20151027085421", "branch": "Mozilla-Aurora", "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 161.0, 160.0, 159.0, 161.0, 158.0, 160.0, 157.0, 158.0, 157.0], "ai-astar": [105.0, 110.0, 109.0, 110.0, 110.0, 109.0, 116.0, 108.0, 109.0, 110.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "audio-beat-detection": [144.0, 121.0, 146.0, 155.0, 122.0, 147.0, 143.0, 126.0, 161.0, 122.0], "json-stringify-tinderbox": [61.0, 61.0, 60.0, 66.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "stanford-crypto-pbkdf2": [135.0, 135.0, 136.0, 146.0, 141.0, 134.0, 132.0, 144.0, 133.0, 135.0], "json-parse-financial": [56.0, 55.0, 53.0, 53.0, 52.0, 52.0, 55.0, 55.0, 68.0, 50.0], "stanford-crypto-sha256-iterative": [63.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 59.0, 61.0], "audio-fft": [72.0, 71.0, 71.0, 145.0, 71.0, 71.0, 71.0, 71.0, 151.0, 70.0], "imaging-darkroom": [145.0, 146.0, 146.0, 144.0, 145.0, 147.0, 145.0, 146.0, 144.0, 145.0], "stanford-crypto-ccm": [112.0, 111.0, 106.0, 104.0, 108.0, 107.0, 112.0, 113.0, 115.0, 106.0], "audio-oscillator": [88.0, 88.0, 133.0, 88.0, 88.0, 88.0, 128.0, 88.0, 89.0, 129.0], "stanford-crypto-aes": [77.0, 77.0, 85.0, 78.0, 79.0, 79.0, 78.0, 77.0, 79.0, 87.0], "imaging-desaturate": [96.0, 95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"suite": 1447.6, "subtests": {"audio-fft": {"std": 30.832450437809836, "min": 70.0, "max": 151.0, "median": 71.0, "filtered": 86.4, "mean": 86.4}, "stanford-crypto-pbkdf2": {"std": 4.570557952810575, "min": 132.0, "max": 146.0, "median": 135.0, "filtered": 137.1, "mean": 137.1}, "audio-beat-detection": {"std": 14.014635207525027, "min": 121.0, "max": 161.0, "median": 143.5, "filtered": 138.7, "mean": 138.7}, "stanford-crypto-ccm": {"std": 3.4698703145794942, "min": 104.0, "max": 115.0, "median": 109.5, "filtered": 109.4, "mean": 109.4}, "imaging-darkroom": {"std": 0.9, "min": 144.0, "max": 147.0, "median": 145.0, "filtered": 145.3, "mean": 145.3}, "json-parse-financial": {"std": 4.7, "min": 50.0, "max": 68.0, "median": 54.0, "filtered": 54.9, "mean": 54.9}, "audio-oscillator": {"std": 19.22004162326398, "min": 88.0, "max": 133.0, "median": 88.0, "filtered": 100.7, "mean": 100.7}, "ai-astar": {"std": 2.5768197453450252, "min": 105.0, "max": 116.0, "median": 109.5, "filtered": 109.6, "mean": 109.6}, "audio-dft": {"std": 1.4456832294800959, "min": 157.0, "max": 161.0, "median": 159.5, "filtered": 159.1, "mean": 159.1}, "stanford-crypto-sha256-iterative": {"std": 1.019803902718557, "min": 59.0, "max": 63.0, "median": 60.0, "filtered": 60.4, "mean": 60.4}, "json-stringify-tinderbox": {"std": 1.562049935181331, "min": 60.0, "max": 66.0, "median": 61.0, "filtered": 61.4, "mean": 61.4}, "imaging-gaussian-blur": {"std": 0.4, "min": 109.0, "max": 110.0, "median": 109.0, "filtered": 109.2, "mean": 109.2}, "stanford-crypto-aes": {"std": 3.3226495451672298, "min": 77.0, "max": 87.0, "median": 78.5, "filtered": 79.6, "mean": 79.6}, "imaging-desaturate": {"std": 0.5999999999999999, "min": 95.0, "max": 97.0, "median": 96.0, "filtered": 95.8, "mean": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1445969885, "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": "20151027085421", "branch": "Mozilla-Aurora", "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23"}}, {"talos_counters": {}, "results": {"DeltaBlue": [165.12549537648613], "Encrypt": [283.68794326241135], "NavierStokes": [4817.307692307692], "Decrypt": [5122.448979591837], "Splay": [544.069640914037], "Richards": [168.09547823163558], "RegExp": [23348.837209302324], "Earley": [538.7931034482758], "Boyer": [10181.818181818182], "RayTrace": [952.3809523809524]}, "summary": {"suite": 23350.408244203725, "subtests": {"DeltaBlue": {"std": 0.0, "min": 165.12549537648613, "max": 165.12549537648613, "median": 165.12549537648613, "value": 400.41060799999985, "filtered": 400.41060799999985, "mean": 165.12549537648613}, "Encrypt": {"std": 0.0, "min": 283.68794326241135, "max": 283.68794326241135, "median": 283.68794326241135, "value": 938.2880249999996, "filtered": 938.2880249999996, "mean": 283.68794326241135}, "NavierStokes": {"std": 0.0, "min": 4817.307692307692, "max": 4817.307692307692, "median": 4817.307692307692, "value": 308.055888223553, "filtered": 308.055888223553, "mean": 4817.307692307692}, "Decrypt": {"std": 0.0, "min": 5122.448979591837, "max": 5122.448979591837, "median": 5122.448979591837, "value": 51.96362151394425, "filtered": 51.96362151394425, "mean": 5122.448979591837}, "Splay": {"std": 0.0, "min": 544.069640914037, "max": 544.069640914037, "median": 544.069640914037, "value": 149.78045800000007, "filtered": 149.78045800000007, "mean": 544.069640914037}, "RegExp": {"std": 0.0, "min": 23348.837209302324, "max": 23348.837209302324, "median": 23348.837209302324, "value": 39.01628984063744, "filtered": 39.01628984063744, "mean": 23348.837209302324}, "Richards": {"std": 0.0, "min": 168.09547823163558, "max": 168.09547823163558, "median": 168.09547823163558, "value": 210.01159799999994, "filtered": 210.01159799999994, "mean": 168.09547823163558}, "Earley": {"std": 0.0, "min": 538.7931034482758, "max": 538.7931034482758, "median": 538.7931034482758, "value": 1236.9553279999998, "filtered": 1236.9553279999998, "mean": 538.7931034482758}, "Boyer": {"std": 0.0, "min": 10181.818181818182, "max": 10181.818181818182, "median": 10181.818181818182, "value": 65.45618750000003, "filtered": 65.45618750000003, "mean": 10181.818181818182}, "RayTrace": {"std": 0.0, "min": 952.3809523809524, "max": 952.3809523809524, "median": 952.3809523809524, "value": 776.9884500000003, "filtered": 776.9884500000003, "mean": 952.3809523809524}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1445969885, "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": "20151027085421", "branch": "Mozilla-Aurora", "revision": "b5c8da05bef9d38b67b6e27d83035af210c58e23"}}] 11:38:14 INFO - RETURN: dromaeo_css: 7446.67 11:38:14 INFO - RETURN: kraken: 1447.60 11:38:14 INFO - RETURN: v8_7: 23350.41 11:38:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23350.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1447.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7446.67"}}} 11:38:14 INFO - Return code: 0 11:38:14 INFO - # TBPL SUCCESS # 11:38:14 INFO - Running post-action listener: _resource_record_post_action 11:38:14 INFO - Running post-run listener: _resource_record_post_run 11:38:15 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 7344128; Write bytes: 385392640; Read time: 2788; Write time: 525228 11:38:15 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 32768; Write bytes: 4669440; Read time: 4; Write time: 216 11:38:15 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 5570560; Write bytes: 322846720; Read time: 2332; Write time: 468052 11:38:15 INFO - Running post-run listener: _upload_blobber_files 11:38:15 INFO - Blob upload gear active. 11:38:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:38:15 INFO - Copying logs to upload dir... 11:38:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.296764 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-10-27 11:38:15.893927) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 11:38:15.897226) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009938 build_url: 'https://queue.taskcluster.net/v1/task/Fs0ixhjYRvCHokSb6w4d3A/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 11:38:15.949347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:38:15.949685) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1445969701.790968-1249754536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:38:15.999878) ========= ========= Started reboot slave lost (results: 0, elapsed: 5 secs) (at 2015-10-27 11:38:16.000249) ========= ========= Finished reboot slave lost (results: 0, elapsed: 5 secs) (at 2015-10-27 11:38:21.036639) =========