builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1445940457.86 results: success (0) buildid: 20151027004102 builduid: ce5cce66a6ff443b8542f971aeebed9c revision: 53f472c13242cefcdd840ebb61bde179ca01d4b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:37.862458) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:37.863019) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:37.863453) ========= 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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007772 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:37.942871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:37.943154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:37.993722) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:37.994005) ========= 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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025478 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:38.042583) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:38.042899) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:38.043294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:38.043569) ========= 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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-27 03:07:38-- 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% 226M=0s 2015-10-27 03:07:38 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216261 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:38.273581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:38.273914) ========= 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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.134090 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:38.419571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 03:07:38.419935) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 53f472c13242cefcdd840ebb61bde179ca01d4b1 --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 53f472c13242cefcdd840ebb61bde179ca01d4b1 --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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-27 03:07:38,530 truncating revision to first 12 chars 2015-10-27 03:07:38,530 Setting DEBUG logging. 2015-10-27 03:07:38,530 attempt 1/10 2015-10-27 03:07:38,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/53f472c13242?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 03:07:39,242 unpacking tar archive at: mozilla-aurora-53f472c13242/testing/mozharness/ program finished with exit code 0 elapsedTime=0.996394 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 03:07:39.428224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:39.428740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:39.436571) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:39.436999) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 03:07:39.437527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 8 secs) (at 2015-10-27 03:07:39.437836) ========= /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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:07:39 INFO - MultiFileLogger online at 20151027 03:07:39 in /builds/slave/test-pgo 03:07:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:07:39 INFO - Guessing talos json url... 03:07:39 INFO - Using buildbot properties: 03:07:39 INFO - { 03:07:39 INFO - "properties": { 03:07:39 INFO - "buildnumber": 1, 03:07:39 INFO - "product": "firefox", 03:07:39 INFO - "script_repo_revision": "production", 03:07:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:07:39 INFO - "repository": "", 03:07:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:07:39 INFO - "buildid": "20151027004102", 03:07:39 INFO - "slavename": "talos-linux64-ix-056", 03:07:39 INFO - "stage_platform": "linux64-pgo", 03:07:39 INFO - "basedir": "/builds/slave/test-pgo", 03:07:39 INFO - "nightly_build": "True", 03:07:39 INFO - "project": "", 03:07:39 INFO - "platform": "ubuntu64_hw", 03:07:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:07:39 INFO - "slavebuilddir": "test", 03:07:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:07:39 INFO - "branch": "mozilla-aurora", 03:07:39 INFO - "repo_path": "releases/mozilla-aurora", 03:07:39 INFO - "pgo_build": "True", 03:07:39 INFO - "builduid": "ce5cce66a6ff443b8542f971aeebed9c", 03:07:39 INFO - "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1" 03:07:39 INFO - }, 03:07:39 INFO - "sourcestamp": { 03:07:39 INFO - "repository": "", 03:07:39 INFO - "hasPatch": false, 03:07:39 INFO - "project": "", 03:07:39 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:07:39 INFO - "changes": [ 03:07:39 INFO - { 03:07:39 INFO - "category": null, 03:07:39 INFO - "files": [ 03:07:39 INFO - { 03:07:39 INFO - "url": null, 03:07:39 INFO - "name": "https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:07:39 INFO - } 03:07:39 INFO - ], 03:07:39 INFO - "repository": "", 03:07:39 INFO - "rev": "53f472c13242cefcdd840ebb61bde179ca01d4b1", 03:07:39 INFO - "who": "sendchange", 03:07:39 INFO - "when": 1445940354, 03:07:39 INFO - "number": 6579173, 03:07:39 INFO - "comments": "", 03:07:39 INFO - "project": "", 03:07:39 INFO - "at": "Tue 27 Oct 2015 03:05:54", 03:07:39 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:07:39 INFO - "revlink": "", 03:07:39 INFO - "properties": [ 03:07:39 INFO - [ 03:07:39 INFO - "buildid", 03:07:39 INFO - "20151027004102", 03:07:39 INFO - "Change" 03:07:39 INFO - ], 03:07:39 INFO - [ 03:07:39 INFO - "builduid", 03:07:39 INFO - "ce5cce66a6ff443b8542f971aeebed9c", 03:07:39 INFO - "Change" 03:07:39 INFO - ], 03:07:39 INFO - [ 03:07:39 INFO - "nightly_build", 03:07:39 INFO - "True", 03:07:39 INFO - "Change" 03:07:39 INFO - ], 03:07:39 INFO - [ 03:07:39 INFO - "pgo_build", 03:07:39 INFO - "True", 03:07:39 INFO - "Change" 03:07:39 INFO - ] 03:07:39 INFO - ], 03:07:39 INFO - "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1" 03:07:39 INFO - } 03:07:39 INFO - ], 03:07:39 INFO - "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1" 03:07:39 INFO - } 03:07:39 INFO - } 03:07:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 03:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:39 INFO - https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 03:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:07:39 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt'), kwargs: {}, attempt #1 03:08:09 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt: timed out 03:08:09 INFO - retry: attempt #1 caught exception: timed out 03:08:09 INFO - retry: Failed, sleeping 30 seconds before retrying 03:08:39 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/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 #2 03:08:40 INFO - Downloaded 107 bytes. 03:08:40 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:08:40 INFO - Contents: 03:08:40 INFO - 20151027004102 03:08:40 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/53f472c13242cefcdd840ebb61bde179ca01d4b1 03:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:40 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/53f472c132/testing/talos/talos.json 03:08:40 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/53f472c132/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 03:08:40 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/53f472c132/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 03:08:40 INFO - Downloaded 6818 bytes. 03:08:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:08:40 INFO - '../fennec_ids.txt'], 03:08:40 INFO - 'tests': ['tcheck2']}, 03:08:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:40 INFO - '--tppagecycles', 03:08:40 INFO - '7'], 03:08:40 INFO - 'tests': ['tsvgm']}}, 03:08:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:08:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:40 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:08:40 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:40 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:08:40 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:08:40 INFO - 'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:40 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'tests': ['damp', 'tps']}, 03:08:40 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['damp', 'tps']}, 03:08:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:08:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:40 INFO - 'other': {'tests': ['a11yr', 03:08:40 INFO - 'ts_paint', 03:08:40 INFO - 'tpaint', 03:08:40 INFO - 'sessionrestore', 03:08:40 INFO - 'sessionrestore_no_auto_restore']}, 03:08:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['a11yr', 03:08:40 INFO - 'ts_paint', 03:08:40 INFO - 'tpaint', 03:08:40 INFO - 'sessionrestore', 03:08:40 INFO - 'sessionrestore_no_auto_restore']}, 03:08:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['a11yr', 03:08:40 INFO - 'ts_paint', 03:08:40 INFO - 'tpaint', 03:08:40 INFO - 'sessionrestore', 03:08:40 INFO - 'sessionrestore_no_auto_restore']}, 03:08:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['a11yr', 03:08:40 INFO - 'ts_paint', 03:08:40 INFO - 'tpaint', 03:08:40 INFO - 'sessionrestore', 03:08:40 INFO - 'sessionrestore_no_auto_restore']}, 03:08:40 INFO - 'other_l64': {'tests': ['a11yr', 03:08:40 INFO - 'ts_paint', 03:08:40 INFO - 'tpaint', 03:08:40 INFO - 'sessionrestore', 03:08:40 INFO - 'sessionrestore_no_auto_restore']}, 03:08:40 INFO - 'other_nol64': {'tests': ['a11yr', 03:08:40 INFO - 'ts_paint', 03:08:40 INFO - 'tpaint', 03:08:40 INFO - 'sessionrestore', 03:08:40 INFO - 'sessionrestore_no_auto_restore']}, 03:08:40 INFO - 'svgr': {'tests': ['tsvgx', 03:08:40 INFO - 'tsvgr_opacity', 03:08:40 INFO - 'tart', 03:08:40 INFO - 'tscrollx', 03:08:40 INFO - 'cart']}, 03:08:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['tsvgx', 03:08:40 INFO - 'tsvgr_opacity', 03:08:40 INFO - 'tart', 03:08:40 INFO - 'tscrollx', 03:08:40 INFO - 'cart']}, 03:08:40 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:08:40 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:08:40 INFO - 'tests': ['tp5o']}, 03:08:40 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:08:40 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:08:40 INFO - 'talos_options': ['--e10s'], 03:08:40 INFO - 'tests': ['tp5o']}, 03:08:40 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:08:40 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:08:40 INFO - 'talos_options': ['--xperf_path', 03:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:40 INFO - 'tests': ['tp5n']}, 03:08:40 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:08:40 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:08:40 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:40 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:08:40 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:08:40 INFO - 'talos_options': ['--e10s', 03:08:40 INFO - '--xperf_path', 03:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 03:08:40 INFO - 'C:/slave/talos-data/talos/xperf.config'], 03:08:40 INFO - 'tests': ['tp5n']}}, 03:08:40 INFO - 'talos.zip': {'path': '', 03:08:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:08:40 INFO - {'append_to_log': False, 03:08:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:08:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:08:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:08:40 INFO - 'branch': 'Mozilla-Aurora', 03:08:40 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:40 INFO - 'config_files': ('talos/linux_config.py',), 03:08:40 INFO - 'default_actions': ('clobber', 03:08:40 INFO - 'read-buildbot-config', 03:08:40 INFO - 'download-and-extract', 03:08:40 INFO - 'populate-webroot', 03:08:40 INFO - 'create-virtualenv', 03:08:40 INFO - 'install', 03:08:40 INFO - 'run-tests'), 03:08:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:40 INFO - 'download_minidump_stackwalk': True, 03:08:40 INFO - 'download_symbols': 'ondemand', 03:08:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:40 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:40 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:40 INFO - 'installer_path': 'installer.exe', 03:08:40 INFO - 'log_level': 'info', 03:08:40 INFO - 'log_name': 'talos', 03:08:40 INFO - 'log_to_console': True, 03:08:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:40 INFO - 'opt_config_files': (), 03:08:40 INFO - 'pip_index': False, 03:08:40 INFO - 'python_webserver': False, 03:08:40 INFO - 'sps_profile': False, 03:08:40 INFO - 'sps_profile_interval': 0, 03:08:40 INFO - 'suite': 'dromaeojs', 03:08:40 INFO - 'system_bits': '64', 03:08:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:40 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 03:08:40 INFO - 'tests': (), 03:08:40 INFO - 'title': 'talos-linux64-ix-056', 03:08:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:40 INFO - 'use_talos_json': True, 03:08:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:08:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:40 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 03:08:40 INFO - 'work_dir': 'build'} 03:08:40 INFO - ##### 03:08:40 INFO - ##### Running clobber step. 03:08:40 INFO - ##### 03:08:40 INFO - Running pre-action listener: _resource_record_pre_action 03:08:40 INFO - Running main action method: clobber 03:08:40 INFO - rmtree: /builds/slave/test-pgo/build 03:08:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:08:46 INFO - Running post-action listener: _resource_record_post_action 03:08:46 INFO - ##### 03:08:46 INFO - ##### Running read-buildbot-config step. 03:08:46 INFO - ##### 03:08:46 INFO - Running pre-action listener: _resource_record_pre_action 03:08:46 INFO - Running main action method: read_buildbot_config 03:08:46 INFO - Using buildbot properties: 03:08:46 INFO - { 03:08:46 INFO - "properties": { 03:08:46 INFO - "buildnumber": 1, 03:08:46 INFO - "product": "firefox", 03:08:46 INFO - "script_repo_revision": "production", 03:08:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:08:46 INFO - "repository": "", 03:08:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:08:46 INFO - "buildid": "20151027004102", 03:08:46 INFO - "slavename": "talos-linux64-ix-056", 03:08:46 INFO - "stage_platform": "linux64-pgo", 03:08:46 INFO - "basedir": "/builds/slave/test-pgo", 03:08:46 INFO - "nightly_build": "True", 03:08:46 INFO - "project": "", 03:08:46 INFO - "platform": "ubuntu64_hw", 03:08:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:08:46 INFO - "slavebuilddir": "test", 03:08:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:08:46 INFO - "branch": "mozilla-aurora", 03:08:46 INFO - "repo_path": "releases/mozilla-aurora", 03:08:46 INFO - "pgo_build": "True", 03:08:46 INFO - "builduid": "ce5cce66a6ff443b8542f971aeebed9c", 03:08:46 INFO - "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1" 03:08:46 INFO - }, 03:08:46 INFO - "sourcestamp": { 03:08:46 INFO - "repository": "", 03:08:46 INFO - "hasPatch": false, 03:08:46 INFO - "project": "", 03:08:46 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:46 INFO - "changes": [ 03:08:46 INFO - { 03:08:46 INFO - "category": null, 03:08:46 INFO - "files": [ 03:08:46 INFO - { 03:08:46 INFO - "url": null, 03:08:46 INFO - "name": "https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:08:46 INFO - } 03:08:46 INFO - ], 03:08:46 INFO - "repository": "", 03:08:46 INFO - "rev": "53f472c13242cefcdd840ebb61bde179ca01d4b1", 03:08:46 INFO - "who": "sendchange", 03:08:46 INFO - "when": 1445940354, 03:08:46 INFO - "number": 6579173, 03:08:46 INFO - "comments": "", 03:08:46 INFO - "project": "", 03:08:46 INFO - "at": "Tue 27 Oct 2015 03:05:54", 03:08:46 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:46 INFO - "revlink": "", 03:08:46 INFO - "properties": [ 03:08:46 INFO - [ 03:08:46 INFO - "buildid", 03:08:46 INFO - "20151027004102", 03:08:46 INFO - "Change" 03:08:46 INFO - ], 03:08:46 INFO - [ 03:08:46 INFO - "builduid", 03:08:46 INFO - "ce5cce66a6ff443b8542f971aeebed9c", 03:08:46 INFO - "Change" 03:08:46 INFO - ], 03:08:46 INFO - [ 03:08:46 INFO - "nightly_build", 03:08:46 INFO - "True", 03:08:46 INFO - "Change" 03:08:46 INFO - ], 03:08:46 INFO - [ 03:08:46 INFO - "pgo_build", 03:08:46 INFO - "True", 03:08:46 INFO - "Change" 03:08:46 INFO - ] 03:08:46 INFO - ], 03:08:46 INFO - "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1" 03:08:46 INFO - } 03:08:46 INFO - ], 03:08:46 INFO - "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1" 03:08:46 INFO - } 03:08:46 INFO - } 03:08:46 INFO - Running post-action listener: _resource_record_post_action 03:08:46 INFO - ##### 03:08:46 INFO - ##### Running download-and-extract step. 03:08:46 INFO - ##### 03:08:46 INFO - Running pre-action listener: _resource_record_pre_action 03:08:46 INFO - Running main action method: download_and_extract 03:08:46 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:46 INFO - https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/test_packages.json 03:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/test_packages.json 03:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:08:46 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 03:09:16 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/test_packages.json: timed out 03:09:16 INFO - retry: attempt #1 caught exception: timed out 03:09:16 INFO - retry: Failed, sleeping 30 seconds before retrying 03:09:46 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #2 03:09:46 INFO - Downloaded 1302 bytes. 03:09:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:09:46 INFO - Using the following test package requirements: 03:09:46 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:09:46 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:46 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:09:46 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:46 INFO - u'jsshell-linux-x86_64.zip'], 03:09:46 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:46 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:09:46 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:09:46 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:46 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:09:46 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:46 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:09:46 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:46 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:09:46 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:09:46 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:46 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:09:46 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:46 INFO - https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:09:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:09:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:09:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:09:46 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 03:10:17 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip: timed out 03:10:17 INFO - retry: attempt #1 caught exception: timed out 03:10:17 INFO - retry: Failed, sleeping 30 seconds before retrying 03:10:47 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/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 #2 03:10:48 INFO - Downloaded 22907105 bytes. 03:10:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:10:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:10:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:10:49 INFO - Return code: 0 03:10:49 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:49 INFO - https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:10:49 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'), kwargs: {}, attempt #1 03:10:51 INFO - Downloaded 22907105 bytes. 03:10:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:10:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:10:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:10:52 INFO - Return code: 0 03:10: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')]} 03:10:52 INFO - https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:10:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:52 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'), kwargs: {}, attempt #1 03:10:53 INFO - Downloaded 10881672 bytes. 03:10:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:10:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:10:53 INFO - Return code: 0 03:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:53 INFO - https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:10:53 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2'), kwargs: {}, attempt #1 03:10:54 INFO - Downloaded 56975220 bytes. 03:10:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:10:54 INFO - mkdir: /builds/slave/test-pgo/properties 03:10:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:10:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:10:54 INFO - Contents: 03:10:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:10:54 INFO - Running post-action listener: _resource_record_post_action 03:10:54 INFO - Running post-action listener: _set_extra_try_arguments 03:10:54 INFO - ##### 03:10:54 INFO - ##### Running populate-webroot step. 03:10:54 INFO - ##### 03:10:54 INFO - Running pre-action listener: _resource_record_pre_action 03:10:54 INFO - Running main action method: populate_webroot 03:10:54 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 03:10:54 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:10:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 03:10:59 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 03:10:59 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:10:59 INFO - Running post-action listener: _resource_record_post_action 03:10:59 INFO - ##### 03:10:59 INFO - ##### Running create-virtualenv step. 03:10:59 INFO - ##### 03:10:59 INFO - Running pre-action listener: _resource_record_pre_action 03:10:59 INFO - Running main action method: create_virtualenv 03:10:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:10:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:10:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:11:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:00 INFO - Using real prefix '/usr' 03:11:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:11:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:02 INFO - Installing pip.................done. 03:11:02 INFO - Return code: 0 03:11:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:02 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 0x7faed16c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, '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': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:11:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:11:02 INFO - Using env: {'DISPLAY': ':0', 03:11:02 INFO - 'HOME': '/home/cltbld', 03:11:02 INFO - 'LANG': 'en_US.UTF-8', 03:11:02 INFO - 'LANGUAGE': 'en_US:en', 03:11:02 INFO - 'LOGNAME': 'cltbld', 03:11:02 INFO - 'MAIL': '/var/mail/cltbld', 03:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:02 INFO - 'MOZ_NO_REMOTE': '1', 03:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:02 INFO - 'NO_EM_RESTART': '1', 03:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:02 INFO - 'SHELL': '/bin/bash', 03:11:02 INFO - 'SHLVL': '1', 03:11:02 INFO - 'TERM': 'linux', 03:11:02 INFO - 'TMOUT': '86400', 03:11:02 INFO - 'USER': 'cltbld', 03:11:02 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:02 INFO - '_': '/tools/buildbot/bin/python'} 03:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:11:03 INFO - Cleaning up... 03:11:03 INFO - Return code: 0 03:11:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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', '--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 0x7faed16c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, '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': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:11:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:11:03 INFO - Using env: {'DISPLAY': ':0', 03:11:03 INFO - 'HOME': '/home/cltbld', 03:11:03 INFO - 'LANG': 'en_US.UTF-8', 03:11:03 INFO - 'LANGUAGE': 'en_US:en', 03:11:03 INFO - 'LOGNAME': 'cltbld', 03:11:03 INFO - 'MAIL': '/var/mail/cltbld', 03:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:03 INFO - 'MOZ_NO_REMOTE': '1', 03:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:03 INFO - 'NO_EM_RESTART': '1', 03:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:03 INFO - 'SHELL': '/bin/bash', 03:11:03 INFO - 'SHLVL': '1', 03:11:03 INFO - 'TERM': 'linux', 03:11:03 INFO - 'TMOUT': '86400', 03:11:03 INFO - 'USER': 'cltbld', 03:11:03 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:03 INFO - '_': '/tools/buildbot/bin/python'} 03:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:03 INFO - Downloading/unpacking psutil>=0.7.1 03:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:11:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:11:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:05 INFO - Installing collected packages: psutil 03:11:05 INFO - Running setup.py install for psutil 03:11:05 INFO - building 'psutil._psutil_linux' extension 03:11:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:11:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:11:06 INFO - building 'psutil._psutil_posix' extension 03:11:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:11:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:11:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:06 INFO - Successfully installed psutil 03:11:06 INFO - Cleaning up... 03:11:06 INFO - Return code: 0 03:11:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:06 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 0x7faed16c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, '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': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:11:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:11:06 INFO - Using env: {'DISPLAY': ':0', 03:11:06 INFO - 'HOME': '/home/cltbld', 03:11:06 INFO - 'LANG': 'en_US.UTF-8', 03:11:06 INFO - 'LANGUAGE': 'en_US:en', 03:11:06 INFO - 'LOGNAME': 'cltbld', 03:11:06 INFO - 'MAIL': '/var/mail/cltbld', 03:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:06 INFO - 'MOZ_NO_REMOTE': '1', 03:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:06 INFO - 'NO_EM_RESTART': '1', 03:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:06 INFO - 'SHELL': '/bin/bash', 03:11:06 INFO - 'SHLVL': '1', 03:11:06 INFO - 'TERM': 'linux', 03:11:06 INFO - 'TMOUT': '86400', 03:11:06 INFO - 'USER': 'cltbld', 03:11:06 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:06 INFO - '_': '/tools/buildbot/bin/python'} 03:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:11:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:11:08 INFO - Installing collected packages: mozsystemmonitor 03:11:08 INFO - Running setup.py install for mozsystemmonitor 03:11:08 INFO - Successfully installed mozsystemmonitor 03:11:08 INFO - Cleaning up... 03:11:08 INFO - Return code: 0 03:11:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:08 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 0x7faed16c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, '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': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:11:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:11:08 INFO - Using env: {'DISPLAY': ':0', 03:11:08 INFO - 'HOME': '/home/cltbld', 03:11:08 INFO - 'LANG': 'en_US.UTF-8', 03:11:08 INFO - 'LANGUAGE': 'en_US:en', 03:11:08 INFO - 'LOGNAME': 'cltbld', 03:11:08 INFO - 'MAIL': '/var/mail/cltbld', 03:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:08 INFO - 'MOZ_NO_REMOTE': '1', 03:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:08 INFO - 'NO_EM_RESTART': '1', 03:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:08 INFO - 'SHELL': '/bin/bash', 03:11:08 INFO - 'SHLVL': '1', 03:11:08 INFO - 'TERM': 'linux', 03:11:08 INFO - 'TMOUT': '86400', 03:11:08 INFO - 'USER': 'cltbld', 03:11:08 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:08 INFO - '_': '/tools/buildbot/bin/python'} 03:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:11:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:11:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:11:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:11 INFO - Downloading docopt-0.6.1.tar.gz 03:11:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:11:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:11 INFO - Running setup.py install for blobuploader 03:11:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:11:11 INFO - Running setup.py install for requests 03:11:11 INFO - Running setup.py install for docopt 03:11:11 INFO - Successfully installed blobuploader requests docopt 03:11:11 INFO - Cleaning up... 03:11:12 INFO - Return code: 0 03:11:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:12 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 0x7faed16c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, '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': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:11:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:11:12 INFO - Using env: {'DISPLAY': ':0', 03:11:12 INFO - 'HOME': '/home/cltbld', 03:11:12 INFO - 'LANG': 'en_US.UTF-8', 03:11:12 INFO - 'LANGUAGE': 'en_US:en', 03:11:12 INFO - 'LOGNAME': 'cltbld', 03:11:12 INFO - 'MAIL': '/var/mail/cltbld', 03:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:12 INFO - 'MOZ_NO_REMOTE': '1', 03:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:12 INFO - 'NO_EM_RESTART': '1', 03:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:12 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:12 INFO - 'SHELL': '/bin/bash', 03:11:12 INFO - 'SHLVL': '1', 03:11:12 INFO - 'TERM': 'linux', 03:11:12 INFO - 'TMOUT': '86400', 03:11:12 INFO - 'USER': 'cltbld', 03:11:12 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:12 INFO - '_': '/tools/buildbot/bin/python'} 03:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:12 INFO - Running setup.py (path:/tmp/pip-kUOp0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:12 INFO - Running setup.py (path:/tmp/pip-gT6z_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:12 INFO - Running setup.py (path:/tmp/pip-lY_p0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:12 INFO - Running setup.py (path:/tmp/pip-trOhEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:12 INFO - Running setup.py (path:/tmp/pip-wgpaRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:12 INFO - Running setup.py (path:/tmp/pip-VcYfA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:12 INFO - Running setup.py (path:/tmp/pip-bZauVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:12 INFO - Running setup.py (path:/tmp/pip-jqoqiC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:12 INFO - Running setup.py (path:/tmp/pip-ZFieY8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:12 INFO - Running setup.py (path:/tmp/pip-Mrr_I5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:12 INFO - Running setup.py (path:/tmp/pip-bZ_4ab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:13 INFO - Running setup.py (path:/tmp/pip-LfWnOx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:13 INFO - Running setup.py (path:/tmp/pip-4zRb5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:13 INFO - Running setup.py (path:/tmp/pip-mMSrEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:13 INFO - Running setup.py (path:/tmp/pip-8GIDqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:13 INFO - Running setup.py (path:/tmp/pip-NW78G8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:13 INFO - Running setup.py (path:/tmp/pip-SnH0q5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:13 INFO - Running setup.py install for manifestparser 03:11:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:11:13 INFO - Running setup.py install for mozcrash 03:11:13 INFO - Running setup.py install for mozdebug 03:11:13 INFO - Running setup.py install for mozdevice 03:11:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:11:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:11:13 INFO - Running setup.py install for mozfile 03:11:13 INFO - Running setup.py install for mozhttpd 03:11:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Running setup.py install for mozinfo 03:11:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Running setup.py install for mozInstall 03:11:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Running setup.py install for mozleak 03:11:14 INFO - Running setup.py install for mozlog 03:11:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Running setup.py install for moznetwork 03:11:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Running setup.py install for mozprocess 03:11:14 INFO - Running setup.py install for mozprofile 03:11:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Running setup.py install for mozrunner 03:11:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:11:14 INFO - Running setup.py install for mozscreenshot 03:11:15 INFO - Running setup.py install for moztest 03:11:15 INFO - Running setup.py install for mozversion 03:11:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:11:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:15 INFO - Cleaning up... 03:11:15 INFO - Return code: 0 03:11:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7faed16c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, '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': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:11:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:11:15 INFO - Using env: {'DISPLAY': ':0', 03:11:15 INFO - 'HOME': '/home/cltbld', 03:11:15 INFO - 'LANG': 'en_US.UTF-8', 03:11:15 INFO - 'LANGUAGE': 'en_US:en', 03:11:15 INFO - 'LOGNAME': 'cltbld', 03:11:15 INFO - 'MAIL': '/var/mail/cltbld', 03:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:15 INFO - 'MOZ_NO_REMOTE': '1', 03:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:15 INFO - 'NO_EM_RESTART': '1', 03:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:15 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:15 INFO - 'SHELL': '/bin/bash', 03:11:15 INFO - 'SHLVL': '1', 03:11:15 INFO - 'TERM': 'linux', 03:11:15 INFO - 'TMOUT': '86400', 03:11:15 INFO - 'USER': 'cltbld', 03:11:15 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:15 INFO - '_': '/tools/buildbot/bin/python'} 03:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:15 INFO - Running setup.py (path:/tmp/pip-rOghJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:15 INFO - Running setup.py (path:/tmp/pip-xLx7Nv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:15 INFO - Running setup.py (path:/tmp/pip-uNRfoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:15 INFO - Running setup.py (path:/tmp/pip-TiqblP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:15 INFO - Running setup.py (path:/tmp/pip-A7yLwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:15 INFO - Running setup.py (path:/tmp/pip-jVhF7E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:15 INFO - Running setup.py (path:/tmp/pip-F9MskV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:15 INFO - Running setup.py (path:/tmp/pip-US7G5i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:16 INFO - Running setup.py (path:/tmp/pip-TWlqjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:16 INFO - Running setup.py (path:/tmp/pip-X7cbTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:16 INFO - Running setup.py (path:/tmp/pip-_8t7Ff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:16 INFO - Running setup.py (path:/tmp/pip-ECm8jk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:16 INFO - Running setup.py (path:/tmp/pip-YrPGoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:16 INFO - Running setup.py (path:/tmp/pip-6hSime-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:16 INFO - Running setup.py (path:/tmp/pip-6B0Rzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:16 INFO - Running setup.py (path:/tmp/pip-6WlwVl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:16 INFO - Running setup.py (path:/tmp/pip-goAC8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:11:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:18 INFO - Downloading blessings-1.5.1.tar.gz 03:11:18 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:11:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:18 INFO - Installing collected packages: blessings 03:11:18 INFO - Running setup.py install for blessings 03:11:18 INFO - Successfully installed blessings 03:11:18 INFO - Cleaning up... 03:11:18 INFO - Return code: 0 03:11:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:11:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:11:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:11:18 INFO - Reading from file tmpfile_stdout 03:11:18 INFO - Current package versions: 03:11:18 INFO - argparse == 1.2.1 03:11:18 INFO - blessings == 1.5.1 03:11:18 INFO - blobuploader == 1.2.4 03:11:18 INFO - docopt == 0.6.1 03:11:18 INFO - manifestparser == 1.1 03:11:18 INFO - mozInstall == 1.12 03:11:18 INFO - mozcrash == 0.16 03:11:18 INFO - mozdebug == 0.1 03:11:18 INFO - mozdevice == 0.46 03:11:18 INFO - mozfile == 1.2 03:11:18 INFO - mozhttpd == 0.7 03:11:18 INFO - mozinfo == 0.8 03:11:18 INFO - mozleak == 0.1 03:11:18 INFO - mozlog == 3.0 03:11:18 INFO - moznetwork == 0.27 03:11:18 INFO - mozprocess == 0.22 03:11:18 INFO - mozprofile == 0.27 03:11:18 INFO - mozrunner == 6.10 03:11:18 INFO - mozscreenshot == 0.1 03:11:18 INFO - mozsystemmonitor == 0.0 03:11:18 INFO - moztest == 0.7 03:11:18 INFO - mozversion == 1.4 03:11:18 INFO - psutil == 3.1.1 03:11:18 INFO - requests == 1.2.3 03:11:18 INFO - wsgiref == 0.1.2 03:11:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:18 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 0x7faed16c1b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c97b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138e4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, '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': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:11:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:11:18 INFO - Using env: {'DISPLAY': ':0', 03:11:18 INFO - 'HOME': '/home/cltbld', 03:11:18 INFO - 'LANG': 'en_US.UTF-8', 03:11:18 INFO - 'LANGUAGE': 'en_US:en', 03:11:18 INFO - 'LOGNAME': 'cltbld', 03:11:18 INFO - 'MAIL': '/var/mail/cltbld', 03:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:18 INFO - 'MOZ_NO_REMOTE': '1', 03:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:18 INFO - 'NO_EM_RESTART': '1', 03:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:18 INFO - 'SHELL': '/bin/bash', 03:11:18 INFO - 'SHLVL': '1', 03:11:18 INFO - 'TERM': 'linux', 03:11:18 INFO - 'TMOUT': '86400', 03:11:18 INFO - 'USER': 'cltbld', 03:11:18 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:18 INFO - '_': '/tools/buildbot/bin/python'} 03:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:11:19 INFO - Cleaning up... 03:11:19 INFO - Return code: 0 03:11:19 INFO - Running post-action listener: _resource_record_post_action 03:11:19 INFO - Running post-action listener: _start_resource_monitoring 03:11:19 INFO - Starting resource monitoring. 03:11:19 INFO - ##### 03:11:19 INFO - ##### Running install step. 03:11:19 INFO - ##### 03:11:19 INFO - Running pre-action listener: _resource_record_pre_action 03:11:19 INFO - Running main action method: install 03:11:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:11:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:11:19 INFO - Reading from file tmpfile_stdout 03:11:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:11:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:11:19 INFO - Reading from file tmpfile_stdout 03:11:19 INFO - Output received: 03:11:19 INFO - Usage: mozinstall [options] installer 03:11:19 INFO - Options: 03:11:19 INFO - -h, --help show this help message and exit 03:11:19 INFO - -d DEST, --destination=DEST 03:11:19 INFO - Directory to install application into. [default: 03:11:19 INFO - "/builds/slave/test-pgo"] 03:11:19 INFO - --app=APP Application being installed. [default: firefox] 03:11:19 INFO - mkdir: /builds/slave/test-pgo/build/application 03:11:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:11:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:11:33 INFO - Reading from file tmpfile_stdout 03:11:33 INFO - Output received: 03:11:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:11:33 INFO - Running post-action listener: _resource_record_post_action 03:11:33 INFO - ##### 03:11:33 INFO - ##### Running run-tests step. 03:11:33 INFO - ##### 03:11:33 INFO - Running pre-action listener: _resource_record_pre_action 03:11:33 INFO - Running main action method: run_tests 03:11:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:11:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:11:33 INFO - Python 2.7.3 03:11:33 INFO - Return code: 0 03:11:33 INFO - grabbing minidump binary from tooltool 03:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:33 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 0x1120bf0>, '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 0x141e4f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141e9a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:11:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:11:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:11:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:11:33 INFO - Return code: 0 03:11:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:11:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:11:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:11:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:11:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:11:33 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/Ec5OJLtST4OJf7n-naqlgw/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-056', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:11:33 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/Ec5OJLtST4OJf7n-naqlgw/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-056 --webServer localhost 03:11:33 INFO - Using env: {'DISPLAY': ':0', 03:11:33 INFO - 'HOME': '/home/cltbld', 03:11:33 INFO - 'LANG': 'en_US.UTF-8', 03:11:33 INFO - 'LANGUAGE': 'en_US:en', 03:11:33 INFO - 'LOGNAME': 'cltbld', 03:11:33 INFO - 'MAIL': '/var/mail/cltbld', 03:11:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:11:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:33 INFO - 'MOZ_NO_REMOTE': '1', 03:11:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:33 INFO - 'NO_EM_RESTART': '1', 03:11:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:33 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:11:33 INFO - 'SHELL': '/bin/bash', 03:11:33 INFO - 'SHLVL': '1', 03:11:33 INFO - 'TERM': 'linux', 03:11:33 INFO - 'TMOUT': '86400', 03:11:33 INFO - 'USER': 'cltbld', 03:11:33 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922', 03:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:33 INFO - '_': '/tools/buildbot/bin/python'} 03:11:33 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/Ec5OJLtST4OJf7n-naqlgw/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-056', '--webServer', 'localhost'] with output_timeout 3600 03:11:33 INFO - mozversion INFO | application_buildid: 20151027004102 03:11:33 INFO - mozversion INFO | application_changeset: 53f472c13242cefcdd840ebb61bde179ca01d4b1 03:11:33 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:11:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:11:33 INFO - mozversion INFO | application_name: Firefox 03:11:33 INFO - mozversion INFO | application_remotingname: firefox-dev 03:11:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:33 INFO - mozversion INFO | application_vendor: Mozilla 03:11:33 INFO - mozversion INFO | application_version: 43.0a2 03:11:33 INFO - mozversion INFO | platform_buildid: 20151027004102 03:11:33 INFO - mozversion INFO | platform_changeset: 53f472c13242cefcdd840ebb61bde179ca01d4b1 03:11:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:33 INFO - mozversion INFO | platform_version: 43.0a2 03:11:33 INFO - 2015-10-27 03:11:33,934 DEBUG : using testdate: 1445940693 03:11:33 INFO - 2015-10-27 03:11:33,934 DEBUG : actual date: 1445940693 03:11:33 INFO - 2015-10-27 03:11:33,943 INFO : Starting test suite talos-linux64-ix-056 03:11:33 INFO - 2015-10-27 03:11:33,943 INFO : Starting test dromaeo_css 03:11:33 INFO - 2015-10-27 03:11:33,943 DEBUG : operating with platform_type : linux_ 03:11:33 INFO - 2015-10-27 03:11:33,944 INFO : Initialising browser for dromaeo_css test... 03:11:33 INFO - 2015-10-27 03:11:33,955 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphQyDQw/profile http://localhost/getInfo.html 03:11:41 INFO - 2015-10-27 03:11:41,305 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:11:41 INFO - 2015-10-27 03:11:41,305 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:11:41 INFO - 2015-10-27 03:11:41,305 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:11:41 INFO - 2015-10-27 03:11:41,306 DEBUG : BROWSER_OUTPUT: __metrics 03:11:41 INFO - 2015-10-27 03:11:41,447 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:11:42 INFO - 2015-10-27 03:11:42,927 INFO : Browser initialized. 03:11:42 INFO - 2015-10-27 03:11:42,927 INFO : Running cycle 1/1 for dromaeo_css test... 03:11:42 INFO - 2015-10-27 03:11:42,927 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphQyDQw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:11:54 INFO - 2015-10-27 03:11:54,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 132587520 03:11:54 INFO - 2015-10-27 03:11:54,626 DEBUG : BROWSER_OUTPUT: 03:14:54 INFO - 2015-10-27 03:14:54,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-dojo.html (next: http://localhost/page_load_test/dromaeo/cssquery-ext.html) 03:14:55 INFO - 2015-10-27 03:14:55,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 250318848 03:14:55 INFO - 2015-10-27 03:14:55,577 DEBUG : BROWSER_OUTPUT: 03:17:57 INFO - 2015-10-27 03:17:57,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-ext.html (next: http://localhost/page_load_test/dromaeo/cssquery-jquery.html) 03:17:58 INFO - 2015-10-27 03:17:58,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 208121856 03:17:58 INFO - 2015-10-27 03:17:58,266 DEBUG : BROWSER_OUTPUT: 03:21:00 INFO - 2015-10-27 03:21:00,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-jquery.html (next: http://localhost/page_load_test/dromaeo/cssquery-mootools.html) 03:21:00 INFO - 2015-10-27 03:21:00,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 206364672 03:21:00 INFO - 2015-10-27 03:21:00,650 DEBUG : BROWSER_OUTPUT: 03:24:02 INFO - 2015-10-27 03:24:02,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-mootools.html (next: http://localhost/page_load_test/dromaeo/cssquery-prototype.html) 03:24:02 INFO - 2015-10-27 03:24:02,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 201965568 03:24:02 INFO - 2015-10-27 03:24:02,969 DEBUG : BROWSER_OUTPUT: 03:27:05 INFO - 2015-10-27 03:27:05,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-prototype.html (next: http://localhost/page_load_test/dromaeo/cssquery-yui.html) 03:27:05 INFO - 2015-10-27 03:27:05,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 195342336 03:27:05 INFO - 2015-10-27 03:27:05,925 DEBUG : BROWSER_OUTPUT: 03:30:07 INFO - 2015-10-27 03:30:07,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/dromaeo/cssquery-yui.html (next: http://localhost/page_load_test/dromaeo/cssquery-dojo.html) 03:30:08 INFO - 2015-10-27 03:30:08,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 238792704 03:30:08 INFO - 2015-10-27 03:30:08,109 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,109 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:30:08 INFO - 2015-10-27 03:30:08,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:30:08 INFO - 2015-10-27 03:30:08,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:30:08 INFO - 2015-10-27 03:30:08,110 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:30:08 INFO - 2015-10-27 03:30:08,110 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3364.4280472319706;3386.2719515304207;3433.279011407603;3435.519027336173;3450.3961806683833;5711.228984087147;5749.281339832521;5757.596968212227;5792.0153573892485;5792.160136780164;5733.541316694665;5796.30444346679;5823;5832.912506312408;5839.5620328475325;5124.487551244864;5166.5866730661455;5265.631405801595;5305.310309659739;5372.301600791911;5160.458151894053;5179.533841954223;5269.736513174345;5293.9735301323435;5297.417284098746;5320.680759154444;5376.946230537703;5380.892382152355;5382.5963052771;5390.973045134789;5018.447970723218;5137.717425541594;5284.603654725873;5319.856230910373;5368.731563421852;5045.117104506733;5163.922541161885;5170.6122040847085;5179.585633149339;5223.2948551945765;5501.14732216507;5532.3914369419335;5548.195511650828;5553.916691249635;5560.054790685593;5861.85345366365;5989.401059894019;6062.848428789272;6190.442860142563;6199.721012554446;6277.089821975834;6306.590071645374;6320.683965801692;6322.968385158091;6337.746490140389;5875.529957603381;5890.734916928705;5890.734916928748;5905.970470147665;5917.289925209003;5977.970110149421;6070.757169713162;6180.505559555225;6191.25704915404;6337.7781777637565;6105.358937311607;6106.908396374058;6107.114468402056;6109.7861574844665;6176.474999625082;6186.536009799283;6190.566660333733;6200.038993955944;6217;6234.750609975641;5953.077273022688;6032.065029920369;6065.211522502134;6124.5712800103565;6139.6009259398;6165.136880836686;6208.317085120633;6211;6213.627182369072;6233.594816337014;4500.639948804088;4703.270992996091;4712;4718.9292160617615;4730.361401210861;4123.8556650517085;4162.83348666056;4165.854195103157;4176.644985176234;4193.580641935782;5898.292204935436;5966;5966.85082872923;5984.551158663117;5998.3701711320555;5985.311689155803;6090;6322.715477803418;6332.525060620472;6332.8416789579705;5876.7355469004;5963.165156878041;5966.642001479925;5983.371745966698;5993.580449368589;5253.13323301651;5267.604929630293;5269.288646032813;5272.2355258487305;5284.920726189033;6120.663363515049;6201.596896201732;6255.40573645503;6464.997925321582;6494.902576461357;6237.1891654084675;6278.717457714505;6294.181756371642;6297.52768542352;6299.779507717208;6442.645654489048;6453.709583068679;6457.515686323451;6460.709268083042;6468.288488266193;5999.430054144849;6058.0610005449225;6133.172021777003;6136;6192.907106393318;6221.595596286408;6337.841553961188;6340.873182536231;6345.270293916259;6354.618722876642;6168.9691551541955;6179.0422484514975;6183.81448556544;6188.040853667689;6200.441960223601;5910.7931222407005;6038.75844966214;6087.847803804763;6183.350748171557;6201.348858369806;6003.549733769897;6031.4270144336215;6037.034074548052;6037.516998640011;6083.391660833881;5929.466348028698;6139.26328840542;6145.293291271561;6150.907736383869;6162.537809664203;5937.435943585352;5986.191864098465;6095.598674869747;6119.785807496716;6144.2319710036245 03:30:08 INFO - 2015-10-27 03:30:08,113 DEBUG : BROWSER_OUTPUT: |1;ext.html;614.8379562626634;653.8267359149824;655.9836004099894;659.5877576514677;663.194219023886;44882;45438.31842522361;45482.54517454824;45631.77184114075;45701.542984570144;49383.25925111117;50005;50052;50067.749661251735;50095.499045009536;8198.836023279531;8335.124811894755;9289.721308360744;9442.858357124614;10845.0781683557;11046.171537134707;11103.111751059936;11163.386013769239;11173.664790056311;11179.161562882775;11200.327980321206;11279.661610151708;11300.830487542693;11304.208705390625;11312.321260724342;8390.244877960982;8621.094785047573;10864.076553492963;11047.337159770439;11055;10620.150387968944;10695;10766.24636275461;10770.676879693621;10771.084457821094;41499.377509337384;41633.37549936753;41872.58127418717;41990.79004604957;42011;3559.66183212597;3614.313280476701;3635.363811333006;3662.157703728131;3671.284099600579;34767.652323476694;35108.824455877555;35112.82443587766;35171.12072198215;35273.118172045644;3674.1549443628114;3682.502862113607;3721.344001919147;3740.7942563159017;3818.045488627843;333970;334326;334406.32796836103;337068;338844;59439.405605943386;60359;69153.3084669157;69839.65080174567;73095.63452182704;72103.63948180225;72241;72508.63745681237;72557.6372118136;72629.27370726225;16275.593110172103;16470.67058658844;16482.917585411997;16494.092824894746;16546;12293.385330733428;12427.130100892851;12441.315727635067;12949.482020719253;13137.60587182386;22217.888910555666;22684.206052788075;22698.205562805222;22699.205527806447;22722.318330450114;8062.637181326854;8142.4300298978505;8216.835663286702;8270.462419942685;8283.213094755989;1156.4969238381332;1191.7854786138405;1226.8773122687837;1259.6976725585976;1290.5612091888802;32089.839550802564;32236.83881580577;32317.192070198435;32629;32841.83579082089;1197.6107764976243;1260.1997731440601;1260.6533203369147;1296.7925131978839;1300.440810451496;14830.077203783276;16614.6677066458;16680.58298542522;16795.580110497336;17510.474685759447;416816;422108;422919;428546;428985;52499.21251181235;53736.73131634317;60985;62866.37133628605;63351.36648633547;1484.4804318488443;1495.7831114488556;1496.0425327790224;1503.2784263553556;1511.1008949674926;30364.696353036186;30389.69610303869;30730.539041914835;31043;31310.217244569067;49798;50985;55969.16046259391;57489.42510575008;57523;249250;250039;250040;250376;251441;32741.34517309688;33161.50257746184;33254;33280.66719332873;33377.499337510446;45688.771556142005;46723.53276467328;50964.49035509597;51038.489615103375;51124.488755111975;41008.1798364037;41492.377614336416;41948.58051419569;42262.57737422586;43031.35452968271;41448.37827432651;41776;41981.580184197766;42242.15515689608;42350.788246058575;42624.36063458989;43293.134137317706;43296.350554741075;43369.56630433655;43469;35402.29195416129;36563;36863;37240;37287.44068839024;28391.858040709663;28580.85709571439;28641.713582864737;28768.856155719088;28796.856015720627 03:30:08 INFO - 2015-10-27 03:30:08,115 DEBUG : BROWSER_OUTPUT: |2;jquery.html;414.98547550835724;418.36199795312126;418.5688740597184;419.8803341047802;422.8837069805803;15776.447824326151;15951.441699540519;18472.429843463306;18484.722729159057;18956;16599.66800663986;16844.663106737888;16916.154192290396;16995.405160819373;17698.82301176991;5769.971150144253;5908.970455147718;5910.349861515251;5914.172015917775;5915.349311575723;4218.978905105486;4282;5841.0362290222065;6512.088307636935;6685.46516278699;6478.352164783531;6588.308227636101;6588.308227636101;6618.271990081087;6626.768063117792;6602.306757790435;6682.599044057372;6701.3298670132845;6703.932960670429;6704.296048914867;5888.941110588925;5978.40215978403;5998.130271110708;6001.729922153513;6005.6997150142315;23230.53538929212;23728.288151355315;23781.762182378126;23801.88099059511;23999.64000539993;2396.113438027923;2438.2928950604305;2452.6934133233344;2495.513374891897;2529.709083455408;14685.926570367186;14796.70406591862;14856;14946.028508147045;15003.924980375137;1822.1982327775736;1905.1807722679243;1914.1482040491987;1925.6341295154016;2000.449876284019;68030.65984670045;69043.65478172577;69800.30199697989;69945.65027174882;70100.29899700989;11497.252678575866;11568.305901645928;11574.074074074222;11634.883651163549;11645.708857278636;15213.771793423108;15215.847841521665;15236.390544378322;15299.770503442458;16337.509874703777;8731.345149113842;8768.517731524827;8780.517071561126;8811.295096392274;8842.734717958472;8613.310935125175;8615.61229744663;8632.438891472035;8716.520591367409;8722.040575536686;6870.519063665595;6888.138982627172;6932.306769323128;6947.235804061549;6975.8604827903155;1199.5921386728555;1241.8944389726794;1245.5516014234868;1264.4057293072242;1778.575980534146;523.7826302084668;547.1601092323265;559.5523581135076;559.7816851427947;562.361719448429;11307.49116289769;12353.62939111828;12432.677053754001;13028.555534031768;13377.799333010013;572.5505478199676;573.6959411511905;579.5913880714087;581.4737662415521;591.4263164730205;7103.82240443993;7156.677949492286;7313.341799238094;7330.047093877762;7332.340089391981;637393;641811;641905;660194;664621;85568;87784.99999999872;87951;88857;89451;613.7913109542777;614.5390956782413;616.4298024327569;617.9165812615329;618.2735286038886;11722.58970936013;11812.350320732443;12024.519019239133;12104.334261615695;12124.151309408257;35402.46896296506;38661;40338.596614033486;40716.59283407128;41418;47718.5228147728;48867.26699099587;50368;54327.72836135952;55362;7302.744403945836;7427.145878224073;7459.216782237787;7522.511036782592;7522.661480233293;12773.744525109632;12894.871051289367;13300.46798128064;13327.933360333136;13444.46222151103;11614.883851161718;11680.299182049104;11760.059195264188;11767.588134415255;11907.226030308002;11170.664880053611;11344.149188811038;11365.033972112133;11494.712632183928;11503.597374091867;9342.766430839283;10229.079382855281;11569.305841649528;11801.35092569917;11846.526138954345;7385.852282954418;7574.242575742602;7587.620618968919;7590.962045189739;7665.808354790952;11741.765164696488;11875.762484750085;12010.75978480408;12115.515379384726;12199.634010979686 03:30:08 INFO - 2015-10-27 03:30:08,115 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1525;1619.7165496038194;1860.49766563028;2003.5792483578448;2052.3124753207676;9300.581473833678;10168.847467287987;10395.636152734656;10402.063814256715;10409.843852342212;10054.949725251381;10084.697459076222;10166.898331016688;10188.694339169837;10208;2210.1380461619983;2231.5983123037845;2462.507498500298;2488.415222422729;2501.574732295505;2528.5954247320433;2557.795376369886;2568.7302833202525;2575.1759436980174;2582.8579428131447;2530.8734563271855;2552.3874270175115;2552.3874270175115;2554.2592648132018;2561.8462892226435;2177.4556360909774;2237.742659594143;2413.51729654069;2454.570450171213;2462.322861213163;2552.4895020995873;2562.3081767922745;2576.3430325267122;2627.4745050989686;2648.510025645262;10647.361158330525;10741.194410419172;10774.19193560486;10776.78446431067;10788.622398216103;5570.108782594765;5655.717214139277;5675.091985282335;5675.148727690879;5679.176519404663;3740.36413809653;3786.848526058954;3838.5777564467885;3913.2760439318818;3930.5479869814767;1106.3970136275668;1161.8896204860525;1165.2600598619852;1177.9587714429954;1198.862130854954;16108.677826443405;16136.435224767194;16142.757858632012;16152;16179.110148941685;5468.589855760833;5487.98472282629;5508.862278442991;5532.585056120807;5560.944390556124;12367.62897113088;12485.87514124847;12490.81263781044;12501.187422817487;12513.499460021498;5870.3249126350165;5875.294964604275;5881.823545293648;5886.58793884424;5888.234529511136;5177.870553236199;5237.8428647140645;5245.659032162897;5253.474652534793;5260.289860868734;4497.190505709003;4508.368828364031;4510.571495707903;4541.545845415498;4586.4496260448295;1385.4042761612402;1389.2914613547164;1397.9091359061629;1398.2030242761527;1410.8377536583218;1191.3209470601846;1214.2046959241711;1214.5809695654984;1556.035258139938;1557.5015994881755;9793.363431376938;9971.551280192409;9971.700848974542;9973.451460169616;9997;566.7902875935848;569.1150261343568;576.9336526299445;610.0757352610798;610.5176910240949;7440.7767766966;7501.512401693873;7565.924340756632;7566.054243219598;7573.2048134945035;13561.254131022888;13757.724845503033;13804.792928106086;13806.65483362924;13810.171389716648;13328.800067998987;13677.110987785962;13696.315184240748;13733.862661373258;13739.725205495834;9626.326157169071;9779.951100244452;9840.901590984142;9844.064813842817;9868.358556693793;9404.294677899321;9522.23822094217;9566.521673916137;9572.707684462786;9590.66432674853;11571.19001669875;11745.882541174478;11754.88245117538;11769.058475321783;11777.293362398283;11711.121665875264;11960.102992275788;11975.461104250155;12111.454984525893;12126.878731212575;9069.18377346042;9322.440653560809;9386.859197111913;9395.671151509665;9395.953020234854;10094.293399461967;10145.239107067147;10282.07461328484;10333.328333658588;10339.224558158017;8081.959590202011;9216;9286;9354.83709749155;9629.104466512268;8264.628091736007;9224.40041397307;9304.627814887328;9330.860037099314;9373.671921482715;9266.814663706553;9401.952990235006;9451.15702438018;9479.146876781122;9481.573329200064;8244.958775206085;8332.208440198172;8337.249647531751;8345.082040975367;8346.62440190205;8723.869141963003;8748.737537873874;8781;8856.601452934505;8861.291096712377 03:30:08 INFO - 2015-10-27 03:30:08,116 DEBUG : BROWSER_OUTPUT: |4;prototype.html;386.6867837051988;387.11351006195815;388.1848118950205;392.0942622541928;392.239056230912;5918.970405147968;5970;5979.073243647236;6000.639961602307;6011.338752737195;5871.471567558919;5960.7317670704815;5963.224780778503;5974.044152935531;5976.342602313742;4634.884127896804;4688.32019357193;4693.765311734417;4736.763161841911;4785.330053792454;4764.833230836922;4766.356541866839;4778.784954677048;4779.90440191196;4785.353977213083;4732.313814496896;4737.976310118444;4739.336492890998;4739.85780426586;4756.262779269219;4731.243001119821;4742.312364707098;4744.857654270378;4751.881202969919;4753.04939012199;4111.362738775465;4163.687723420756;4172.91654166918;4187.246295666779;4187.853425130106;5645.887082258373;5648.661080335193;5652.123920792284;5657.23627310312;5664.348599910981;5230.947690523122;5317.813876514303;5366.275552800361;5427.945720542783;5435.918461223085;6262.6868656566985;6295.244570651551;6328.746850125989;6331.68341582919;6340.651264180468;4576.702514336557;4578.9542104579195;4579.816807327703;4584;4593.035462552868;6425.100485931974;6439.5170362223025;6514.543981921267;6514.93485065148;6518.413342799171;4636.44362676481;4681.6020638245445;4687.789049492781;4688.2030054890065;4688.718676879398;4703.0593881223895;4745.122152401747;4748.7863046163;4750.287456881426;4760.071786001697;5420.783168673288;5421.213923981;5425.538829199562;5430.13117901134;5432.483914028161;6260.123582698426;6423.229212494531;6426.678666066678;6427.228732552124;6430.3891130342545;1728.161841506868;1749.5013921032698;1750.5798608333907;1751.8248175182634;1754.1054062428254;1160.5647882044234;1181.9586314478952;1183.6094088950626;1199.1366216324232;1207.0705556721275;6257.092721555349;6258.374162583706;6263.185785847811;6265.404786545271;6270.3416141305415;6570.342965703391;6583.275839657634;6586.143801305895;6594.604323740591;6610.6694665267505;6125.754969801158;6240.219972503437;6254.593451425642;6260;6270.31026587075;3635.309291234657;3644.1982763791925;3648.744587878823;3659.4876717259604;3661.615530369273;6724.159480064992;6780.254172041072;6789.32106789327;6793.422559082534;6801.285864984205;6474.902876456857;6705.765298214539;6740.460763138937;6768.83077923046;6771.492138089663;6404.327545607737;6666.966665166643;6711.630860302633;6716.899246511404;6741.460683145337;6472.320406357265;6494.577852439576;6533.18335208099;6559.409653131241;6571.934280657132;6488.805335839932;6495.155629768289;6499.610023398611;6505.381988711065;6508.707108180049;6633.668316584248;6769.593824370553;6777.661116944035;6850.8287292816085;6869.862602748017;4708.293755936637;4724.740139292372;4727.598154156935;4736.905261894812;4747.074320507468;6644.800655980328;6646.60120392778;6648;6648.966755166193;6659.733610655519;6332.841678958063;6345.302016778243;6346.238451385863;6361.522885783492;6486.156799616019;6305.495560355069;6313.90529142054;6319.336469670802;6320.936790632035;6321.431071203614;6178.598391104564;6208.192934918612;6217.347178546188;6231.2522497300615;6251.437370636482;6242.469390101892;6373.7131829066875;6377.362263773585;6429;6455;6348.682565871781;6356.9046464304;6357.268914074755;6365.936340636535;6372 03:30:08 INFO - 2015-10-27 03:30:08,117 DEBUG : BROWSER_OUTPUT: |5;yui.html;844.8141408890044;919.6183583812718;921.2307723051252;923.7875288683607;930.878985731855;12993.155444896087;13261.33693315334;13440.52958146465;13462.057655964087;13584.184948903048;13373.866261337384;13442.39509222085;13464.93267533661;13470.730585388312;13478.730425391486;752.4619896773805;762.1007211490439;929.1962452478625;939;939.8872135343734;930.3441074042818;934.7102398256528;935.8362286599818;936.180841763457;941.3081385181886;790.9406794490408;792.3779832831228;977.4233202410576;984.7833476635129;986.6793292180071;966.2849491376401;967.2262190247844;969.5346233807777;974.8342781727088;977.184051317151;723.9457040721967;725.7532438970775;725.8403151306704;727.3490226247532;729.7445893937132;13716.177029378268;13797.51708690191;13862;13870.098443601235;13873.514426995107;12125;12719.236845789283;12747.107702460831;12848.935755321258;12955.287459189742;10173.84739228912;10242.692719218436;10314.12329951955;10321.225908056926;10450.738731531772;3405.3019131078067;3500.5099286099967;3500.7374446916583;3535.3106144301873;3552.982235088808;44479.33281000787;44785.10429791386;44983.77508112438;45570.544294557294;45848.3122753159;9650.613975441043;9655.749795682454;9688.46713430768;9694.22446204302;9765.414075155513;17336;17520.824791752173;17586;17590.824091758917;17594.91202543979;7432;7608.885866712004;7613.733519326908;7685.03937007874;7706.653200605986;4013.57857424972;4104.0970986382945;4160.646345060643;4171.3325867860995;4173.728707633994;3157.6210854697124;3171.413288541581;3192.664770199142;3195.1532843796413;3201.135693362779;521.4576840086344;525.8238490105857;528.5560129491246;531.9468053194649;560.347195517226;518.3158231134942;574.1015311038212;616.6824085595922;654.8330175805235;666.8399584099781;7976.601169941479;8111.456345598532;8180.181981801772;8387.329013678891;8570.571471426403;657.1457105762489;666.5201055240219;669.5514005616249;679.3138929681057;680.3706571421416;3586.941852153621;3794.8482060717815;3825.158465137665;3868.458415821787;4019.799010049486;53081.2037819433;53401;53674.73162634162;53690;53765.73117134389;46106.76946615245;46223.99999999933;46298.074038519044;46460.30309545359;46558.06883862304;37634.62365376366;37858;38672.613273867464;39632.603673963466;39779;7379.815504612213;7528.661210245443;8055.234752698484;8197.83604327922;8618.827623447622;27109.72890271151;27511.58732618972;28037.158885233475;28066.2983425416;28375.57436638411;37752;38435.42346864855;38689.80655096819;38912.610873890895;39688;7548.471606987678;7740.109887363025;7761.3790896727;8570;8880.422772519765;11751.882481175078;12106.152569320064;12418.627441176779;12599.559015434415;13043.478260869459;10630.186362466231;10641.361518308926;10887.401192934465;11607.245529040585;11912.344821034927;10189.949050254998;10495.580176792842;10497.370157790558;10677.09244714208;10807.513661885077;9535.52322383892;10828.133749300194;10987.83518247211;11209.49557269941;11480.311181329147;8841.425307355;9166.312526560669;9224.077592240723;9661.275404344562;9986.60053597877;9437.905620943702;9666.130048295687;9680.903190968;9752.414855108716;9860.359076659994 03:30:08 INFO - 2015-10-27 03:30:08,117 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:30:08 INFO - 2015-10-27 03:30:08,117 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:30:08 INFO - 2015-10-27 03:30:08,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 03:30:08 INFO - 2015-10-27 03:30:08,117 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:30:08 INFO - 2015-10-27 03:30:08,117 DEBUG : BROWSER_OUTPUT: __startTimestamp1445941808107__endTimestamp 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5756.19 Median:5993.58 stddev:666.05 (11.1%) stddev-sans-first:641.12 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: Values: 3364.4 3386.3 3433.3 3435.5 3450.4 5711.2 5749.3 5757.6 5792.0 5792.2 5733.5 5796.3 5823.0 5832.9 5839.6 5124.5 5166.6 5265.6 5305.3 5372.3 5160.5 5179.5 5269.7 5294.0 5297.4 5320.7 5376.9 5380.9 5382.6 5391.0 5018.4 5137.7 5284.6 5319.9 5368.7 5045.1 5163.9 5170.6 5179.6 5223.3 5501.1 5532.4 5548.2 5553.9 5560.1 5861.9 5989.4 6062.8 6190.4 6199.7 6277.1 6306.6 6320.7 6323.0 6337.7 5875.5 5890.7 5890.7 5906.0 5917.3 5978.0 6070.8 6180.5 6191.3 6337.8 6105.4 6106.9 6107.1 6109.8 6176.5 6186.5 6190.6 6200.0 6217.0 6234.8 5953.1 6032.1 6065.2 6124.6 6139.6 6165.1 6208.3 6211.0 6213.6 6233.6 4500.6 4703.3 4712.0 4718.9 4730.4 4123.9 4162.8 4165.9 4176.6 4193.6 5898.3 5966.0 5966.9 5984.6 5998.4 5985.3 6090.0 6322.7 6332.5 6332.8 5876.7 5963.2 5966.6 5983.4 5993.6 5253.1 5267.6 5269.3 5272.2 5284.9 6120.7 6201.6 6255.4 6465.0 6494.9 6237.2 6278.7 6294.2 6297.5 6299.8 6442.6 6453.7 6457.5 6460.7 6468.3 5999.4 6058.1 6133.2 6136.0 6192.9 6221.6 6337.8 6340.9 6345.3 6354.6 6169.0 6179.0 6183.8 6188.0 6200.4 5910.8 6038.8 6087.8 6183.4 6201.3 6003.5 6031.4 6037.0 6037.5 6083.4 5929.5 6139.3 6145.3 6150.9 6162.5 5937.4 5986.2 6095.6 6119.8 6144.2 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53125.36 Median:3586.99 stddev:90312.40 (2517.8%) stddev-sans-first:90479.69 03:30:08 INFO - 2015-10-27 03:30:08,118 DEBUG : BROWSER_OUTPUT: Values: 614.8 653.8 656.0 659.6 663.2 44882.0 45438.3 45482.5 45631.8 45701.5 49383.3 50005.0 50052.0 50067.7 50095.5 8198.8 8335.1 9289.7 9442.9 10845.1 11046.2 11103.1 11163.4 11173.7 11179.2 11200.3 11279.7 11300.8 11304.2 11312.3 8390.2 8621.1 10864.1 11047.3 11055.0 10620.2 10695.0 10766.2 10770.7 10771.1 41499.4 41633.4 41872.6 41990.8 42011.0 3559.7 3614.3 3635.4 3662.2 3671.3 34767.7 35108.8 35112.8 35171.1 35273.1 3674.2 3682.5 3721.3 3740.8 3818.0 333970.0 334326.0 334406.3 337068.0 338844.0 59439.4 60359.0 69153.3 69839.7 73095.6 72103.6 72241.0 72508.6 72557.6 72629.3 16275.6 16470.7 16482.9 16494.1 16546.0 12293.4 12427.1 12441.3 12949.5 13137.6 22217.9 22684.2 22698.2 22699.2 22722.3 8062.6 8142.4 8216.8 8270.5 8283.2 1156.5 1191.8 1226.9 1259.7 1290.6 32089.8 32236.8 32317.2 32629.0 32841.8 1197.6 1260.2 1260.7 1296.8 1300.4 14830.1 16614.7 16680.6 16795.6 17510.5 416816.0 422108.0 422919.0 428546.0 428985.0 52499.2 53736.7 60985.0 62866.4 63351.4 1484.5 1495.8 1496.0 1503.3 1511.1 30364.7 30389.7 30730.5 31043.0 31310.2 49798.0 50985.0 55969.2 57489.4 57523.0 249250.0 250039.0 250040.0 250376.0 251441.0 32741.3 33161.5 33254.0 33280.7 33377.5 45688.8 46723.5 50964.5 51038.5 51124.5 41008.2 41492.4 41948.6 42262.6 43031.4 41448.4 41776.0 41981.6 42242.2 42350.8 42624.4 43293.1 43296.4 43369.6 43469.0 35402.3 36563.0 36863.0 37240.0 37287.4 28391.9 28580.9 28641.7 28768.9 28796.9 03:30:08 INFO - 2015-10-27 03:30:08,119 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,119 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32391.35 Median:26000.26 stddev:106211.92 (408.5%) stddev-sans-first:106482.73 03:30:08 INFO - 2015-10-27 03:30:08,119 DEBUG : BROWSER_OUTPUT: Values: 415.0 418.4 418.6 419.9 422.9 15776.4 15951.4 18472.4 18484.7 18956.0 16599.7 16844.7 16916.2 16995.4 17698.8 5770.0 5909.0 5910.3 5914.2 5915.3 4219.0 4282.0 5841.0 6512.1 6685.5 6478.4 6588.3 6588.3 6618.3 6626.8 6602.3 6682.6 6701.3 6703.9 6704.3 5888.9 5978.4 5998.1 6001.7 6005.7 23230.5 23728.3 23781.8 23801.9 23999.6 2396.1 2438.3 2452.7 2495.5 2529.7 14685.9 14796.7 14856.0 14946.0 15003.9 1822.2 1905.2 1914.1 1925.6 2000.4 68030.7 69043.7 69800.3 69945.7 70100.3 11497.3 11568.3 11574.1 11634.9 11645.7 15213.8 15215.8 15236.4 15299.8 16337.5 8731.3 8768.5 8780.5 8811.3 8842.7 8613.3 8615.6 8632.4 8716.5 8722.0 6870.5 6888.1 6932.3 6947.2 6975.9 1199.6 1241.9 1245.6 1264.4 1778.6 523.8 547.2 559.6 559.8 562.4 11307.5 12353.6 12432.7 13028.6 13377.8 572.6 573.7 579.6 581.5 591.4 7103.8 7156.7 7313.3 7330.0 7332.3 637393.0 641811.0 641905.0 660194.0 664621.0 85568.0 87785.0 87951.0 88857.0 89451.0 613.8 614.5 616.4 617.9 618.3 11722.6 11812.4 12024.5 12104.3 12124.2 35402.5 38661.0 40338.6 40716.6 41418.0 47718.5 48867.3 50368.0 54327.7 55362.0 7302.7 7427.1 7459.2 7522.5 7522.7 12773.7 12894.9 13300.5 13327.9 13444.5 11614.9 11680.3 11760.1 11767.6 11907.2 11170.7 11344.1 11365.0 11494.7 11503.6 9342.8 10229.1 11569.3 11801.4 11846.5 7385.9 7574.2 7587.6 7591.0 7665.8 11741.8 11875.8 12010.8 12115.5 12199.6 03:30:08 INFO - 2015-10-27 03:30:08,119 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,121 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7255.57 Median:2579.60 stddev:4204.87 (163.0%) stddev-sans-first:4194.61 03:30:08 INFO - 2015-10-27 03:30:08,121 DEBUG : BROWSER_OUTPUT: Values: 1525.0 1619.7 1860.5 2003.6 2052.3 9300.6 10168.8 10395.6 10402.1 10409.8 10054.9 10084.7 10166.9 10188.7 10208.0 2210.1 2231.6 2462.5 2488.4 2501.6 2528.6 2557.8 2568.7 2575.2 2582.9 2530.9 2552.4 2552.4 2554.3 2561.8 2177.5 2237.7 2413.5 2454.6 2462.3 2552.5 2562.3 2576.3 2627.5 2648.5 10647.4 10741.2 10774.2 10776.8 10788.6 5570.1 5655.7 5675.1 5675.1 5679.2 3740.4 3786.8 3838.6 3913.3 3930.5 1106.4 1161.9 1165.3 1178.0 1198.9 16108.7 16136.4 16142.8 16152.0 16179.1 5468.6 5488.0 5508.9 5532.6 5560.9 12367.6 12485.9 12490.8 12501.2 12513.5 5870.3 5875.3 5881.8 5886.6 5888.2 5177.9 5237.8 5245.7 5253.5 5260.3 4497.2 4508.4 4510.6 4541.5 4586.4 1385.4 1389.3 1397.9 1398.2 1410.8 1191.3 1214.2 1214.6 1556.0 1557.5 9793.4 9971.6 9971.7 9973.5 9997.0 566.8 569.1 576.9 610.1 610.5 7440.8 7501.5 7565.9 7566.1 7573.2 13561.3 13757.7 13804.8 13806.7 13810.2 13328.8 13677.1 13696.3 13733.9 13739.7 9626.3 9780.0 9840.9 9844.1 9868.4 9404.3 9522.2 9566.5 9572.7 9590.7 11571.2 11745.9 11754.9 11769.1 11777.3 11711.1 11960.1 11975.5 12111.5 12126.9 9069.2 9322.4 9386.9 9395.7 9396.0 10094.3 10145.2 10282.1 10333.3 10339.2 8082.0 9216.0 9286.0 9354.8 9629.1 8264.6 9224.4 9304.6 9330.9 9373.7 9266.8 9402.0 9451.2 9479.1 9481.6 8245.0 8332.2 8337.2 8345.1 8346.6 8723.9 8748.7 8781.0 8856.6 8861.3 03:30:08 INFO - 2015-10-27 03:30:08,121 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,121 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5380.09 Median:6152.18 stddev:1555.31 (25.3%) stddev-sans-first:1513.84 03:30:08 INFO - 2015-10-27 03:30:08,121 DEBUG : BROWSER_OUTPUT: Values: 386.7 387.1 388.2 392.1 392.2 5919.0 5970.0 5979.1 6000.6 6011.3 5871.5 5960.7 5963.2 5974.0 5976.3 4634.9 4688.3 4693.8 4736.8 4785.3 4764.8 4766.4 4778.8 4779.9 4785.4 4732.3 4738.0 4739.3 4739.9 4756.3 4731.2 4742.3 4744.9 4751.9 4753.0 4111.4 4163.7 4172.9 4187.2 4187.9 5645.9 5648.7 5652.1 5657.2 5664.3 5230.9 5317.8 5366.3 5427.9 5435.9 6262.7 6295.2 6328.7 6331.7 6340.7 4576.7 4579.0 4579.8 4584.0 4593.0 6425.1 6439.5 6514.5 6514.9 6518.4 4636.4 4681.6 4687.8 4688.2 4688.7 4703.1 4745.1 4748.8 4750.3 4760.1 5420.8 5421.2 5425.5 5430.1 5432.5 6260.1 6423.2 6426.7 6427.2 6430.4 1728.2 1749.5 1750.6 1751.8 1754.1 1160.6 1182.0 1183.6 1199.1 1207.1 6257.1 6258.4 6263.2 6265.4 6270.3 6570.3 6583.3 6586.1 6594.6 6610.7 6125.8 6240.2 6254.6 6260.0 6270.3 3635.3 3644.2 3648.7 3659.5 3661.6 6724.2 6780.3 6789.3 6793.4 6801.3 6474.9 6705.8 6740.5 6768.8 6771.5 6404.3 6667.0 6711.6 6716.9 6741.5 6472.3 6494.6 6533.2 6559.4 6571.9 6488.8 6495.2 6499.6 6505.4 6508.7 6633.7 6769.6 6777.7 6850.8 6869.9 4708.3 4724.7 4727.6 4736.9 4747.1 6644.8 6646.6 6648.0 6649.0 6659.7 6332.8 6345.3 6346.2 6361.5 6486.2 6305.5 6313.9 6319.3 6320.9 6321.4 6178.6 6208.2 6217.3 6231.3 6251.4 6242.5 6373.7 6377.4 6429.0 6455.0 6348.7 6356.9 6357.3 6365.9 6372.0 03:30:08 INFO - 2015-10-27 03:30:08,121 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,121 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12739.09 Median:46261.04 stddev:14180.60 (30.7%) stddev-sans-first:14192.24 03:30:08 INFO - 2015-10-27 03:30:08,122 DEBUG : BROWSER_OUTPUT: Values: 844.8 919.6 921.2 923.8 930.9 12993.2 13261.3 13440.5 13462.1 13584.2 13373.9 13442.4 13464.9 13470.7 13478.7 752.5 762.1 929.2 939.0 939.9 930.3 934.7 935.8 936.2 941.3 790.9 792.4 977.4 984.8 986.7 966.3 967.2 969.5 974.8 977.2 723.9 725.8 725.8 727.3 729.7 13716.2 13797.5 13862.0 13870.1 13873.5 12125.0 12719.2 12747.1 12848.9 12955.3 10173.8 10242.7 10314.1 10321.2 10450.7 3405.3 3500.5 3500.7 3535.3 3553.0 44479.3 44785.1 44983.8 45570.5 45848.3 9650.6 9655.7 9688.5 9694.2 9765.4 17336.0 17520.8 17586.0 17590.8 17594.9 7432.0 7608.9 7613.7 7685.0 7706.7 4013.6 4104.1 4160.6 4171.3 4173.7 3157.6 3171.4 3192.7 3195.2 3201.1 521.5 525.8 528.6 531.9 560.3 518.3 574.1 616.7 654.8 666.8 7976.6 8111.5 8180.2 8387.3 8570.6 657.1 666.5 669.6 679.3 680.4 3586.9 3794.8 3825.2 3868.5 4019.8 53081.2 53401.0 53674.7 53690.0 53765.7 46106.8 46224.0 46298.1 46460.3 46558.1 37634.6 37858.0 38672.6 39632.6 39779.0 7379.8 7528.7 8055.2 8197.8 8618.8 27109.7 27511.6 28037.2 28066.3 28375.6 37752.0 38435.4 38689.8 38912.6 39688.0 7548.5 7740.1 7761.4 8570.0 8880.4 11751.9 12106.2 12418.6 12599.6 13043.5 10630.2 10641.4 10887.4 11607.2 11912.3 10189.9 10495.6 10497.4 10677.1 10807.5 9535.5 10828.1 10987.8 11209.5 11480.3 8841.4 9166.3 9224.1 9661.3 9986.6 9437.9 9666.1 9680.9 9752.4 9860.4 03:30:08 INFO - 2015-10-27 03:30:08,122 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:30:08 INFO - 2015-10-27 03:30:08,122 DEBUG : BROWSER_OUTPUT: 03:30:08 INFO - 2015-10-27 03:30:08,782 INFO : Browser exited with error code: 0 03:30:08 INFO - 2015-10-27 03:30:08,802 INFO : Completed test dromaeo_css (00:18:34) 03:30:08 INFO - 2015-10-27 03:30:08,803 INFO : Starting test kraken 03:30:08 INFO - 2015-10-27 03:30:08,803 DEBUG : operating with platform_type : linux_ 03:30:08 INFO - 2015-10-27 03:30:08,803 INFO : Initialising browser for kraken test... 03:30:08 INFO - 2015-10-27 03:30:08,809 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH3np5p/profile http://localhost/getInfo.html 03:30:12 INFO - 2015-10-27 03:30:12,766 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:30:12 INFO - 2015-10-27 03:30:12,766 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:30:12 INFO - 2015-10-27 03:30:12,766 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:30:12 INFO - 2015-10-27 03:30:12,766 DEBUG : BROWSER_OUTPUT: __metrics 03:30:12 INFO - 2015-10-27 03:30:12,883 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:30:14 INFO - 2015-10-27 03:30:14,228 INFO : Browser initialized. 03:30:14 INFO - 2015-10-27 03:30:14,228 INFO : Running cycle 1/1 for kraken test... 03:30:14 INFO - 2015-10-27 03:30:14,229 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH3np5p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:30:25 INFO - 2015-10-27 03:30:25,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 132280320 03:30:25 INFO - 2015-10-27 03:30:25,907 DEBUG : BROWSER_OUTPUT: 03:30:28 INFO - 2015-10-27 03:30:28,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=ai-astar (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection) 03:30:29 INFO - 2015-10-27 03:30:29,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 166080512 03:30:29 INFO - 2015-10-27 03:30:29,359 DEBUG : BROWSER_OUTPUT: 03:30:31 INFO - 2015-10-27 03:30:31,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-beat-detection (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-dft) 03:30:32 INFO - 2015-10-27 03:30:32,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 161763328 03:30:32 INFO - 2015-10-27 03:30:32,462 DEBUG : BROWSER_OUTPUT: 03:30:35 INFO - 2015-10-27 03:30:35,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-dft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-fft) 03:30:35 INFO - 2015-10-27 03:30:35,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 161460224 03:30:35 INFO - 2015-10-27 03:30:35,768 DEBUG : BROWSER_OUTPUT: 03:30:37 INFO - 2015-10-27 03:30:37,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-fft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator) 03:30:38 INFO - 2015-10-27 03:30:38,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 160604160 03:30:38 INFO - 2015-10-27 03:30:38,286 DEBUG : BROWSER_OUTPUT: 03:30:40 INFO - 2015-10-27 03:30:40,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-oscillator (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur) 03:30:40 INFO - 2015-10-27 03:30:40,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 155979776 03:30:40 INFO - 2015-10-27 03:30:40,933 DEBUG : BROWSER_OUTPUT: 03:30:43 INFO - 2015-10-27 03:30:43,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom) 03:30:44 INFO - 2015-10-27 03:30:44,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 157184000 03:30:44 INFO - 2015-10-27 03:30:44,319 DEBUG : BROWSER_OUTPUT: 03:30:47 INFO - 2015-10-27 03:30:47,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-darkroom (next: http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate) 03:30:48 INFO - 2015-10-27 03:30:48,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 157458432 03:30:48 INFO - 2015-10-27 03:30:48,256 DEBUG : BROWSER_OUTPUT: 03:30:50 INFO - 2015-10-27 03:30:50,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=imaging-desaturate (next: http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial) 03:30:51 INFO - 2015-10-27 03:30:51,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 155402240 03:30:51 INFO - 2015-10-27 03:30:51,512 DEBUG : BROWSER_OUTPUT: 03:30:52 INFO - 2015-10-27 03:30:52,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-parse-financial (next: http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:53 INFO - 2015-10-27 03:30:53,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 166592512 03:30:53 INFO - 2015-10-27 03:30:53,549 DEBUG : BROWSER_OUTPUT: 03:30:55 INFO - 2015-10-27 03:30:55,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes) 03:30:55 INFO - 2015-10-27 03:30:55,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 164761600 03:30:55 INFO - 2015-10-27 03:30:55,829 DEBUG : BROWSER_OUTPUT: 03:30:57 INFO - 2015-10-27 03:30:57,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm) 03:30:58 INFO - 2015-10-27 03:30:58,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 173211648 03:30:58 INFO - 2015-10-27 03:30:58,343 DEBUG : BROWSER_OUTPUT: 03:31:00 INFO - 2015-10-27 03:31:00,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:01 INFO - 2015-10-27 03:31:01,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 176820224 03:31:01 INFO - 2015-10-27 03:31:01,569 DEBUG : BROWSER_OUTPUT: 03:31:03 INFO - 2015-10-27 03:31:03,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:04 INFO - 2015-10-27 03:31:04,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 175808512 03:31:04 INFO - 2015-10-27 03:31:04,522 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost/page_load_test/kraken/driver.html?testName=ai-astar) 03:31:06 INFO - 2015-10-27 03:31:06,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 233066496 03:31:06 INFO - 2015-10-27 03:31:06,387 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,388 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:31:06 INFO - 2015-10-27 03:31:06,388 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:31:06 INFO - 2015-10-27 03:31:06,388 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:31:06 INFO - 2015-10-27 03:31:06,389 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:31:06 INFO - 2015-10-27 03:31:06,389 DEBUG : BROWSER_OUTPUT: |0;ai-astar;103;108;108;108;109;109;116;111;107;108 03:31:06 INFO - 2015-10-27 03:31:06,389 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;123;145;158;123;148;147;122;166;125 03:31:06 INFO - 2015-10-27 03:31:06,389 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;162;160;159;160;159;159;160 03:31:06 INFO - 2015-10-27 03:31:06,389 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;70;71;156;70;74;70;71;165;71 03:31:06 INFO - 2015-10-27 03:31:06,389 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;87;134;89;88;89;130;87;88;131 03:31:06 INFO - 2015-10-27 03:31:06,390 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;111;110;109;109;109 03:31:06 INFO - 2015-10-27 03:31:06,390 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;145;147;147;146;146;146 03:31:06 INFO - 2015-10-27 03:31:06,390 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 03:31:06 INFO - 2015-10-27 03:31:06,390 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;53;53;54;53;52;54;53;64;52 03:31:06 INFO - 2015-10-27 03:31:06,390 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;62;61;61;61;61;61;60;61 03:31:06 INFO - 2015-10-27 03:31:06,390 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;77;77;79;85;78;86;78;80;78 03:31:06 INFO - 2015-10-27 03:31:06,391 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;104;117;116;111;111;115;106;125;115 03:31:06 INFO - 2015-10-27 03:31:06,391 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;137;136;138;135;134;138;137;133;124 03:31:06 INFO - 2015-10-27 03:31:06,391 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;65;63;61;65;62;61;61;62;64 03:31:06 INFO - 2015-10-27 03:31:06,391 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:31:06 INFO - 2015-10-27 03:31:06,391 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:31:06 INFO - 2015-10-27 03:31:06,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,885 03:31:06 INFO - 2015-10-27 03:31:06,391 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:31:06 INFO - 2015-10-27 03:31:06,392 DEBUG : BROWSER_OUTPUT: __startTimestamp1445941866387__endTimestamp 03:31:06 INFO - 2015-10-27 03:31:06,392 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,395 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:31:06 INFO - 2015-10-27 03:31:06,395 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:31:06 INFO - 2015-10-27 03:31:06,395 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,396 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:108.50 stddev:3.27 (3.0%) stddev-sans-first:2.74 03:31:06 INFO - 2015-10-27 03:31:06,396 DEBUG : BROWSER_OUTPUT: Values: 103.0 108.0 108.0 108.0 109.0 109.0 116.0 111.0 107.0 108.0 03:31:06 INFO - 2015-10-27 03:31:06,396 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,396 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:147.50 stddev:17.77 (12.0%) stddev-sans-first:16.82 03:31:06 INFO - 2015-10-27 03:31:06,396 DEBUG : BROWSER_OUTPUT: Values: 165.0 123.0 145.0 158.0 123.0 148.0 147.0 122.0 166.0 125.0 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 162.0 160.0 159.0 160.0 159.0 159.0 160.0 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.70 Median:70.50 stddev:37.92 (53.8%) stddev-sans-first:39.55 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 156.0 70.0 74.0 70.0 71.0 165.0 71.0 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.20 Median:88.00 stddev:21.06 (23.9%) stddev-sans-first:21.87 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: Values: 89.0 87.0 134.0 89.0 88.0 89.0 130.0 87.0 88.0 131.0 03:31:06 INFO - 2015-10-27 03:31:06,397 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 111.0 110.0 109.0 109.0 109.0 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 145.0 147.0 147.0 146.0 146.0 146.0 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:3.52 (6.6%) stddev-sans-first:3.73 03:31:06 INFO - 2015-10-27 03:31:06,398 DEBUG : BROWSER_OUTPUT: Values: 54.0 53.0 53.0 54.0 53.0 52.0 54.0 53.0 64.0 52.0 03:31:06 INFO - 2015-10-27 03:31:06,399 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:78.50 stddev:3.24 (4.1%) stddev-sans-first:3.38 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: Values: 78.0 77.0 77.0 79.0 85.0 78.0 86.0 78.0 80.0 78.0 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.50 Median:115.00 stddev:5.93 (5.2%) stddev-sans-first:6.26 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: Values: 115.0 104.0 117.0 116.0 111.0 111.0 115.0 106.0 125.0 115.0 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,400 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.60 Median:137.00 stddev:5.06 (3.7%) stddev-sans-first:4.36 03:31:06 INFO - 2015-10-27 03:31:06,401 DEBUG : BROWSER_OUTPUT: Values: 144.0 137.0 136.0 138.0 135.0 134.0 138.0 137.0 133.0 124.0 03:31:06 INFO - 2015-10-27 03:31:06,401 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2015-10-27 03:31:06,401 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.65 (2.6%) stddev-sans-first:1.66 03:31:06 INFO - 2015-10-27 03:31:06,401 DEBUG : BROWSER_OUTPUT: Values: 61.0 65.0 63.0 61.0 65.0 62.0 61.0 61.0 62.0 64.0 03:31:06 INFO - 2015-10-27 03:31:06,401 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:31:06 INFO - 2015-10-27 03:31:06,401 DEBUG : BROWSER_OUTPUT: 03:31:07 INFO - 2015-10-27 03:31:07,238 INFO : Browser exited with error code: 0 03:31:07 INFO - 2015-10-27 03:31:07,285 INFO : Completed test kraken (00:00:58) 03:31:07 INFO - 2015-10-27 03:31:07,285 INFO : Starting test v8_7 03:31:07 INFO - 2015-10-27 03:31:07,285 DEBUG : operating with platform_type : linux_ 03:31:07 INFO - 2015-10-27 03:31:07,285 INFO : Initialising browser for v8_7 test... 03:31:07 INFO - 2015-10-27 03:31:07,292 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptBnDdr/profile http://localhost/getInfo.html 03:31:11 INFO - 2015-10-27 03:31:11,187 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:31:11 INFO - 2015-10-27 03:31:11,187 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:31:11 INFO - 2015-10-27 03:31:11,188 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:31:11 INFO - 2015-10-27 03:31:11,188 DEBUG : BROWSER_OUTPUT: __metrics 03:31:11 INFO - 2015-10-27 03:31:11,385 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:12 INFO - 2015-10-27 03:31:12,662 INFO : Browser initialized. 03:31:12 INFO - 2015-10-27 03:31:12,662 INFO : Running cycle 1/1 for v8_7 test... 03:31:12 INFO - 2015-10-27 03:31:12,663 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptBnDdr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/v8_7/v8.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:31:24 INFO - 2015-10-27 03:31:24,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 132497408 03:31:24 INFO - 2015-10-27 03:31:24,328 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/v8_7/run.html (next: http://localhost/page_load_test/v8_7/run.html) 03:31:45 INFO - 2015-10-27 03:31:45,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 430309376 03:31:45 INFO - 2015-10-27 03:31:45,958 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,958 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:31:45 INFO - 2015-10-27 03:31:45,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:31:45 INFO - 2015-10-27 03:31:45,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:31:45 INFO - 2015-10-27 03:31:45,959 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:31:45 INFO - 2015-10-27 03:31:45,959 DEBUG : BROWSER_OUTPUT: |0;Richards;168.63406408094434 03:31:45 INFO - 2015-10-27 03:31:45,959 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.17665407978984 03:31:45 INFO - 2015-10-27 03:31:45,959 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.6901408450704 03:31:45 INFO - 2015-10-27 03:31:45,959 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5086.294416243655 03:31:45 INFO - 2015-10-27 03:31:45,960 DEBUG : BROWSER_OUTPUT: |4;RayTrace;957.8544061302682 03:31:45 INFO - 2015-10-27 03:31:45,960 DEBUG : BROWSER_OUTPUT: |5;Earley;544.6623093681917 03:31:45 INFO - 2015-10-27 03:31:45,960 DEBUG : BROWSER_OUTPUT: |6;Boyer;10224.489795918367 03:31:45 INFO - 2015-10-27 03:31:45,960 DEBUG : BROWSER_OUTPUT: |7;RegExp;23952.380952380954 03:31:45 INFO - 2015-10-27 03:31:45,960 DEBUG : BROWSER_OUTPUT: |8;Splay;533.3333333333334 03:31:45 INFO - 2015-10-27 03:31:45,960 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: __startTimestamp1445941905956__endTimestamp 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.63 Median:168.63 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: Values: 168.6 03:31:45 INFO - 2015-10-27 03:31:45,961 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.18 Median:164.18 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: Values: 164.2 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.69 Median:281.69 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: Values: 281.7 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5086.29 Median:5086.29 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: Values: 5086.3 03:31:45 INFO - 2015-10-27 03:31:45,962 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,963 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:957.85 Median:957.85 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,963 DEBUG : BROWSER_OUTPUT: Values: 957.9 03:31:45 INFO - 2015-10-27 03:31:45,963 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,963 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.66 Median:544.66 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,963 DEBUG : BROWSER_OUTPUT: Values: 544.7 03:31:45 INFO - 2015-10-27 03:31:45,963 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,964 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10224.49 Median:10224.49 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,964 DEBUG : BROWSER_OUTPUT: Values: 10224.5 03:31:45 INFO - 2015-10-27 03:31:45,964 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,964 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23952.38 Median:23952.38 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,964 DEBUG : BROWSER_OUTPUT: Values: 23952.4 03:31:45 INFO - 2015-10-27 03:31:45,964 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,964 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:533.33 Median:533.33 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,965 DEBUG : BROWSER_OUTPUT: Values: 533.3 03:31:45 INFO - 2015-10-27 03:31:45,965 DEBUG : BROWSER_OUTPUT: 03:31:45 INFO - 2015-10-27 03:31:45,965 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:31:45 INFO - 2015-10-27 03:31:45,966 DEBUG : BROWSER_OUTPUT: Values: 4840.6 03:31:45 INFO - 2015-10-27 03:31:45,966 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:31:45 INFO - 2015-10-27 03:31:45,966 DEBUG : BROWSER_OUTPUT: 03:31:46 INFO - 2015-10-27 03:31:46,830 INFO : Browser exited with error code: 0 03:31:46 INFO - 2015-10-27 03:31:46,844 INFO : Completed test v8_7 (00:00:39) 03:31:46 INFO - 2015-10-27 03:31:46,844 INFO : Completed test suite (00:20:12) 03:31:46 INFO - 2015-10-27 03:31:46,844 DEBUG : Working with test: dromaeo_css 03:31:46 INFO - 2015-10-27 03:31:46,844 DEBUG : Generating results file: dromaeo_css 03:31:46 INFO - 2015-10-27 03:31:46,845 DEBUG : Working with test: kraken 03:31:46 INFO - 2015-10-27 03:31:46,845 DEBUG : Generating results file: kraken 03:31:46 INFO - 2015-10-27 03:31:46,846 INFO : javascript benchmark 03:31:46 INFO - 2015-10-27 03:31:46,846 DEBUG : Working with test: v8_7 03:31:46 INFO - 2015-10-27 03:31:46,846 DEBUG : Generating results file: v8_7 03:31:46 INFO - 2015-10-27 03:31:46,846 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:31:46 INFO - 2015-10-27 03:31:46,902 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:31:46 INFO - 2015-10-27 03:31:46,902 DEBUG : process_Request line: dromaeo_css 7474.89 graph.html#tests=[[72,52,35]] 03:31:46 INFO - 2015-10-27 03:31:46,902 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:31:46 INFO - 2015-10-27 03:31:46,934 DEBUG : process_Request line: kraken 1458.90 graph.html#tests=[[232,52,35]] 03:31:46 INFO - 2015-10-27 03:31:46,934 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:31:47 INFO - 2015-10-27 03:31:47,002 DEBUG : process_Request line: v8_7 23317.67 graph.html#tests=[[230,52,35]] 03:31:47 INFO - 2015-10-27 03:31:47,004 INFO : javascript benchmark 03:31:47 INFO - 2015-10-27 03:31:47,006 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [414.98547550835724, 418.36199795312126, 418.5688740597184, 419.8803341047802, 422.8837069805803, 15776.447824326151, 15951.441699540519, 18472.429843463306, 18484.722729159057, 18956.0, 16599.66800663986, 16844.663106737888, 16916.154192290396, 16995.405160819373, 17698.82301176991, 5769.971150144253, 5908.970455147718, 5910.349861515251, 5914.172015917775, 5915.349311575723, 4218.978905105486, 4282.0, 5841.0362290222065, 6512.088307636935, 6685.46516278699, 6478.352164783531, 6588.308227636101, 6588.308227636101, 6618.271990081087, 6626.768063117792, 6602.306757790435, 6682.599044057372, 6701.3298670132845, 6703.932960670429, 6704.296048914867, 5888.941110588925, 5978.40215978403, 5998.130271110708, 6001.729922153513, 6005.6997150142315, 23230.53538929212, 23728.288151355315, 23781.762182378126, 23801.88099059511, 23999.64000539993, 2396.113438027923, 2438.2928950604305, 2452.6934133233344, 2495.513374891897, 2529.709083455408, 14685.926570367186, 14796.70406591862, 14856.0, 14946.028508147045, 15003.924980375137, 1822.1982327775736, 1905.1807722679243, 1914.1482040491987, 1925.6341295154016, 2000.449876284019, 68030.65984670045, 69043.65478172577, 69800.30199697989, 69945.65027174882, 70100.29899700989, 11497.252678575866, 11568.305901645928, 11574.074074074222, 11634.883651163549, 11645.708857278636, 15213.771793423108, 15215.847841521665, 15236.390544378322, 15299.770503442458, 16337.509874703777, 8731.345149113842, 8768.517731524827, 8780.517071561126, 8811.295096392274, 8842.734717958472, 8613.310935125175, 8615.61229744663, 8632.438891472035, 8716.520591367409, 8722.040575536686, 6870.519063665595, 6888.138982627172, 6932.306769323128, 6947.235804061549, 6975.8604827903155, 1199.5921386728555, 1241.8944389726794, 1245.5516014234868, 1264.4057293072242, 1778.575980534146, 523.7826302084668, 547.1601092323265, 559.5523581135076, 559.7816851427947, 562.361719448429, 11307.49116289769, 12353.62939111828, 12432.677053754001, 13028.555534031768, 13377.799333010013, 572.5505478199676, 573.6959411511905, 579.5913880714087, 581.4737662415521, 591.4263164730205, 7103.82240443993, 7156.677949492286, 7313.341799238094, 7330.047093877762, 7332.340089391981, 637393.0, 641811.0, 641905.0, 660194.0, 664621.0, 85568.0, 87784.99999999872, 87951.0, 88857.0, 89451.0, 613.7913109542777, 614.5390956782413, 616.4298024327569, 617.9165812615329, 618.2735286038886, 11722.58970936013, 11812.350320732443, 12024.519019239133, 12104.334261615695, 12124.151309408257, 35402.46896296506, 38661.0, 40338.596614033486, 40716.59283407128, 41418.0, 47718.5228147728, 48867.26699099587, 50368.0, 54327.72836135952, 55362.0, 7302.744403945836, 7427.145878224073, 7459.216782237787, 7522.511036782592, 7522.661480233293, 12773.744525109632, 12894.871051289367, 13300.46798128064, 13327.933360333136, 13444.46222151103, 11614.883851161718, 11680.299182049104, 11760.059195264188, 11767.588134415255, 11907.226030308002, 11170.664880053611, 11344.149188811038, 11365.033972112133, 11494.712632183928, 11503.597374091867, 9342.766430839283, 10229.079382855281, 11569.305841649528, 11801.35092569917, 11846.526138954345, 7385.852282954418, 7574.242575742602, 7587.620618968919, 7590.962045189739, 7665.808354790952, 11741.765164696488, 11875.762484750085, 12010.75978480408, 12115.515379384726, 12199.634010979686], "dojo.html": [3364.4280472319706, 3386.2719515304207, 3433.279011407603, 3435.519027336173, 3450.3961806683833, 5711.228984087147, 5749.281339832521, 5757.596968212227, 5792.0153573892485, 5792.160136780164, 5733.541316694665, 5796.30444346679, 5823.0, 5832.912506312408, 5839.5620328475325, 5124.487551244864, 5166.5866730661455, 5265.631405801595, 5305.310309659739, 5372.301600791911, 5160.458151894053, 5179.533841954223, 5269.736513174345, 5293.9735301323435, 5297.417284098746, 5320.680759154444, 5376.946230537703, 5380.892382152355, 5382.5963052771, 5390.973045134789, 5018.447970723218, 5137.717425541594, 5284.603654725873, 5319.856230910373, 5368.731563421852, 5045.117104506733, 5163.922541161885, 5170.6122040847085, 5179.585633149339, 5223.2948551945765, 5501.14732216507, 5532.3914369419335, 5548.195511650828, 5553.916691249635, 5560.054790685593, 5861.85345366365, 5989.401059894019, 6062.848428789272, 6190.442860142563, 6199.721012554446, 6277.089821975834, 6306.590071645374, 6320.683965801692, 6322.968385158091, 6337.746490140389, 5875.529957603381, 5890.734916928705, 5890.734916928748, 5905.970470147665, 5917.289925209003, 5977.970110149421, 6070.757169713162, 6180.505559555225, 6191.25704915404, 6337.7781777637565, 6105.358937311607, 6106.908396374058, 6107.114468402056, 6109.7861574844665, 6176.474999625082, 6186.536009799283, 6190.566660333733, 6200.038993955944, 6217.0, 6234.750609975641, 5953.077273022688, 6032.065029920369, 6065.211522502134, 6124.5712800103565, 6139.6009259398, 6165.136880836686, 6208.317085120633, 6211.0, 6213.627182369072, 6233.594816337014, 4500.639948804088, 4703.270992996091, 4712.0, 4718.9292160617615, 4730.361401210861, 4123.8556650517085, 4162.83348666056, 4165.854195103157, 4176.644985176234, 4193.580641935782, 5898.292204935436, 5966.0, 5966.85082872923, 5984.551158663117, 5998.3701711320555, 5985.311689155803, 6090.0, 6322.715477803418, 6332.525060620472, 6332.8416789579705, 5876.7355469004, 5963.165156878041, 5966.642001479925, 5983.371745966698, 5993.580449368589, 5253.13323301651, 5267.604929630293, 5269.288646032813, 5272.2355258487305, 5284.920726189033, 6120.663363515049, 6201.596896201732, 6255.40573645503, 6464.997925321582, 6494.902576461357, 6237.1891654084675, 6278.717457714505, 6294.181756371642, 6297.52768542352, 6299.779507717208, 6442.645654489048, 6453.709583068679, 6457.515686323451, 6460.709268083042, 6468.288488266193, 5999.430054144849, 6058.0610005449225, 6133.172021777003, 6136.0, 6192.907106393318, 6221.595596286408, 6337.841553961188, 6340.873182536231, 6345.270293916259, 6354.618722876642, 6168.9691551541955, 6179.0422484514975, 6183.81448556544, 6188.040853667689, 6200.441960223601, 5910.7931222407005, 6038.75844966214, 6087.847803804763, 6183.350748171557, 6201.348858369806, 6003.549733769897, 6031.4270144336215, 6037.034074548052, 6037.516998640011, 6083.391660833881, 5929.466348028698, 6139.26328840542, 6145.293291271561, 6150.907736383869, 6162.537809664203, 5937.435943585352, 5986.191864098465, 6095.598674869747, 6119.785807496716, 6144.2319710036245], "mootools.html": [1525.0, 1619.7165496038194, 1860.49766563028, 2003.5792483578448, 2052.3124753207676, 9300.581473833678, 10168.847467287987, 10395.636152734656, 10402.063814256715, 10409.843852342212, 10054.949725251381, 10084.697459076222, 10166.898331016688, 10188.694339169837, 10208.0, 2210.1380461619983, 2231.5983123037845, 2462.507498500298, 2488.415222422729, 2501.574732295505, 2528.5954247320433, 2557.795376369886, 2568.7302833202525, 2575.1759436980174, 2582.8579428131447, 2530.8734563271855, 2552.3874270175115, 2552.3874270175115, 2554.2592648132018, 2561.8462892226435, 2177.4556360909774, 2237.742659594143, 2413.51729654069, 2454.570450171213, 2462.322861213163, 2552.4895020995873, 2562.3081767922745, 2576.3430325267122, 2627.4745050989686, 2648.510025645262, 10647.361158330525, 10741.194410419172, 10774.19193560486, 10776.78446431067, 10788.622398216103, 5570.108782594765, 5655.717214139277, 5675.091985282335, 5675.148727690879, 5679.176519404663, 3740.36413809653, 3786.848526058954, 3838.5777564467885, 3913.2760439318818, 3930.5479869814767, 1106.3970136275668, 1161.8896204860525, 1165.2600598619852, 1177.9587714429954, 1198.862130854954, 16108.677826443405, 16136.435224767194, 16142.757858632012, 16152.0, 16179.110148941685, 5468.589855760833, 5487.98472282629, 5508.862278442991, 5532.585056120807, 5560.944390556124, 12367.62897113088, 12485.87514124847, 12490.81263781044, 12501.187422817487, 12513.499460021498, 5870.3249126350165, 5875.294964604275, 5881.823545293648, 5886.58793884424, 5888.234529511136, 5177.870553236199, 5237.8428647140645, 5245.659032162897, 5253.474652534793, 5260.289860868734, 4497.190505709003, 4508.368828364031, 4510.571495707903, 4541.545845415498, 4586.4496260448295, 1385.4042761612402, 1389.2914613547164, 1397.9091359061629, 1398.2030242761527, 1410.8377536583218, 1191.3209470601846, 1214.2046959241711, 1214.5809695654984, 1556.035258139938, 1557.5015994881755, 9793.363431376938, 9971.551280192409, 9971.700848974542, 9973.451460169616, 9997.0, 566.7902875935848, 569.1150261343568, 576.9336526299445, 610.0757352610798, 610.5176910240949, 7440.7767766966, 7501.512401693873, 7565.924340756632, 7566.054243219598, 7573.2048134945035, 13561.254131022888, 13757.724845503033, 13804.792928106086, 13806.65483362924, 13810.171389716648, 13328.800067998987, 13677.110987785962, 13696.315184240748, 13733.862661373258, 13739.725205495834, 9626.326157169071, 9779.951100244452, 9840.901590984142, 9844.064813842817, 9868.358556693793, 9404.294677899321, 9522.23822094217, 9566.521673916137, 9572.707684462786, 9590.66432674853, 11571.19001669875, 11745.882541174478, 11754.88245117538, 11769.058475321783, 11777.293362398283, 11711.121665875264, 11960.102992275788, 11975.461104250155, 12111.454984525893, 12126.878731212575, 9069.18377346042, 9322.440653560809, 9386.859197111913, 9395.671151509665, 9395.953020234854, 10094.293399461967, 10145.239107067147, 10282.07461328484, 10333.328333658588, 10339.224558158017, 8081.959590202011, 9216.0, 9286.0, 9354.83709749155, 9629.104466512268, 8264.628091736007, 9224.40041397307, 9304.627814887328, 9330.860037099314, 9373.671921482715, 9266.814663706553, 9401.952990235006, 9451.15702438018, 9479.146876781122, 9481.573329200064, 8244.958775206085, 8332.208440198172, 8337.249647531751, 8345.082040975367, 8346.62440190205, 8723.869141963003, 8748.737537873874, 8781.0, 8856.601452934505, 8861.291096712377], "ext.html": [614.8379562626634, 653.8267359149824, 655.9836004099894, 659.5877576514677, 663.194219023886, 44882.0, 45438.31842522361, 45482.54517454824, 45631.77184114075, 45701.542984570144, 49383.25925111117, 50005.0, 50052.0, 50067.749661251735, 50095.499045009536, 8198.836023279531, 8335.124811894755, 9289.721308360744, 9442.858357124614, 10845.0781683557, 11046.171537134707, 11103.111751059936, 11163.386013769239, 11173.664790056311, 11179.161562882775, 11200.327980321206, 11279.661610151708, 11300.830487542693, 11304.208705390625, 11312.321260724342, 8390.244877960982, 8621.094785047573, 10864.076553492963, 11047.337159770439, 11055.0, 10620.150387968944, 10695.0, 10766.24636275461, 10770.676879693621, 10771.084457821094, 41499.377509337384, 41633.37549936753, 41872.58127418717, 41990.79004604957, 42011.0, 3559.66183212597, 3614.313280476701, 3635.363811333006, 3662.157703728131, 3671.284099600579, 34767.652323476694, 35108.824455877555, 35112.82443587766, 35171.12072198215, 35273.118172045644, 3674.1549443628114, 3682.502862113607, 3721.344001919147, 3740.7942563159017, 3818.045488627843, 333970.0, 334326.0, 334406.32796836103, 337068.0, 338844.0, 59439.405605943386, 60359.0, 69153.3084669157, 69839.65080174567, 73095.63452182704, 72103.63948180225, 72241.0, 72508.63745681237, 72557.6372118136, 72629.27370726225, 16275.593110172103, 16470.67058658844, 16482.917585411997, 16494.092824894746, 16546.0, 12293.385330733428, 12427.130100892851, 12441.315727635067, 12949.482020719253, 13137.60587182386, 22217.888910555666, 22684.206052788075, 22698.205562805222, 22699.205527806447, 22722.318330450114, 8062.637181326854, 8142.4300298978505, 8216.835663286702, 8270.462419942685, 8283.213094755989, 1156.4969238381332, 1191.7854786138405, 1226.8773122687837, 1259.6976725585976, 1290.5612091888802, 32089.839550802564, 32236.83881580577, 32317.192070198435, 32629.0, 32841.83579082089, 1197.6107764976243, 1260.1997731440601, 1260.6533203369147, 1296.7925131978839, 1300.440810451496, 14830.077203783276, 16614.6677066458, 16680.58298542522, 16795.580110497336, 17510.474685759447, 416816.0, 422108.0, 422919.0, 428546.0, 428985.0, 52499.21251181235, 53736.73131634317, 60985.0, 62866.37133628605, 63351.36648633547, 1484.4804318488443, 1495.7831114488556, 1496.0425327790224, 1503.2784263553556, 1511.1008949674926, 30364.696353036186, 30389.69610303869, 30730.539041914835, 31043.0, 31310.217244569067, 49798.0, 50985.0, 55969.16046259391, 57489.42510575008, 57523.0, 249250.0, 250039.0, 250040.0, 250376.0, 251441.0, 32741.34517309688, 33161.50257746184, 33254.0, 33280.66719332873, 33377.499337510446, 45688.771556142005, 46723.53276467328, 50964.49035509597, 51038.489615103375, 51124.488755111975, 41008.1798364037, 41492.377614336416, 41948.58051419569, 42262.57737422586, 43031.35452968271, 41448.37827432651, 41776.0, 41981.580184197766, 42242.15515689608, 42350.788246058575, 42624.36063458989, 43293.134137317706, 43296.350554741075, 43369.56630433655, 43469.0, 35402.29195416129, 36563.0, 36863.0, 37240.0, 37287.44068839024, 28391.858040709663, 28580.85709571439, 28641.713582864737, 28768.856155719088, 28796.856015720627], "prototype.html": [386.6867837051988, 387.11351006195815, 388.1848118950205, 392.0942622541928, 392.239056230912, 5918.970405147968, 5970.0, 5979.073243647236, 6000.639961602307, 6011.338752737195, 5871.471567558919, 5960.7317670704815, 5963.224780778503, 5974.044152935531, 5976.342602313742, 4634.884127896804, 4688.32019357193, 4693.765311734417, 4736.763161841911, 4785.330053792454, 4764.833230836922, 4766.356541866839, 4778.784954677048, 4779.90440191196, 4785.353977213083, 4732.313814496896, 4737.976310118444, 4739.336492890998, 4739.85780426586, 4756.262779269219, 4731.243001119821, 4742.312364707098, 4744.857654270378, 4751.881202969919, 4753.04939012199, 4111.362738775465, 4163.687723420756, 4172.91654166918, 4187.246295666779, 4187.853425130106, 5645.887082258373, 5648.661080335193, 5652.123920792284, 5657.23627310312, 5664.348599910981, 5230.947690523122, 5317.813876514303, 5366.275552800361, 5427.945720542783, 5435.918461223085, 6262.6868656566985, 6295.244570651551, 6328.746850125989, 6331.68341582919, 6340.651264180468, 4576.702514336557, 4578.9542104579195, 4579.816807327703, 4584.0, 4593.035462552868, 6425.100485931974, 6439.5170362223025, 6514.543981921267, 6514.93485065148, 6518.413342799171, 4636.44362676481, 4681.6020638245445, 4687.789049492781, 4688.2030054890065, 4688.718676879398, 4703.0593881223895, 4745.122152401747, 4748.7863046163, 4750.287456881426, 4760.071786001697, 5420.783168673288, 5421.213923981, 5425.538829199562, 5430.13117901134, 5432.483914028161, 6260.123582698426, 6423.229212494531, 6426.678666066678, 6427.228732552124, 6430.3891130342545, 1728.161841506868, 1749.5013921032698, 1750.5798608333907, 1751.8248175182634, 1754.1054062428254, 1160.5647882044234, 1181.9586314478952, 1183.6094088950626, 1199.1366216324232, 1207.0705556721275, 6257.092721555349, 6258.374162583706, 6263.185785847811, 6265.404786545271, 6270.3416141305415, 6570.342965703391, 6583.275839657634, 6586.143801305895, 6594.604323740591, 6610.6694665267505, 6125.754969801158, 6240.219972503437, 6254.593451425642, 6260.0, 6270.31026587075, 3635.309291234657, 3644.1982763791925, 3648.744587878823, 3659.4876717259604, 3661.615530369273, 6724.159480064992, 6780.254172041072, 6789.32106789327, 6793.422559082534, 6801.285864984205, 6474.902876456857, 6705.765298214539, 6740.460763138937, 6768.83077923046, 6771.492138089663, 6404.327545607737, 6666.966665166643, 6711.630860302633, 6716.899246511404, 6741.460683145337, 6472.320406357265, 6494.577852439576, 6533.18335208099, 6559.409653131241, 6571.934280657132, 6488.805335839932, 6495.155629768289, 6499.610023398611, 6505.381988711065, 6508.707108180049, 6633.668316584248, 6769.593824370553, 6777.661116944035, 6850.8287292816085, 6869.862602748017, 4708.293755936637, 4724.740139292372, 4727.598154156935, 4736.905261894812, 4747.074320507468, 6644.800655980328, 6646.60120392778, 6648.0, 6648.966755166193, 6659.733610655519, 6332.841678958063, 6345.302016778243, 6346.238451385863, 6361.522885783492, 6486.156799616019, 6305.495560355069, 6313.90529142054, 6319.336469670802, 6320.936790632035, 6321.431071203614, 6178.598391104564, 6208.192934918612, 6217.347178546188, 6231.2522497300615, 6251.437370636482, 6242.469390101892, 6373.7131829066875, 6377.362263773585, 6429.0, 6455.0, 6348.682565871781, 6356.9046464304, 6357.268914074755, 6365.936340636535, 6372.0], "yui.html": [844.8141408890044, 919.6183583812718, 921.2307723051252, 923.7875288683607, 930.878985731855, 12993.155444896087, 13261.33693315334, 13440.52958146465, 13462.057655964087, 13584.184948903048, 13373.866261337384, 13442.39509222085, 13464.93267533661, 13470.730585388312, 13478.730425391486, 752.4619896773805, 762.1007211490439, 929.1962452478625, 939.0, 939.8872135343734, 930.3441074042818, 934.7102398256528, 935.8362286599818, 936.180841763457, 941.3081385181886, 790.9406794490408, 792.3779832831228, 977.4233202410576, 984.7833476635129, 986.6793292180071, 966.2849491376401, 967.2262190247844, 969.5346233807777, 974.8342781727088, 977.184051317151, 723.9457040721967, 725.7532438970775, 725.8403151306704, 727.3490226247532, 729.7445893937132, 13716.177029378268, 13797.51708690191, 13862.0, 13870.098443601235, 13873.514426995107, 12125.0, 12719.236845789283, 12747.107702460831, 12848.935755321258, 12955.287459189742, 10173.84739228912, 10242.692719218436, 10314.12329951955, 10321.225908056926, 10450.738731531772, 3405.3019131078067, 3500.5099286099967, 3500.7374446916583, 3535.3106144301873, 3552.982235088808, 44479.33281000787, 44785.10429791386, 44983.77508112438, 45570.544294557294, 45848.3122753159, 9650.613975441043, 9655.749795682454, 9688.46713430768, 9694.22446204302, 9765.414075155513, 17336.0, 17520.824791752173, 17586.0, 17590.824091758917, 17594.91202543979, 7432.0, 7608.885866712004, 7613.733519326908, 7685.03937007874, 7706.653200605986, 4013.57857424972, 4104.0970986382945, 4160.646345060643, 4171.3325867860995, 4173.728707633994, 3157.6210854697124, 3171.413288541581, 3192.664770199142, 3195.1532843796413, 3201.135693362779, 521.4576840086344, 525.8238490105857, 528.5560129491246, 531.9468053194649, 560.347195517226, 518.3158231134942, 574.1015311038212, 616.6824085595922, 654.8330175805235, 666.8399584099781, 7976.601169941479, 8111.456345598532, 8180.181981801772, 8387.329013678891, 8570.571471426403, 657.1457105762489, 666.5201055240219, 669.5514005616249, 679.3138929681057, 680.3706571421416, 3586.941852153621, 3794.8482060717815, 3825.158465137665, 3868.458415821787, 4019.799010049486, 53081.2037819433, 53401.0, 53674.73162634162, 53690.0, 53765.73117134389, 46106.76946615245, 46223.99999999933, 46298.074038519044, 46460.30309545359, 46558.06883862304, 37634.62365376366, 37858.0, 38672.613273867464, 39632.603673963466, 39779.0, 7379.815504612213, 7528.661210245443, 8055.234752698484, 8197.83604327922, 8618.827623447622, 27109.72890271151, 27511.58732618972, 28037.158885233475, 28066.2983425416, 28375.57436638411, 37752.0, 38435.42346864855, 38689.80655096819, 38912.610873890895, 39688.0, 7548.471606987678, 7740.109887363025, 7761.3790896727, 8570.0, 8880.422772519765, 11751.882481175078, 12106.152569320064, 12418.627441176779, 12599.559015434415, 13043.478260869459, 10630.186362466231, 10641.361518308926, 10887.401192934465, 11607.245529040585, 11912.344821034927, 10189.949050254998, 10495.580176792842, 10497.370157790558, 10677.09244714208, 10807.513661885077, 9535.52322383892, 10828.133749300194, 10987.83518247211, 11209.49557269941, 11480.311181329147, 8841.425307355, 9166.312526560669, 9224.077592240723, 9661.275404344562, 9986.60053597877, 9437.905620943702, 9666.130048295687, 9680.903190968, 9752.414855108716, 9860.359076659994]}, "summary": {"suite": 7474.89012889317, "subtests": {"jquery.html": {"std": 105916.48012635423, "min": 414.98547550835724, "max": 664621.0, "median": 9092.750574398877, "filtered": 8631.140789956858, "mean": 32391.350378853254}, "dojo.html": {"std": 664.0251979791897, "min": 3364.4280472319706, "max": 6494.902576461357, "median": 5993.580449368589, "filtered": 5711.011666446774, "mean": 5756.187732158388}, "mootools.html": {"std": 4193.175620880699, "min": 566.7902875935848, "max": 16179.110148941685, "median": 8341.165844253559, "filtered": 5592.656801398764, "mean": 7255.570601530827}, "ext.html": {"std": 90061.1830494299, "min": 614.8379562626634, "max": 428985.0, "median": 31700.028397685815, "filtered": 20973.185231751326, "mean": 53125.35689249711}, "prototype.html": {"std": 1550.981911599764, "min": 386.6867837051988, "max": 6869.862602748017, "median": 6068.546861269177, "filtered": 4896.836152581096, "mean": 5380.093290179756}, "yui.html": {"std": 14141.15075358514, "min": 518.3158231134942, "max": 53765.73117134389, "median": 9593.06859963998, "filtered": 6160.475004592721, "mean": 12739.092076526991}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-056"}, "testrun": {"date": 1445940693, "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": "20151027004102", "branch": "Mozilla-Aurora", "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 159.0, 162.0, 160.0, 159.0, 160.0, 159.0, 159.0, 160.0], "ai-astar": [103.0, 108.0, 108.0, 108.0, 109.0, 109.0, 116.0, 111.0, 107.0, 108.0], "imaging-gaussian-blur": [109.0, 110.0, 109.0, 109.0, 109.0, 111.0, 110.0, 109.0, 109.0, 109.0], "audio-beat-detection": [165.0, 123.0, 145.0, 158.0, 123.0, 148.0, 147.0, 122.0, 166.0, 125.0], "json-stringify-tinderbox": [62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0], "stanford-crypto-pbkdf2": [144.0, 137.0, 136.0, 138.0, 135.0, 134.0, 138.0, 137.0, 133.0, 124.0], "json-parse-financial": [54.0, 53.0, 53.0, 54.0, 53.0, 52.0, 54.0, 53.0, 64.0, 52.0], "stanford-crypto-sha256-iterative": [61.0, 65.0, 63.0, 61.0, 65.0, 62.0, 61.0, 61.0, 62.0, 64.0], "audio-fft": [69.0, 70.0, 71.0, 156.0, 70.0, 74.0, 70.0, 71.0, 165.0, 71.0], "imaging-darkroom": [147.0, 147.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 146.0, 146.0], "stanford-crypto-ccm": [115.0, 104.0, 117.0, 116.0, 111.0, 111.0, 115.0, 106.0, 125.0, 115.0], "audio-oscillator": [89.0, 87.0, 134.0, 89.0, 88.0, 89.0, 130.0, 87.0, 88.0, 131.0], "stanford-crypto-aes": [78.0, 77.0, 77.0, 79.0, 85.0, 78.0, 86.0, 78.0, 80.0, 78.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0]}, "summary": {"suite": 1458.8999999999996, "subtests": {"audio-fft": {"std": 35.977909889264, "min": 69.0, "max": 165.0, "median": 71.0, "filtered": 88.7, "mean": 88.7}, "stanford-crypto-pbkdf2": {"std": 4.800000000000001, "min": 124.0, "max": 144.0, "median": 136.5, "filtered": 135.6, "mean": 135.6}, "audio-beat-detection": {"std": 16.85704600456438, "min": 122.0, "max": 166.0, "median": 146.0, "filtered": 142.2, "mean": 142.2}, "stanford-crypto-ccm": {"std": 5.6258332716140815, "min": 104.0, "max": 125.0, "median": 115.0, "filtered": 113.5, "mean": 113.5}, "imaging-darkroom": {"std": 0.6403124237432849, "min": 145.0, "max": 147.0, "median": 146.0, "filtered": 146.3, "mean": 146.3}, "json-parse-financial": {"std": 3.340658617698013, "min": 52.0, "max": 64.0, "median": 53.0, "filtered": 54.2, "mean": 54.2}, "audio-oscillator": {"std": 19.978988963408533, "min": 87.0, "max": 134.0, "median": 89.0, "filtered": 101.2, "mean": 101.2}, "ai-astar": {"std": 3.1, "min": 103.0, "max": 116.0, "median": 108.0, "filtered": 108.7, "mean": 108.7}, "audio-dft": {"std": 0.9433981132056604, "min": 159.0, "max": 162.0, "median": 160.0, "filtered": 159.9, "mean": 159.9}, "stanford-crypto-sha256-iterative": {"std": 1.5652475842498528, "min": 61.0, "max": 65.0, "median": 62.0, "filtered": 62.5, "mean": 62.5}, "json-stringify-tinderbox": {"std": 0.6, "min": 60.0, "max": 62.0, "median": 61.0, "filtered": 61.2, "mean": 61.2}, "imaging-gaussian-blur": {"std": 0.66332495807108, "min": 109.0, "max": 111.0, "median": 109.0, "filtered": 109.4, "mean": 109.4}, "stanford-crypto-aes": {"std": 3.0724582991474434, "min": 77.0, "max": 86.0, "median": 78.0, "filtered": 79.6, "mean": 79.6}, "imaging-desaturate": {"std": 0.30000000000000004, "min": 95.0, "max": 96.0, "median": 96.0, "filtered": 95.9, "mean": 95.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-056"}, "testrun": {"date": 1445940693, "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": "20151027004102", "branch": "Mozilla-Aurora", "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.17665407978984], "Encrypt": [281.6901408450704], "NavierStokes": [4840.579710144928], "Decrypt": [5086.294416243655], "Splay": [533.3333333333334], "Richards": [168.63406408094434], "RegExp": [23952.380952380954], "Earley": [544.6623093681917], "Boyer": [10224.489795918367], "RayTrace": [957.8544061302682]}, "summary": {"suite": 23317.665076803194, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.17665407978984, "max": 164.17665407978984, "median": 164.17665407978984, "value": 402.7247380000001, "filtered": 402.7247380000001, "mean": 164.17665407978984}, "Encrypt": {"std": 0.0, "min": 281.6901408450704, "max": 281.6901408450704, "median": 281.6901408450704, "value": 944.9425500000004, "filtered": 944.9425500000004, "mean": 281.6901408450704}, "NavierStokes": {"std": 0.0, "min": 4840.579710144928, "max": 4840.579710144928, "median": 4840.579710144928, "value": 306.5748502994012, "filtered": 306.5748502994012, "mean": 4840.579710144928}, "Decrypt": {"std": 0.0, "min": 5086.294416243655, "max": 5086.294416243655, "median": 5086.294416243655, "value": 52.33299101796402, "filtered": 52.33299101796402, "mean": 5086.294416243655}, "Splay": {"std": 0.0, "min": 533.3333333333334, "max": 533.3333333333334, "median": 533.3333333333334, "value": 152.795625, "filtered": 152.795625, "mean": 533.3333333333334}, "RegExp": {"std": 0.0, "min": 23952.380952380954, "max": 23952.380952380954, "median": 23952.380952380954, "value": 38.0331709741551, "filtered": 38.0331709741551, "mean": 23952.380952380954}, "Richards": {"std": 0.0, "min": 168.63406408094434, "max": 168.63406408094434, "median": 168.63406408094434, "value": 209.34085999999994, "filtered": 209.34085999999994, "mean": 168.63406408094434}, "Earley": {"std": 0.0, "min": 544.6623093681917, "max": 544.6623093681917, "median": 544.6623093681917, "value": 1223.6260680000005, "filtered": 1223.6260680000005, "mean": 544.6623093681917}, "Boyer": {"std": 0.0, "min": 10224.489795918367, "max": 10224.489795918367, "median": 10224.489795918367, "value": 65.18300798403193, "filtered": 65.18300798403193, "mean": 10224.489795918367}, "RayTrace": {"std": 0.0, "min": 957.8544061302682, "max": 957.8544061302682, "median": 957.8544061302682, "value": 772.5485159999996, "filtered": 772.5485159999996, "mean": 957.8544061302682}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-056"}, "testrun": {"date": 1445940693, "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": "20151027004102", "branch": "Mozilla-Aurora", "revision": "53f472c13242cefcdd840ebb61bde179ca01d4b1"}}] 03:31:47 INFO - RETURN: dromaeo_css: 7474.89 03:31:47 INFO - RETURN: kraken: 1458.90 03:31:47 INFO - RETURN: v8_7: 23317.67 03:31:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23317.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1458.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7474.89"}}} 03:31:47 INFO - Return code: 0 03:31:47 INFO - # TBPL SUCCESS # 03:31:47 INFO - Running post-action listener: _resource_record_post_action 03:31:47 INFO - Running post-run listener: _resource_record_post_run 03:31:48 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 7352320; Write bytes: 427806720; Read time: 1812; Write time: 643820 03:31:48 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 26718208; Read time: 0; Write time: 11116 03:31:48 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 5152768; Write bytes: 401088512; Read time: 1664; Write time: 632704 03:31:48 INFO - Running post-run listener: _upload_blobber_files 03:31:48 INFO - Blob upload gear active. 03:31:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:31:48 INFO - Copying logs to upload dir... 03:31:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1448.735931 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 8 secs) (at 2015-10-27 03:31:48.165138) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 03:31:48.171243) ========= 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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009911 build_url: 'https://queue.taskcluster.net/v1/task/Ec5OJLtST4OJf7n-naqlgw/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 03:31:48.222857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:31:48.223183) ========= 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=0ae9de487587ba4b94dd3100000001b5-1445939839.876511-1792048922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 03:31:48.272763) ========= ========= Started reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-27 03:31:48.273075) ========= ========= Finished reboot slave lost (results: 0, elapsed: 4 secs) (at 2015-10-27 03:31:52.573312) =========