builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1445972725.87 results: success (0) buildid: 20151027095132 builduid: f16a78cac75b4064839b0022ff810f21 revision: b0f5fa1535dd89740f3226c21d39801c074e1960 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.870493) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.870951) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.871278) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006225 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.927040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.927393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.941630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.941997) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020641 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.991261) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.991573) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.991957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:25.992246) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-27 12:05:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.4M=0s 2015-10-27 12:05:26 (47.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166384 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.170973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.171321) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.117890 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.300601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.301000) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b0f5fa1535dd89740f3226c21d39801c074e1960 --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 b0f5fa1535dd89740f3226c21d39801c074e1960 --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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-27 12:05:26,363 truncating revision to first 12 chars 2015-10-27 12:05:26,364 Setting DEBUG logging. 2015-10-27 12:05:26,364 attempt 1/10 2015-10-27 12:05:26,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b0f5fa1535dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 12:05:26,627 unpacking tar archive at: mozilla-aurora-b0f5fa1535dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534689 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.847993) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.848319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.858565) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.858926) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 12:05:26.859383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-10-27 12:05:26.859674) ========= /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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:05:27 INFO - MultiFileLogger online at 20151027 12:05:27 in /builds/slave/test-pgo 12:05:27 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 12:05:27 INFO - Guessing talos json url... 12:05:27 INFO - Using buildbot properties: 12:05:27 INFO - { 12:05:27 INFO - "properties": { 12:05:27 INFO - "buildnumber": 2, 12:05:27 INFO - "product": "firefox", 12:05:27 INFO - "script_repo_revision": "production", 12:05:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:05:27 INFO - "repository": "", 12:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:05:27 INFO - "buildid": "20151027095132", 12:05:27 INFO - "slavename": "talos-linux64-ix-009", 12:05:27 INFO - "pgo_build": "True", 12:05:27 INFO - "basedir": "/builds/slave/test-pgo", 12:05:27 INFO - "project": "", 12:05:27 INFO - "platform": "ubuntu64_hw", 12:05:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:05:27 INFO - "slavebuilddir": "test", 12:05:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:05:27 INFO - "branch": "mozilla-aurora", 12:05:27 INFO - "repo_path": "releases/mozilla-aurora", 12:05:27 INFO - "stage_platform": "linux64-pgo", 12:05:27 INFO - "builduid": "f16a78cac75b4064839b0022ff810f21", 12:05:27 INFO - "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960" 12:05:27 INFO - }, 12:05:27 INFO - "sourcestamp": { 12:05:27 INFO - "repository": "", 12:05:27 INFO - "hasPatch": false, 12:05:27 INFO - "project": "", 12:05:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:05:27 INFO - "changes": [ 12:05:27 INFO - { 12:05:27 INFO - "category": null, 12:05:27 INFO - "files": [ 12:05:27 INFO - { 12:05:27 INFO - "url": null, 12:05:27 INFO - "name": "https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 12:05:27 INFO - } 12:05:27 INFO - ], 12:05:27 INFO - "repository": "", 12:05:27 INFO - "rev": "b0f5fa1535dd89740f3226c21d39801c074e1960", 12:05:27 INFO - "who": "kwierso@gmail.com", 12:05:27 INFO - "when": 1445972655, 12:05:27 INFO - "number": 6581635, 12:05:27 INFO - "comments": "Bug 1211970 - \"Muted errors in workers are not correctly reported to the console\". r=bz, a=lizzard", 12:05:27 INFO - "project": "", 12:05:27 INFO - "at": "Tue 27 Oct 2015 12:04:15", 12:05:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:05:27 INFO - "revlink": "", 12:05:27 INFO - "properties": [ 12:05:27 INFO - [ 12:05:27 INFO - "buildid", 12:05:27 INFO - "20151027095132", 12:05:27 INFO - "Change" 12:05:27 INFO - ], 12:05:27 INFO - [ 12:05:27 INFO - "builduid", 12:05:27 INFO - "f16a78cac75b4064839b0022ff810f21", 12:05:27 INFO - "Change" 12:05:27 INFO - ], 12:05:27 INFO - [ 12:05:27 INFO - "pgo_build", 12:05:27 INFO - "True", 12:05:27 INFO - "Change" 12:05:27 INFO - ] 12:05:27 INFO - ], 12:05:27 INFO - "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960" 12:05:27 INFO - } 12:05:27 INFO - ], 12:05:27 INFO - "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960" 12:05:27 INFO - } 12:05:27 INFO - } 12:05:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 12:05:27 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')]} 12:05:27 INFO - https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 12:05:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 12:05:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 12:05:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:27 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:27 INFO - Downloaded 107 bytes. 12:05:27 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 12:05:27 INFO - Contents: 12:05:27 INFO - 20151027095132 12:05:27 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/b0f5fa1535dd89740f3226c21d39801c074e1960 12:05:27 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')]} 12:05:27 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b0f5fa1535/testing/talos/talos.json 12:05:27 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b0f5fa1535/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 12:05:27 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/b0f5fa1535/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 12:05:28 INFO - Downloaded 6818 bytes. 12:05:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:05:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:05:28 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:05:28 INFO - '../fennec_ids.txt'], 12:05:28 INFO - 'tests': ['tcheck2']}, 12:05:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:05:28 INFO - '--tppagecycles', 12:05:28 INFO - '7'], 12:05:28 INFO - 'tests': ['tsvgm']}}, 12:05:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:05:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:05:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:05:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:05:28 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 12:05:28 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 12:05:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:28 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 12:05:28 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 12:05:28 INFO - 'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:28 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'tests': ['damp', 'tps']}, 12:05:28 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['damp', 'tps']}, 12:05:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:05:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:05:28 INFO - 'other': {'tests': ['a11yr', 12:05:28 INFO - 'ts_paint', 12:05:28 INFO - 'tpaint', 12:05:28 INFO - 'sessionrestore', 12:05:28 INFO - 'sessionrestore_no_auto_restore']}, 12:05:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['a11yr', 12:05:28 INFO - 'ts_paint', 12:05:28 INFO - 'tpaint', 12:05:28 INFO - 'sessionrestore', 12:05:28 INFO - 'sessionrestore_no_auto_restore']}, 12:05:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['a11yr', 12:05:28 INFO - 'ts_paint', 12:05:28 INFO - 'tpaint', 12:05:28 INFO - 'sessionrestore', 12:05:28 INFO - 'sessionrestore_no_auto_restore']}, 12:05:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['a11yr', 12:05:28 INFO - 'ts_paint', 12:05:28 INFO - 'tpaint', 12:05:28 INFO - 'sessionrestore', 12:05:28 INFO - 'sessionrestore_no_auto_restore']}, 12:05:28 INFO - 'other_l64': {'tests': ['a11yr', 12:05:28 INFO - 'ts_paint', 12:05:28 INFO - 'tpaint', 12:05:28 INFO - 'sessionrestore', 12:05:28 INFO - 'sessionrestore_no_auto_restore']}, 12:05:28 INFO - 'other_nol64': {'tests': ['a11yr', 12:05:28 INFO - 'ts_paint', 12:05:28 INFO - 'tpaint', 12:05:28 INFO - 'sessionrestore', 12:05:28 INFO - 'sessionrestore_no_auto_restore']}, 12:05:28 INFO - 'svgr': {'tests': ['tsvgx', 12:05:28 INFO - 'tsvgr_opacity', 12:05:28 INFO - 'tart', 12:05:28 INFO - 'tscrollx', 12:05:28 INFO - 'cart']}, 12:05:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['tsvgx', 12:05:28 INFO - 'tsvgr_opacity', 12:05:28 INFO - 'tart', 12:05:28 INFO - 'tscrollx', 12:05:28 INFO - 'cart']}, 12:05:28 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 12:05:28 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 12:05:28 INFO - 'tests': ['tp5o']}, 12:05:28 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 12:05:28 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 12:05:28 INFO - 'talos_options': ['--e10s'], 12:05:28 INFO - 'tests': ['tp5o']}, 12:05:28 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 12:05:28 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 12:05:28 INFO - 'talos_options': ['--xperf_path', 12:05:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:28 INFO - 'tests': ['tp5n']}, 12:05:28 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 12:05:28 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 12:05:28 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:28 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 12:05:28 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 12:05:28 INFO - 'talos_options': ['--e10s', 12:05:28 INFO - '--xperf_path', 12:05:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 12:05:28 INFO - 'C:/slave/talos-data/talos/xperf.config'], 12:05:28 INFO - 'tests': ['tp5n']}}, 12:05:28 INFO - 'talos.zip': {'path': '', 12:05:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:05:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:05:28 INFO - {'append_to_log': False, 12:05:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:05:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:05:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:05:28 INFO - 'branch': 'Mozilla-Aurora', 12:05:28 INFO - 'buildbot_json_path': 'buildprops.json', 12:05:28 INFO - 'config_files': ('talos/linux_config.py',), 12:05:28 INFO - 'default_actions': ('clobber', 12:05:28 INFO - 'read-buildbot-config', 12:05:28 INFO - 'download-and-extract', 12:05:28 INFO - 'populate-webroot', 12:05:28 INFO - 'create-virtualenv', 12:05:28 INFO - 'install', 12:05:28 INFO - 'run-tests'), 12:05:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:05:28 INFO - 'download_minidump_stackwalk': True, 12:05:28 INFO - 'download_symbols': 'ondemand', 12:05:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:05:28 INFO - 'tooltool.py': '/tools/tooltool.py', 12:05:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:05:28 INFO - '/tools/misc-python/virtualenv.py')}, 12:05:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:05:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:05:28 INFO - 'installer_path': 'installer.exe', 12:05:28 INFO - 'log_level': 'info', 12:05:28 INFO - 'log_name': 'talos', 12:05:28 INFO - 'log_to_console': True, 12:05:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:05:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:05:28 INFO - 'opt_config_files': (), 12:05:28 INFO - 'pip_index': False, 12:05:28 INFO - 'python_webserver': False, 12:05:28 INFO - 'sps_profile': False, 12:05:28 INFO - 'sps_profile_interval': 0, 12:05:28 INFO - 'suite': 'dromaeojs', 12:05:28 INFO - 'system_bits': '64', 12:05:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:05:28 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 12:05:28 INFO - 'tests': (), 12:05:28 INFO - 'title': 'talos-linux64-ix-009', 12:05:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:05:28 INFO - 'use_talos_json': True, 12:05:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:05:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:05:28 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 12:05:28 INFO - 'work_dir': 'build'} 12:05:28 INFO - ##### 12:05:28 INFO - ##### Running clobber step. 12:05:28 INFO - ##### 12:05:28 INFO - Running pre-action listener: _resource_record_pre_action 12:05:28 INFO - Running main action method: clobber 12:05:28 INFO - rmtree: /builds/slave/test-pgo/build 12:05:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:05:29 INFO - Running post-action listener: _resource_record_post_action 12:05:29 INFO - ##### 12:05:29 INFO - ##### Running read-buildbot-config step. 12:05:29 INFO - ##### 12:05:29 INFO - Running pre-action listener: _resource_record_pre_action 12:05:29 INFO - Running main action method: read_buildbot_config 12:05:29 INFO - Using buildbot properties: 12:05:29 INFO - { 12:05:29 INFO - "properties": { 12:05:29 INFO - "buildnumber": 2, 12:05:29 INFO - "product": "firefox", 12:05:29 INFO - "script_repo_revision": "production", 12:05:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:05:29 INFO - "repository": "", 12:05:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:05:29 INFO - "buildid": "20151027095132", 12:05:29 INFO - "slavename": "talos-linux64-ix-009", 12:05:29 INFO - "pgo_build": "True", 12:05:29 INFO - "basedir": "/builds/slave/test-pgo", 12:05:29 INFO - "project": "", 12:05:29 INFO - "platform": "ubuntu64_hw", 12:05:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:05:29 INFO - "slavebuilddir": "test", 12:05:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:05:29 INFO - "branch": "mozilla-aurora", 12:05:29 INFO - "repo_path": "releases/mozilla-aurora", 12:05:29 INFO - "stage_platform": "linux64-pgo", 12:05:29 INFO - "builduid": "f16a78cac75b4064839b0022ff810f21", 12:05:29 INFO - "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960" 12:05:29 INFO - }, 12:05:29 INFO - "sourcestamp": { 12:05:29 INFO - "repository": "", 12:05:29 INFO - "hasPatch": false, 12:05:29 INFO - "project": "", 12:05:29 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:05:29 INFO - "changes": [ 12:05:29 INFO - { 12:05:29 INFO - "category": null, 12:05:29 INFO - "files": [ 12:05:29 INFO - { 12:05:29 INFO - "url": null, 12:05:29 INFO - "name": "https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 12:05:29 INFO - } 12:05:29 INFO - ], 12:05:29 INFO - "repository": "", 12:05:29 INFO - "rev": "b0f5fa1535dd89740f3226c21d39801c074e1960", 12:05:29 INFO - "who": "kwierso@gmail.com", 12:05:29 INFO - "when": 1445972655, 12:05:29 INFO - "number": 6581635, 12:05:29 INFO - "comments": "Bug 1211970 - \"Muted errors in workers are not correctly reported to the console\". r=bz, a=lizzard", 12:05:29 INFO - "project": "", 12:05:29 INFO - "at": "Tue 27 Oct 2015 12:04:15", 12:05:29 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 12:05:29 INFO - "revlink": "", 12:05:29 INFO - "properties": [ 12:05:29 INFO - [ 12:05:29 INFO - "buildid", 12:05:29 INFO - "20151027095132", 12:05:29 INFO - "Change" 12:05:29 INFO - ], 12:05:29 INFO - [ 12:05:29 INFO - "builduid", 12:05:29 INFO - "f16a78cac75b4064839b0022ff810f21", 12:05:29 INFO - "Change" 12:05:29 INFO - ], 12:05:29 INFO - [ 12:05:29 INFO - "pgo_build", 12:05:29 INFO - "True", 12:05:29 INFO - "Change" 12:05:29 INFO - ] 12:05:29 INFO - ], 12:05:29 INFO - "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960" 12:05:29 INFO - } 12:05:29 INFO - ], 12:05:29 INFO - "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960" 12:05:29 INFO - } 12:05:29 INFO - } 12:05:29 INFO - Running post-action listener: _resource_record_post_action 12:05:29 INFO - ##### 12:05:29 INFO - ##### Running download-and-extract step. 12:05:29 INFO - ##### 12:05:29 INFO - Running pre-action listener: _resource_record_pre_action 12:05:29 INFO - Running main action method: download_and_extract 12:05:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:29 INFO - https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/test_packages.json 12:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/test_packages.json 12:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:05:29 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 12:05:30 INFO - Downloaded 1302 bytes. 12:05:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:05:30 INFO - Using the following test package requirements: 12:05:30 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 12:05:30 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 12:05:30 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:05:30 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 12:05:30 INFO - u'jsshell-linux-x86_64.zip'], 12:05:30 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 12:05:30 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:05:30 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 12:05:30 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 12:05:30 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:05:30 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 12:05:30 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:05:30 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 12:05:30 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:05:30 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 12:05:30 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 12:05:30 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:05:30 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:30 INFO - https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:05:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 12:05:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 12:05:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:30 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:35 INFO - Downloaded 22908053 bytes. 12:05:35 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 12:05:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 12:05:35 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 12:05:36 INFO - Return code: 0 12:05:36 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 12:05: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')]} 12:05:36 INFO - https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 12:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 12:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:36 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:43 INFO - Downloaded 22908053 bytes. 12:05:43 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 12:05:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 12:05:43 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 12:05:44 INFO - Return code: 0 12:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:44 INFO - https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:05:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 12:05:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 12:05:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:44 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:45 INFO - Downloaded 10881672 bytes. 12:05:45 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 12:05:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 12:05:45 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 12:05:46 INFO - Return code: 0 12:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:46 INFO - https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 12:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 12:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:46 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:05:47 INFO - Downloaded 56987532 bytes. 12:05:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 12:05:47 INFO - mkdir: /builds/slave/test-pgo/properties 12:05:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:05:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:05:47 INFO - Contents: 12:05:47 INFO - build_url:https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 12:05:47 INFO - Running post-action listener: _resource_record_post_action 12:05:47 INFO - Running post-action listener: _set_extra_try_arguments 12:05:47 INFO - ##### 12:05:47 INFO - ##### Running populate-webroot step. 12:05:47 INFO - ##### 12:05:47 INFO - Running pre-action listener: _resource_record_pre_action 12:05:47 INFO - Running main action method: populate_webroot 12:05:47 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 12:05:47 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 12:05:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 12:05:47 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 12:05:47 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 12:05:47 INFO - Running post-action listener: _resource_record_post_action 12:05:47 INFO - ##### 12:05:47 INFO - ##### Running create-virtualenv step. 12:05:47 INFO - ##### 12:05:47 INFO - Running pre-action listener: _resource_record_pre_action 12:05:47 INFO - Running main action method: create_virtualenv 12:05:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:05:47 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 12:05:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:05:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:05:48 INFO - Using real prefix '/usr' 12:05:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:05:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:05:51 INFO - Installing pip.................done. 12:05:51 INFO - Return code: 0 12:05:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:05:51 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')]} 12:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:51 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')]} 12:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:51 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 0x7fe705523b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25287b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ed4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', '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 12:05:51 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 12:05:51 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 12:05:51 INFO - Using env: {'DISPLAY': ':0', 12:05:51 INFO - 'HOME': '/home/cltbld', 12:05:51 INFO - 'LANG': 'en_US.UTF-8', 12:05:51 INFO - 'LANGUAGE': 'en_US:en', 12:05:51 INFO - 'LOGNAME': 'cltbld', 12:05:51 INFO - 'MAIL': '/var/mail/cltbld', 12:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:51 INFO - 'MOZ_NO_REMOTE': '1', 12:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:51 INFO - 'NO_EM_RESTART': '1', 12:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:05:51 INFO - 'PWD': '/builds/slave/test-pgo', 12:05:51 INFO - 'SHELL': '/bin/bash', 12:05:51 INFO - 'SHLVL': '1', 12:05:51 INFO - 'TERM': 'linux', 12:05:51 INFO - 'TMOUT': '86400', 12:05:51 INFO - 'USER': 'cltbld', 12:05:51 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:51 INFO - '_': '/tools/buildbot/bin/python'} 12:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:52 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 12:05:52 INFO - Cleaning up... 12:05:52 INFO - Return code: 0 12:05:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:05:52 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')]} 12:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:52 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')]} 12:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:52 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 0x7fe705523b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25287b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ed4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', '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 12:05:52 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 12:05:52 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 12:05:52 INFO - Using env: {'DISPLAY': ':0', 12:05:52 INFO - 'HOME': '/home/cltbld', 12:05:52 INFO - 'LANG': 'en_US.UTF-8', 12:05:52 INFO - 'LANGUAGE': 'en_US:en', 12:05:52 INFO - 'LOGNAME': 'cltbld', 12:05:52 INFO - 'MAIL': '/var/mail/cltbld', 12:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:52 INFO - 'MOZ_NO_REMOTE': '1', 12:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:52 INFO - 'NO_EM_RESTART': '1', 12:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:05:52 INFO - 'PWD': '/builds/slave/test-pgo', 12:05:52 INFO - 'SHELL': '/bin/bash', 12:05:52 INFO - 'SHLVL': '1', 12:05:52 INFO - 'TERM': 'linux', 12:05:52 INFO - 'TMOUT': '86400', 12:05:52 INFO - 'USER': 'cltbld', 12:05:52 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:52 INFO - '_': '/tools/buildbot/bin/python'} 12:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:52 INFO - Downloading/unpacking psutil>=0.7.1 12:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:05:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:05:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:54 INFO - Installing collected packages: psutil 12:05:54 INFO - Running setup.py install for psutil 12:05:54 INFO - building 'psutil._psutil_linux' extension 12:05:54 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 12:05:54 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 12:05:55 INFO - building 'psutil._psutil_posix' extension 12:05:55 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 12:05:55 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 12:05:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:55 INFO - Successfully installed psutil 12:05:55 INFO - Cleaning up... 12:05:55 INFO - Return code: 0 12:05:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:55 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 0x7fe705523b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25287b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ed4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', '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 12:05:55 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 12:05:55 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 12:05:55 INFO - Using env: {'DISPLAY': ':0', 12:05:55 INFO - 'HOME': '/home/cltbld', 12:05:55 INFO - 'LANG': 'en_US.UTF-8', 12:05:55 INFO - 'LANGUAGE': 'en_US:en', 12:05:55 INFO - 'LOGNAME': 'cltbld', 12:05:55 INFO - 'MAIL': '/var/mail/cltbld', 12:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:55 INFO - 'MOZ_NO_REMOTE': '1', 12:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:55 INFO - 'NO_EM_RESTART': '1', 12:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:05:55 INFO - 'PWD': '/builds/slave/test-pgo', 12:05:55 INFO - 'SHELL': '/bin/bash', 12:05:55 INFO - 'SHLVL': '1', 12:05:55 INFO - 'TERM': 'linux', 12:05:55 INFO - 'TMOUT': '86400', 12:05:55 INFO - 'USER': 'cltbld', 12:05:55 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:55 INFO - '_': '/tools/buildbot/bin/python'} 12:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:05:55 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 12:05:55 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 12:05:55 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 12:05:55 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 12:05:55 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 12:05:55 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 12:05:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:05:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:05:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:05:57 INFO - Installing collected packages: mozsystemmonitor 12:05:57 INFO - Running setup.py install for mozsystemmonitor 12:05:57 INFO - Successfully installed mozsystemmonitor 12:05:57 INFO - Cleaning up... 12:05:57 INFO - Return code: 0 12:05:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:57 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 0x7fe705523b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25287b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ed4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', '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 12:05:57 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 12:05:57 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 12:05:57 INFO - Using env: {'DISPLAY': ':0', 12:05:57 INFO - 'HOME': '/home/cltbld', 12:05:57 INFO - 'LANG': 'en_US.UTF-8', 12:05:57 INFO - 'LANGUAGE': 'en_US:en', 12:05:57 INFO - 'LOGNAME': 'cltbld', 12:05:57 INFO - 'MAIL': '/var/mail/cltbld', 12:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:57 INFO - 'MOZ_NO_REMOTE': '1', 12:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:57 INFO - 'NO_EM_RESTART': '1', 12:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:05:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:05:57 INFO - 'SHELL': '/bin/bash', 12:05:57 INFO - 'SHLVL': '1', 12:05:57 INFO - 'TERM': 'linux', 12:05:57 INFO - 'TMOUT': '86400', 12:05:57 INFO - 'USER': 'cltbld', 12:05:57 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:57 INFO - '_': '/tools/buildbot/bin/python'} 12:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:57 INFO - Downloading/unpacking blobuploader==1.2.4 12:05:57 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 12:05:57 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 12:05:57 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 12:05:57 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 12:05:57 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 12:05:57 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 12:05:59 INFO - Downloading blobuploader-1.2.4.tar.gz 12:05:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:05:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:05:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:05:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:05:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 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 12:05:59 INFO - Downloading docopt-0.6.1.tar.gz 12:05:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:05:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:06:00 INFO - Installing collected packages: blobuploader, requests, docopt 12:06:00 INFO - Running setup.py install for blobuploader 12:06:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:06:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:06:00 INFO - Running setup.py install for requests 12:06:00 INFO - Running setup.py install for docopt 12:06:00 INFO - Successfully installed blobuploader requests docopt 12:06:00 INFO - Cleaning up... 12:06:00 INFO - Return code: 0 12:06:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:06:00 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')]} 12:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:00 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')]} 12:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:00 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 0x7fe705523b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25287b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ed4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', '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 12:06:00 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 12:06:00 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 12:06:00 INFO - Using env: {'DISPLAY': ':0', 12:06:00 INFO - 'HOME': '/home/cltbld', 12:06:00 INFO - 'LANG': 'en_US.UTF-8', 12:06:00 INFO - 'LANGUAGE': 'en_US:en', 12:06:00 INFO - 'LOGNAME': 'cltbld', 12:06:00 INFO - 'MAIL': '/var/mail/cltbld', 12:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:00 INFO - 'MOZ_NO_REMOTE': '1', 12:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:00 INFO - 'NO_EM_RESTART': '1', 12:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:06:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:06:00 INFO - 'SHELL': '/bin/bash', 12:06:00 INFO - 'SHLVL': '1', 12:06:00 INFO - 'TERM': 'linux', 12:06:00 INFO - 'TMOUT': '86400', 12:06:00 INFO - 'USER': 'cltbld', 12:06:00 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:00 INFO - '_': '/tools/buildbot/bin/python'} 12:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:06:00 INFO - Running setup.py (path:/tmp/pip-fQeXpK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:06:00 INFO - Running setup.py (path:/tmp/pip-vziOQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:06:00 INFO - Running setup.py (path:/tmp/pip-uW5tOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:06:01 INFO - Running setup.py (path:/tmp/pip-OEmEWV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:06:01 INFO - Running setup.py (path:/tmp/pip-zVUZu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:06:01 INFO - Running setup.py (path:/tmp/pip-9k4NAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:06:01 INFO - Running setup.py (path:/tmp/pip-iooaN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:06:01 INFO - Running setup.py (path:/tmp/pip-sQ1K83-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:06:01 INFO - Running setup.py (path:/tmp/pip-Hon9TH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:06:01 INFO - Running setup.py (path:/tmp/pip-nVr9HA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:06:01 INFO - Running setup.py (path:/tmp/pip-wRxBV_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:06:01 INFO - Running setup.py (path:/tmp/pip-1LhOxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:06:01 INFO - Running setup.py (path:/tmp/pip-4xoMDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:06:01 INFO - Running setup.py (path:/tmp/pip-fBlC9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:06:01 INFO - Running setup.py (path:/tmp/pip-J4d3X0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:06:01 INFO - Running setup.py (path:/tmp/pip-HcPdfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:06:01 INFO - Running setup.py (path:/tmp/pip-sP3q9h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:06:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:02 INFO - Running setup.py install for manifestparser 12:06:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Running setup.py install for mozcrash 12:06:02 INFO - Running setup.py install for mozdebug 12:06:02 INFO - Running setup.py install for mozdevice 12:06:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Running setup.py install for mozfile 12:06:02 INFO - Running setup.py install for mozhttpd 12:06:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Running setup.py install for mozinfo 12:06:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Running setup.py install for mozInstall 12:06:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:06:02 INFO - Running setup.py install for mozleak 12:06:02 INFO - Running setup.py install for mozlog 12:06:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:06:03 INFO - Running setup.py install for moznetwork 12:06:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:06:03 INFO - Running setup.py install for mozprocess 12:06:03 INFO - Running setup.py install for mozprofile 12:06:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:06:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:06:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:06:03 INFO - Running setup.py install for mozrunner 12:06:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:06:03 INFO - Running setup.py install for mozscreenshot 12:06:03 INFO - Running setup.py install for moztest 12:06:03 INFO - Running setup.py install for mozversion 12:06:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:06:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:03 INFO - Cleaning up... 12:06:03 INFO - Return code: 0 12:06:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:03 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 0x7fe705523b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25287b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ed4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', '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 12:06:03 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 12:06:03 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 12:06:03 INFO - Using env: {'DISPLAY': ':0', 12:06:03 INFO - 'HOME': '/home/cltbld', 12:06:03 INFO - 'LANG': 'en_US.UTF-8', 12:06:03 INFO - 'LANGUAGE': 'en_US:en', 12:06:03 INFO - 'LOGNAME': 'cltbld', 12:06:03 INFO - 'MAIL': '/var/mail/cltbld', 12:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:03 INFO - 'MOZ_NO_REMOTE': '1', 12:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:03 INFO - 'NO_EM_RESTART': '1', 12:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:06:03 INFO - 'PWD': '/builds/slave/test-pgo', 12:06:03 INFO - 'SHELL': '/bin/bash', 12:06:03 INFO - 'SHLVL': '1', 12:06:03 INFO - 'TERM': 'linux', 12:06:03 INFO - 'TMOUT': '86400', 12:06:03 INFO - 'USER': 'cltbld', 12:06:03 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:03 INFO - '_': '/tools/buildbot/bin/python'} 12:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:06:04 INFO - Running setup.py (path:/tmp/pip-4RNwlK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:06:04 INFO - Running setup.py (path:/tmp/pip-Z3q0Rb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:06:04 INFO - Running setup.py (path:/tmp/pip-8FlnD3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:06:04 INFO - Running setup.py (path:/tmp/pip-V5RouN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:06:04 INFO - Running setup.py (path:/tmp/pip-ijiT00-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:06:04 INFO - Running setup.py (path:/tmp/pip-OGnNE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:06:04 INFO - Running setup.py (path:/tmp/pip-qPYSbx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:06:04 INFO - Running setup.py (path:/tmp/pip-YMBoY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:06:04 INFO - Running setup.py (path:/tmp/pip-_zhI6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:06:04 INFO - Running setup.py (path:/tmp/pip-uzPi_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:06:04 INFO - Running setup.py (path:/tmp/pip-_DhZB4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:06:04 INFO - Running setup.py (path:/tmp/pip-imHUw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:06:04 INFO - Running setup.py (path:/tmp/pip-Teqa2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:06:04 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)) 12:06:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:06:04 INFO - Running setup.py (path:/tmp/pip-txHUr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:06:05 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)) 12:06:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:06:05 INFO - Running setup.py (path:/tmp/pip-FGaCpU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:06:05 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)) 12:06:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:06:05 INFO - Running setup.py (path:/tmp/pip-sw4OOk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:06:05 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)) 12:06:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:06:05 INFO - Running setup.py (path:/tmp/pip-ZJcsV_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:06:05 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 12:06:05 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 12:06:05 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 12:06:05 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 12:06:05 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 12:06:05 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 12:06:06 INFO - Downloading blessings-1.5.1.tar.gz 12:06:06 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 12:06:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:06:07 INFO - Installing collected packages: blessings 12:06:07 INFO - Running setup.py install for blessings 12:06:07 INFO - Successfully installed blessings 12:06:07 INFO - Cleaning up... 12:06:07 INFO - Return code: 0 12:06:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:06:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:06:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:06:07 INFO - Reading from file tmpfile_stdout 12:06:07 INFO - Current package versions: 12:06:07 INFO - argparse == 1.2.1 12:06:07 INFO - blessings == 1.5.1 12:06:07 INFO - blobuploader == 1.2.4 12:06:07 INFO - docopt == 0.6.1 12:06:07 INFO - manifestparser == 1.1 12:06:07 INFO - mozInstall == 1.12 12:06:07 INFO - mozcrash == 0.16 12:06:07 INFO - mozdebug == 0.1 12:06:07 INFO - mozdevice == 0.46 12:06:07 INFO - mozfile == 1.2 12:06:07 INFO - mozhttpd == 0.7 12:06:07 INFO - mozinfo == 0.8 12:06:07 INFO - mozleak == 0.1 12:06:07 INFO - mozlog == 3.0 12:06:07 INFO - moznetwork == 0.27 12:06:07 INFO - mozprocess == 0.22 12:06:07 INFO - mozprofile == 0.27 12:06:07 INFO - mozrunner == 6.10 12:06:07 INFO - mozscreenshot == 0.1 12:06:07 INFO - mozsystemmonitor == 0.0 12:06:07 INFO - moztest == 0.7 12:06:07 INFO - mozversion == 1.4 12:06:07 INFO - psutil == 3.1.1 12:06:07 INFO - requests == 1.2.3 12:06:07 INFO - wsgiref == 0.1.2 12:06:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:06:07 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')]} 12:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:07 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')]} 12:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:07 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 0x7fe705523b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25287b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ed4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', '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 12:06:07 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 12:06:07 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 12:06:07 INFO - Using env: {'DISPLAY': ':0', 12:06:07 INFO - 'HOME': '/home/cltbld', 12:06:07 INFO - 'LANG': 'en_US.UTF-8', 12:06:07 INFO - 'LANGUAGE': 'en_US:en', 12:06:07 INFO - 'LOGNAME': 'cltbld', 12:06:07 INFO - 'MAIL': '/var/mail/cltbld', 12:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:07 INFO - 'MOZ_NO_REMOTE': '1', 12:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:07 INFO - 'NO_EM_RESTART': '1', 12:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:06:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:06:07 INFO - 'SHELL': '/bin/bash', 12:06:07 INFO - 'SHLVL': '1', 12:06:07 INFO - 'TERM': 'linux', 12:06:07 INFO - 'TMOUT': '86400', 12:06:07 INFO - 'USER': 'cltbld', 12:06:07 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:07 INFO - '_': '/tools/buildbot/bin/python'} 12:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 INFO - Cleaning up... 12:06:07 INFO - Return code: 0 12:06:07 INFO - Running post-action listener: _resource_record_post_action 12:06:07 INFO - Running post-action listener: _start_resource_monitoring 12:06:07 INFO - Starting resource monitoring. 12:06:07 INFO - ##### 12:06:07 INFO - ##### Running install step. 12:06:07 INFO - ##### 12:06:07 INFO - Running pre-action listener: _resource_record_pre_action 12:06:07 INFO - Running main action method: install 12:06:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:06:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:06:07 INFO - Reading from file tmpfile_stdout 12:06:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:06:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:06:07 INFO - Reading from file tmpfile_stdout 12:06:07 INFO - Output received: 12:06:07 INFO - Usage: mozinstall [options] installer 12:06:07 INFO - Options: 12:06:07 INFO - -h, --help show this help message and exit 12:06:07 INFO - -d DEST, --destination=DEST 12:06:07 INFO - Directory to install application into. [default: 12:06:07 INFO - "/builds/slave/test-pgo"] 12:06:07 INFO - --app=APP Application being installed. [default: firefox] 12:06:07 INFO - mkdir: /builds/slave/test-pgo/build/application 12:06:07 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'] 12:06:07 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 12:06:22 INFO - Reading from file tmpfile_stdout 12:06:22 INFO - Output received: 12:06:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:06:22 INFO - Running post-action listener: _resource_record_post_action 12:06:22 INFO - ##### 12:06:22 INFO - ##### Running run-tests step. 12:06:22 INFO - ##### 12:06:22 INFO - Running pre-action listener: _resource_record_pre_action 12:06:22 INFO - Running main action method: run_tests 12:06:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:06:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:06:22 INFO - Python 2.7.3 12:06:22 INFO - Return code: 0 12:06:22 INFO - grabbing minidump binary from tooltool 12:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:22 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 0x237fbf0>, '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 0x267d4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267d9a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:06:22 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 12:06:22 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 12:06:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:06:22 INFO - Return code: 0 12:06:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:06:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:06:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:06:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:06:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:06:22 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/7HyAd8vTTD6QC5BswTrDGw/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-009', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:06:22 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/7HyAd8vTTD6QC5BswTrDGw/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-009 --webServer localhost 12:06:22 INFO - Using env: {'DISPLAY': ':0', 12:06:22 INFO - 'HOME': '/home/cltbld', 12:06:22 INFO - 'LANG': 'en_US.UTF-8', 12:06:22 INFO - 'LANGUAGE': 'en_US:en', 12:06:22 INFO - 'LOGNAME': 'cltbld', 12:06:22 INFO - 'MAIL': '/var/mail/cltbld', 12:06:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:06:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:22 INFO - 'MOZ_NO_REMOTE': '1', 12:06:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:22 INFO - 'NO_EM_RESTART': '1', 12:06:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:06:22 INFO - 'PWD': '/builds/slave/test-pgo', 12:06:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:06:22 INFO - 'SHELL': '/bin/bash', 12:06:22 INFO - 'SHLVL': '1', 12:06:22 INFO - 'TERM': 'linux', 12:06:22 INFO - 'TMOUT': '86400', 12:06:22 INFO - 'USER': 'cltbld', 12:06:22 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950', 12:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:22 INFO - '_': '/tools/buildbot/bin/python'} 12:06:22 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/7HyAd8vTTD6QC5BswTrDGw/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-009', '--webServer', 'localhost'] with output_timeout 3600 12:06:22 INFO - mozversion INFO | application_buildid: 20151027095132 12:06:22 INFO - mozversion INFO | application_changeset: b0f5fa1535dd89740f3226c21d39801c074e1960 12:06:22 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 12:06:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:06:22 INFO - mozversion INFO | application_name: Firefox 12:06:22 INFO - mozversion INFO | application_remotingname: firefox-dev 12:06:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:06:22 INFO - mozversion INFO | application_vendor: Mozilla 12:06:22 INFO - mozversion INFO | application_version: 43.0a2 12:06:22 INFO - mozversion INFO | platform_buildid: 20151027095132 12:06:22 INFO - mozversion INFO | platform_changeset: b0f5fa1535dd89740f3226c21d39801c074e1960 12:06:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:06:22 INFO - mozversion INFO | platform_version: 43.0a2 12:06:22 INFO - 2015-10-27 12:06:22,500 DEBUG : using testdate: 1445972782 12:06:22 INFO - 2015-10-27 12:06:22,500 DEBUG : actual date: 1445972782 12:06:22 INFO - 2015-10-27 12:06:22,548 INFO : Starting test suite talos-linux64-ix-009 12:06:22 INFO - 2015-10-27 12:06:22,548 INFO : Starting test dromaeo_css 12:06:22 INFO - 2015-10-27 12:06:22,548 DEBUG : operating with platform_type : linux_ 12:06:22 INFO - 2015-10-27 12:06:22,548 INFO : Initialising browser for dromaeo_css test... 12:06:22 INFO - 2015-10-27 12:06:22,568 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcw8fwU/profile http://localhost/getInfo.html 12:06:28 INFO - 2015-10-27 12:06:28,684 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:06:28 INFO - 2015-10-27 12:06:28,684 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:06:28 INFO - 2015-10-27 12:06:28,684 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:06:28 INFO - 2015-10-27 12:06:28,684 DEBUG : BROWSER_OUTPUT: __metrics 12:06:28 INFO - 2015-10-27 12:06:28,765 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:30 INFO - 2015-10-27 12:06:30,169 INFO : Browser initialized. 12:06:30 INFO - 2015-10-27 12:06:30,170 INFO : Running cycle 1/1 for dromaeo_css test... 12:06:30 INFO - 2015-10-27 12:06:30,170 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcw8fwU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:06:41 INFO - 2015-10-27 12:06:41,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 131776512 12:06:41 INFO - 2015-10-27 12:06:41,814 DEBUG : BROWSER_OUTPUT: 12:09:41 INFO - 2015-10-27 12:09:41,223 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) 12:09:42 INFO - 2015-10-27 12:09:42,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 246079488 12:09:42 INFO - 2015-10-27 12:09:42,328 DEBUG : BROWSER_OUTPUT: 12:12:44 INFO - 2015-10-27 12:12:44,456 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) 12:12:45 INFO - 2015-10-27 12:12:45,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 205017088 12:12:45 INFO - 2015-10-27 12:12:45,018 DEBUG : BROWSER_OUTPUT: 12:15:46 INFO - 2015-10-27 12:15:46,759 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) 12:15:47 INFO - 2015-10-27 12:15:47,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 208596992 12:15:47 INFO - 2015-10-27 12:15:47,320 DEBUG : BROWSER_OUTPUT: 12:18:49 INFO - 2015-10-27 12:18:49,057 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) 12:18:49 INFO - 2015-10-27 12:18:49,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 200974336 12:18:49 INFO - 2015-10-27 12:18:49,627 DEBUG : BROWSER_OUTPUT: 12:21:52 INFO - 2015-10-27 12:21:52,000 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) 12:21:52 INFO - 2015-10-27 12:21:52,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 195936256 12:21:52 INFO - 2015-10-27 12:21:52,583 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,656 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) 12:24:54 INFO - 2015-10-27 12:24:54,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 228765696 12:24:54 INFO - 2015-10-27 12:24:54,907 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,907 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:24:54 INFO - 2015-10-27 12:24:54,907 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:24:54 INFO - 2015-10-27 12:24:54,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:24:54 INFO - 2015-10-27 12:24:54,908 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:24:54 INFO - 2015-10-27 12:24:54,911 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3362.6637336266367;3402.9829850850742;3429.5370125033114;3430.9313813723725;3456.9827150864244;5789.363170051296;5790.797322093727;5791.652500849941;5792;5795.652260864345;5783.971080144604;5811.0702287633985;5836.766529338832;5839.824805255838;5873.618214816034;5113.054084994288;5224.138017227153;5269.473052694738;5281.63028587999;5377.516023557879;5164.457731938149;5224.164133738603;5239.580833533309;5258;5314.787408503656;5288.497592728685;5299.60252981026;5305.495977882095;5308;5318.973405132969;5099.3370861787735;5290.074237008546;5309.681419114865;5361.249425080492;5388.299521062276;5168.457311982263;5191.325127733408;5272.340957380327;5283.788648454057;5302.310699609065;5581.553475721973;5630.408807075239;5631.8592035199035;5649.8587535311535;5661.405552416978;6071.635701857903;6176.938230617726;6290.339514350973;6305.873882522324;6310.305866354697;6175.505959523227;6290;6292.370762923717;6293.056041593752;6303.779367722108;5865.882682346371;5891.558133140032;5898;5903.409659034062;5910.143029260733;6125.877482450415;6208.068789681493;6231.158793562811;6428.550001499943;6440.130582371414;6143.907841382383;6156.969215153896;6184.81445556634;6189.752409903554;6194.81415557534;6266.216722909637;6279.309275979638;6285.528585356116;6288.119663247149;6297.653629050446;6039.516838652898;6130.264368275835;6157.415045570753;6213.875722485615;6252.155958945576;6289.0880822280515;6289.559730818799;6293.527985401113;6294.559380843297;6300.30696623371;4741.691790033637;4748.905021899612;4752.619790416758;4754.334393184957;4758.524147585283;4099.1801639672185;4135.8966025848995;4165.312723400665;4183.644390226865;4202.054537728986;5839.211706419664;5843.5325173985975;5845.035569131046;5851.561132915049;5866.941330586639;6087.4521293083835;6292.937070629327;6295.527835412362;6299.244090709144;6300.558960872787;5750.2524671793235;5822.534197264294;5833.82498525045;5850.678212698257;5856.1508581255475;5375.6774593524515;5429.511343979061;5462.071447853795;5465.316835395575;5468.562514998791;6135.055103640796;6264.655443950626;6515.934840651627;6532.248791388956;6537.280899101095;6167.167432396569;6249.1563638908165;6268.592541484789;6273.153124328157;6280.560360774702;6420.518461115528;6455.644939528371;6467.773627923;6470.352964703492;6489.994050922114;5899;6034.185384972972;6046.97201475759;6199.132121502903;6204.7828326008375;6278.843028924313;6334.556581039283;6347.650879201688;6348.93651063502;6357.841053973688;6150.846228844136;6183.84540386494;6186.443220110212;6189.288231853215;6199.504039676905;5866.325372582037;5993.940060599338;6015.368386319374;6107.114468401968;6176;5996.370381110095;6063;6067.211262535842;6067.484263837623;6075.908861367171;6124.448799608057;6207.286162091417;6213.03697926822;6214.533909956681;6228.439440450381;5729.341125770589;5869.442402971711;5980.34216236205;6079.361667024898;6095.847603809941 12:24:54 INFO - 2015-10-27 12:24:54,915 DEBUG : BROWSER_OUTPUT: |1;ext.html;572.8281515545335;614.6772944204289;620.5780069552703;626.5989766549409;634.5050860328943;43278.78360608197;44189.558104418946;44215.55784442154;44237.336439953346;44258.77870610647;47739;48200;48212.276815847705;48230.517694823044;48241.758791206;7816.921830781676;7928.246816552418;9200.40197387171;9335.299852511054;10419.687409377731;10223.437710925897;10294.639687610936;10299.53652085658;10299.691009269734;10309;10569.894301056967;10578.894211057906;10674.519646615881;10676.572937082507;10677.41274229917;8068.394870384715;8270.917290827105;11091.223614346958;11442.885571144265;11446.599369022128;10812.026917577456;10947.781044379148;10948.890511094867;10956.397398143099;10960.232783705143;42670.146597067884;43024.78487607542;43043.1391372174;43111.35332970008;43162.56837431617;3907;4410.933835992462;4467.932981005288;4558.5897269245925;4563.06457176278;33727.83136084329;34018.48972265418;34056.6594334056;34167.829160854286;34192;3820.4888154094465;3854.1520865409566;3867.245887052026;3872.341701910682;3931.6264954829244;345904;347197;350129;350806;351027;59328.40671593315;60381.09428358578;66208;66681;69589.65205173942;67913.66043169852;67924.32075679279;68187.65906170437;68275.65862170658;68428;17133.485995420157;17351.65296694059;17370.739438908426;17372.913135434494;17416.303347866196;13098.410571524304;13166.407511661999;13171.209727416386;13172;13173.47306107764;21232.469188270417;21400.571988560452;21449.356519304445;21566.137354505958;21672.891635542037;8393.412461127662;8578.91421085781;8620.52587107715;8704.956475217583;8754.424203643406;1056.7992081504644;1075.317083875735;1159.8724140344555;1178.3106882473849;1274.5539061328645;31475.685243147735;31746.206344841565;31889.840550797097;31953.201169970936;32681.50977735336;1201.6515210588832;1225.914186006971;1241.366902879538;1241.7081985733346;1335.8931285497138;13728.862711372958;16252.51242462728;16604.418845340355;16670.91664541694;17068.743968840477;314648;317975;319237;319991;320019;54631;54674;54726.17910731342;54849.45150548523;54904;1381.2679279981426;1384.7576674081995;1490.7912892195102;1525.6109692028463;1526.221626970231;29710;30232.395352093274;31653.84173079212;32028.19929501781;32978.26464100702;49029.2839750607;49676.751616243135;54425.72787136039;55988.16017759818;56069.43930560805;577658;581719;583833;587076;587159;35777.64222357847;35914.10214744652;35967.64032359748;36001.81999089988;36376;49388.50611493983;50020;50316;50504.49495504998;50893.491065090355;40174.19651606893;40636.3904541438;41705;41735.37396939109;42426.575734242266;41867.581324186365;42011;42679;42746.1450770989;42846.57153428426;42043.15913681648;42981.1403771929;43095.56904431041;43257.053432596236;43375.78312108419;35797.82101089478;37085.3311600984;37563.62436375601;37875.0423635903;38086.23827523379;27729.722702772713;29229.85385073061;29281.41437171202;29389;29458.558121628623 12:24:54 INFO - 2015-10-27 12:24:54,915 DEBUG : BROWSER_OUTPUT: |2;jquery.html;408.7670028083991;410.3741793764511;412.18798966036894;415.3230234717412;419.1323959404034;15113.773293400607;15565.455209067684;18956.62086758264;19044.523886902818;19349.226030958762;18605;19020.61958760824;19561.41315760526;19578.510537236576;19865.304714334965;5801.477866991981;5932.584719069667;5940.07928771039;5942.465178133967;5942.97028514859;3999.560048394674;5879.353271140171;6263.154474146;6525.412712855842;6531.346865313478;6360.268569114564;6432.614043157426;6457;6484.93515064848;6516.771912983047;6409.134766806468;6457.773977910751;6473.93526064738;6495.902561461582;6500.577462464948;5709.800156994485;5752.165935939307;5775.5668324875805;5781.335146458169;5786.450287222707;13946.163230206119;23932;24189.87905060481;24491.387715307083;24590.631140532907;2279.111146652807;2287.7597852225445;2305.5388922215457;2307.953840923189;2385.546746118232;9894.851577226347;9965.152961998167;10065.194784417303;10252.179825613934;10319.638812641597;1842.3735929783804;1854.4343975087593;1859.191251805469;1860.8232217939274;1884.2463014794055;72721;73085.6345718268;73384.63307683427;73859;74644.25355746482;7614.581198034161;7643;7660.1573826879;7679.769606911802;7683.039620047494;9056.411333263317;9147.908520914705;9192.494412807226;9196.310276729271;9210.769730756785;5859.2382990211;5875.383084776123;5881.2942446906645;5910.408959104056;5928.614640048383;5939.792107276225;5973.970130149409;5976.551758618121;6029.427204415573;6030.306514750772;3411.403004474207;3462.6537346265677;3466.0468371197617;3487.4245749451056;3489.581250249986;1192.421675487388;1197.8083506638895;1201.6815543880878;1246.4764798784531;1310.678883673506;530.8991291654573;542.3518894920533;548.3912856729028;553.0818840724459;569.2969183058918;11280.605178818867;12550.435230414654;12632.873671263353;12718.682032949251;12763.425645845959;554.4898693202264;556.9832905012856;574.2420005592578;583.107844997155;590.7046476761619;6674;6728.601511210207;6783.491238157158;6785.592864428051;6883.449324054063;568577;570126;619690;623934;637775;89639.55180224057;90573;92262;92605.5369723147;92861.53569232246;594.9970250148722;600.198734689186;601.4797200421604;604.5163868904858;608.5587948737218;11249.325040497597;11488.19582629208;11655.650330490098;11715.297082175097;11741.11941604366;37664.43503347397;38161.6183838158;38284.425733614575;40618.390724139754;42305;51574;52728.209076864645;53507;53814;55066;7471.103467583707;7614.733484328022;7631.503952243309;7636.885446718415;7639.541627502145;11292.435378230892;11598.47806848677;12870.16343937641;12959.740805184032;13295.401706923018;11145.777084458428;11160.441977901235;11245.71885702864;11418.828717569077;11674.533018679158;11110.555577776799;11294.096472282363;11360.659180224606;11395.202335836411;11459.083273337947;11361.943190283995;11715.648530544097;11721.413929303671;11798.705032374259;11816.527338906348;7309.122905251191;7456.291652293024;7515.060617422822;7558.811029724301;7595.278448547379;10744.946275268574;11747.47136378848;11894.762104758029;11925;11997.160198786001 12:24:54 INFO - 2015-10-27 12:24:54,916 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1537.2390666620024;1648.4092850399365;1838.0350316084055;2000.58987907479;2019.6970454431842;9005.27957763379;10425;10542.736431589214;10581.047705706485;10586.841197382046;10007.199424046077;10081.44552049637;10114.595416183362;10137.49312534374;10198.286119971604;2193.0679461228992;2226.3766145479212;2457.225973818246;2477.838940468873;2512.5477414065463;2545.592705167174;2548.2355293411997;2581.406276556393;2582.8062895282833;2590.313566904772;2521.508305880345;2567.2298310506867;2569.4604133132066;2569.961450578243;2573.1122762646855;2204.0742887987085;2237.5413040326694;2469.802415806731;2508.8871000804825;2529.4941011797714;2524.8737563121954;2556.629288753139;2570.8071894607792;2605.71337152913;2610.2430295214367;10420.270581059329;10432.061114499656;10497.635307410064;10508.422036787973;10551.947240263826;5729.140628905656;5808.12878068289;5809.7676092956235;5817.650940943557;5820.738066787005;3815.0398500700226;3816.122291872885;3919.274934137165;3940.8817735467983;3951.7354446577106;1190.4761904761963;1209.848768903887;1211.3943028485758;1219.408586835384;1223.0399136677754;16466.42367517131;16653.666926661397;16690.83309166905;16708.916455417646;16713.832861671348;5343.866403339947;5346;5387.138057910715;5389.649672771257;5392.946070539245;13303.733925321632;13398.06213565041;13440.798388024188;13442;13459.798103028463;5916.171735956969;5918.201042859159;5930.555208359304;5931.228940237742;5933.050711886164;5305.522502974751;5334.75993580282;5336.546393556591;5343.866403339947;5350.812721554805;4355.041890784022;4355.73865568067;4365.563443655609;4374.759388233614;4405.361222622766;1269.397036407699;1275.5726831511547;1285.1132718424258;1290.1549485087282;1298.1237664576374;1241.6150993192139;1263.6524955637274;1291.8643542428097;1565.8512441318057;1566.3891082477842;10114.190864730952;10356.17150627948;10380.650515432946;10382.688519344432;10383.792324153475;1218.0864351736197;1257.2268055146203;1261.949522019109;1287.459267107817;1295.1193188631632;7696.307332340116;7711.383089352838;7768.728094516778;7784.3772498200005;7799.415043871732;13864.861351386558;14063.507777227747;14074.577762667137;14078.296085195903;14093;13360.131591446525;13809.24049177305;13821.101628394123;13847.584572462842;13855.099418537762;9619.903800961902;9796.216302695768;9873.901260987443;9876.160526355341;9932.900670993198;9518.95240523793;9574.56914438838;9590.952045239728;9615.855762163434;9621.711348659552;11596.246243994114;11803.114766392384;11803.350815705218;11822.82265765997;11900.285982841056;11801.940990295338;11958.701032474257;12117.636470905887;12124.75750485003;12145.878541214475;9484.715458536255;9583.952080239555;9609.615615375586;9615;9616.51917404141;10173.186145108522;10198.235132365251;10248.64129755455;10503.579856805947;10601.575936962436;8413;9737.707868763948;9845.901540984498;9847.901520984698;9855.211583073193;8405.70580029696;9442.15020648145;9561.760955976157;9589.089036541518;9728.12446879756;9654.806903862023;9708.417494950043;9742;9800.65697700577;9819.45992970365;8704.956475217583;8824.3381746368;8849.513276769581;8867.645294188418;8874.911250887666;8787.780305492413;8820.898282298762;8885.822283554422;8890.822183556422;8892.33307501953 12:24:54 INFO - 2015-10-27 12:24:54,917 DEBUG : BROWSER_OUTPUT: |4;prototype.html;389.61428186095776;389.8050974512744;391.4558763318986;398.219489799992;402.863026570966;5822.854428639286;5935.643861368316;5940.227770389849;5961.523078153748;5975.133605627187;5751.482366587006;5890.587658863881;5891.351951285366;5891.558133140021;5907.822765317047;4503.166914120881;4538.432695913011;4601.6548758843055;4689.835855745041;4691.929621055687;4666.883327916796;4674.252119660855;4676.906461870761;4704.694194877322;4706.623470122382;4648.209804333272;4653.069386122772;4654.534546545336;4659.650526210531;4665.463471700747;4639.814407423699;4646.4888862225125;4648.395708557883;4648.930266045995;4652.441706995149;4101.46680931477;4168.958310416887;4187.623113919732;4211.831526738927;4213.641840443566;5672.8014519492035;5677.602567820254;5681.062624666925;5681.886362272731;5700.486956173922;5170.870728231786;5465.180222966586;5492;5492.725363731797;5501.284832971688;5961.5230781537375;6141.048137538689;6157.384261573807;6167.044108163197;6168.19813424252;4590.472095709003;4598.954010459886;4620.237660786;4630.560096790833;4635.420572428447;6383.87232255357;6425.004124360778;6460.676966151674;6461.0631458438265;6463.515236357292;4635.258358662598;4700.623950083985;4714.976425117852;4743.359646447685;4819.638527110481;4841.467438581753;4851.58761505276;4861.927071093936;4862.1005114053305;4875.585575226075;5463.863403414946;5475.370332411744;5481.451854814487;5486.451354864482;5488.121900495981;6186.752529898754;6324.873502529924;6326.304106548276;6332.588381755171;6342.302346741854;1756.6223261998732;1764.9911750441165;1765.0468746876543;1777.5289548269718;1779.359430604981;1229.5757963502576;1248.9687757806128;1258.8237646729465;1262.9179103358251;1266.8479782425984;6071.726772295169;6073.210482637317;6117.510599152057;6124.11200375943;6132.6933653317155;6518.967405162944;6533.738650454024;6534.346565343428;6540.37866402691;6541.084248205255;5999.610025348338;6091.0558863376245;6114.174586430864;6118.969405152946;6119.969400152971;3585.1933315003917;3603.819809009539;3606.026372879308;3607.8376473058775;3611.7110631149444;6713.731450741916;6715.832104197434;6723.731050757915;6729.22613899398;6729.22613899398;6413.390727880844;6614.536982411185;6640.501962352843;6671.366220209073;6677.799666010027;6411.1024456576115;6469.126667899774;6620.602763834186;6628.734850606018;6690.69891854858;6455.870882582228;6466.385693359123;6476.384743449365;6477.676116194078;6492.642904640101;6367.204099487564;6382.521310901794;6391.073294372383;6394;6401.807945761635;6622.37087476689;6710.396064354231;6713.1944166700305;6720.865582688221;6728.360805723449;4573.565511276423;4599.724016559017;4600.401947746772;4601.332806742937;4602.585767280961;6449.484041276781;6491.28595854465;6502.512311576556;6510.3489651034515;6511.869762604816;6218.844528886814;6299.338569450142;6300.716467759054;6315.400036996478;6318.399752023551;6310.873782524415;6321.431071203614;6324.462420694109;6327.3356297589935;6332.52506062038;6220.968895155495;6227.314995350417;6230.968845155745;6234.501239900706;6240.12638230639;6267.435930766253;6344.460720838781;6347.619142851444;6348.047792830927;6353.777617783356;6196.256449226122;6200.286966998853;6206;6261;6270.874582508415 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: |5;yui.html;852.8678054901493;868.5743985447131;898.3531857062912;932.0725877751638;945.9621615135395;13848.961327900397;14111.717765644707;14133.363998620061;14133.64665883352;14205.28973551322;13344.733105337888;13427.060105792598;13454.260015699132;13465;13470.797938030937;735.9153697324823;743.045186934789;910.103548005216;925.255169588481;925.4169872980013;942.9905700943006;943.3208090175063;950.2920324358363;950.9001554836747;952.0146648219095;919.4483310014004;989.4310771306491;994.6966175316526;994.7314225159239;995.2933417273745;762.9923700763004;769.9114601820778;925.7176561148847;974.7611835100446;1010.9090181883665;716.3839098375392;719.5323040023974;721.992780072203;722.0577146823446;722.0865605009667;12732.172408793398;12844.550440734529;12873.291968941705;12879.098463107586;12884.098113132084;12578.81131783024;12663;12835.358232088452;12961.870381296161;13318.267495287755;10812.783744325148;10877.292975956538;10931.617393391272;10965.396903170322;11220.046296064762;3839.1361943562756;3884.941725874086;3900.0444891001603;3907.765534067965;3911.5110611173604;42783.144337113394;42797.99999999969;43039.78480107611;46423.303650444934;46687.76656116698;10322.432266225429;10385.688429347132;10432.739181520523;10458.215633827342;10561.524731387106;17742.11289435549;17764.289428422977;17780.199891004937;17783.644327113645;18009.819901801075;8416.747497575083;8464.984201895688;8626.48241105523;8670.566471676391;8718.95640521806;4605.424321959755;4616.146012987608;4651.5813576778255;4711.575958163713;4790.041991601694;3418.470137128699;3425.794452332868;3436.5017072524843;3450.8274586270586;3464.8787292444645;545.4681685356745;564.7571544236018;569.9230603868425;574.0814696485589;574.2706762411714;706.1667232665401;730.9707611695472;737.7565403416967;741.3142842870324;744.6314074533141;8781.956090219635;9135.269178465707;9362.196053532229;9447.858282125773;9493.620255189853;611.5810669691276;637.9617222966637;641.9358064193543;682.6211452643731;739.6227923758921;4338.175746608134;4625.838095666702;4629.189891768927;4659.8136074557315;4744.786484608201;50252.246216306055;50288;50341.24488132681;50393;50419.24371134436;44310;44767.32849007267;44994.325085123746;45235;45305;39031.80484097618;40225.396619050734;40650;40658.39012414816;40903.97740056582;8718.607662655322;8822.117788221127;9018.368714189945;9225.769355766159;9371.625134994523;28237.43525129527;28374.85812570924;28829.135125946254;29027.709722902502;29034.27414314659;37986.050348741504;38461.80769096137;39914;40111.59888401079;40168;8758;9044.14080662336;9119.814424125087;9209.723708288762;9274.768130796783;12705.618831435071;12711.61865144047;12734.235945843278;12951.546695865976;13133.802992955305;12176.57381991626;12314.568990085305;12364.62906112818;12374.566890159162;12378.133530653127;11705.824412633647;11716.70708232301;11802;12111.75776484483;12546.1844980076;10114.821195614159;11693.473793679135;12046.698832529257;12073.154879158375;12551.435185416496;9970.30207885441;10032.347897386646;10043.246756493147;10100;10226.948865255627;10094.32269128759;10098.54556544972;10136.847947280648;10194.133498652402;10426.27016108865 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,870 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: __startTimestamp1445973894906__endTimestamp 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,919 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5781.80 Median:6015.37 stddev:667.41 (11.1%) stddev-sans-first:641.91 12:24:54 INFO - 2015-10-27 12:24:54,920 DEBUG : BROWSER_OUTPUT: Values: 3362.7 3403.0 3429.5 3430.9 3457.0 5789.4 5790.8 5791.7 5792.0 5795.7 5784.0 5811.1 5836.8 5839.8 5873.6 5113.1 5224.1 5269.5 5281.6 5377.5 5164.5 5224.2 5239.6 5258.0 5314.8 5288.5 5299.6 5305.5 5308.0 5319.0 5099.3 5290.1 5309.7 5361.2 5388.3 5168.5 5191.3 5272.3 5283.8 5302.3 5581.6 5630.4 5631.9 5649.9 5661.4 6071.6 6176.9 6290.3 6305.9 6310.3 6175.5 6290.0 6292.4 6293.1 6303.8 5865.9 5891.6 5898.0 5903.4 5910.1 6125.9 6208.1 6231.2 6428.6 6440.1 6143.9 6157.0 6184.8 6189.8 6194.8 6266.2 6279.3 6285.5 6288.1 6297.7 6039.5 6130.3 6157.4 6213.9 6252.2 6289.1 6289.6 6293.5 6294.6 6300.3 4741.7 4748.9 4752.6 4754.3 4758.5 4099.2 4135.9 4165.3 4183.6 4202.1 5839.2 5843.5 5845.0 5851.6 5866.9 6087.5 6292.9 6295.5 6299.2 6300.6 5750.3 5822.5 5833.8 5850.7 5856.2 5375.7 5429.5 5462.1 5465.3 5468.6 6135.1 6264.7 6515.9 6532.2 6537.3 6167.2 6249.2 6268.6 6273.2 6280.6 6420.5 6455.6 6467.8 6470.4 6490.0 5899.0 6034.2 6047.0 6199.1 6204.8 6278.8 6334.6 6347.7 6348.9 6357.8 6150.8 6183.8 6186.4 6189.3 6199.5 5866.3 5993.9 6015.4 6107.1 6176.0 5996.4 6063.0 6067.2 6067.5 6075.9 6124.4 6207.3 6213.0 6214.5 6228.4 5729.3 5869.4 5980.3 6079.4 6095.8 12:24:54 INFO - 2015-10-27 12:24:54,920 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,920 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59532.40 Median:37324.48 stddev:114969.06 (308.0%) stddev-sans-first:115206.35 12:24:54 INFO - 2015-10-27 12:24:54,921 DEBUG : BROWSER_OUTPUT: Values: 572.8 614.7 620.6 626.6 634.5 43278.8 44189.6 44215.6 44237.3 44258.8 47739.0 48200.0 48212.3 48230.5 48241.8 7816.9 7928.2 9200.4 9335.3 10419.7 10223.4 10294.6 10299.5 10299.7 10309.0 10569.9 10578.9 10674.5 10676.6 10677.4 8068.4 8270.9 11091.2 11442.9 11446.6 10812.0 10947.8 10948.9 10956.4 10960.2 42670.1 43024.8 43043.1 43111.4 43162.6 3907.0 4410.9 4467.9 4558.6 4563.1 33727.8 34018.5 34056.7 34167.8 34192.0 3820.5 3854.2 3867.2 3872.3 3931.6 345904.0 347197.0 350129.0 350806.0 351027.0 59328.4 60381.1 66208.0 66681.0 69589.7 67913.7 67924.3 68187.7 68275.7 68428.0 17133.5 17351.7 17370.7 17372.9 17416.3 13098.4 13166.4 13171.2 13172.0 13173.5 21232.5 21400.6 21449.4 21566.1 21672.9 8393.4 8578.9 8620.5 8705.0 8754.4 1056.8 1075.3 1159.9 1178.3 1274.6 31475.7 31746.2 31889.8 31953.2 32681.5 1201.7 1225.9 1241.4 1241.7 1335.9 13728.9 16252.5 16604.4 16670.9 17068.7 314648.0 317975.0 319237.0 319991.0 320019.0 54631.0 54674.0 54726.2 54849.5 54904.0 1381.3 1384.8 1490.8 1525.6 1526.2 29710.0 30232.4 31653.8 32028.2 32978.3 49029.3 49676.8 54425.7 55988.2 56069.4 577658.0 581719.0 583833.0 587076.0 587159.0 35777.6 35914.1 35967.6 36001.8 36376.0 49388.5 50020.0 50316.0 50504.5 50893.5 40174.2 40636.4 41705.0 41735.4 42426.6 41867.6 42011.0 42679.0 42746.1 42846.6 42043.2 42981.1 43095.6 43257.1 43375.8 35797.8 37085.3 37563.6 37875.0 38086.2 27729.7 29229.9 29281.4 29389.0 29458.6 12:24:54 INFO - 2015-10-27 12:24:54,921 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,921 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30708.37 Median:27807.20 stddev:99269.04 (357.0%) stddev-sans-first:99521.45 12:24:54 INFO - 2015-10-27 12:24:54,921 DEBUG : BROWSER_OUTPUT: Values: 408.8 410.4 412.2 415.3 419.1 15113.8 15565.5 18956.6 19044.5 19349.2 18605.0 19020.6 19561.4 19578.5 19865.3 5801.5 5932.6 5940.1 5942.5 5943.0 3999.6 5879.4 6263.2 6525.4 6531.3 6360.3 6432.6 6457.0 6484.9 6516.8 6409.1 6457.8 6473.9 6495.9 6500.6 5709.8 5752.2 5775.6 5781.3 5786.5 13946.2 23932.0 24189.9 24491.4 24590.6 2279.1 2287.8 2305.5 2308.0 2385.5 9894.9 9965.2 10065.2 10252.2 10319.6 1842.4 1854.4 1859.2 1860.8 1884.2 72721.0 73085.6 73384.6 73859.0 74644.3 7614.6 7643.0 7660.2 7679.8 7683.0 9056.4 9147.9 9192.5 9196.3 9210.8 5859.2 5875.4 5881.3 5910.4 5928.6 5939.8 5974.0 5976.6 6029.4 6030.3 3411.4 3462.7 3466.0 3487.4 3489.6 1192.4 1197.8 1201.7 1246.5 1310.7 530.9 542.4 548.4 553.1 569.3 11280.6 12550.4 12632.9 12718.7 12763.4 554.5 557.0 574.2 583.1 590.7 6674.0 6728.6 6783.5 6785.6 6883.4 568577.0 570126.0 619690.0 623934.0 637775.0 89639.6 90573.0 92262.0 92605.5 92861.5 595.0 600.2 601.5 604.5 608.6 11249.3 11488.2 11655.7 11715.3 11741.1 37664.4 38161.6 38284.4 40618.4 42305.0 51574.0 52728.2 53507.0 53814.0 55066.0 7471.1 7614.7 7631.5 7636.9 7639.5 11292.4 11598.5 12870.2 12959.7 13295.4 11145.8 11160.4 11245.7 11418.8 11674.5 11110.6 11294.1 11360.7 11395.2 11459.1 11361.9 11715.6 11721.4 11798.7 11816.5 7309.1 7456.3 7515.1 7558.8 7595.3 10744.9 11747.5 11894.8 11925.0 11997.2 12:24:54 INFO - 2015-10-27 12:24:54,921 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,921 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7396.89 Median:2537.54 stddev:4290.67 (169.1%) stddev-sans-first:4280.10 12:24:54 INFO - 2015-10-27 12:24:54,922 DEBUG : BROWSER_OUTPUT: Values: 1537.2 1648.4 1838.0 2000.6 2019.7 9005.3 10425.0 10542.7 10581.0 10586.8 10007.2 10081.4 10114.6 10137.5 10198.3 2193.1 2226.4 2457.2 2477.8 2512.5 2545.6 2548.2 2581.4 2582.8 2590.3 2521.5 2567.2 2569.5 2570.0 2573.1 2204.1 2237.5 2469.8 2508.9 2529.5 2524.9 2556.6 2570.8 2605.7 2610.2 10420.3 10432.1 10497.6 10508.4 10551.9 5729.1 5808.1 5809.8 5817.7 5820.7 3815.0 3816.1 3919.3 3940.9 3951.7 1190.5 1209.8 1211.4 1219.4 1223.0 16466.4 16653.7 16690.8 16708.9 16713.8 5343.9 5346.0 5387.1 5389.6 5392.9 13303.7 13398.1 13440.8 13442.0 13459.8 5916.2 5918.2 5930.6 5931.2 5933.1 5305.5 5334.8 5336.5 5343.9 5350.8 4355.0 4355.7 4365.6 4374.8 4405.4 1269.4 1275.6 1285.1 1290.2 1298.1 1241.6 1263.7 1291.9 1565.9 1566.4 10114.2 10356.2 10380.7 10382.7 10383.8 1218.1 1257.2 1261.9 1287.5 1295.1 7696.3 7711.4 7768.7 7784.4 7799.4 13864.9 14063.5 14074.6 14078.3 14093.0 13360.1 13809.2 13821.1 13847.6 13855.1 9619.9 9796.2 9873.9 9876.2 9932.9 9519.0 9574.6 9591.0 9615.9 9621.7 11596.2 11803.1 11803.4 11822.8 11900.3 11801.9 11958.7 12117.6 12124.8 12145.9 9484.7 9584.0 9609.6 9615.0 9616.5 10173.2 10198.2 10248.6 10503.6 10601.6 8413.0 9737.7 9845.9 9847.9 9855.2 8405.7 9442.2 9561.8 9589.1 9728.1 9654.8 9708.4 9742.0 9800.7 9819.5 8705.0 8824.3 8849.5 8867.6 8874.9 8787.8 8820.9 8885.8 8890.8 8892.3 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5330.44 Median:5987.37 stddev:1523.00 (25.4%) stddev-sans-first:1481.44 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: Values: 389.6 389.8 391.5 398.2 402.9 5822.9 5935.6 5940.2 5961.5 5975.1 5751.5 5890.6 5891.4 5891.6 5907.8 4503.2 4538.4 4601.7 4689.8 4691.9 4666.9 4674.3 4676.9 4704.7 4706.6 4648.2 4653.1 4654.5 4659.7 4665.5 4639.8 4646.5 4648.4 4648.9 4652.4 4101.5 4169.0 4187.6 4211.8 4213.6 5672.8 5677.6 5681.1 5681.9 5700.5 5170.9 5465.2 5492.0 5492.7 5501.3 5961.5 6141.0 6157.4 6167.0 6168.2 4590.5 4599.0 4620.2 4630.6 4635.4 6383.9 6425.0 6460.7 6461.1 6463.5 4635.3 4700.6 4715.0 4743.4 4819.6 4841.5 4851.6 4861.9 4862.1 4875.6 5463.9 5475.4 5481.5 5486.5 5488.1 6186.8 6324.9 6326.3 6332.6 6342.3 1756.6 1765.0 1765.0 1777.5 1779.4 1229.6 1249.0 1258.8 1262.9 1266.8 6071.7 6073.2 6117.5 6124.1 6132.7 6519.0 6533.7 6534.3 6540.4 6541.1 5999.6 6091.1 6114.2 6119.0 6120.0 3585.2 3603.8 3606.0 3607.8 3611.7 6713.7 6715.8 6723.7 6729.2 6729.2 6413.4 6614.5 6640.5 6671.4 6677.8 6411.1 6469.1 6620.6 6628.7 6690.7 6455.9 6466.4 6476.4 6477.7 6492.6 6367.2 6382.5 6391.1 6394.0 6401.8 6622.4 6710.4 6713.2 6720.9 6728.4 4573.6 4599.7 4600.4 4601.3 4602.6 6449.5 6491.3 6502.5 6510.3 6511.9 6218.8 6299.3 6300.7 6315.4 6318.4 6310.9 6321.4 6324.5 6327.3 6332.5 6221.0 6227.3 6231.0 6234.5 6240.1 6267.4 6344.5 6347.6 6348.0 6353.8 6196.3 6200.3 6206.0 6261.0 6270.9 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13035.05 Median:42790.57 stddev:13841.84 (32.3%) stddev-sans-first:13850.44 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: Values: 852.9 868.6 898.4 932.1 946.0 13849.0 14111.7 14133.4 14133.6 14205.3 13344.7 13427.1 13454.3 13465.0 13470.8 735.9 743.0 910.1 925.3 925.4 943.0 943.3 950.3 950.9 952.0 919.4 989.4 994.7 994.7 995.3 763.0 769.9 925.7 974.8 1010.9 716.4 719.5 722.0 722.1 722.1 12732.2 12844.6 12873.3 12879.1 12884.1 12578.8 12663.0 12835.4 12961.9 13318.3 10812.8 10877.3 10931.6 10965.4 11220.0 3839.1 3884.9 3900.0 3907.8 3911.5 42783.1 42798.0 43039.8 46423.3 46687.8 10322.4 10385.7 10432.7 10458.2 10561.5 17742.1 17764.3 17780.2 17783.6 18009.8 8416.7 8465.0 8626.5 8670.6 8719.0 4605.4 4616.1 4651.6 4711.6 4790.0 3418.5 3425.8 3436.5 3450.8 3464.9 545.5 564.8 569.9 574.1 574.3 706.2 731.0 737.8 741.3 744.6 8782.0 9135.3 9362.2 9447.9 9493.6 611.6 638.0 641.9 682.6 739.6 4338.2 4625.8 4629.2 4659.8 4744.8 50252.2 50288.0 50341.2 50393.0 50419.2 44310.0 44767.3 44994.3 45235.0 45305.0 39031.8 40225.4 40650.0 40658.4 40904.0 8718.6 8822.1 9018.4 9225.8 9371.6 28237.4 28374.9 28829.1 29027.7 29034.3 37986.1 38461.8 39914.0 40111.6 40168.0 8758.0 9044.1 9119.8 9209.7 9274.8 12705.6 12711.6 12734.2 12951.5 13133.8 12176.6 12314.6 12364.6 12374.6 12378.1 11705.8 11716.7 11802.0 12111.8 12546.2 10114.8 11693.5 12046.7 12073.2 12551.4 9970.3 10032.3 10043.2 10100.0 10226.9 10094.3 10098.5 10136.8 10194.1 10426.3 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:24:54 INFO - 2015-10-27 12:24:54,923 DEBUG : BROWSER_OUTPUT: 12:24:55 INFO - 2015-10-27 12:24:55,541 INFO : Browser exited with error code: 0 12:24:55 INFO - 2015-10-27 12:24:55,567 INFO : Completed test dromaeo_css (00:18:33) 12:24:55 INFO - 2015-10-27 12:24:55,567 INFO : Starting test kraken 12:24:55 INFO - 2015-10-27 12:24:55,567 DEBUG : operating with platform_type : linux_ 12:24:55 INFO - 2015-10-27 12:24:55,568 INFO : Initialising browser for kraken test... 12:24:55 INFO - 2015-10-27 12:24:55,573 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_rAxXm/profile http://localhost/getInfo.html 12:24:59 INFO - 2015-10-27 12:24:59,227 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:24:59 INFO - 2015-10-27 12:24:59,227 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:24:59 INFO - 2015-10-27 12:24:59,227 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:24:59 INFO - 2015-10-27 12:24:59,227 DEBUG : BROWSER_OUTPUT: __metrics 12:24:59 INFO - 2015-10-27 12:24:59,344 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:25:00 INFO - 2015-10-27 12:25:00,578 INFO : Browser initialized. 12:25:00 INFO - 2015-10-27 12:25:00,578 INFO : Running cycle 1/1 for kraken test... 12:25:00 INFO - 2015-10-27 12:25:00,578 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_rAxXm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:25:12 INFO - 2015-10-27 12:25:12,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 133103616 12:25:12 INFO - 2015-10-27 12:25:12,191 DEBUG : BROWSER_OUTPUT: 12:25:15 INFO - 2015-10-27 12:25:15,089 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) 12:25:15 INFO - 2015-10-27 12:25:15,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 167628800 12:25:15 INFO - 2015-10-27 12:25:15,656 DEBUG : BROWSER_OUTPUT: 12:25:18 INFO - 2015-10-27 12:25:18,173 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) 12:25:18 INFO - 2015-10-27 12:25:18,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 163209216 12:25:18 INFO - 2015-10-27 12:25:18,735 DEBUG : BROWSER_OUTPUT: 12:25:21 INFO - 2015-10-27 12:25:21,533 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) 12:25:22 INFO - 2015-10-27 12:25:22,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 162516992 12:25:22 INFO - 2015-10-27 12:25:22,099 DEBUG : BROWSER_OUTPUT: 12:25:24 INFO - 2015-10-27 12:25:24,051 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) 12:25:24 INFO - 2015-10-27 12:25:24,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 160055296 12:25:24 INFO - 2015-10-27 12:25:24,606 DEBUG : BROWSER_OUTPUT: 12:25:26 INFO - 2015-10-27 12:25:26,707 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) 12:25:27 INFO - 2015-10-27 12:25:27,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 154853376 12:25:27 INFO - 2015-10-27 12:25:27,269 DEBUG : BROWSER_OUTPUT: 12:25:30 INFO - 2015-10-27 12:25:30,067 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) 12:25:30 INFO - 2015-10-27 12:25:30,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 155488256 12:25:30 INFO - 2015-10-27 12:25:30,634 DEBUG : BROWSER_OUTPUT: 12:25:33 INFO - 2015-10-27 12:25:33,941 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) 12:25:34 INFO - 2015-10-27 12:25:34,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 157487104 12:25:34 INFO - 2015-10-27 12:25:34,505 DEBUG : BROWSER_OUTPUT: 12:25:37 INFO - 2015-10-27 12:25:37,153 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) 12:25:37 INFO - 2015-10-27 12:25:37,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 155537408 12:25:37 INFO - 2015-10-27 12:25:37,723 DEBUG : BROWSER_OUTPUT: 12:25:39 INFO - 2015-10-27 12:25:39,191 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) 12:25:39 INFO - 2015-10-27 12:25:39,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 166768640 12:25:40 INFO - 2015-10-27 12:25:39,745 DEBUG : BROWSER_OUTPUT: 12:25:41 INFO - 2015-10-27 12:25:41,439 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) 12:25:42 INFO - 2015-10-27 12:25:42,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 164995072 12:25:42 INFO - 2015-10-27 12:25:42,033 DEBUG : BROWSER_OUTPUT: 12:25:43 INFO - 2015-10-27 12:25:43,993 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) 12:25:44 INFO - 2015-10-27 12:25:44,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 173932544 12:25:44 INFO - 2015-10-27 12:25:44,567 DEBUG : BROWSER_OUTPUT: 12:25:46 INFO - 2015-10-27 12:25:46,820 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) 12:25:47 INFO - 2015-10-27 12:25:47,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 178561024 12:25:47 INFO - 2015-10-27 12:25:47,395 DEBUG : BROWSER_OUTPUT: 12:25:49 INFO - 2015-10-27 12:25:49,790 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) 12:25:50 INFO - 2015-10-27 12:25:50,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 174538752 12:25:50 INFO - 2015-10-27 12:25:50,357 DEBUG : BROWSER_OUTPUT: 12:25:51 INFO - 2015-10-27 12:25:51,938 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) 12:25:52 INFO - 2015-10-27 12:25:52,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 234164224 12:25:52 INFO - 2015-10-27 12:25:52,188 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,189 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:25:52 INFO - 2015-10-27 12:25:52,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:25:52 INFO - 2015-10-27 12:25:52,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:25:52 INFO - 2015-10-27 12:25:52,191 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:25:52 INFO - 2015-10-27 12:25:52,191 DEBUG : BROWSER_OUTPUT: |0;ai-astar;104;110;109;110;109;108;115;109;108;107 12:25:52 INFO - 2015-10-27 12:25:52,191 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;121;147;165;122;145;148;123;156;122 12:25:52 INFO - 2015-10-27 12:25:52,191 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;159;161;158;158;159;160;159;157;158 12:25:52 INFO - 2015-10-27 12:25:52,192 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;70;144;71;71;70;72;152;71 12:25:52 INFO - 2015-10-27 12:25:52,192 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;131;88;88;89;140;88;89;132 12:25:52 INFO - 2015-10-27 12:25:52,192 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;110;110;110 12:25:52 INFO - 2015-10-27 12:25:52,192 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;147;146;145;146;145;146 12:25:52 INFO - 2015-10-27 12:25:52,192 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;95;96;96;95;95 12:25:52 INFO - 2015-10-27 12:25:52,192 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;54;53;53;53;53;52;52;63;52 12:25:52 INFO - 2015-10-27 12:25:52,193 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;60;62;61;60;60;61;61;61;61;61 12:25:52 INFO - 2015-10-27 12:25:52,193 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;78;78;80;78;78;79;79;79;79 12:25:52 INFO - 2015-10-27 12:25:52,193 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;112;112;110;103;107;108;113;115;108 12:25:52 INFO - 2015-10-27 12:25:52,193 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;138;134;139;138;127;138;133;134;135 12:25:52 INFO - 2015-10-27 12:25:52,193 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;61;60;60;60;60;61;60;58;59 12:25:52 INFO - 2015-10-27 12:25:52,193 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:25:52 INFO - 2015-10-27 12:25:52,193 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:25:52 INFO - 2015-10-27 12:25:52,194 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,863 12:25:52 INFO - 2015-10-27 12:25:52,194 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:25:52 INFO - 2015-10-27 12:25:52,194 DEBUG : BROWSER_OUTPUT: __startTimestamp1445973952189__endTimestamp 12:25:52 INFO - 2015-10-27 12:25:52,194 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,197 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:25:52 INFO - 2015-10-27 12:25:52,198 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:25:52 INFO - 2015-10-27 12:25:52,198 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,198 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.90 Median:109.00 stddev:2.77 (2.5%) stddev-sans-first:2.30 12:25:52 INFO - 2015-10-27 12:25:52,198 DEBUG : BROWSER_OUTPUT: Values: 104.0 110.0 109.0 110.0 109.0 108.0 115.0 109.0 108.0 107.0 12:25:52 INFO - 2015-10-27 12:25:52,198 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,198 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.70 Median:147.50 stddev:16.26 (11.0%) stddev-sans-first:16.97 12:25:52 INFO - 2015-10-27 12:25:52,198 DEBUG : BROWSER_OUTPUT: Values: 148.0 121.0 147.0 165.0 122.0 145.0 148.0 123.0 156.0 122.0 12:25:52 INFO - 2015-10-27 12:25:52,199 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,199 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.10 Median:159.00 stddev:1.52 (1.0%) stddev-sans-first:1.20 12:25:52 INFO - 2015-10-27 12:25:52,199 DEBUG : BROWSER_OUTPUT: Values: 162.0 159.0 161.0 158.0 158.0 159.0 160.0 159.0 157.0 158.0 12:25:52 INFO - 2015-10-27 12:25:52,199 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,199 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.10 Median:70.50 stddev:32.69 (46.4%) stddev-sans-first:34.14 12:25:52 INFO - 2015-10-27 12:25:52,199 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 144.0 71.0 71.0 70.0 72.0 152.0 71.0 12:25:52 INFO - 2015-10-27 12:25:52,199 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,200 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:88.50 stddev:22.23 (25.1%) stddev-sans-first:23.05 12:25:52 INFO - 2015-10-27 12:25:52,200 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 131.0 88.0 88.0 89.0 140.0 88.0 89.0 132.0 12:25:52 INFO - 2015-10-27 12:25:52,200 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,200 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:25:52 INFO - 2015-10-27 12:25:52,200 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 12:25:52 INFO - 2015-10-27 12:25:52,200 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 147.0 146.0 145.0 146.0 145.0 146.0 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.00 stddev:3.30 (6.2%) stddev-sans-first:3.48 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: Values: 55.0 54.0 53.0 53.0 53.0 53.0 52.0 52.0 63.0 52.0 12:25:52 INFO - 2015-10-27 12:25:52,201 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: Values: 60.0 62.0 61.0 60.0 60.0 61.0 61.0 61.0 61.0 61.0 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:4.27 (5.4%) stddev-sans-first:0.71 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: Values: 92.0 78.0 78.0 80.0 78.0 78.0 79.0 79.0 79.0 79.0 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:3.67 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: Values: 116.0 112.0 112.0 110.0 103.0 107.0 108.0 113.0 115.0 108.0 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.80 Median:136.50 stddev:3.68 (2.7%) stddev-sans-first:3.76 12:25:52 INFO - 2015-10-27 12:25:52,202 DEBUG : BROWSER_OUTPUT: Values: 132.0 138.0 134.0 139.0 138.0 127.0 138.0 133.0 134.0 135.0 12:25:52 INFO - 2015-10-27 12:25:52,203 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,203 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:0.93 12:25:52 INFO - 2015-10-27 12:25:52,203 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 60.0 60.0 60.0 60.0 61.0 60.0 58.0 59.0 12:25:52 INFO - 2015-10-27 12:25:52,203 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:25:52 INFO - 2015-10-27 12:25:52,203 DEBUG : BROWSER_OUTPUT: 12:25:52 INFO - 2015-10-27 12:25:52,926 INFO : Browser exited with error code: 0 12:25:52 INFO - 2015-10-27 12:25:52,980 INFO : Completed test kraken (00:00:57) 12:25:52 INFO - 2015-10-27 12:25:52,980 INFO : Starting test v8_7 12:25:52 INFO - 2015-10-27 12:25:52,980 DEBUG : operating with platform_type : linux_ 12:25:52 INFO - 2015-10-27 12:25:52,980 INFO : Initialising browser for v8_7 test... 12:25:52 INFO - 2015-10-27 12:25:52,986 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphDwflx/profile http://localhost/getInfo.html 12:25:56 INFO - 2015-10-27 12:25:56,578 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:25:56 INFO - 2015-10-27 12:25:56,579 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:25:56 INFO - 2015-10-27 12:25:56,579 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:25:56 INFO - 2015-10-27 12:25:56,579 DEBUG : BROWSER_OUTPUT: __metrics 12:25:56 INFO - 2015-10-27 12:25:56,727 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:25:58 INFO - 2015-10-27 12:25:58,006 INFO : Browser initialized. 12:25:58 INFO - 2015-10-27 12:25:58,007 INFO : Running cycle 1/1 for v8_7 test... 12:25:58 INFO - 2015-10-27 12:25:58,007 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphDwflx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:26:09 INFO - 2015-10-27 12:26:09,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 132100096 12:26:09 INFO - 2015-10-27 12:26:09,692 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,125 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) 12:26:31 INFO - 2015-10-27 12:26:31,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 427978752 12:26:31 INFO - 2015-10-27 12:26:31,376 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,376 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:26:31 INFO - 2015-10-27 12:26:31,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:26:31 INFO - 2015-10-27 12:26:31,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:26:31 INFO - 2015-10-27 12:26:31,376 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:26:31 INFO - 2015-10-27 12:26:31,377 DEBUG : BROWSER_OUTPUT: |0;Richards;168.35016835016836 12:26:31 INFO - 2015-10-27 12:26:31,377 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.74464579901152 12:26:31 INFO - 2015-10-27 12:26:31,377 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.5315315315315 12:26:31 INFO - 2015-10-27 12:26:31,377 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5096.446700507614 12:26:31 INFO - 2015-10-27 12:26:31,377 DEBUG : BROWSER_OUTPUT: |4;RayTrace;959.6928982725528 12:26:31 INFO - 2015-10-27 12:26:31,378 DEBUG : BROWSER_OUTPUT: |5;Earley;537.345513164965 12:26:31 INFO - 2015-10-27 12:26:31,378 DEBUG : BROWSER_OUTPUT: |6;Boyer;10242.424242424242 12:26:31 INFO - 2015-10-27 12:26:31,378 DEBUG : BROWSER_OUTPUT: |7;RegExp;23159.090909090908 12:26:31 INFO - 2015-10-27 12:26:31,378 DEBUG : BROWSER_OUTPUT: |8;Splay;526.3157894736842 12:26:31 INFO - 2015-10-27 12:26:31,378 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4807.692307692308 12:26:31 INFO - 2015-10-27 12:26:31,378 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:26:31 INFO - 2015-10-27 12:26:31,378 DEBUG : BROWSER_OUTPUT: __startTimestamp1445973991374__endTimestamp 12:26:31 INFO - 2015-10-27 12:26:31,379 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,379 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:26:31 INFO - 2015-10-27 12:26:31,379 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:26:31 INFO - 2015-10-27 12:26:31,379 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,379 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.35 Median:168.35 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,380 DEBUG : BROWSER_OUTPUT: Values: 168.4 12:26:31 INFO - 2015-10-27 12:26:31,380 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,380 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.74 Median:164.74 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,380 DEBUG : BROWSER_OUTPUT: Values: 164.7 12:26:31 INFO - 2015-10-27 12:26:31,380 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,380 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,380 DEBUG : BROWSER_OUTPUT: Values: 281.5 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5096.45 Median:5096.45 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: Values: 5096.4 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:959.69 Median:959.69 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: Values: 959.7 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:537.35 Median:537.35 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,381 DEBUG : BROWSER_OUTPUT: Values: 537.3 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10242.42 Median:10242.42 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: Values: 10242.4 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23159.09 Median:23159.09 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: Values: 23159.1 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:526.32 Median:526.32 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: Values: 526.3 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4807.69 Median:4807.69 stddev:0.00 (0.0%) 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: Values: 4807.7 12:26:31 INFO - 2015-10-27 12:26:31,382 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:26:31 INFO - 2015-10-27 12:26:31,383 DEBUG : BROWSER_OUTPUT: 12:26:32 INFO - 2015-10-27 12:26:32,177 INFO : Browser exited with error code: 0 12:26:32 INFO - 2015-10-27 12:26:32,192 INFO : Completed test v8_7 (00:00:39) 12:26:32 INFO - 2015-10-27 12:26:32,192 INFO : Completed test suite (00:20:09) 12:26:32 INFO - 2015-10-27 12:26:32,192 DEBUG : Working with test: dromaeo_css 12:26:32 INFO - 2015-10-27 12:26:32,192 DEBUG : Generating results file: dromaeo_css 12:26:32 INFO - 2015-10-27 12:26:32,193 DEBUG : Working with test: kraken 12:26:32 INFO - 2015-10-27 12:26:32,193 DEBUG : Generating results file: kraken 12:26:32 INFO - 2015-10-27 12:26:32,193 INFO : javascript benchmark 12:26:32 INFO - 2015-10-27 12:26:32,193 DEBUG : Working with test: v8_7 12:26:32 INFO - 2015-10-27 12:26:32,193 DEBUG : Generating results file: v8_7 12:26:32 INFO - 2015-10-27 12:26:32,194 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:26:32 INFO - 2015-10-27 12:26:32,251 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 12:26:32 INFO - 2015-10-27 12:26:32,251 DEBUG : process_Request line: dromaeo_css 7483.69 graph.html#tests=[[72,52,35]] 12:26:32 INFO - 2015-10-27 12:26:32,251 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:26:32 INFO - 2015-10-27 12:26:32,384 DEBUG : process_Request line: kraken 1446.60 graph.html#tests=[[232,52,35]] 12:26:32 INFO - 2015-10-27 12:26:32,384 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:26:32 INFO - 2015-10-27 12:26:32,505 DEBUG : process_Request line: v8_7 23457.41 graph.html#tests=[[230,52,35]] 12:26:32 INFO - 2015-10-27 12:26:32,507 INFO : javascript benchmark 12:26:32 INFO - 2015-10-27 12:26:32,510 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [408.7670028083991, 410.3741793764511, 412.18798966036894, 415.3230234717412, 419.1323959404034, 15113.773293400607, 15565.455209067684, 18956.62086758264, 19044.523886902818, 19349.226030958762, 18605.0, 19020.61958760824, 19561.41315760526, 19578.510537236576, 19865.304714334965, 5801.477866991981, 5932.584719069667, 5940.07928771039, 5942.465178133967, 5942.97028514859, 3999.560048394674, 5879.353271140171, 6263.154474146, 6525.412712855842, 6531.346865313478, 6360.268569114564, 6432.614043157426, 6457.0, 6484.93515064848, 6516.771912983047, 6409.134766806468, 6457.773977910751, 6473.93526064738, 6495.902561461582, 6500.577462464948, 5709.800156994485, 5752.165935939307, 5775.5668324875805, 5781.335146458169, 5786.450287222707, 13946.163230206119, 23932.0, 24189.87905060481, 24491.387715307083, 24590.631140532907, 2279.111146652807, 2287.7597852225445, 2305.5388922215457, 2307.953840923189, 2385.546746118232, 9894.851577226347, 9965.152961998167, 10065.194784417303, 10252.179825613934, 10319.638812641597, 1842.3735929783804, 1854.4343975087593, 1859.191251805469, 1860.8232217939274, 1884.2463014794055, 72721.0, 73085.6345718268, 73384.63307683427, 73859.0, 74644.25355746482, 7614.581198034161, 7643.0, 7660.1573826879, 7679.769606911802, 7683.039620047494, 9056.411333263317, 9147.908520914705, 9192.494412807226, 9196.310276729271, 9210.769730756785, 5859.2382990211, 5875.383084776123, 5881.2942446906645, 5910.408959104056, 5928.614640048383, 5939.792107276225, 5973.970130149409, 5976.551758618121, 6029.427204415573, 6030.306514750772, 3411.403004474207, 3462.6537346265677, 3466.0468371197617, 3487.4245749451056, 3489.581250249986, 1192.421675487388, 1197.8083506638895, 1201.6815543880878, 1246.4764798784531, 1310.678883673506, 530.8991291654573, 542.3518894920533, 548.3912856729028, 553.0818840724459, 569.2969183058918, 11280.605178818867, 12550.435230414654, 12632.873671263353, 12718.682032949251, 12763.425645845959, 554.4898693202264, 556.9832905012856, 574.2420005592578, 583.107844997155, 590.7046476761619, 6674.0, 6728.601511210207, 6783.491238157158, 6785.592864428051, 6883.449324054063, 568577.0, 570126.0, 619690.0, 623934.0, 637775.0, 89639.55180224057, 90573.0, 92262.0, 92605.5369723147, 92861.53569232246, 594.9970250148722, 600.198734689186, 601.4797200421604, 604.5163868904858, 608.5587948737218, 11249.325040497597, 11488.19582629208, 11655.650330490098, 11715.297082175097, 11741.11941604366, 37664.43503347397, 38161.6183838158, 38284.425733614575, 40618.390724139754, 42305.0, 51574.0, 52728.209076864645, 53507.0, 53814.0, 55066.0, 7471.103467583707, 7614.733484328022, 7631.503952243309, 7636.885446718415, 7639.541627502145, 11292.435378230892, 11598.47806848677, 12870.16343937641, 12959.740805184032, 13295.401706923018, 11145.777084458428, 11160.441977901235, 11245.71885702864, 11418.828717569077, 11674.533018679158, 11110.555577776799, 11294.096472282363, 11360.659180224606, 11395.202335836411, 11459.083273337947, 11361.943190283995, 11715.648530544097, 11721.413929303671, 11798.705032374259, 11816.527338906348, 7309.122905251191, 7456.291652293024, 7515.060617422822, 7558.811029724301, 7595.278448547379, 10744.946275268574, 11747.47136378848, 11894.762104758029, 11925.0, 11997.160198786001], "dojo.html": [3362.6637336266367, 3402.9829850850742, 3429.5370125033114, 3430.9313813723725, 3456.9827150864244, 5789.363170051296, 5790.797322093727, 5791.652500849941, 5792.0, 5795.652260864345, 5783.971080144604, 5811.0702287633985, 5836.766529338832, 5839.824805255838, 5873.618214816034, 5113.054084994288, 5224.138017227153, 5269.473052694738, 5281.63028587999, 5377.516023557879, 5164.457731938149, 5224.164133738603, 5239.580833533309, 5258.0, 5314.787408503656, 5288.497592728685, 5299.60252981026, 5305.495977882095, 5308.0, 5318.973405132969, 5099.3370861787735, 5290.074237008546, 5309.681419114865, 5361.249425080492, 5388.299521062276, 5168.457311982263, 5191.325127733408, 5272.340957380327, 5283.788648454057, 5302.310699609065, 5581.553475721973, 5630.408807075239, 5631.8592035199035, 5649.8587535311535, 5661.405552416978, 6071.635701857903, 6176.938230617726, 6290.339514350973, 6305.873882522324, 6310.305866354697, 6175.505959523227, 6290.0, 6292.370762923717, 6293.056041593752, 6303.779367722108, 5865.882682346371, 5891.558133140032, 5898.0, 5903.409659034062, 5910.143029260733, 6125.877482450415, 6208.068789681493, 6231.158793562811, 6428.550001499943, 6440.130582371414, 6143.907841382383, 6156.969215153896, 6184.81445556634, 6189.752409903554, 6194.81415557534, 6266.216722909637, 6279.309275979638, 6285.528585356116, 6288.119663247149, 6297.653629050446, 6039.516838652898, 6130.264368275835, 6157.415045570753, 6213.875722485615, 6252.155958945576, 6289.0880822280515, 6289.559730818799, 6293.527985401113, 6294.559380843297, 6300.30696623371, 4741.691790033637, 4748.905021899612, 4752.619790416758, 4754.334393184957, 4758.524147585283, 4099.1801639672185, 4135.8966025848995, 4165.312723400665, 4183.644390226865, 4202.054537728986, 5839.211706419664, 5843.5325173985975, 5845.035569131046, 5851.561132915049, 5866.941330586639, 6087.4521293083835, 6292.937070629327, 6295.527835412362, 6299.244090709144, 6300.558960872787, 5750.2524671793235, 5822.534197264294, 5833.82498525045, 5850.678212698257, 5856.1508581255475, 5375.6774593524515, 5429.511343979061, 5462.071447853795, 5465.316835395575, 5468.562514998791, 6135.055103640796, 6264.655443950626, 6515.934840651627, 6532.248791388956, 6537.280899101095, 6167.167432396569, 6249.1563638908165, 6268.592541484789, 6273.153124328157, 6280.560360774702, 6420.518461115528, 6455.644939528371, 6467.773627923, 6470.352964703492, 6489.994050922114, 5899.0, 6034.185384972972, 6046.97201475759, 6199.132121502903, 6204.7828326008375, 6278.843028924313, 6334.556581039283, 6347.650879201688, 6348.93651063502, 6357.841053973688, 6150.846228844136, 6183.84540386494, 6186.443220110212, 6189.288231853215, 6199.504039676905, 5866.325372582037, 5993.940060599338, 6015.368386319374, 6107.114468401968, 6176.0, 5996.370381110095, 6063.0, 6067.211262535842, 6067.484263837623, 6075.908861367171, 6124.448799608057, 6207.286162091417, 6213.03697926822, 6214.533909956681, 6228.439440450381, 5729.341125770589, 5869.442402971711, 5980.34216236205, 6079.361667024898, 6095.847603809941], "mootools.html": [1537.2390666620024, 1648.4092850399365, 1838.0350316084055, 2000.58987907479, 2019.6970454431842, 9005.27957763379, 10425.0, 10542.736431589214, 10581.047705706485, 10586.841197382046, 10007.199424046077, 10081.44552049637, 10114.595416183362, 10137.49312534374, 10198.286119971604, 2193.0679461228992, 2226.3766145479212, 2457.225973818246, 2477.838940468873, 2512.5477414065463, 2545.592705167174, 2548.2355293411997, 2581.406276556393, 2582.8062895282833, 2590.313566904772, 2521.508305880345, 2567.2298310506867, 2569.4604133132066, 2569.961450578243, 2573.1122762646855, 2204.0742887987085, 2237.5413040326694, 2469.802415806731, 2508.8871000804825, 2529.4941011797714, 2524.8737563121954, 2556.629288753139, 2570.8071894607792, 2605.71337152913, 2610.2430295214367, 10420.270581059329, 10432.061114499656, 10497.635307410064, 10508.422036787973, 10551.947240263826, 5729.140628905656, 5808.12878068289, 5809.7676092956235, 5817.650940943557, 5820.738066787005, 3815.0398500700226, 3816.122291872885, 3919.274934137165, 3940.8817735467983, 3951.7354446577106, 1190.4761904761963, 1209.848768903887, 1211.3943028485758, 1219.408586835384, 1223.0399136677754, 16466.42367517131, 16653.666926661397, 16690.83309166905, 16708.916455417646, 16713.832861671348, 5343.866403339947, 5346.0, 5387.138057910715, 5389.649672771257, 5392.946070539245, 13303.733925321632, 13398.06213565041, 13440.798388024188, 13442.0, 13459.798103028463, 5916.171735956969, 5918.201042859159, 5930.555208359304, 5931.228940237742, 5933.050711886164, 5305.522502974751, 5334.75993580282, 5336.546393556591, 5343.866403339947, 5350.812721554805, 4355.041890784022, 4355.73865568067, 4365.563443655609, 4374.759388233614, 4405.361222622766, 1269.397036407699, 1275.5726831511547, 1285.1132718424258, 1290.1549485087282, 1298.1237664576374, 1241.6150993192139, 1263.6524955637274, 1291.8643542428097, 1565.8512441318057, 1566.3891082477842, 10114.190864730952, 10356.17150627948, 10380.650515432946, 10382.688519344432, 10383.792324153475, 1218.0864351736197, 1257.2268055146203, 1261.949522019109, 1287.459267107817, 1295.1193188631632, 7696.307332340116, 7711.383089352838, 7768.728094516778, 7784.3772498200005, 7799.415043871732, 13864.861351386558, 14063.507777227747, 14074.577762667137, 14078.296085195903, 14093.0, 13360.131591446525, 13809.24049177305, 13821.101628394123, 13847.584572462842, 13855.099418537762, 9619.903800961902, 9796.216302695768, 9873.901260987443, 9876.160526355341, 9932.900670993198, 9518.95240523793, 9574.56914438838, 9590.952045239728, 9615.855762163434, 9621.711348659552, 11596.246243994114, 11803.114766392384, 11803.350815705218, 11822.82265765997, 11900.285982841056, 11801.940990295338, 11958.701032474257, 12117.636470905887, 12124.75750485003, 12145.878541214475, 9484.715458536255, 9583.952080239555, 9609.615615375586, 9615.0, 9616.51917404141, 10173.186145108522, 10198.235132365251, 10248.64129755455, 10503.579856805947, 10601.575936962436, 8413.0, 9737.707868763948, 9845.901540984498, 9847.901520984698, 9855.211583073193, 8405.70580029696, 9442.15020648145, 9561.760955976157, 9589.089036541518, 9728.12446879756, 9654.806903862023, 9708.417494950043, 9742.0, 9800.65697700577, 9819.45992970365, 8704.956475217583, 8824.3381746368, 8849.513276769581, 8867.645294188418, 8874.911250887666, 8787.780305492413, 8820.898282298762, 8885.822283554422, 8890.822183556422, 8892.33307501953], "ext.html": [572.8281515545335, 614.6772944204289, 620.5780069552703, 626.5989766549409, 634.5050860328943, 43278.78360608197, 44189.558104418946, 44215.55784442154, 44237.336439953346, 44258.77870610647, 47739.0, 48200.0, 48212.276815847705, 48230.517694823044, 48241.758791206, 7816.921830781676, 7928.246816552418, 9200.40197387171, 9335.299852511054, 10419.687409377731, 10223.437710925897, 10294.639687610936, 10299.53652085658, 10299.691009269734, 10309.0, 10569.894301056967, 10578.894211057906, 10674.519646615881, 10676.572937082507, 10677.41274229917, 8068.394870384715, 8270.917290827105, 11091.223614346958, 11442.885571144265, 11446.599369022128, 10812.026917577456, 10947.781044379148, 10948.890511094867, 10956.397398143099, 10960.232783705143, 42670.146597067884, 43024.78487607542, 43043.1391372174, 43111.35332970008, 43162.56837431617, 3907.0, 4410.933835992462, 4467.932981005288, 4558.5897269245925, 4563.06457176278, 33727.83136084329, 34018.48972265418, 34056.6594334056, 34167.829160854286, 34192.0, 3820.4888154094465, 3854.1520865409566, 3867.245887052026, 3872.341701910682, 3931.6264954829244, 345904.0, 347197.0, 350129.0, 350806.0, 351027.0, 59328.40671593315, 60381.09428358578, 66208.0, 66681.0, 69589.65205173942, 67913.66043169852, 67924.32075679279, 68187.65906170437, 68275.65862170658, 68428.0, 17133.485995420157, 17351.65296694059, 17370.739438908426, 17372.913135434494, 17416.303347866196, 13098.410571524304, 13166.407511661999, 13171.209727416386, 13172.0, 13173.47306107764, 21232.469188270417, 21400.571988560452, 21449.356519304445, 21566.137354505958, 21672.891635542037, 8393.412461127662, 8578.91421085781, 8620.52587107715, 8704.956475217583, 8754.424203643406, 1056.7992081504644, 1075.317083875735, 1159.8724140344555, 1178.3106882473849, 1274.5539061328645, 31475.685243147735, 31746.206344841565, 31889.840550797097, 31953.201169970936, 32681.50977735336, 1201.6515210588832, 1225.914186006971, 1241.366902879538, 1241.7081985733346, 1335.8931285497138, 13728.862711372958, 16252.51242462728, 16604.418845340355, 16670.91664541694, 17068.743968840477, 314648.0, 317975.0, 319237.0, 319991.0, 320019.0, 54631.0, 54674.0, 54726.17910731342, 54849.45150548523, 54904.0, 1381.2679279981426, 1384.7576674081995, 1490.7912892195102, 1525.6109692028463, 1526.221626970231, 29710.0, 30232.395352093274, 31653.84173079212, 32028.19929501781, 32978.26464100702, 49029.2839750607, 49676.751616243135, 54425.72787136039, 55988.16017759818, 56069.43930560805, 577658.0, 581719.0, 583833.0, 587076.0, 587159.0, 35777.64222357847, 35914.10214744652, 35967.64032359748, 36001.81999089988, 36376.0, 49388.50611493983, 50020.0, 50316.0, 50504.49495504998, 50893.491065090355, 40174.19651606893, 40636.3904541438, 41705.0, 41735.37396939109, 42426.575734242266, 41867.581324186365, 42011.0, 42679.0, 42746.1450770989, 42846.57153428426, 42043.15913681648, 42981.1403771929, 43095.56904431041, 43257.053432596236, 43375.78312108419, 35797.82101089478, 37085.3311600984, 37563.62436375601, 37875.0423635903, 38086.23827523379, 27729.722702772713, 29229.85385073061, 29281.41437171202, 29389.0, 29458.558121628623], "prototype.html": [389.61428186095776, 389.8050974512744, 391.4558763318986, 398.219489799992, 402.863026570966, 5822.854428639286, 5935.643861368316, 5940.227770389849, 5961.523078153748, 5975.133605627187, 5751.482366587006, 5890.587658863881, 5891.351951285366, 5891.558133140021, 5907.822765317047, 4503.166914120881, 4538.432695913011, 4601.6548758843055, 4689.835855745041, 4691.929621055687, 4666.883327916796, 4674.252119660855, 4676.906461870761, 4704.694194877322, 4706.623470122382, 4648.209804333272, 4653.069386122772, 4654.534546545336, 4659.650526210531, 4665.463471700747, 4639.814407423699, 4646.4888862225125, 4648.395708557883, 4648.930266045995, 4652.441706995149, 4101.46680931477, 4168.958310416887, 4187.623113919732, 4211.831526738927, 4213.641840443566, 5672.8014519492035, 5677.602567820254, 5681.062624666925, 5681.886362272731, 5700.486956173922, 5170.870728231786, 5465.180222966586, 5492.0, 5492.725363731797, 5501.284832971688, 5961.5230781537375, 6141.048137538689, 6157.384261573807, 6167.044108163197, 6168.19813424252, 4590.472095709003, 4598.954010459886, 4620.237660786, 4630.560096790833, 4635.420572428447, 6383.87232255357, 6425.004124360778, 6460.676966151674, 6461.0631458438265, 6463.515236357292, 4635.258358662598, 4700.623950083985, 4714.976425117852, 4743.359646447685, 4819.638527110481, 4841.467438581753, 4851.58761505276, 4861.927071093936, 4862.1005114053305, 4875.585575226075, 5463.863403414946, 5475.370332411744, 5481.451854814487, 5486.451354864482, 5488.121900495981, 6186.752529898754, 6324.873502529924, 6326.304106548276, 6332.588381755171, 6342.302346741854, 1756.6223261998732, 1764.9911750441165, 1765.0468746876543, 1777.5289548269718, 1779.359430604981, 1229.5757963502576, 1248.9687757806128, 1258.8237646729465, 1262.9179103358251, 1266.8479782425984, 6071.726772295169, 6073.210482637317, 6117.510599152057, 6124.11200375943, 6132.6933653317155, 6518.967405162944, 6533.738650454024, 6534.346565343428, 6540.37866402691, 6541.084248205255, 5999.610025348338, 6091.0558863376245, 6114.174586430864, 6118.969405152946, 6119.969400152971, 3585.1933315003917, 3603.819809009539, 3606.026372879308, 3607.8376473058775, 3611.7110631149444, 6713.731450741916, 6715.832104197434, 6723.731050757915, 6729.22613899398, 6729.22613899398, 6413.390727880844, 6614.536982411185, 6640.501962352843, 6671.366220209073, 6677.799666010027, 6411.1024456576115, 6469.126667899774, 6620.602763834186, 6628.734850606018, 6690.69891854858, 6455.870882582228, 6466.385693359123, 6476.384743449365, 6477.676116194078, 6492.642904640101, 6367.204099487564, 6382.521310901794, 6391.073294372383, 6394.0, 6401.807945761635, 6622.37087476689, 6710.396064354231, 6713.1944166700305, 6720.865582688221, 6728.360805723449, 4573.565511276423, 4599.724016559017, 4600.401947746772, 4601.332806742937, 4602.585767280961, 6449.484041276781, 6491.28595854465, 6502.512311576556, 6510.3489651034515, 6511.869762604816, 6218.844528886814, 6299.338569450142, 6300.716467759054, 6315.400036996478, 6318.399752023551, 6310.873782524415, 6321.431071203614, 6324.462420694109, 6327.3356297589935, 6332.52506062038, 6220.968895155495, 6227.314995350417, 6230.968845155745, 6234.501239900706, 6240.12638230639, 6267.435930766253, 6344.460720838781, 6347.619142851444, 6348.047792830927, 6353.777617783356, 6196.256449226122, 6200.286966998853, 6206.0, 6261.0, 6270.874582508415], "yui.html": [852.8678054901493, 868.5743985447131, 898.3531857062912, 932.0725877751638, 945.9621615135395, 13848.961327900397, 14111.717765644707, 14133.363998620061, 14133.64665883352, 14205.28973551322, 13344.733105337888, 13427.060105792598, 13454.260015699132, 13465.0, 13470.797938030937, 735.9153697324823, 743.045186934789, 910.103548005216, 925.255169588481, 925.4169872980013, 942.9905700943006, 943.3208090175063, 950.2920324358363, 950.9001554836747, 952.0146648219095, 919.4483310014004, 989.4310771306491, 994.6966175316526, 994.7314225159239, 995.2933417273745, 762.9923700763004, 769.9114601820778, 925.7176561148847, 974.7611835100446, 1010.9090181883665, 716.3839098375392, 719.5323040023974, 721.992780072203, 722.0577146823446, 722.0865605009667, 12732.172408793398, 12844.550440734529, 12873.291968941705, 12879.098463107586, 12884.098113132084, 12578.81131783024, 12663.0, 12835.358232088452, 12961.870381296161, 13318.267495287755, 10812.783744325148, 10877.292975956538, 10931.617393391272, 10965.396903170322, 11220.046296064762, 3839.1361943562756, 3884.941725874086, 3900.0444891001603, 3907.765534067965, 3911.5110611173604, 42783.144337113394, 42797.99999999969, 43039.78480107611, 46423.303650444934, 46687.76656116698, 10322.432266225429, 10385.688429347132, 10432.739181520523, 10458.215633827342, 10561.524731387106, 17742.11289435549, 17764.289428422977, 17780.199891004937, 17783.644327113645, 18009.819901801075, 8416.747497575083, 8464.984201895688, 8626.48241105523, 8670.566471676391, 8718.95640521806, 4605.424321959755, 4616.146012987608, 4651.5813576778255, 4711.575958163713, 4790.041991601694, 3418.470137128699, 3425.794452332868, 3436.5017072524843, 3450.8274586270586, 3464.8787292444645, 545.4681685356745, 564.7571544236018, 569.9230603868425, 574.0814696485589, 574.2706762411714, 706.1667232665401, 730.9707611695472, 737.7565403416967, 741.3142842870324, 744.6314074533141, 8781.956090219635, 9135.269178465707, 9362.196053532229, 9447.858282125773, 9493.620255189853, 611.5810669691276, 637.9617222966637, 641.9358064193543, 682.6211452643731, 739.6227923758921, 4338.175746608134, 4625.838095666702, 4629.189891768927, 4659.8136074557315, 4744.786484608201, 50252.246216306055, 50288.0, 50341.24488132681, 50393.0, 50419.24371134436, 44310.0, 44767.32849007267, 44994.325085123746, 45235.0, 45305.0, 39031.80484097618, 40225.396619050734, 40650.0, 40658.39012414816, 40903.97740056582, 8718.607662655322, 8822.117788221127, 9018.368714189945, 9225.769355766159, 9371.625134994523, 28237.43525129527, 28374.85812570924, 28829.135125946254, 29027.709722902502, 29034.27414314659, 37986.050348741504, 38461.80769096137, 39914.0, 40111.59888401079, 40168.0, 8758.0, 9044.14080662336, 9119.814424125087, 9209.723708288762, 9274.768130796783, 12705.618831435071, 12711.61865144047, 12734.235945843278, 12951.546695865976, 13133.802992955305, 12176.57381991626, 12314.568990085305, 12364.62906112818, 12374.566890159162, 12378.133530653127, 11705.824412633647, 11716.70708232301, 11802.0, 12111.75776484483, 12546.1844980076, 10114.821195614159, 11693.473793679135, 12046.698832529257, 12073.154879158375, 12551.435185416496, 9970.30207885441, 10032.347897386646, 10043.246756493147, 10100.0, 10226.948865255627, 10094.32269128759, 10098.54556544972, 10136.847947280648, 10194.133498652402, 10426.27016108865]}, "summary": {"suite": 7483.687200347067, "subtests": {"jquery.html": {"std": 98992.91268988811, "min": 408.7670028083991, "max": 637775.0, "median": 7638.2135371102795, "filtered": 7925.336036536717, "mean": 30708.37126234817}, "dojo.html": {"std": 665.3860697518427, "min": 3362.6637336266367, "max": 6537.280899101095, "median": 6015.368386319374, "filtered": 5736.4940717059535, "mean": 5781.797222861043}, "mootools.html": {"std": 4278.731206918672, "min": 1190.4761904761963, "max": 16713.832861671348, "median": 8822.618228467782, "filtered": 5778.310882010136, "mean": 7396.894162758185}, "ext.html": {"std": 114649.25612208032, "min": 572.8281515545335, "max": 587159.0, "median": 31818.02344781933, "filtered": 21244.17815443252, "mean": 59532.39788311519}, "prototype.html": {"std": 1518.767068803151, "min": 389.61428186095776, "max": 6729.22613899398, "median": 5968.3283418904675, "filtered": 4865.08252639196, "mean": 5330.443239991102}, "yui.html": {"std": 13803.339055135433, "min": 545.4681685356745, "max": 50419.24371134436, "median": 10099.27278272486, "filtered": 6469.402480562144, "mean": 13035.05227047874}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-009"}, "testrun": {"date": 1445972782, "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": "20151027095132", "branch": "Mozilla-Aurora", "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 159.0, 161.0, 158.0, 158.0, 159.0, 160.0, 159.0, 157.0, 158.0], "ai-astar": [104.0, 110.0, 109.0, 110.0, 109.0, 108.0, 115.0, 109.0, 108.0, 107.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0], "audio-beat-detection": [148.0, 121.0, 147.0, 165.0, 122.0, 145.0, 148.0, 123.0, 156.0, 122.0], "json-stringify-tinderbox": [60.0, 62.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0], "stanford-crypto-pbkdf2": [132.0, 138.0, 134.0, 139.0, 138.0, 127.0, 138.0, 133.0, 134.0, 135.0], "json-parse-financial": [55.0, 54.0, 53.0, 53.0, 53.0, 53.0, 52.0, 52.0, 63.0, 52.0], "stanford-crypto-sha256-iterative": [62.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 58.0, 59.0], "audio-fft": [70.0, 70.0, 70.0, 144.0, 71.0, 71.0, 70.0, 72.0, 152.0, 71.0], "imaging-darkroom": [145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 146.0], "stanford-crypto-ccm": [116.0, 112.0, 112.0, 110.0, 103.0, 107.0, 108.0, 113.0, 115.0, 108.0], "audio-oscillator": [89.0, 89.0, 131.0, 88.0, 88.0, 89.0, 140.0, 88.0, 89.0, 132.0], "stanford-crypto-aes": [92.0, 78.0, 78.0, 80.0, 78.0, 78.0, 79.0, 79.0, 79.0, 79.0], "imaging-desaturate": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0]}, "summary": {"suite": 1446.6, "subtests": {"audio-fft": {"std": 31.007902218628075, "min": 70.0, "max": 152.0, "median": 71.0, "filtered": 86.1, "mean": 86.1}, "stanford-crypto-pbkdf2": {"std": 3.4871191548325386, "min": 127.0, "max": 139.0, "median": 134.5, "filtered": 134.8, "mean": 134.8}, "audio-beat-detection": {"std": 15.42757271899893, "min": 121.0, "max": 165.0, "median": 146.0, "filtered": 139.7, "mean": 139.7}, "stanford-crypto-ccm": {"std": 3.7735924528226414, "min": 103.0, "max": 116.0, "median": 111.0, "filtered": 110.4, "mean": 110.4}, "imaging-darkroom": {"std": 0.6403124237432849, "min": 145.0, "max": 147.0, "median": 146.0, "filtered": 145.7, "mean": 145.7}, "json-parse-financial": {"std": 3.1304951684997055, "min": 52.0, "max": 63.0, "median": 53.0, "filtered": 54.0, "mean": 54.0}, "audio-oscillator": {"std": 21.090519197023102, "min": 88.0, "max": 140.0, "median": 89.0, "filtered": 102.3, "mean": 102.3}, "ai-astar": {"std": 2.624880949681338, "min": 104.0, "max": 115.0, "median": 109.0, "filtered": 108.9, "mean": 108.9}, "audio-dft": {"std": 1.4456832294800956, "min": 157.0, "max": 162.0, "median": 159.0, "filtered": 159.1, "mean": 159.1}, "stanford-crypto-sha256-iterative": {"std": 1.044030650891055, "min": 58.0, "max": 62.0, "median": 60.0, "filtered": 60.1, "mean": 60.1}, "json-stringify-tinderbox": {"std": 0.5999999999999999, "min": 60.0, "max": 62.0, "median": 61.0, "filtered": 60.8, "mean": 60.8}, "imaging-gaussian-blur": {"std": 0.45825756949558405, "min": 109.0, "max": 110.0, "median": 109.0, "filtered": 109.3, "mean": 109.3}, "stanford-crypto-aes": {"std": 4.049691346263317, "min": 78.0, "max": 92.0, "median": 79.0, "filtered": 80.0, "mean": 80.0}, "imaging-desaturate": {"std": 0.4898979485566356, "min": 95.0, "max": 96.0, "median": 95.0, "filtered": 95.4, "mean": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-009"}, "testrun": {"date": 1445972782, "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": "20151027095132", "branch": "Mozilla-Aurora", "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.74464579901152], "Encrypt": [281.5315315315315], "NavierStokes": [4807.692307692308], "Decrypt": [5096.446700507614], "Splay": [526.3157894736842], "Richards": [168.35016835016836], "RegExp": [23159.090909090908], "Earley": [537.345513164965], "Boyer": [10242.424242424242], "RayTrace": [959.6928982725528]}, "summary": {"suite": 23457.408038649675, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.74464579901152, "max": 164.74464579901152, "median": 164.74464579901152, "value": 401.33626, "filtered": 401.33626, "mean": 164.74464579901152}, "Encrypt": {"std": 0.0, "min": 281.5315315315315, "max": 281.5315315315315, "median": 281.5315315315315, "value": 945.4749119999998, "filtered": 945.4749119999998, "mean": 281.5315315315315}, "NavierStokes": {"std": 0.0, "min": 4807.692307692308, "max": 4807.692307692308, "median": 4807.692307692308, "value": 308.6719999999999, "filtered": 308.6719999999999, "mean": 4807.692307692308}, "Decrypt": {"std": 0.0, "min": 5096.446700507614, "max": 5096.446700507614, "median": 5096.446700507614, "value": 52.22874203187249, "filtered": 52.22874203187249, "mean": 5096.446700507614}, "Splay": {"std": 0.0, "min": 526.3157894736842, "max": 526.3157894736842, "median": 526.3157894736842, "value": 154.83289999999997, "filtered": 154.83289999999997, "mean": 526.3157894736842}, "RegExp": {"std": 0.0, "min": 23159.090909090908, "max": 23159.090909090908, "median": 23159.090909090908, "value": 39.33595682041214, "filtered": 39.33595682041214, "mean": 23159.090909090908}, "Richards": {"std": 0.0, "min": 168.35016835016836, "max": 168.35016835016836, "median": 168.35016835016836, "value": 209.69388000000006, "filtered": 209.69388000000006, "mean": 168.35016835016836}, "Earley": {"std": 0.0, "min": 537.345513164965, "max": 537.345513164965, "median": 537.345513164965, "value": 1240.2876430000006, "filtered": 1240.2876430000006, "mean": 537.345513164965}, "Boyer": {"std": 0.0, "min": 10242.424242424242, "max": 10242.424242424242, "median": 10242.424242424242, "value": 65.06887278106507, "filtered": 65.06887278106507, "mean": 10242.424242424242}, "RayTrace": {"std": 0.0, "min": 959.6928982725528, "max": 959.6928982725528, "median": 959.6928982725528, "value": 771.0685379999996, "filtered": 771.0685379999996, "mean": 959.6928982725528}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-009"}, "testrun": {"date": 1445972782, "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": "20151027095132", "branch": "Mozilla-Aurora", "revision": "b0f5fa1535dd89740f3226c21d39801c074e1960"}}] 12:26:32 INFO - RETURN: dromaeo_css: 7483.69 12:26:32 INFO - RETURN: kraken: 1446.60 12:26:32 INFO - RETURN: v8_7: 23457.41 12:26:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23457.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1446.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7483.69"}}} 12:26:32 INFO - Return code: 0 12:26:32 INFO - # TBPL SUCCESS # 12:26:32 INFO - Running post-action listener: _resource_record_post_action 12:26:32 INFO - Running post-run listener: _resource_record_post_run 12:26:33 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 7450624; Write bytes: 390627328; Read time: 1684; Write time: 420960 12:26:33 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 6987776; Read time: 0; Write time: 592 12:26:33 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 5263360; Write bytes: 383639552; Read time: 1532; Write time: 420368 12:26:33 INFO - Running post-run listener: _upload_blobber_files 12:26:33 INFO - Blob upload gear active. 12:26:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:26:33 INFO - Copying logs to upload dir... 12:26:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.858312 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-10-27 12:26:33.737212) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 12:26:33.743427) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010096 build_url: 'https://queue.taskcluster.net/v1/task/7HyAd8vTTD6QC5BswTrDGw/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 12:26:33.795312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:26:33.795670) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1445972724.624859-710469950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 12:26:33.845731) ========= ========= Started reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-27 12:26:33.846058) ========= ========= Finished reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-27 12:26:36.865954) =========