builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1446026863.8 results: success (0) buildid: 20151028004029 builduid: 5b5ef848e825488f84ea871431662b07 revision: 927509f2757caac0fd74abb007e7459eeeffcee9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.796057) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.796522) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.796927) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.002860 basedir: '/builds/slave/test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.865970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.866378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.913220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.913631) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017193 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.961630) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.962073) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.962650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:43.962963) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-10-28 03:07:43-- 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% 227M=0s 2015-10-28 03:07:44 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200863 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.176381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.176695) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.076930 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.265900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.266329) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 927509f2757caac0fd74abb007e7459eeeffcee9 --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 927509f2757caac0fd74abb007e7459eeeffcee9 --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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-10-28 03:07:44,321 truncating revision to first 12 chars 2015-10-28 03:07:44,321 Setting DEBUG logging. 2015-10-28 03:07:44,321 attempt 1/10 2015-10-28 03:07:44,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/927509f2757c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-28 03:07:44,687 unpacking tar archive at: mozilla-aurora-927509f2757c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643967 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.923116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.923442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.931461) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.931745) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-28 03:07:44.932144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-10-28 03:07:44.932434) ========= /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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:07:45 INFO - MultiFileLogger online at 20151028 03:07:45 in /builds/slave/test-pgo 03:07:45 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:45 INFO - Guessing talos json url... 03:07:45 INFO - Using buildbot properties: 03:07:45 INFO - { 03:07:45 INFO - "properties": { 03:07:45 INFO - "buildnumber": 2, 03:07:45 INFO - "product": "firefox", 03:07:45 INFO - "script_repo_revision": "production", 03:07:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:07:45 INFO - "repository": "", 03:07:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:07:45 INFO - "buildid": "20151028004029", 03:07:45 INFO - "slavename": "talos-linux64-ix-060", 03:07:45 INFO - "stage_platform": "linux64-pgo", 03:07:45 INFO - "basedir": "/builds/slave/test-pgo", 03:07:45 INFO - "nightly_build": "True", 03:07:45 INFO - "project": "", 03:07:45 INFO - "platform": "ubuntu64_hw", 03:07:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:07:45 INFO - "slavebuilddir": "test", 03:07:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:07:45 INFO - "branch": "mozilla-aurora", 03:07:45 INFO - "repo_path": "releases/mozilla-aurora", 03:07:45 INFO - "pgo_build": "True", 03:07:45 INFO - "builduid": "5b5ef848e825488f84ea871431662b07", 03:07:45 INFO - "revision": "927509f2757caac0fd74abb007e7459eeeffcee9" 03:07:45 INFO - }, 03:07:45 INFO - "sourcestamp": { 03:07:45 INFO - "repository": "", 03:07:45 INFO - "hasPatch": false, 03:07:45 INFO - "project": "", 03:07:45 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:07:45 INFO - "changes": [ 03:07:45 INFO - { 03:07:45 INFO - "category": null, 03:07:45 INFO - "files": [ 03:07:45 INFO - { 03:07:45 INFO - "url": null, 03:07:45 INFO - "name": "https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:07:45 INFO - } 03:07:45 INFO - ], 03:07:45 INFO - "repository": "", 03:07:45 INFO - "rev": "927509f2757caac0fd74abb007e7459eeeffcee9", 03:07:45 INFO - "who": "sendchange", 03:07:45 INFO - "when": 1446026481, 03:07:45 INFO - "number": 6586015, 03:07:45 INFO - "comments": "", 03:07:45 INFO - "project": "", 03:07:45 INFO - "at": "Wed 28 Oct 2015 03:01:21", 03:07:45 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:07:45 INFO - "revlink": "", 03:07:45 INFO - "properties": [ 03:07:45 INFO - [ 03:07:45 INFO - "buildid", 03:07:45 INFO - "20151028004029", 03:07:45 INFO - "Change" 03:07:45 INFO - ], 03:07:45 INFO - [ 03:07:45 INFO - "builduid", 03:07:45 INFO - "5b5ef848e825488f84ea871431662b07", 03:07:45 INFO - "Change" 03:07:45 INFO - ], 03:07:45 INFO - [ 03:07:45 INFO - "nightly_build", 03:07:45 INFO - "True", 03:07:45 INFO - "Change" 03:07:45 INFO - ], 03:07:45 INFO - [ 03:07:45 INFO - "pgo_build", 03:07:45 INFO - "True", 03:07:45 INFO - "Change" 03:07:45 INFO - ] 03:07:45 INFO - ], 03:07:45 INFO - "revision": "927509f2757caac0fd74abb007e7459eeeffcee9" 03:07:45 INFO - } 03:07:45 INFO - ], 03:07:45 INFO - "revision": "927509f2757caac0fd74abb007e7459eeeffcee9" 03:07:45 INFO - } 03:07:45 INFO - } 03:07:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2. 03:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:45 INFO - https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 03:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:45 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:45 INFO - Downloaded 107 bytes. 03:07:45 INFO - Reading from file /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.txt 03:07:45 INFO - Contents: 03:07:45 INFO - 20151028004029 03:07:45 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/927509f2757caac0fd74abb007e7459eeeffcee9 03:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:45 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/927509f275/testing/talos/talos.json 03:07:45 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/927509f275/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 03:07:45 INFO - retry: Calling _download_file with args: ('https://hg.mozilla.org/releases/mozilla-aurora/raw-file/927509f275/testing/talos/talos.json', '/builds/slave/test-pgo/build/talos.json'), kwargs: {}, attempt #1 03:07:46 INFO - Downloaded 6818 bytes. 03:07:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:07:46 INFO - '../fennec_ids.txt'], 03:07:46 INFO - 'tests': ['tcheck2']}, 03:07:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:46 INFO - '--tppagecycles', 03:07:46 INFO - '7'], 03:07:46 INFO - 'tests': ['tsvgm']}}, 03:07:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:07:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:07:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:07:46 INFO - 'g1': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:07:46 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:46 INFO - 'g1-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:07:46 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:07:46 INFO - 'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:46 INFO - 'g2': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'tests': ['damp', 'tps']}, 03:07:46 INFO - 'g2-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['damp', 'tps']}, 03:07:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:07:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:46 INFO - 'other': {'tests': ['a11yr', 03:07:46 INFO - 'ts_paint', 03:07:46 INFO - 'tpaint', 03:07:46 INFO - 'sessionrestore', 03:07:46 INFO - 'sessionrestore_no_auto_restore']}, 03:07:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['a11yr', 03:07:46 INFO - 'ts_paint', 03:07:46 INFO - 'tpaint', 03:07:46 INFO - 'sessionrestore', 03:07:46 INFO - 'sessionrestore_no_auto_restore']}, 03:07:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['a11yr', 03:07:46 INFO - 'ts_paint', 03:07:46 INFO - 'tpaint', 03:07:46 INFO - 'sessionrestore', 03:07:46 INFO - 'sessionrestore_no_auto_restore']}, 03:07:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['a11yr', 03:07:46 INFO - 'ts_paint', 03:07:46 INFO - 'tpaint', 03:07:46 INFO - 'sessionrestore', 03:07:46 INFO - 'sessionrestore_no_auto_restore']}, 03:07:46 INFO - 'other_l64': {'tests': ['a11yr', 03:07:46 INFO - 'ts_paint', 03:07:46 INFO - 'tpaint', 03:07:46 INFO - 'sessionrestore', 03:07:46 INFO - 'sessionrestore_no_auto_restore']}, 03:07:46 INFO - 'other_nol64': {'tests': ['a11yr', 03:07:46 INFO - 'ts_paint', 03:07:46 INFO - 'tpaint', 03:07:46 INFO - 'sessionrestore', 03:07:46 INFO - 'sessionrestore_no_auto_restore']}, 03:07:46 INFO - 'svgr': {'tests': ['tsvgx', 03:07:46 INFO - 'tsvgr_opacity', 03:07:46 INFO - 'tart', 03:07:46 INFO - 'tscrollx', 03:07:46 INFO - 'cart']}, 03:07:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['tsvgx', 03:07:46 INFO - 'tsvgr_opacity', 03:07:46 INFO - 'tart', 03:07:46 INFO - 'tscrollx', 03:07:46 INFO - 'cart']}, 03:07:46 INFO - 'tp5o': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:07:46 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:07:46 INFO - 'tests': ['tp5o']}, 03:07:46 INFO - 'tp5o-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5o.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:07:46 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:07:46 INFO - 'talos_options': ['--e10s'], 03:07:46 INFO - 'tests': ['tp5o']}, 03:07:46 INFO - 'xperf': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:07:46 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:07:46 INFO - 'talos_options': ['--xperf_path', 03:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:46 INFO - 'tests': ['tp5n']}, 03:07:46 INFO - 'xperf-e10s': {'pagesets_manifest_path': 'talos/page_load_test/tp5n/tp5n.manifest', 03:07:46 INFO - 'pagesets_parent_dir_path': 'talos/page_load_test/', 03:07:46 INFO - 'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:46 INFO - 'plugins': {'32': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash32_10_3_183_5.zip', 03:07:46 INFO - '64': 'http://talos-bundles.pvt.build.mozilla.org/zips/flash64_11_0_d1_98.zip'}, 03:07:46 INFO - 'talos_options': ['--e10s', 03:07:46 INFO - '--xperf_path', 03:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 03:07:46 INFO - 'C:/slave/talos-data/talos/xperf.config'], 03:07:46 INFO - 'tests': ['tp5n']}}, 03:07:46 INFO - 'talos.zip': {'path': '', 03:07:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:46 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:07:46 INFO - {'append_to_log': False, 03:07:46 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:07:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:07:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:07:46 INFO - 'branch': 'Mozilla-Aurora', 03:07:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:46 INFO - 'config_files': ('talos/linux_config.py',), 03:07:46 INFO - 'default_actions': ('clobber', 03:07:46 INFO - 'read-buildbot-config', 03:07:46 INFO - 'download-and-extract', 03:07:46 INFO - 'populate-webroot', 03:07:46 INFO - 'create-virtualenv', 03:07:46 INFO - 'install', 03:07:46 INFO - 'run-tests'), 03:07:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:46 INFO - 'download_minidump_stackwalk': True, 03:07:46 INFO - 'download_symbols': 'ondemand', 03:07:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:07:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:07:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:07:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:07:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:46 INFO - 'installer_path': 'installer.exe', 03:07:46 INFO - 'log_level': 'info', 03:07:46 INFO - 'log_name': 'talos', 03:07:46 INFO - 'log_to_console': True, 03:07:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:07:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:07:46 INFO - 'opt_config_files': (), 03:07:46 INFO - 'pip_index': False, 03:07:46 INFO - 'python_webserver': False, 03:07:46 INFO - 'sps_profile': False, 03:07:46 INFO - 'sps_profile_interval': 0, 03:07:46 INFO - 'suite': 'dromaeojs', 03:07:46 INFO - 'system_bits': '64', 03:07:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:46 INFO - 'talos_url': 'https://hg.mozilla.org/build/talos/archive/tip.tar.gz', 03:07:46 INFO - 'tests': (), 03:07:46 INFO - 'title': 'talos-linux64-ix-060', 03:07:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:46 INFO - 'use_talos_json': True, 03:07:46 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:07:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:46 INFO - 'webroot': '/builds/slave/test-pgo/../talos-data', 03:07:46 INFO - 'work_dir': 'build'} 03:07:46 INFO - ##### 03:07:46 INFO - ##### Running clobber step. 03:07:46 INFO - ##### 03:07:46 INFO - Running pre-action listener: _resource_record_pre_action 03:07:46 INFO - Running main action method: clobber 03:07:46 INFO - rmtree: /builds/slave/test-pgo/build 03:07:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:07:50 INFO - Running post-action listener: _resource_record_post_action 03:07:50 INFO - ##### 03:07:50 INFO - ##### Running read-buildbot-config step. 03:07:50 INFO - ##### 03:07:50 INFO - Running pre-action listener: _resource_record_pre_action 03:07:50 INFO - Running main action method: read_buildbot_config 03:07:50 INFO - Using buildbot properties: 03:07:50 INFO - { 03:07:50 INFO - "properties": { 03:07:50 INFO - "buildnumber": 2, 03:07:50 INFO - "product": "firefox", 03:07:50 INFO - "script_repo_revision": "production", 03:07:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:07:50 INFO - "repository": "", 03:07:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:07:50 INFO - "buildid": "20151028004029", 03:07:50 INFO - "slavename": "talos-linux64-ix-060", 03:07:50 INFO - "stage_platform": "linux64-pgo", 03:07:50 INFO - "basedir": "/builds/slave/test-pgo", 03:07:50 INFO - "nightly_build": "True", 03:07:50 INFO - "project": "", 03:07:50 INFO - "platform": "ubuntu64_hw", 03:07:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:07:50 INFO - "slavebuilddir": "test", 03:07:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:07:50 INFO - "branch": "mozilla-aurora", 03:07:50 INFO - "repo_path": "releases/mozilla-aurora", 03:07:50 INFO - "pgo_build": "True", 03:07:50 INFO - "builduid": "5b5ef848e825488f84ea871431662b07", 03:07:50 INFO - "revision": "927509f2757caac0fd74abb007e7459eeeffcee9" 03:07:50 INFO - }, 03:07:50 INFO - "sourcestamp": { 03:07:50 INFO - "repository": "", 03:07:50 INFO - "hasPatch": false, 03:07:50 INFO - "project": "", 03:07:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:07:50 INFO - "changes": [ 03:07:50 INFO - { 03:07:50 INFO - "category": null, 03:07:50 INFO - "files": [ 03:07:50 INFO - { 03:07:50 INFO - "url": null, 03:07:50 INFO - "name": "https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2" 03:07:50 INFO - } 03:07:50 INFO - ], 03:07:50 INFO - "repository": "", 03:07:50 INFO - "rev": "927509f2757caac0fd74abb007e7459eeeffcee9", 03:07:50 INFO - "who": "sendchange", 03:07:50 INFO - "when": 1446026481, 03:07:50 INFO - "number": 6586015, 03:07:50 INFO - "comments": "", 03:07:50 INFO - "project": "", 03:07:50 INFO - "at": "Wed 28 Oct 2015 03:01:21", 03:07:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:07:50 INFO - "revlink": "", 03:07:50 INFO - "properties": [ 03:07:50 INFO - [ 03:07:50 INFO - "buildid", 03:07:50 INFO - "20151028004029", 03:07:50 INFO - "Change" 03:07:50 INFO - ], 03:07:50 INFO - [ 03:07:50 INFO - "builduid", 03:07:50 INFO - "5b5ef848e825488f84ea871431662b07", 03:07:50 INFO - "Change" 03:07:50 INFO - ], 03:07:50 INFO - [ 03:07:50 INFO - "nightly_build", 03:07:50 INFO - "True", 03:07:50 INFO - "Change" 03:07:50 INFO - ], 03:07:50 INFO - [ 03:07:50 INFO - "pgo_build", 03:07:50 INFO - "True", 03:07:50 INFO - "Change" 03:07:50 INFO - ] 03:07:50 INFO - ], 03:07:50 INFO - "revision": "927509f2757caac0fd74abb007e7459eeeffcee9" 03:07:50 INFO - } 03:07:50 INFO - ], 03:07:50 INFO - "revision": "927509f2757caac0fd74abb007e7459eeeffcee9" 03:07:50 INFO - } 03:07:50 INFO - } 03:07:50 INFO - Running post-action listener: _resource_record_post_action 03:07:50 INFO - ##### 03:07:50 INFO - ##### Running download-and-extract step. 03:07:50 INFO - ##### 03:07:50 INFO - Running pre-action listener: _resource_record_pre_action 03:07:50 INFO - Running main action method: download_and_extract 03:07:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:50 INFO - https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/test_packages.json 03:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/test_packages.json 03:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:07:50 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/test_packages.json', '/builds/slave/test-pgo/build/test_packages.json'), kwargs: {}, attempt #1 03:07:51 INFO - Downloaded 1302 bytes. 03:07:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:07:51 INFO - Using the following test package requirements: 03:07:51 INFO - {u'common': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:07:51 INFO - u'cppunittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:07:51 INFO - u'firefox-43.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:07:51 INFO - u'jittest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:07:51 INFO - u'jsshell-linux-x86_64.zip'], 03:07:51 INFO - u'mochitest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:07:51 INFO - u'firefox-43.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:07:51 INFO - u'mozbase': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:07:51 INFO - u'reftest': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:07:51 INFO - u'firefox-43.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:07:51 INFO - u'talos': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:07:51 INFO - u'firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:07:51 INFO - u'web-platform': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:07:51 INFO - u'firefox-43.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:07:51 INFO - u'webapprt': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'], 03:07:51 INFO - u'xpcshell': [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip', 03:07:51 INFO - u'firefox-43.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:07:51 INFO - Downloading packages: [u'firefox-43.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:51 INFO - https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:51 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:52 INFO - Downloaded 22907257 bytes. 03:07:52 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:07:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:07:52 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:07:53 INFO - Return code: 0 03:07:53 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:07: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:07:53 INFO - https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:07:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:07:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:07:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:53 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:54 INFO - Downloaded 22907257 bytes. 03:07:54 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:07:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.common.tests.zip 03:07:54 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:07:55 INFO - Return code: 0 03:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:55 INFO - https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:55 INFO - retry: Calling _download_file with args: (u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:56 INFO - Downloaded 10881672 bytes. 03:07:56 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:07:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-43.0a2.en-US.linux-x86_64.talos.tests.zip 03:07:56 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:07:56 INFO - Return code: 0 03:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:56 INFO - https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:56 INFO - retry: Calling _download_file with args: ('http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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:07:58 INFO - Downloaded 56976157 bytes. 03:07:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:07:58 INFO - mkdir: /builds/slave/test-pgo/properties 03:07:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:07:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:07:58 INFO - Contents: 03:07:58 INFO - build_url:https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 03:07:58 INFO - Running post-action listener: _resource_record_post_action 03:07:58 INFO - Running post-action listener: _set_extra_try_arguments 03:07:58 INFO - ##### 03:07:58 INFO - ##### Running populate-webroot step. 03:07:58 INFO - ##### 03:07:58 INFO - Running pre-action listener: _resource_record_pre_action 03:07:58 INFO - Running main action method: populate_webroot 03:07:58 INFO - Populating webroot /builds/slave/test-pgo/../talos-data... 03:07:58 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:07:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/../talos-data/talos',), kwargs: {}, attempt #1 03:07:58 INFO - copying tree: /builds/slave/test-pgo/build/tests/talos/talos to /builds/slave/test-pgo/../talos-data/talos 03:07:58 INFO - rmtree: /builds/slave/test-pgo/../talos-data/talos 03:07:59 INFO - Running post-action listener: _resource_record_post_action 03:07:59 INFO - ##### 03:07:59 INFO - ##### Running create-virtualenv step. 03:07:59 INFO - ##### 03:07:59 INFO - Running pre-action listener: _resource_record_pre_action 03:07:59 INFO - Running main action method: create_virtualenv 03:07:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:07: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:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:07:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:59 INFO - Using real prefix '/usr' 03:07:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:07:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:01 INFO - Installing pip.................done. 03:08:01 INFO - Return code: 0 03:08:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:08:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:01 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 0x7f65c4936b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', '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:08:01 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:08:01 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:08:01 INFO - Using env: {'DISPLAY': ':0', 03:08:01 INFO - 'HOME': '/home/cltbld', 03:08:01 INFO - 'LANG': 'en_US.UTF-8', 03:08:01 INFO - 'LANGUAGE': 'en_US:en', 03:08:01 INFO - 'LOGNAME': 'cltbld', 03:08:01 INFO - 'MAIL': '/var/mail/cltbld', 03:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:01 INFO - 'MOZ_NO_REMOTE': '1', 03:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:01 INFO - 'NO_EM_RESTART': '1', 03:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:01 INFO - 'SHELL': '/bin/bash', 03:08:01 INFO - 'SHLVL': '1', 03:08:01 INFO - 'TERM': 'linux', 03:08:01 INFO - 'TMOUT': '86400', 03:08:01 INFO - 'USER': 'cltbld', 03:08:01 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:01 INFO - '_': '/tools/buildbot/bin/python'} 03:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:02 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:08:02 INFO - Cleaning up... 03:08:02 INFO - Return code: 0 03:08:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:08: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:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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', '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 0x7f65c4936b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', '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:08: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:08: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 psutil>=0.7.1 03:08:02 INFO - Using env: {'DISPLAY': ':0', 03:08:02 INFO - 'HOME': '/home/cltbld', 03:08:02 INFO - 'LANG': 'en_US.UTF-8', 03:08:02 INFO - 'LANGUAGE': 'en_US:en', 03:08:02 INFO - 'LOGNAME': 'cltbld', 03:08:02 INFO - 'MAIL': '/var/mail/cltbld', 03:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:02 INFO - 'MOZ_NO_REMOTE': '1', 03:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:02 INFO - 'NO_EM_RESTART': '1', 03:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:02 INFO - 'SHELL': '/bin/bash', 03:08:02 INFO - 'SHLVL': '1', 03:08:02 INFO - 'TERM': 'linux', 03:08:02 INFO - 'TMOUT': '86400', 03:08:02 INFO - 'USER': 'cltbld', 03:08:02 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:02 INFO - '_': '/tools/buildbot/bin/python'} 03:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:02 INFO - Downloading/unpacking psutil>=0.7.1 03:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:08:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:08:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:04 INFO - Installing collected packages: psutil 03:08:04 INFO - Running setup.py install for psutil 03:08:04 INFO - building 'psutil._psutil_linux' extension 03:08:04 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:08:05 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:08:05 INFO - building 'psutil._psutil_posix' extension 03:08:05 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:08:05 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:08:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:05 INFO - Successfully installed psutil 03:08:05 INFO - Cleaning up... 03:08:05 INFO - Return code: 0 03:08:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:08:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:05 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 0x7f65c4936b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', '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:08:05 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:08:05 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:08:05 INFO - Using env: {'DISPLAY': ':0', 03:08:05 INFO - 'HOME': '/home/cltbld', 03:08:05 INFO - 'LANG': 'en_US.UTF-8', 03:08:05 INFO - 'LANGUAGE': 'en_US:en', 03:08:05 INFO - 'LOGNAME': 'cltbld', 03:08:05 INFO - 'MAIL': '/var/mail/cltbld', 03:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:05 INFO - 'MOZ_NO_REMOTE': '1', 03:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:05 INFO - 'NO_EM_RESTART': '1', 03:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:05 INFO - 'SHELL': '/bin/bash', 03:08:05 INFO - 'SHLVL': '1', 03:08:05 INFO - 'TERM': 'linux', 03:08:05 INFO - 'TMOUT': '86400', 03:08:05 INFO - 'USER': 'cltbld', 03:08:05 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:05 INFO - '_': '/tools/buildbot/bin/python'} 03:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:08:06 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:08:06 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:08:06 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:08:06 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:08:06 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:08:06 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:08:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:08:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:08:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:08:07 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:08:07 INFO - Installing collected packages: mozsystemmonitor 03:08:07 INFO - Running setup.py install for mozsystemmonitor 03:08:07 INFO - Successfully installed mozsystemmonitor 03:08:07 INFO - Cleaning up... 03:08:08 INFO - Return code: 0 03:08:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:08: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:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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 0x7f65c4936b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', '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:08: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:08: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:08:08 INFO - Using env: {'DISPLAY': ':0', 03:08:08 INFO - 'HOME': '/home/cltbld', 03:08:08 INFO - 'LANG': 'en_US.UTF-8', 03:08:08 INFO - 'LANGUAGE': 'en_US:en', 03:08:08 INFO - 'LOGNAME': 'cltbld', 03:08:08 INFO - 'MAIL': '/var/mail/cltbld', 03:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:08 INFO - 'MOZ_NO_REMOTE': '1', 03:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:08 INFO - 'NO_EM_RESTART': '1', 03:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:08 INFO - 'SHELL': '/bin/bash', 03:08:08 INFO - 'SHLVL': '1', 03:08:08 INFO - 'TERM': 'linux', 03:08:08 INFO - 'TMOUT': '86400', 03:08:08 INFO - 'USER': 'cltbld', 03:08:08 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:08 INFO - '_': '/tools/buildbot/bin/python'} 03:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:08 INFO - Downloading/unpacking blobuploader==1.2.4 03:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:08:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08: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:08: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:08: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:08: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:08: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:08: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:08:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:08:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:08:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08: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:08: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:08: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:08: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:08: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:08: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:08:10 INFO - Downloading docopt-0.6.1.tar.gz 03:08:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:08:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:10 INFO - Running setup.py install for blobuploader 03:08:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:08:10 INFO - Running setup.py install for requests 03:08:11 INFO - Running setup.py install for docopt 03:08:11 INFO - Successfully installed blobuploader requests docopt 03:08:11 INFO - Cleaning up... 03:08:11 INFO - Return code: 0 03:08:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:08:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:11 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 0x7f65c4936b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', '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:08:11 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:08:11 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:08:11 INFO - Using env: {'DISPLAY': ':0', 03:08:11 INFO - 'HOME': '/home/cltbld', 03:08:11 INFO - 'LANG': 'en_US.UTF-8', 03:08:11 INFO - 'LANGUAGE': 'en_US:en', 03:08:11 INFO - 'LOGNAME': 'cltbld', 03:08:11 INFO - 'MAIL': '/var/mail/cltbld', 03:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:11 INFO - 'MOZ_NO_REMOTE': '1', 03:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:11 INFO - 'NO_EM_RESTART': '1', 03:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:11 INFO - 'SHELL': '/bin/bash', 03:08:11 INFO - 'SHLVL': '1', 03:08:11 INFO - 'TERM': 'linux', 03:08:11 INFO - 'TMOUT': '86400', 03:08:11 INFO - 'USER': 'cltbld', 03:08:11 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:11 INFO - '_': '/tools/buildbot/bin/python'} 03:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:11 INFO - Running setup.py (path:/tmp/pip-3iS_Ki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:11 INFO - Running setup.py (path:/tmp/pip-DUTqlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:11 INFO - Running setup.py (path:/tmp/pip-IH3XUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:11 INFO - Running setup.py (path:/tmp/pip-k0T9wu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08:11 INFO - Running setup.py (path:/tmp/pip-swnymP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08:11 INFO - Running setup.py (path:/tmp/pip-SOl_Vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08:11 INFO - Running setup.py (path:/tmp/pip-fwZGKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:11 INFO - Running setup.py (path:/tmp/pip-rLocFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:12 INFO - Running setup.py (path:/tmp/pip-3l1MTX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:12 INFO - Running setup.py (path:/tmp/pip-4yKTyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:12 INFO - Running setup.py (path:/tmp/pip-lyaFlg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:12 INFO - Running setup.py (path:/tmp/pip-_pZaLR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:12 INFO - Running setup.py (path:/tmp/pip-7yD3pF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:12 INFO - Running setup.py (path:/tmp/pip-EBuTfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:12 INFO - Running setup.py (path:/tmp/pip-5oWwiD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:12 INFO - Running setup.py (path:/tmp/pip-AmcRvg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:12 INFO - Running setup.py (path:/tmp/pip-rUuFun-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:08:12 INFO - Running setup.py install for manifestparser 03:08:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:08:12 INFO - Running setup.py install for mozcrash 03:08:12 INFO - Running setup.py install for mozdebug 03:08:12 INFO - Running setup.py install for mozdevice 03:08:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Running setup.py install for mozfile 03:08:13 INFO - Running setup.py install for mozhttpd 03:08:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Running setup.py install for mozinfo 03:08:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Running setup.py install for mozInstall 03:08:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Running setup.py install for mozleak 03:08:13 INFO - Running setup.py install for mozlog 03:08:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Running setup.py install for moznetwork 03:08:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Running setup.py install for mozprocess 03:08:13 INFO - Running setup.py install for mozprofile 03:08:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:08:13 INFO - Running setup.py install for mozrunner 03:08:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:08:14 INFO - Running setup.py install for mozscreenshot 03:08:14 INFO - Running setup.py install for moztest 03:08:14 INFO - Running setup.py install for mozversion 03:08:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:08:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:08:14 INFO - Cleaning up... 03:08:14 INFO - Return code: 0 03:08:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:14 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 0x7f65c4936b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', '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:08:14 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:08:14 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:08:14 INFO - Using env: {'DISPLAY': ':0', 03:08:14 INFO - 'HOME': '/home/cltbld', 03:08:14 INFO - 'LANG': 'en_US.UTF-8', 03:08:14 INFO - 'LANGUAGE': 'en_US:en', 03:08:14 INFO - 'LOGNAME': 'cltbld', 03:08:14 INFO - 'MAIL': '/var/mail/cltbld', 03:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:14 INFO - 'MOZ_NO_REMOTE': '1', 03:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:14 INFO - 'NO_EM_RESTART': '1', 03:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:14 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:14 INFO - 'SHELL': '/bin/bash', 03:08:14 INFO - 'SHLVL': '1', 03:08:14 INFO - 'TERM': 'linux', 03:08:14 INFO - 'TMOUT': '86400', 03:08:14 INFO - 'USER': 'cltbld', 03:08:14 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:14 INFO - '_': '/tools/buildbot/bin/python'} 03:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:14 INFO - Running setup.py (path:/tmp/pip-Paaw5s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:14 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:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:14 INFO - Running setup.py (path:/tmp/pip-PIXA_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:14 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:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:14 INFO - Running setup.py (path:/tmp/pip-DTIob_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:14 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:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:14 INFO - Running setup.py (path:/tmp/pip-or2Tq4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:14 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:08:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08:14 INFO - Running setup.py (path:/tmp/pip-b2SeK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08: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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08:15 INFO - Running setup.py (path:/tmp/pip-jbDzZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08: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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08:15 INFO - Running setup.py (path:/tmp/pip-1G7tBm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08: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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:15 INFO - Running setup.py (path:/tmp/pip-ngalB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:15 INFO - Running setup.py (path:/tmp/pip-s0DJLV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:15 INFO - Running setup.py (path:/tmp/pip-cFQl4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:15 INFO - Running setup.py (path:/tmp/pip-32v98c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:15 INFO - Running setup.py (path:/tmp/pip-0m6WQ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:15 INFO - Running setup.py (path:/tmp/pip-nHsff5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:15 INFO - Running setup.py (path:/tmp/pip-IYme_S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:15 INFO - Running setup.py (path:/tmp/pip-FVQ5mK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:15 INFO - Running setup.py (path:/tmp/pip-Xs9qTF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:15 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:08:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:15 INFO - Running setup.py (path:/tmp/pip-vHih7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:15 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:08:15 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:08:15 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:08:15 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:08:15 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:08:15 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:08:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:15 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:08:15 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:08:15 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:08:15 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:08:15 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:08:15 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:08:17 INFO - Downloading blessings-1.5.1.tar.gz 03:08:17 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:08:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:08:17 INFO - Installing collected packages: blessings 03:08:17 INFO - Running setup.py install for blessings 03:08:17 INFO - Successfully installed blessings 03:08:17 INFO - Cleaning up... 03:08:17 INFO - Return code: 0 03:08:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:08:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:08:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:08:18 INFO - Reading from file tmpfile_stdout 03:08:18 INFO - Current package versions: 03:08:18 INFO - argparse == 1.2.1 03:08:18 INFO - blessings == 1.5.1 03:08:18 INFO - blobuploader == 1.2.4 03:08:18 INFO - docopt == 0.6.1 03:08:18 INFO - manifestparser == 1.1 03:08:18 INFO - mozInstall == 1.12 03:08:18 INFO - mozcrash == 0.16 03:08:18 INFO - mozdebug == 0.1 03:08:18 INFO - mozdevice == 0.46 03:08:18 INFO - mozfile == 1.2 03:08:18 INFO - mozhttpd == 0.7 03:08:18 INFO - mozinfo == 0.8 03:08:18 INFO - mozleak == 0.1 03:08:18 INFO - mozlog == 3.0 03:08:18 INFO - moznetwork == 0.27 03:08:18 INFO - mozprocess == 0.22 03:08:18 INFO - mozprofile == 0.27 03:08:18 INFO - mozrunner == 6.10 03:08:18 INFO - mozscreenshot == 0.1 03:08:18 INFO - mozsystemmonitor == 0.0 03:08:18 INFO - moztest == 0.7 03:08:18 INFO - mozversion == 1.4 03:08:18 INFO - psutil == 3.1.1 03:08:18 INFO - requests == 1.2.3 03:08:18 INFO - wsgiref == 0.1.2 03:08:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:08: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:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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 0x7f65c4936b90>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152d7b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', '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:08: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:08: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:08:18 INFO - Using env: {'DISPLAY': ':0', 03:08:18 INFO - 'HOME': '/home/cltbld', 03:08:18 INFO - 'LANG': 'en_US.UTF-8', 03:08:18 INFO - 'LANGUAGE': 'en_US:en', 03:08:18 INFO - 'LOGNAME': 'cltbld', 03:08:18 INFO - 'MAIL': '/var/mail/cltbld', 03:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:18 INFO - 'MOZ_NO_REMOTE': '1', 03:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:18 INFO - 'NO_EM_RESTART': '1', 03:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:18 INFO - 'SHELL': '/bin/bash', 03:08:18 INFO - 'SHLVL': '1', 03:08:18 INFO - 'TERM': 'linux', 03:08:18 INFO - 'TMOUT': '86400', 03:08:18 INFO - 'USER': 'cltbld', 03:08:18 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:18 INFO - '_': '/tools/buildbot/bin/python'} 03:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 INFO - Cleaning up... 03:08:18 INFO - Return code: 0 03:08:18 INFO - Running post-action listener: _resource_record_post_action 03:08:18 INFO - Running post-action listener: _start_resource_monitoring 03:08:18 INFO - Starting resource monitoring. 03:08:18 INFO - ##### 03:08:18 INFO - ##### Running install step. 03:08:18 INFO - ##### 03:08:18 INFO - Running pre-action listener: _resource_record_pre_action 03:08:18 INFO - Running main action method: install 03:08:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:08:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:08:18 INFO - Reading from file tmpfile_stdout 03:08:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:08:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:08:18 INFO - Reading from file tmpfile_stdout 03:08:18 INFO - Output received: 03:08:18 INFO - Usage: mozinstall [options] installer 03:08:18 INFO - Options: 03:08:18 INFO - -h, --help show this help message and exit 03:08:18 INFO - -d DEST, --destination=DEST 03:08:18 INFO - Directory to install application into. [default: 03:08:18 INFO - "/builds/slave/test-pgo"] 03:08:18 INFO - --app=APP Application being installed. [default: firefox] 03:08:18 INFO - mkdir: /builds/slave/test-pgo/build/application 03:08:18 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:08:18 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:08:32 INFO - Reading from file tmpfile_stdout 03:08:32 INFO - Output received: 03:08:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:08:32 INFO - Running post-action listener: _resource_record_post_action 03:08:32 INFO - ##### 03:08:32 INFO - ##### Running run-tests step. 03:08:32 INFO - ##### 03:08:32 INFO - Running pre-action listener: _resource_record_pre_action 03:08:32 INFO - Running main action method: run_tests 03:08:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:08:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:08:32 INFO - Python 2.7.3 03:08:32 INFO - Return code: 0 03:08:32 INFO - grabbing minidump binary from tooltool 03:08:32 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:32 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 0x1384bf0>, '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 0x16824f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16829a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:08:32 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:08:32 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:08:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:08:32 INFO - Return code: 0 03:08:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:08:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:08:32 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/2MyaIPZvSfWgQCkwPGPOaA/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-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:08:32 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/2MyaIPZvSfWgQCkwPGPOaA/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-060 --webServer localhost 03:08:32 INFO - Using env: {'DISPLAY': ':0', 03:08:32 INFO - 'HOME': '/home/cltbld', 03:08:32 INFO - 'LANG': 'en_US.UTF-8', 03:08:32 INFO - 'LANGUAGE': 'en_US:en', 03:08:32 INFO - 'LOGNAME': 'cltbld', 03:08:32 INFO - 'MAIL': '/var/mail/cltbld', 03:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:32 INFO - 'MOZ_NO_REMOTE': '1', 03:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:32 INFO - 'NO_EM_RESTART': '1', 03:08:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:08:32 INFO - 'SHELL': '/bin/bash', 03:08:32 INFO - 'SHLVL': '1', 03:08:32 INFO - 'TERM': 'linux', 03:08:32 INFO - 'TMOUT': '86400', 03:08:32 INFO - 'USER': 'cltbld', 03:08:32 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054', 03:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:32 INFO - '_': '/tools/buildbot/bin/python'} 03:08:32 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/2MyaIPZvSfWgQCkwPGPOaA/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-060', '--webServer', 'localhost'] with output_timeout 3600 03:08:33 INFO - mozversion INFO | application_buildid: 20151028004029 03:08:33 INFO - mozversion INFO | application_changeset: 927509f2757caac0fd74abb007e7459eeeffcee9 03:08:33 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:08:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:08:33 INFO - mozversion INFO | application_name: Firefox 03:08:33 INFO - mozversion INFO | application_remotingname: firefox-dev 03:08:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:08:33 INFO - mozversion INFO | application_vendor: Mozilla 03:08:33 INFO - mozversion INFO | application_version: 43.0a2 03:08:33 INFO - mozversion INFO | platform_buildid: 20151028004029 03:08:33 INFO - mozversion INFO | platform_changeset: 927509f2757caac0fd74abb007e7459eeeffcee9 03:08:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:08:33 INFO - mozversion INFO | platform_version: 43.0a2 03:08:33 INFO - 2015-10-28 03:08:33,157 DEBUG : using testdate: 1446026913 03:08:33 INFO - 2015-10-28 03:08:33,157 DEBUG : actual date: 1446026913 03:08:33 INFO - 2015-10-28 03:08:33,244 INFO : Starting test suite talos-linux64-ix-060 03:08:33 INFO - 2015-10-28 03:08:33,245 INFO : Starting test dromaeo_css 03:08:33 INFO - 2015-10-28 03:08:33,245 DEBUG : operating with platform_type : linux_ 03:08:33 INFO - 2015-10-28 03:08:33,245 INFO : Initialising browser for dromaeo_css test... 03:08:33 INFO - 2015-10-28 03:08:33,261 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqEfgpG/profile http://localhost/getInfo.html 03:08:38 INFO - 2015-10-28 03:08:38,445 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:08:38 INFO - 2015-10-28 03:08:38,445 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:08:38 INFO - 2015-10-28 03:08:38,446 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:08:38 INFO - 2015-10-28 03:08:38,446 DEBUG : BROWSER_OUTPUT: __metrics 03:08:38 INFO - 2015-10-28 03:08:38,628 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:08:40 INFO - 2015-10-28 03:08:40,182 INFO : Browser initialized. 03:08:40 INFO - 2015-10-28 03:08:40,182 INFO : Running cycle 1/1 for dromaeo_css test... 03:08:40 INFO - 2015-10-28 03:08:40,182 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqEfgpG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/dromaeo/css.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:08:51 INFO - 2015-10-28 03:08:51,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 132632576 03:08:51 INFO - 2015-10-28 03:08:51,880 DEBUG : BROWSER_OUTPUT: 03:11:51 INFO - 2015-10-28 03:11:51,185 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:11:52 INFO - 2015-10-28 03:11:52,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 221032448 03:11:52 INFO - 2015-10-28 03:11:52,150 DEBUG : BROWSER_OUTPUT: 03:14:54 INFO - 2015-10-28 03:14:54,296 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:14:54 INFO - 2015-10-28 03:14:54,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 206925824 03:14:54 INFO - 2015-10-28 03:14:54,857 DEBUG : BROWSER_OUTPUT: 03:17:56 INFO - 2015-10-28 03:17:56,656 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:17:57 INFO - 2015-10-28 03:17:57,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 214528000 03:17:57 INFO - 2015-10-28 03:17:57,217 DEBUG : BROWSER_OUTPUT: 03:20:58 INFO - 2015-10-28 03:20:58,875 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:20:59 INFO - 2015-10-28 03:20:59,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 199094272 03:20:59 INFO - 2015-10-28 03:20:59,441 DEBUG : BROWSER_OUTPUT: 03:24:01 INFO - 2015-10-28 03:24:01,738 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:24:02 INFO - 2015-10-28 03:24:02,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 196513792 03:24:02 INFO - 2015-10-28 03:24:02,311 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,418 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:27:04 INFO - 2015-10-28 03:27:04,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 241602560 03:27:04 INFO - 2015-10-28 03:27:04,669 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,669 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:27:04 INFO - 2015-10-28 03:27:04,669 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:27:04 INFO - 2015-10-28 03:27:04,669 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:27:04 INFO - 2015-10-28 03:27:04,669 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:27:04 INFO - 2015-10-28 03:27:04,673 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3348.213169905072;3410.9488357674622;3415.897523074307;3434.605020422651;3443.4490481522953;5701.201831743554;5701.458361455665;5729.111987641912;5735.111057786039;5739.25389699339;5759.769609215637;5788.6816225107605;5789.073748200289;5826.300843898727;5834.5915785895;5230.790768369261;5244.659097158682;5275.683458992454;5321.52106310432;5348.277982472375;5275.498827611371;5278.155495120763;5286.973565132169;5288.973555132219;5288.973555132238;5111.437741848412;5191.169412893938;5216.217567364906;5273.736313184345;5309.150535914255;5262.000219958234;5263;5263.842084737464;5264.631475796696;5285.365756109291;5098.6685865419;5239.13554263546;5241.3710354757295;5329.733513324357;5337.653052551611;5407.486288802557;5476.698781567012;5479.424660410639;5494.80768173112;5506.779728810843;6201.81394558164;6216.502679785606;6247.531435142382;6254.562180647356;6256.061590761422;6036.275646922353;6145.78489752861;6279.497640188774;6285.528585356116;6286.591371560879;5630.324361076697;5712.343080545749;5740.311162660466;5741.942580574224;5758.049921762904;6235.625862448268;6247.500199983991;6247.531435142382;6256.061590761331;6263.655498947602;5950.761969521171;5955.34491205967;6057.787977420858;6069.544784141119;6082.878342433127;6101.694915254219;6213.937860621336;6237.75048998035;6241.469475094577;6242.063690446469;6165.10605962133;6184;6194.81415557534;6202.472789812917;6208.255009398901;5986.880262394728;6045.8488537786025;6116.327204007555;6148.78479253224;6157;4666.136764698542;4668.206404911173;4681.578657920735;4686.320483529869;4686.343911852344;4172.415861779354;4187.72779769314;4202.789860506962;4204.243236217449;4218.135282267128;5691.800786972519;5755.539556835443;5801.622894511843;5874.794382196688;5903.76384944606;6152.938470615326;6195.983382955022;6205.255369355616;6224.719887604978;6233.532485063638;5909.320428150818;5910.34986151523;5915.053591425437;5928.851778705567;5961.940380596138;5218.921716174261;5251.711155886386;5308.416074231832;5321.6540924839765;5342.065138600807;6230.408111229426;6317.842053948688;6317.96841015792;6318.494520438354;6322.178116844781;5986.730597123227;6107.84730381744;6117.663528505975;6123.418275263843;6137.508999280136;6234.470070044097;6352.68236588178;6361.01404282337;6375.171227740364;6377.7767778127545;6012.038073908328;6018.6689732063405;6031;6049.062395328731;6118.938810611837;5995.910061348996;6095.817125486243;6106.084087386927;6119.755209791559;6120.724567394389;5920.407959204217;5952.107183922446;6089.695515224133;6094.634321940521;6108.389161083856;5985.982382994988;6025.728842202199;6029.125776762433;6036.849078773066;6053.092036194606;5713.314402271754;5829.59192856496;5944.613600115978;5950.34546199909;5951.49412299942;6051.576389652682;6147.784827531015;6164;6164.044573091178;6167.84580385476;5966.3735307793795;5972.820815375546;5976.19321391624;5977.7310021050025;5991.221141251609 03:27:04 INFO - 2015-10-28 03:27:04,674 DEBUG : BROWSER_OUTPUT: |1;ext.html;602.6926267603524;647.4690753582058;653.1378580274038;655.7311502284065;661.0711949710657;35927.46108808367;46412;46490;46605.30092048618;46748;50293.24560131601;50881.69268997513;50894.23658645123;50996.745016274865;51028;8335;8462.957685211597;9243.121903419182;9404.62381504739;10764.461776911163;11037;11149.275297105703;11154.609588664358;11166.162537809656;11166.720831979224;11168.218224724273;11228.270162439456;11274.718132046683;11287.774244515105;11291.153163512728;11140.944295278512;11177.44112794357;11256.831147532794;11266.155038372113;11273.774524509547;10958;11057.668269951915;11085.113190944705;11085.667429977113;11089.2237543372;46143.76928115338;46549.30176047362;46672;46672.299915501295;46678;3627.365211088049;3657.3416784978695;3779.3008293465796;4186.790660466995;4393.033532622818;35331.1167220819;35419.822900885585;35483.4677479838;35813.46279805805;37272.44091338632;3718.9814050929845;3731.533558305212;3741.681957033655;3783.16770310534;3858.305505009097;349201;349823;454679;464410;472267;72538.27461725421;72808.63595681988;72825;73114.63442682753;73418;71700.64149679322;73688;77831;77946.61026694831;77992.61003694945;19879.10544025522;19976.3008294709;20150.798492015187;20320.39038828808;20325.49186270355;14764.778528322084;14867.851321486647;14867.925660371846;14868.851311486964;14889.255537223313;23532.29403117909;23801.642975355036;23916.641250381257;23932.88033559821;23986.52026959451;8972.730818075468;9152.63389464414;9214;9276.72169834906;9281.118293762082;1097.720081379243;1157.9594714184964;1180.9940950295365;1232.9136960412684;1289.0976316578433;31406.528902066486;32482.837585811918;35670;35807;36118.09704757402;1222.2483172848633;1234.4259919137644;1243.6766440725296;1306.882380585752;1359.232033900843;15095.698086038437;16457.341706331612;16894.15529223534;17285.654286914192;17620.383286585165;456407;460452;461262;461825.4543636369;463617;64428.67785661136;64877.35122648808;64960;64975.35024649693;65012;1441.8630230128122;1479.2160155117804;1579.0683496736751;1613.9972867289189;1691.687037897993;34237.14407139841;34655.82672086624;34674.82662586772;34800.47799283063;34839.47740783839;53028.469715303894;53166.20250696165;53577;53625;54384.184237235684;554186;561257;564582;567370;567811;38634;38634;39273.60726392699;39277;39325.21349572935;50360.49639503558;50818.74590627023;51008.74495627647;51091.744541277054;51817;41404.79297603493;42707.35938960856;42909.785451072545;43256.35115473333;43520.12959740851;42598.36102458404;43098;43279.567204327555;43948;44151.558484414745;43289.35065974076;43479.782601086794;43536.78231608822;43537.78231108824;43836.780816095714;36732;38046.809765950995;38304.61695383122;38973;39177.80411097926;28884.855575721987;28995.420091598473;30676.233094172825;31003;31072.22319442032 03:27:04 INFO - 2015-10-28 03:27:04,674 DEBUG : BROWSER_OUTPUT: |2;jquery.html;400.61340806122087;400.84767788240464;403.7617805494758;404.85020542399315;407.1246819338422;15984.280707368167;16415.917920410382;18921.905390473046;19086.61826763464;19346.322878699248;12653.810192847115;19234.230630774753;19247;19532.707009394835;19609.607807843833;4861.368022157123;4966;4972.403311602613;4975.353204083464;4977.676451030689;3794.6395092466173;3869.941950870739;4931.728754918496;5194.11700010999;5339.092354299778;5262.631615786897;5266.3943646480575;5267.578593712494;5273.604479664022;5290.444503327153;5154.716490593016;5250.4487028861995;5261.894762104736;5264;5265.842024739245;4568.33759104928;4602.677812553123;4605.332226827091;4607.723536587815;4616.746078965655;15224.543263702106;15499.147546884917;16123.307052759526;16366.099864507447;16391.83608163915;2324.1168356024773;2465.0755966512556;2471.1845091119885;2503.7120731115974;2506.035176457059;10442.947785261102;10547.367157970546;10592.576296948113;10848.457577121113;10880.075193608553;1729.9827001729948;1778.813224611423;1833.9541511462187;1889.1121173048646;1903.067496926496;72583;73331;73758.63120684416;73997.63001185014;75250.62374688147;8072.959635201903;8103;8152.347812175011;8194.09864914859;8203.261706446328;9796.51017449139;9804.558794854249;9831.311808173503;9855.113039826307;9879.407235565888;6480.833449978954;6537.70580323877;6590.143281373391;6597.208334999831;6610.272869984298;6825.078614386995;6879.346462086194;6905.343992320722;6920.723171073201;6944.131983502062;3737.8691745788765;3746.9437958430644;3758.323501769653;3801.581825999138;3806.8477260909253;1280.3534215221255;1282.2306616030307;1298.0524217321408;1328.5018118205674;1370.0820450298324;509.5261406891626;528.4319356691572;535.7053620508783;550.9696966666792;562.361719448429;11983.221090629082;13423.731525369438;13780.724385512434;13912.930435347758;13953.441862325597;547.6084599511289;558.274243483478;567.2172402085096;568.496880260972;569.5529009727344;7302.324191314857;7684.423668224794;7748.806279843049;7788.376929845599;7821.765347039598;576498;578875;579492;603193;608695;90993;92565.5371723137;94226.52886735523;94835.52582237044;95476;559.3232189051212;568.0485187311319;569.6041251330369;571.2373980735764;572.4447286132445;11653.30080195191;11884.881151188723;11886.821697674715;11899.702507437383;11980.400979951142;42348.36477452902;42625.36061959135;43058.78470607627;43364.132717344844;44305;53212;54264.18603721026;54691;54905.72547137239;55116;7756.3019328260725;7934.2859142677435;7961.72133975308;7964.402669799904;7965.522068675898;13843.653908652364;13967.371468284155;14275.64310892236;14354.856451435351;14403.927980360031;12049.156559040783;12316.199447035913;12531.18547294423;12610.306433146265;12663.683407914876;11970.162088654059;12113.939430303144;12202.450889709808;12256.080793940668;12271.141020128862;10629.840552391875;10791.892081079088;12093.75812483763;12672.619821405373;12693.238405695687;7421.369183619453;7453.627318633939;7697.923020769945;7963.562004089831;7967.362610990991;12190.817137742764;12227.205231659913;12449.25304481734;12454.501819927102;12464.626061218178 03:27:04 INFO - 2015-10-28 03:27:04,676 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1528.342812590587;1626.5848711620893;1860.5534671678797;2007.6988451732238;2036.4603380104265;8893.110688931112;9693;10122.69631911042;10122.848157277647;10150.898491015088;9758.756031099208;9889.75275618108;9891.703248902544;9892.109710126088;9907.455089970066;2464.790492808109;2472.8763561821925;2478.6653801736807;2482.2925466242123;2485.9378515537073;2456.4964182342665;2560.2703229579574;2562.948741025178;2567.358160459885;2576.8840402181945;2410.987945060272;2414.855108693484;2419.661247425362;2435.3302841718582;2452.730199678034;2375.2755409600063;2376.9643455348096;2391.8564886106888;2396.508715713275;2409.662647229389;2387.6896003519605;2422.6123820188864;2429.720582133042;2438.183208625113;2484.35406794233;8869.290456763443;9802.166815820663;9818.852717209247;9826.263030272687;9892.208623310189;5276.736163191825;5560.610757246995;5642.633228840154;5645.407232240596;5659.915101273484;3491.9825400872833;3499.1602015516346;3533.9293214135573;3559.039059453933;3593.802340871251;1074.9355038697704;1131.9886801131966;1133.2010932292715;1135.4606561883122;1150.764093360859;15555.144467054308;15650.217489125613;15689.450869219523;15719.37122515098;15739.527814165593;5173.1722924331925;5184.040952423814;5229.320188375486;5236.29310043147;5252.684838909678;13044.282564459047;13090.934545327213;13108.541201057917;13118;13144.474221031243;5833.620814647034;5836.474717275466;5838.153467747238;5842.415758424124;5844.298684157843;5176.7411629418375;5274.26160337553;5296.496832800878;5298.231756395378;5300.09898317287;4243.490781106287;4265.232258193493;4278.72188307759;4308.698391112592;4334.19817333788;1305.4582348325528;1306.399056434051;1315.4343632238229;1319.1359659423092;1326.0187461278585;1213.5327898759042;1234.7900856854355;1237.4988129807443;1363.2706502021372;1383.4466213514474;9682.128608425275;9777.951110244545;9872.901270987199;9885.802283954281;9895.554700038372;583.8277708076128;590.8316129902958;592.1946153231602;597.7937611524018;602.599271484458;6942.652867356612;7115.67979440916;7130.750423735144;7135.678894449762;7253.238409966983;12492.625221243377;12532.436040378205;12591.433385497674;12625.800548947835;12651.493940242288;12584.4337004835;13015.544455944186;13105.934470327587;13111.60665180027;13125.212487250796;9373.1564159226;9561.856572151424;9622.278329125204;9662.420254784736;9673.129418352382;9578;9627;9684.46735429558;9689.757756056155;9708.2718796092;11237;11344.546218151512;11410.82883756761;11447.656570302905;11519;11485.655430337103;11631.127665424958;11698.76602467929;11705.824412633987;11742.88257117418;8837.911620883966;8974.86537701922;8982.550872456482;8998.640054398013;9011.774705632411;9952.10431061208;10002.199824013916;10070.546825392728;10082.899171008195;10172.898271017491;9258.166764991183;9276.95361523215;9322.813543729224;9387.765305867408;9415.387999779992;9002.909970900208;9123.042080581443;9151.267898568232;9200;9212.078792121003;9049.502277374808;9241.630334786532;9353.25173986093;9360.15758581731;9361.719148425558;8240.876386854321;8371.95814020926;8397.698356754712;8409.117042710428;8436.072032076589;8557.272631826116;8581;8594.78513037179;8594.78513037179;8599 03:27:04 INFO - 2015-10-28 03:27:04,676 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.1991458833271;373.64877015605333;373.9233457141286;378.1340729728921;389.06041908790274;5957;5976.432238937299;6018.819435416939;6042.879142417149;6044.697765111749;5902.734376953037;5902.822915312548;5913.615614985023;5919.082542205965;5942.316633587128;4644.442666879971;4661.254199328091;4694.694844835092;4700.7649617519155;4756.429228492586;4720.43354797423;4735.573798358147;4735.621150307984;4737.952620473786;4743.383360163174;4552.84065057723;4607.0785842831565;4701.7414042227665;4702.365180700613;4707.105649926503;4644.907101857961;4666.463356713987;4689.320048592935;4705.505921878222;4706.482286948433;4148.087420767426;4154.065335299563;4170.270202714512;4175.519815221258;4186.937195942063;5530.446955304477;5611.8877622447735;5612.803551875665;5724.427557244284;5750.223719797816;5429.8099566515375;5437.401885792599;5441.047816632113;5443.918341224885;5451.155070963967;6289.685515724242;6293.559450838443;6293.653849038301;6294.339094395068;6300.495960323163;4547.257367231172;4570.200214962401;4617.630589552828;4620.3762492063815;4629.097326021427;6561.704723287464;6569.37590928861;6577.046328282372;6580.76967306142;6581.341865813428;4729.905401891943;4730.5032971538185;4732.645051621143;4734.55021772931;4735.289706544046;4798.352222449995;4799;4799.880002999953;4800.447948485899;4803.231482962779;5345.118055520873;5435.809746658848;5488.506034456918;5488.80789172385;5492.642978206404;6413.486921046305;6419.839504012437;6420.0690899819265;6420.325865784025;6422.74309027643;1744.2325376834153;1762.647470505904;1764.3824661368676;1766.7703198584102;1767.4432553745528;1217.5616777959926;1220.4568966809684;1224.136983426682;1228.1832581333492;1252.154795513025;6189.566730328834;6225.595336303126;6239.313675495692;6240.126382306481;6248.593841400295;6567.4417674497245;6580.473562115019;6590.538662293593;6594.505412094112;6601.174853143357;6077.301110372276;6230.221222347207;6239.1577137085915;6241.282252540925;6244.875102498016;3623.4383670530583;3650.014496086095;3651.8721844735837;3653.8721144759807;3654.3056819204267;6554.934450655433;6645.169353830771;6758.628275444898;6791.456683465311;6795.558288711218;6593.934060659332;6612.801615951529;6719.294474080249;6723.22682891464;6729;6633.4693224541925;6637.9668101660145;6640.269570347161;6640.900386494206;6641.269460359356;6438.871222575616;6527.608343499405;6547.148870646785;6588.868222635616;6596.571222870498;6481.449076828522;6486.481081513562;6487.902681459687;6490.935090649033;6493.610383376824;6736.191657001191;6762.8647427052165;6764.3573860483175;6767.627780472121;6768.255491895986;4642.396488456479;4668.299755036772;4741.146593613183;4743.288506724019;4744.217204161275;6624.56940298879;6624.701888414937;6625.503087268377;6633.9668301658185;6639.568428052161;6383.39357761012;6442.420182183439;6463.676816159267;6475.870482590416;6477.222733272038;6276.309605943251;6360.300366959538;6375.203099612549;6377.043443483514;6377.744890204525;6266.154069200599;6266.843328916813;6269.749210031548;6286.748530058747;6309.621422714652;6481.805545833632;6490.772822951174;6491.253505846888;6495.74017039332;6498.675066246763;6256.249250090018;6339.587926784744;6353.459955903615;6353.9046914295395;6355.809325720235 03:27:04 INFO - 2015-10-28 03:27:04,677 DEBUG : BROWSER_OUTPUT: |5;yui.html;813.6054013803305;872.8647059705744;948.0519480519481;957.0716405087064;962.5476026267661;14036.298185090744;14374.568762937115;14376.353064112114;14386.280685965712;14387.496437624684;12864.356782160878;12984.610461686165;13009.609711708641;13028.609141725763;13036.478540858354;759.2938567132592;767.8272388712523;925.2366797392161;937.5359197197397;937.74212091675;912.3978174404895;927.8561822917425;932.9533523323806;936.3398803843309;936.8782058332407;972.8492083726999;977.6773664690635;977.8142152990945;977.9315447918613;978.5205249427801;792.6987744657022;800.1998001998031;958.9952050239774;973.4937832327186;988.8220120378329;716.7527203114917;716.9820754481127;722.0613202836345;722.3895808042196;722.7867779005206;13471.191728496322;13670.726585468334;13682.726345473035;13686.65783355424;13717.245551494663;12315.5073797048;12857.871421285854;12991.675208119872;13000.544980925717;13491.527796527074;10162.644307449278;10406.063454289151;10477.79044419115;10600.310979786367;10761.408122553257;3875.069983204011;3935.704822138351;3981.402789581557;3998.3802510610903;3999.920001599981;41548.376774348406;41978.580214198075;41992.79003604963;46839;47134.2929856049;10286.742831429274;10381.273310868166;10509.737256568647;10515.158787296998;10633;20103;20533.897330513253;20575.691364629543;20592;20619.4845128873;8176.550289734122;8249.216324449168;8354.289885359813;8440.831183376298;8555.786105347415;4523.389342438794;4556.908861822812;4589.839355622537;4612.331211974312;4687.929681054787;3224.081136876026;3251.235959549504;3260.347930413879;3265.559149514833;3269.2317305433203;524.7638562646824;533.871870751017;538.2276433318201;549.8323011481457;550.6943646276275;612.9509639228941;684.3567046975827;701.3792793377897;706.5478094019832;743.3198623259765;8272.710455134042;8528.40301178924;8566.443181193203;8568;8582.656693732306;600.5375860587324;668.6055227415848;729.8175456135966;735.2867718313228;751.143696186348;4101.384792281182;4222.619964203175;4242.809073591696;4243.724157929724;4244.172386384687;54047;54149.45850541523;54215.45784542183;54362.45637543653;54364.72817635886;46490;48150.759246203546;48299.75850120727;48450.75774621175;48503.27245091327;38621.61378386236;39282.80358598246;39376.60623393787;39519.20961580752;39551;7674.309312161932;7849.136594974662;7922.801929951797;7973.122956474667;8087.636056377595;27474.450510989267;28049.298767530974;28211.15366539007;28638.856805715837;28721.856390717912;35305.29389412146;35906.46140307845;36124.27751445009;36143.81928090343;38457.42313865238;10383.117435017806;10461.9476902615;10655.20085993569;10855.945720271664;11080.168987325822;10580.36517808934;10816;11020.173486988348;11278.097752179641;11571.132165087483;10071.899281007096;10153.39079655223;10521.736956576147;10531.315464494783;10550.947245263724;10618.8407173894;10667.093297069836;10815.459227038775;10927.672169834917;11051;10368.53341599645;10419.589780710814;10620.150387969099;10625;10956.178286628694;9238.815223695623;9432.386894851812;9460.668876589287;9461.858072129062;10180.79638407213;9661.3237073407;9810.901890980998;10028.147607453448;10072.395656260647;10153.39079655223 03:27:04 INFO - 2015-10-28 03:27:04,677 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:27:04 INFO - 2015-10-28 03:27:04,677 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:27:04 INFO - 2015-10-28 03:27:04,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 03:27:04 INFO - 2015-10-28 03:27:04,677 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:27:04 INFO - 2015-10-28 03:27:04,677 DEBUG : BROWSER_OUTPUT: __startTimestamp1446028024668__endTimestamp 03:27:04 INFO - 2015-10-28 03:27:04,677 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,678 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:27:04 INFO - 2015-10-28 03:27:04,678 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:27:04 INFO - 2015-10-28 03:27:04,678 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,678 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5716.68 Median:5955.34 stddev:640.23 (10.8%) stddev-sans-first:614.64 03:27:04 INFO - 2015-10-28 03:27:04,678 DEBUG : BROWSER_OUTPUT: Values: 3348.2 3410.9 3415.9 3434.6 3443.4 5701.2 5701.5 5729.1 5735.1 5739.3 5759.8 5788.7 5789.1 5826.3 5834.6 5230.8 5244.7 5275.7 5321.5 5348.3 5275.5 5278.2 5287.0 5289.0 5289.0 5111.4 5191.2 5216.2 5273.7 5309.2 5262.0 5263.0 5263.8 5264.6 5285.4 5098.7 5239.1 5241.4 5329.7 5337.7 5407.5 5476.7 5479.4 5494.8 5506.8 6201.8 6216.5 6247.5 6254.6 6256.1 6036.3 6145.8 6279.5 6285.5 6286.6 5630.3 5712.3 5740.3 5741.9 5758.0 6235.6 6247.5 6247.5 6256.1 6263.7 5950.8 5955.3 6057.8 6069.5 6082.9 6101.7 6213.9 6237.8 6241.5 6242.1 6165.1 6184.0 6194.8 6202.5 6208.3 5986.9 6045.8 6116.3 6148.8 6157.0 4666.1 4668.2 4681.6 4686.3 4686.3 4172.4 4187.7 4202.8 4204.2 4218.1 5691.8 5755.5 5801.6 5874.8 5903.8 6152.9 6196.0 6205.3 6224.7 6233.5 5909.3 5910.3 5915.1 5928.9 5961.9 5218.9 5251.7 5308.4 5321.7 5342.1 6230.4 6317.8 6318.0 6318.5 6322.2 5986.7 6107.8 6117.7 6123.4 6137.5 6234.5 6352.7 6361.0 6375.2 6377.8 6012.0 6018.7 6031.0 6049.1 6118.9 5995.9 6095.8 6106.1 6119.8 6120.7 5920.4 5952.1 6089.7 6094.6 6108.4 5986.0 6025.7 6029.1 6036.8 6053.1 5713.3 5829.6 5944.6 5950.3 5951.5 6051.6 6147.8 6164.0 6164.0 6167.8 5966.4 5972.8 5976.2 5977.7 5991.2 03:27:04 INFO - 2015-10-28 03:27:04,678 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,678 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66518.87 Median:38634.00 stddev:128464.27 (332.5%) stddev-sans-first:128729.32 03:27:04 INFO - 2015-10-28 03:27:04,679 DEBUG : BROWSER_OUTPUT: Values: 602.7 647.5 653.1 655.7 661.1 35927.5 46412.0 46490.0 46605.3 46748.0 50293.2 50881.7 50894.2 50996.7 51028.0 8335.0 8463.0 9243.1 9404.6 10764.5 11037.0 11149.3 11154.6 11166.2 11166.7 11168.2 11228.3 11274.7 11287.8 11291.2 11140.9 11177.4 11256.8 11266.2 11273.8 10958.0 11057.7 11085.1 11085.7 11089.2 46143.8 46549.3 46672.0 46672.3 46678.0 3627.4 3657.3 3779.3 4186.8 4393.0 35331.1 35419.8 35483.5 35813.5 37272.4 3719.0 3731.5 3741.7 3783.2 3858.3 349201.0 349823.0 454679.0 464410.0 472267.0 72538.3 72808.6 72825.0 73114.6 73418.0 71700.6 73688.0 77831.0 77946.6 77992.6 19879.1 19976.3 20150.8 20320.4 20325.5 14764.8 14867.9 14867.9 14868.9 14889.3 23532.3 23801.6 23916.6 23932.9 23986.5 8972.7 9152.6 9214.0 9276.7 9281.1 1097.7 1158.0 1181.0 1232.9 1289.1 31406.5 32482.8 35670.0 35807.0 36118.1 1222.2 1234.4 1243.7 1306.9 1359.2 15095.7 16457.3 16894.2 17285.7 17620.4 456407.0 460452.0 461262.0 461825.5 463617.0 64428.7 64877.4 64960.0 64975.4 65012.0 1441.9 1479.2 1579.1 1614.0 1691.7 34237.1 34655.8 34674.8 34800.5 34839.5 53028.5 53166.2 53577.0 53625.0 54384.2 554186.0 561257.0 564582.0 567370.0 567811.0 38634.0 38634.0 39273.6 39277.0 39325.2 50360.5 50818.7 51008.7 51091.7 51817.0 41404.8 42707.4 42909.8 43256.4 43520.1 42598.4 43098.0 43279.6 43948.0 44151.6 43289.4 43479.8 43536.8 43537.8 43836.8 36732.0 38046.8 38304.6 38973.0 39177.8 28884.9 28995.4 30676.2 31003.0 31072.2 03:27:04 INFO - 2015-10-28 03:27:04,680 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,680 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30442.75 Median:4612.23 stddev:96867.33 (2100.2%) stddev-sans-first:97112.80 03:27:04 INFO - 2015-10-28 03:27:04,680 DEBUG : BROWSER_OUTPUT: Values: 400.6 400.8 403.8 404.9 407.1 15984.3 16415.9 18921.9 19086.6 19346.3 12653.8 19234.2 19247.0 19532.7 19609.6 4861.4 4966.0 4972.4 4975.4 4977.7 3794.6 3869.9 4931.7 5194.1 5339.1 5262.6 5266.4 5267.6 5273.6 5290.4 5154.7 5250.4 5261.9 5264.0 5265.8 4568.3 4602.7 4605.3 4607.7 4616.7 15224.5 15499.1 16123.3 16366.1 16391.8 2324.1 2465.1 2471.2 2503.7 2506.0 10442.9 10547.4 10592.6 10848.5 10880.1 1730.0 1778.8 1834.0 1889.1 1903.1 72583.0 73331.0 73758.6 73997.6 75250.6 8073.0 8103.0 8152.3 8194.1 8203.3 9796.5 9804.6 9831.3 9855.1 9879.4 6480.8 6537.7 6590.1 6597.2 6610.3 6825.1 6879.3 6905.3 6920.7 6944.1 3737.9 3746.9 3758.3 3801.6 3806.8 1280.4 1282.2 1298.1 1328.5 1370.1 509.5 528.4 535.7 551.0 562.4 11983.2 13423.7 13780.7 13912.9 13953.4 547.6 558.3 567.2 568.5 569.6 7302.3 7684.4 7748.8 7788.4 7821.8 576498.0 578875.0 579492.0 603193.0 608695.0 90993.0 92565.5 94226.5 94835.5 95476.0 559.3 568.0 569.6 571.2 572.4 11653.3 11884.9 11886.8 11899.7 11980.4 42348.4 42625.4 43058.8 43364.1 44305.0 53212.0 54264.2 54691.0 54905.7 55116.0 7756.3 7934.3 7961.7 7964.4 7965.5 13843.7 13967.4 14275.6 14354.9 14403.9 12049.2 12316.2 12531.2 12610.3 12663.7 11970.2 12113.9 12202.5 12256.1 12271.1 10629.8 10791.9 12093.8 12672.6 12693.2 7421.4 7453.6 7697.9 7963.6 7967.4 12190.8 12227.2 12449.3 12454.5 12464.6 03:27:04 INFO - 2015-10-28 03:27:04,680 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,680 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:7074.62 Median:4321.45 stddev:4086.91 (94.6%) stddev-sans-first:4077.12 03:27:04 INFO - 2015-10-28 03:27:04,680 DEBUG : BROWSER_OUTPUT: Values: 1528.3 1626.6 1860.6 2007.7 2036.5 8893.1 9693.0 10122.7 10122.8 10150.9 9758.8 9889.8 9891.7 9892.1 9907.5 2464.8 2472.9 2478.7 2482.3 2485.9 2456.5 2560.3 2562.9 2567.4 2576.9 2411.0 2414.9 2419.7 2435.3 2452.7 2375.3 2377.0 2391.9 2396.5 2409.7 2387.7 2422.6 2429.7 2438.2 2484.4 8869.3 9802.2 9818.9 9826.3 9892.2 5276.7 5560.6 5642.6 5645.4 5659.9 3492.0 3499.2 3533.9 3559.0 3593.8 1074.9 1132.0 1133.2 1135.5 1150.8 15555.1 15650.2 15689.5 15719.4 15739.5 5173.2 5184.0 5229.3 5236.3 5252.7 13044.3 13090.9 13108.5 13118.0 13144.5 5833.6 5836.5 5838.2 5842.4 5844.3 5176.7 5274.3 5296.5 5298.2 5300.1 4243.5 4265.2 4278.7 4308.7 4334.2 1305.5 1306.4 1315.4 1319.1 1326.0 1213.5 1234.8 1237.5 1363.3 1383.4 9682.1 9778.0 9872.9 9885.8 9895.6 583.8 590.8 592.2 597.8 602.6 6942.7 7115.7 7130.8 7135.7 7253.2 12492.6 12532.4 12591.4 12625.8 12651.5 12584.4 13015.5 13105.9 13111.6 13125.2 9373.2 9561.9 9622.3 9662.4 9673.1 9578.0 9627.0 9684.5 9689.8 9708.3 11237.0 11344.5 11410.8 11447.7 11519.0 11485.7 11631.1 11698.8 11705.8 11742.9 8837.9 8974.9 8982.6 8998.6 9011.8 9952.1 10002.2 10070.5 10082.9 10172.9 9258.2 9277.0 9322.8 9387.8 9415.4 9002.9 9123.0 9151.3 9200.0 9212.1 9049.5 9241.6 9353.3 9360.2 9361.7 8240.9 8372.0 8397.7 8409.1 8436.1 8557.3 8581.0 8594.8 8594.8 8599.0 03:27:04 INFO - 2015-10-28 03:27:04,681 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,681 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5386.00 Median:6133.43 stddev:1556.14 (25.4%) stddev-sans-first:1514.15 03:27:04 INFO - 2015-10-28 03:27:04,682 DEBUG : BROWSER_OUTPUT: Values: 363.2 373.6 373.9 378.1 389.1 5957.0 5976.4 6018.8 6042.9 6044.7 5902.7 5902.8 5913.6 5919.1 5942.3 4644.4 4661.3 4694.7 4700.8 4756.4 4720.4 4735.6 4735.6 4738.0 4743.4 4552.8 4607.1 4701.7 4702.4 4707.1 4644.9 4666.5 4689.3 4705.5 4706.5 4148.1 4154.1 4170.3 4175.5 4186.9 5530.4 5611.9 5612.8 5724.4 5750.2 5429.8 5437.4 5441.0 5443.9 5451.2 6289.7 6293.6 6293.7 6294.3 6300.5 4547.3 4570.2 4617.6 4620.4 4629.1 6561.7 6569.4 6577.0 6580.8 6581.3 4729.9 4730.5 4732.6 4734.6 4735.3 4798.4 4799.0 4799.9 4800.4 4803.2 5345.1 5435.8 5488.5 5488.8 5492.6 6413.5 6419.8 6420.1 6420.3 6422.7 1744.2 1762.6 1764.4 1766.8 1767.4 1217.6 1220.5 1224.1 1228.2 1252.2 6189.6 6225.6 6239.3 6240.1 6248.6 6567.4 6580.5 6590.5 6594.5 6601.2 6077.3 6230.2 6239.2 6241.3 6244.9 3623.4 3650.0 3651.9 3653.9 3654.3 6554.9 6645.2 6758.6 6791.5 6795.6 6593.9 6612.8 6719.3 6723.2 6729.0 6633.5 6638.0 6640.3 6640.9 6641.3 6438.9 6527.6 6547.1 6588.9 6596.6 6481.4 6486.5 6487.9 6490.9 6493.6 6736.2 6762.9 6764.4 6767.6 6768.3 4642.4 4668.3 4741.1 4743.3 4744.2 6624.6 6624.7 6625.5 6634.0 6639.6 6383.4 6442.4 6463.7 6475.9 6477.2 6276.3 6360.3 6375.2 6377.0 6377.7 6266.2 6266.8 6269.7 6286.7 6309.6 6481.8 6490.8 6491.3 6495.7 6498.7 6256.2 6339.6 6353.5 6353.9 6355.8 03:27:04 INFO - 2015-10-28 03:27:04,682 DEBUG : BROWSER_OUTPUT: 03:27:04 INFO - 2015-10-28 03:27:04,682 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12953.27 Median:41763.48 stddev:14187.49 (34.0%) stddev-sans-first:14198.00 03:27:04 INFO - 2015-10-28 03:27:04,682 DEBUG : BROWSER_OUTPUT: Values: 813.6 872.9 948.1 957.1 962.5 14036.3 14374.6 14376.4 14386.3 14387.5 12864.4 12984.6 13009.6 13028.6 13036.5 759.3 767.8 925.2 937.5 937.7 912.4 927.9 933.0 936.3 936.9 972.8 977.7 977.8 977.9 978.5 792.7 800.2 959.0 973.5 988.8 716.8 717.0 722.1 722.4 722.8 13471.2 13670.7 13682.7 13686.7 13717.2 12315.5 12857.9 12991.7 13000.5 13491.5 10162.6 10406.1 10477.8 10600.3 10761.4 3875.1 3935.7 3981.4 3998.4 3999.9 41548.4 41978.6 41992.8 46839.0 47134.3 10286.7 10381.3 10509.7 10515.2 10633.0 20103.0 20533.9 20575.7 20592.0 20619.5 8176.6 8249.2 8354.3 8440.8 8555.8 4523.4 4556.9 4589.8 4612.3 4687.9 3224.1 3251.2 3260.3 3265.6 3269.2 524.8 533.9 538.2 549.8 550.7 613.0 684.4 701.4 706.5 743.3 8272.7 8528.4 8566.4 8568.0 8582.7 600.5 668.6 729.8 735.3 751.1 4101.4 4222.6 4242.8 4243.7 4244.2 54047.0 54149.5 54215.5 54362.5 54364.7 46490.0 48150.8 48299.8 48450.8 48503.3 38621.6 39282.8 39376.6 39519.2 39551.0 7674.3 7849.1 7922.8 7973.1 8087.6 27474.5 28049.3 28211.2 28638.9 28721.9 35305.3 35906.5 36124.3 36143.8 38457.4 10383.1 10461.9 10655.2 10855.9 11080.2 10580.4 10816.0 11020.2 11278.1 11571.1 10071.9 10153.4 10521.7 10531.3 10550.9 10618.8 10667.1 10815.5 10927.7 11051.0 10368.5 10419.6 10620.2 10625.0 10956.2 9238.8 9432.4 9460.7 9461.9 10180.8 9661.3 9810.9 10028.1 10072.4 10153.4 03:27:04 INFO - 2015-10-28 03:27:04,682 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:27:04 INFO - 2015-10-28 03:27:04,682 DEBUG : BROWSER_OUTPUT: 03:27:05 INFO - 2015-10-28 03:27:05,246 INFO : Browser exited with error code: 0 03:27:05 INFO - 2015-10-28 03:27:05,266 INFO : Completed test dromaeo_css (00:18:32) 03:27:05 INFO - 2015-10-28 03:27:05,267 INFO : Starting test kraken 03:27:05 INFO - 2015-10-28 03:27:05,267 DEBUG : operating with platform_type : linux_ 03:27:05 INFO - 2015-10-28 03:27:05,267 INFO : Initialising browser for kraken test... 03:27:05 INFO - 2015-10-28 03:27:05,272 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps3VHDM/profile http://localhost/getInfo.html 03:27:08 INFO - 2015-10-28 03:27:08,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:27:08 INFO - 2015-10-28 03:27:08,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:27:08 INFO - 2015-10-28 03:27:08,846 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:27:08 INFO - 2015-10-28 03:27:08,846 DEBUG : BROWSER_OUTPUT: __metrics 03:27:08 INFO - 2015-10-28 03:27:08,942 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:27:10 INFO - 2015-10-28 03:27:10,143 INFO : Browser initialized. 03:27:10 INFO - 2015-10-28 03:27:10,144 INFO : Running cycle 1/1 for kraken test... 03:27:10 INFO - 2015-10-28 03:27:10,144 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps3VHDM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/page_load_test/kraken/kraken.manifest -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:27:21 INFO - 2015-10-28 03:27:21,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 133042176 03:27:21 INFO - 2015-10-28 03:27:21,792 DEBUG : BROWSER_OUTPUT: 03:27:24 INFO - 2015-10-28 03:27:24,689 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:27:25 INFO - 2015-10-28 03:27:25,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 166076416 03:27:25 INFO - 2015-10-28 03:27:25,264 DEBUG : BROWSER_OUTPUT: 03:27:27 INFO - 2015-10-28 03:27:27,835 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:27:28 INFO - 2015-10-28 03:27:28,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 163823616 03:27:28 INFO - 2015-10-28 03:27:28,397 DEBUG : BROWSER_OUTPUT: 03:27:31 INFO - 2015-10-28 03:27:31,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost/page_load_test/kraken/driver.html?testName=audio-dft (next: http://localhost/page_load_test/kraken/driver.html?testName=audio-fft) 03:27:31 INFO - 2015-10-28 03:27:31,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 161955840 03:27:31 INFO - 2015-10-28 03:27:31,717 DEBUG : BROWSER_OUTPUT: 03:27:33 INFO - 2015-10-28 03:27:33,654 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:27:34 INFO - 2015-10-28 03:27:34,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 160550912 03:27:34 INFO - 2015-10-28 03:27:34,216 DEBUG : BROWSER_OUTPUT: 03:27:36 INFO - 2015-10-28 03:27:36,309 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:27:36 INFO - 2015-10-28 03:27:36,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 156311552 03:27:36 INFO - 2015-10-28 03:27:36,871 DEBUG : BROWSER_OUTPUT: 03:27:39 INFO - 2015-10-28 03:27:39,682 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:27:40 INFO - 2015-10-28 03:27:40,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 156389376 03:27:40 INFO - 2015-10-28 03:27:40,247 DEBUG : BROWSER_OUTPUT: 03:27:43 INFO - 2015-10-28 03:27:43,560 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:27:44 INFO - 2015-10-28 03:27:44,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 158035968 03:27:44 INFO - 2015-10-28 03:27:44,127 DEBUG : BROWSER_OUTPUT: 03:27:46 INFO - 2015-10-28 03:27:46,809 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:27:47 INFO - 2015-10-28 03:27:47,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 155074560 03:27:47 INFO - 2015-10-28 03:27:47,375 DEBUG : BROWSER_OUTPUT: 03:27:48 INFO - 2015-10-28 03:27:48,842 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:27:49 INFO - 2015-10-28 03:27:49,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 166748160 03:27:49 INFO - 2015-10-28 03:27:49,404 DEBUG : BROWSER_OUTPUT: 03:27:51 INFO - 2015-10-28 03:27:51,085 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:27:51 INFO - 2015-10-28 03:27:51,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 165064704 03:27:51 INFO - 2015-10-28 03:27:51,671 DEBUG : BROWSER_OUTPUT: 03:27:53 INFO - 2015-10-28 03:27:53,614 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:27:54 INFO - 2015-10-28 03:27:54,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 171962368 03:27:54 INFO - 2015-10-28 03:27:54,180 DEBUG : BROWSER_OUTPUT: 03:27:56 INFO - 2015-10-28 03:27:56,438 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:27:57 INFO - 2015-10-28 03:27:57,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 176615424 03:27:57 INFO - 2015-10-28 03:27:57,008 DEBUG : BROWSER_OUTPUT: 03:27:59 INFO - 2015-10-28 03:27:59,402 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:27:59 INFO - 2015-10-28 03:27:59,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 174825472 03:27:59 INFO - 2015-10-28 03:27:59,968 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,565 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:28:01 INFO - 2015-10-28 03:28:01,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 232452096 03:28:01 INFO - 2015-10-28 03:28:01,824 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,824 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:28:01 INFO - 2015-10-28 03:28:01,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:28:01 INFO - 2015-10-28 03:28:01,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:28:01 INFO - 2015-10-28 03:28:01,825 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:28:01 INFO - 2015-10-28 03:28:01,825 DEBUG : BROWSER_OUTPUT: |0;ai-astar;104;115;110;110;110;110;116;110;108;110 03:28:01 INFO - 2015-10-28 03:28:01,825 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;122;158;159;131;150;145;123;161;130 03:28:01 INFO - 2015-10-28 03:28:01,825 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;160;160;162;161;160;158;159;158 03:28:01 INFO - 2015-10-28 03:28:01,825 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;72;143;70;70;70;72;149;72 03:28:01 INFO - 2015-10-28 03:28:01,826 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;88;140;87;88;88;131;88;88;131 03:28:01 INFO - 2015-10-28 03:28:01,826 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;109;110;110 03:28:01 INFO - 2015-10-28 03:28:01,826 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;147;145;145;145 03:28:01 INFO - 2015-10-28 03:28:01,826 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;96;96;95;96;96 03:28:01 INFO - 2015-10-28 03:28:01,826 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;55;54;52;53;53;53;52;65;51 03:28:01 INFO - 2015-10-28 03:28:01,827 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;62;61;61;62;61;62;61;61;61 03:28:01 INFO - 2015-10-28 03:28:01,827 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;85;77;79;78;78;78;79;79;78 03:28:01 INFO - 2015-10-28 03:28:01,827 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;110;106;105;112;106;114;104;107;114 03:28:01 INFO - 2015-10-28 03:28:01,827 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;135;131;132;132;134;132;133;135;149 03:28:01 INFO - 2015-10-28 03:28:01,827 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;61;61;61;59;61;62;63;63;60 03:28:01 INFO - 2015-10-28 03:28:01,828 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:28:01 INFO - 2015-10-28 03:28:01,828 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:28:01 INFO - 2015-10-28 03:28:01,828 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,847 03:28:01 INFO - 2015-10-28 03:28:01,828 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:28:01 INFO - 2015-10-28 03:28:01,828 DEBUG : BROWSER_OUTPUT: __startTimestamp1446028081816__endTimestamp 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:3.33 (3.0%) stddev-sans-first:2.65 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: Values: 104.0 115.0 110.0 110.0 110.0 110.0 116.0 110.0 108.0 110.0 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,829 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:154.00 stddev:16.20 (10.5%) stddev-sans-first:15.83 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: Values: 162.0 122.0 158.0 159.0 131.0 150.0 145.0 123.0 161.0 130.0 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.41 (0.9%) stddev-sans-first:1.30 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 160.0 160.0 162.0 161.0 160.0 158.0 159.0 158.0 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.10 Median:71.50 stddev:31.61 (44.2%) stddev-sans-first:33.12 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 143.0 70.0 70.0 70.0 72.0 149.0 72.0 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.80 Median:88.00 stddev:22.36 (25.4%) stddev-sans-first:23.23 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: Values: 89.0 88.0 140.0 87.0 88.0 88.0 131.0 88.0 88.0 131.0 03:28:01 INFO - 2015-10-28 03:28:01,830 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 147.0 145.0 145.0 145.0 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,831 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:3.97 (7.4%) stddev-sans-first:4.21 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: Values: 54.0 55.0 54.0 52.0 53.0 53.0 53.0 52.0 65.0 51.0 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 61.0 61.0 62.0 61.0 62.0 61.0 61.0 61.0 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:2.30 (2.9%) stddev-sans-first:2.35 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: Values: 77.0 85.0 77.0 79.0 78.0 78.0 78.0 79.0 79.0 78.0 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:109.10 Median:111.00 stddev:3.93 (3.5%) stddev-sans-first:3.91 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 106.0 105.0 112.0 106.0 114.0 104.0 107.0 114.0 03:28:01 INFO - 2015-10-28 03:28:01,832 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,833 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.00 Median:134.50 stddev:5.25 (3.9%) stddev-sans-first:5.52 03:28:01 INFO - 2015-10-28 03:28:01,833 DEBUG : BROWSER_OUTPUT: Values: 137.0 135.0 131.0 132.0 132.0 134.0 132.0 133.0 135.0 149.0 03:28:01 INFO - 2015-10-28 03:28:01,833 DEBUG : BROWSER_OUTPUT: 03:28:01 INFO - 2015-10-28 03:28:01,833 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:1.23 (2.0%) stddev-sans-first:1.30 03:28:01 INFO - 2015-10-28 03:28:01,833 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 61.0 59.0 61.0 62.0 63.0 63.0 60.0 03:28:01 INFO - 2015-10-28 03:28:01,833 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:28:01 INFO - 2015-10-28 03:28:01,833 DEBUG : BROWSER_OUTPUT: 03:28:02 INFO - 2015-10-28 03:28:02,661 INFO : Browser exited with error code: 0 03:28:02 INFO - 2015-10-28 03:28:02,714 INFO : Completed test kraken (00:00:57) 03:28:02 INFO - 2015-10-28 03:28:02,714 INFO : Starting test v8_7 03:28:02 INFO - 2015-10-28 03:28:02,714 DEBUG : operating with platform_type : linux_ 03:28:02 INFO - 2015-10-28 03:28:02,714 INFO : Initialising browser for v8_7 test... 03:28:02 INFO - 2015-10-28 03:28:02,720 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMN04eC/profile http://localhost/getInfo.html 03:28:06 INFO - 2015-10-28 03:28:06,199 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:28:06 INFO - 2015-10-28 03:28:06,199 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:28:06 INFO - 2015-10-28 03:28:06,199 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:28:06 INFO - 2015-10-28 03:28:06,199 DEBUG : BROWSER_OUTPUT: __metrics 03:28:06 INFO - 2015-10-28 03:28:06,316 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:28:07 INFO - 2015-10-28 03:28:07,440 INFO : Browser initialized. 03:28:07 INFO - 2015-10-28 03:28:07,441 INFO : Running cycle 1/1 for v8_7 test... 03:28:07 INFO - 2015-10-28 03:28:07,441 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMN04eC/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:28:19 INFO - 2015-10-28 03:28:19,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 132558848 03:28:19 INFO - 2015-10-28 03:28:19,145 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,523 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:28:40 INFO - 2015-10-28 03:28:40,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 426786816 03:28:40 INFO - 2015-10-28 03:28:40,770 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,771 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:28:40 INFO - 2015-10-28 03:28:40,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:28:40 INFO - 2015-10-28 03:28:40,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:28:40 INFO - 2015-10-28 03:28:40,772 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:28:40 INFO - 2015-10-28 03:28:40,772 DEBUG : BROWSER_OUTPUT: |0;Richards;168.4352366515075 03:28:40 INFO - 2015-10-28 03:28:40,772 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.31153466973382 03:28:40 INFO - 2015-10-28 03:28:40,772 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8988764044944 03:28:40 INFO - 2015-10-28 03:28:40,773 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5081.218274111675 03:28:40 INFO - 2015-10-28 03:28:40,773 DEBUG : BROWSER_OUTPUT: |4;RayTrace;955.1098376313277 03:28:40 INFO - 2015-10-28 03:28:40,773 DEBUG : BROWSER_OUTPUT: |5;Earley;539.0835579514825 03:28:40 INFO - 2015-10-28 03:28:40,774 DEBUG : BROWSER_OUTPUT: |6;Boyer;10265.30612244898 03:28:40 INFO - 2015-10-28 03:28:40,774 DEBUG : BROWSER_OUTPUT: |7;RegExp;23348.837209302324 03:28:40 INFO - 2015-10-28 03:28:40,774 DEBUG : BROWSER_OUTPUT: |8;Splay;526.0389268805892 03:28:40 INFO - 2015-10-28 03:28:40,774 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 03:28:40 INFO - 2015-10-28 03:28:40,774 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:28:40 INFO - 2015-10-28 03:28:40,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1446028120770__endTimestamp 03:28:40 INFO - 2015-10-28 03:28:40,775 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,775 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:28:40 INFO - 2015-10-28 03:28:40,775 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:28:40 INFO - 2015-10-28 03:28:40,776 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,777 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.44 Median:168.44 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,777 DEBUG : BROWSER_OUTPUT: Values: 168.4 03:28:40 INFO - 2015-10-28 03:28:40,777 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,777 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.31 Median:164.31 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,778 DEBUG : BROWSER_OUTPUT: Values: 164.3 03:28:40 INFO - 2015-10-28 03:28:40,778 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,778 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,778 DEBUG : BROWSER_OUTPUT: Values: 280.9 03:28:40 INFO - 2015-10-28 03:28:40,778 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,779 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5081.22 Median:5081.22 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,779 DEBUG : BROWSER_OUTPUT: Values: 5081.2 03:28:40 INFO - 2015-10-28 03:28:40,779 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,779 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:955.11 Median:955.11 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,779 DEBUG : BROWSER_OUTPUT: Values: 955.1 03:28:40 INFO - 2015-10-28 03:28:40,780 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,780 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:539.08 Median:539.08 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,780 DEBUG : BROWSER_OUTPUT: Values: 539.1 03:28:40 INFO - 2015-10-28 03:28:40,780 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,780 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10265.31 Median:10265.31 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: Values: 10265.3 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23348.84 Median:23348.84 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: Values: 23348.8 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:526.04 Median:526.04 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: Values: 526.0 03:28:40 INFO - 2015-10-28 03:28:40,781 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-10-28 03:28:40,782 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 03:28:40 INFO - 2015-10-28 03:28:40,782 DEBUG : BROWSER_OUTPUT: Values: 4817.3 03:28:40 INFO - 2015-10-28 03:28:40,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:28:40 INFO - 2015-10-28 03:28:40,782 DEBUG : BROWSER_OUTPUT: 03:28:41 INFO - 2015-10-28 03:28:41,581 INFO : Browser exited with error code: 0 03:28:41 INFO - 2015-10-28 03:28:41,598 INFO : Completed test v8_7 (00:00:38) 03:28:41 INFO - 2015-10-28 03:28:41,598 INFO : Completed test suite (00:20:08) 03:28:41 INFO - 2015-10-28 03:28:41,598 DEBUG : Working with test: dromaeo_css 03:28:41 INFO - 2015-10-28 03:28:41,598 DEBUG : Generating results file: dromaeo_css 03:28:41 INFO - 2015-10-28 03:28:41,599 DEBUG : Working with test: kraken 03:28:41 INFO - 2015-10-28 03:28:41,599 DEBUG : Generating results file: kraken 03:28:41 INFO - 2015-10-28 03:28:41,600 INFO : javascript benchmark 03:28:41 INFO - 2015-10-28 03:28:41,600 DEBUG : Working with test: v8_7 03:28:41 INFO - 2015-10-28 03:28:41,600 DEBUG : Generating results file: v8_7 03:28:41 INFO - 2015-10-28 03:28:41,600 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:28:41 INFO - 2015-10-28 03:28:41,661 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:28:41 INFO - 2015-10-28 03:28:41,662 DEBUG : process_Request line: dromaeo_css 7458.93 graph.html#tests=[[72,52,35]] 03:28:41 INFO - 2015-10-28 03:28:41,662 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:28:41 INFO - 2015-10-28 03:28:41,692 DEBUG : process_Request line: kraken 1452.70 graph.html#tests=[[232,52,35]] 03:28:41 INFO - 2015-10-28 03:28:41,692 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:28:41 INFO - 2015-10-28 03:28:41,735 DEBUG : process_Request line: v8_7 23450.90 graph.html#tests=[[230,52,35]] 03:28:41 INFO - 2015-10-28 03:28:41,738 INFO : javascript benchmark 03:28:41 INFO - 2015-10-28 03:28:41,742 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [400.61340806122087, 400.84767788240464, 403.7617805494758, 404.85020542399315, 407.1246819338422, 15984.280707368167, 16415.917920410382, 18921.905390473046, 19086.61826763464, 19346.322878699248, 12653.810192847115, 19234.230630774753, 19247.0, 19532.707009394835, 19609.607807843833, 4861.368022157123, 4966.0, 4972.403311602613, 4975.353204083464, 4977.676451030689, 3794.6395092466173, 3869.941950870739, 4931.728754918496, 5194.11700010999, 5339.092354299778, 5262.631615786897, 5266.3943646480575, 5267.578593712494, 5273.604479664022, 5290.444503327153, 5154.716490593016, 5250.4487028861995, 5261.894762104736, 5264.0, 5265.842024739245, 4568.33759104928, 4602.677812553123, 4605.332226827091, 4607.723536587815, 4616.746078965655, 15224.543263702106, 15499.147546884917, 16123.307052759526, 16366.099864507447, 16391.83608163915, 2324.1168356024773, 2465.0755966512556, 2471.1845091119885, 2503.7120731115974, 2506.035176457059, 10442.947785261102, 10547.367157970546, 10592.576296948113, 10848.457577121113, 10880.075193608553, 1729.9827001729948, 1778.813224611423, 1833.9541511462187, 1889.1121173048646, 1903.067496926496, 72583.0, 73331.0, 73758.63120684416, 73997.63001185014, 75250.62374688147, 8072.959635201903, 8103.0, 8152.347812175011, 8194.09864914859, 8203.261706446328, 9796.51017449139, 9804.558794854249, 9831.311808173503, 9855.113039826307, 9879.407235565888, 6480.833449978954, 6537.70580323877, 6590.143281373391, 6597.208334999831, 6610.272869984298, 6825.078614386995, 6879.346462086194, 6905.343992320722, 6920.723171073201, 6944.131983502062, 3737.8691745788765, 3746.9437958430644, 3758.323501769653, 3801.581825999138, 3806.8477260909253, 1280.3534215221255, 1282.2306616030307, 1298.0524217321408, 1328.5018118205674, 1370.0820450298324, 509.5261406891626, 528.4319356691572, 535.7053620508783, 550.9696966666792, 562.361719448429, 11983.221090629082, 13423.731525369438, 13780.724385512434, 13912.930435347758, 13953.441862325597, 547.6084599511289, 558.274243483478, 567.2172402085096, 568.496880260972, 569.5529009727344, 7302.324191314857, 7684.423668224794, 7748.806279843049, 7788.376929845599, 7821.765347039598, 576498.0, 578875.0, 579492.0, 603193.0, 608695.0, 90993.0, 92565.5371723137, 94226.52886735523, 94835.52582237044, 95476.0, 559.3232189051212, 568.0485187311319, 569.6041251330369, 571.2373980735764, 572.4447286132445, 11653.30080195191, 11884.881151188723, 11886.821697674715, 11899.702507437383, 11980.400979951142, 42348.36477452902, 42625.36061959135, 43058.78470607627, 43364.132717344844, 44305.0, 53212.0, 54264.18603721026, 54691.0, 54905.72547137239, 55116.0, 7756.3019328260725, 7934.2859142677435, 7961.72133975308, 7964.402669799904, 7965.522068675898, 13843.653908652364, 13967.371468284155, 14275.64310892236, 14354.856451435351, 14403.927980360031, 12049.156559040783, 12316.199447035913, 12531.18547294423, 12610.306433146265, 12663.683407914876, 11970.162088654059, 12113.939430303144, 12202.450889709808, 12256.080793940668, 12271.141020128862, 10629.840552391875, 10791.892081079088, 12093.75812483763, 12672.619821405373, 12693.238405695687, 7421.369183619453, 7453.627318633939, 7697.923020769945, 7963.562004089831, 7967.362610990991, 12190.817137742764, 12227.205231659913, 12449.25304481734, 12454.501819927102, 12464.626061218178], "dojo.html": [3348.213169905072, 3410.9488357674622, 3415.897523074307, 3434.605020422651, 3443.4490481522953, 5701.201831743554, 5701.458361455665, 5729.111987641912, 5735.111057786039, 5739.25389699339, 5759.769609215637, 5788.6816225107605, 5789.073748200289, 5826.300843898727, 5834.5915785895, 5230.790768369261, 5244.659097158682, 5275.683458992454, 5321.52106310432, 5348.277982472375, 5275.498827611371, 5278.155495120763, 5286.973565132169, 5288.973555132219, 5288.973555132238, 5111.437741848412, 5191.169412893938, 5216.217567364906, 5273.736313184345, 5309.150535914255, 5262.000219958234, 5263.0, 5263.842084737464, 5264.631475796696, 5285.365756109291, 5098.6685865419, 5239.13554263546, 5241.3710354757295, 5329.733513324357, 5337.653052551611, 5407.486288802557, 5476.698781567012, 5479.424660410639, 5494.80768173112, 5506.779728810843, 6201.81394558164, 6216.502679785606, 6247.531435142382, 6254.562180647356, 6256.061590761422, 6036.275646922353, 6145.78489752861, 6279.497640188774, 6285.528585356116, 6286.591371560879, 5630.324361076697, 5712.343080545749, 5740.311162660466, 5741.942580574224, 5758.049921762904, 6235.625862448268, 6247.500199983991, 6247.531435142382, 6256.061590761331, 6263.655498947602, 5950.761969521171, 5955.34491205967, 6057.787977420858, 6069.544784141119, 6082.878342433127, 6101.694915254219, 6213.937860621336, 6237.75048998035, 6241.469475094577, 6242.063690446469, 6165.10605962133, 6184.0, 6194.81415557534, 6202.472789812917, 6208.255009398901, 5986.880262394728, 6045.8488537786025, 6116.327204007555, 6148.78479253224, 6157.0, 4666.136764698542, 4668.206404911173, 4681.578657920735, 4686.320483529869, 4686.343911852344, 4172.415861779354, 4187.72779769314, 4202.789860506962, 4204.243236217449, 4218.135282267128, 5691.800786972519, 5755.539556835443, 5801.622894511843, 5874.794382196688, 5903.76384944606, 6152.938470615326, 6195.983382955022, 6205.255369355616, 6224.719887604978, 6233.532485063638, 5909.320428150818, 5910.34986151523, 5915.053591425437, 5928.851778705567, 5961.940380596138, 5218.921716174261, 5251.711155886386, 5308.416074231832, 5321.6540924839765, 5342.065138600807, 6230.408111229426, 6317.842053948688, 6317.96841015792, 6318.494520438354, 6322.178116844781, 5986.730597123227, 6107.84730381744, 6117.663528505975, 6123.418275263843, 6137.508999280136, 6234.470070044097, 6352.68236588178, 6361.01404282337, 6375.171227740364, 6377.7767778127545, 6012.038073908328, 6018.6689732063405, 6031.0, 6049.062395328731, 6118.938810611837, 5995.910061348996, 6095.817125486243, 6106.084087386927, 6119.755209791559, 6120.724567394389, 5920.407959204217, 5952.107183922446, 6089.695515224133, 6094.634321940521, 6108.389161083856, 5985.982382994988, 6025.728842202199, 6029.125776762433, 6036.849078773066, 6053.092036194606, 5713.314402271754, 5829.59192856496, 5944.613600115978, 5950.34546199909, 5951.49412299942, 6051.576389652682, 6147.784827531015, 6164.0, 6164.044573091178, 6167.84580385476, 5966.3735307793795, 5972.820815375546, 5976.19321391624, 5977.7310021050025, 5991.221141251609], "mootools.html": [1528.342812590587, 1626.5848711620893, 1860.5534671678797, 2007.6988451732238, 2036.4603380104265, 8893.110688931112, 9693.0, 10122.69631911042, 10122.848157277647, 10150.898491015088, 9758.756031099208, 9889.75275618108, 9891.703248902544, 9892.109710126088, 9907.455089970066, 2464.790492808109, 2472.8763561821925, 2478.6653801736807, 2482.2925466242123, 2485.9378515537073, 2456.4964182342665, 2560.2703229579574, 2562.948741025178, 2567.358160459885, 2576.8840402181945, 2410.987945060272, 2414.855108693484, 2419.661247425362, 2435.3302841718582, 2452.730199678034, 2375.2755409600063, 2376.9643455348096, 2391.8564886106888, 2396.508715713275, 2409.662647229389, 2387.6896003519605, 2422.6123820188864, 2429.720582133042, 2438.183208625113, 2484.35406794233, 8869.290456763443, 9802.166815820663, 9818.852717209247, 9826.263030272687, 9892.208623310189, 5276.736163191825, 5560.610757246995, 5642.633228840154, 5645.407232240596, 5659.915101273484, 3491.9825400872833, 3499.1602015516346, 3533.9293214135573, 3559.039059453933, 3593.802340871251, 1074.9355038697704, 1131.9886801131966, 1133.2010932292715, 1135.4606561883122, 1150.764093360859, 15555.144467054308, 15650.217489125613, 15689.450869219523, 15719.37122515098, 15739.527814165593, 5173.1722924331925, 5184.040952423814, 5229.320188375486, 5236.29310043147, 5252.684838909678, 13044.282564459047, 13090.934545327213, 13108.541201057917, 13118.0, 13144.474221031243, 5833.620814647034, 5836.474717275466, 5838.153467747238, 5842.415758424124, 5844.298684157843, 5176.7411629418375, 5274.26160337553, 5296.496832800878, 5298.231756395378, 5300.09898317287, 4243.490781106287, 4265.232258193493, 4278.72188307759, 4308.698391112592, 4334.19817333788, 1305.4582348325528, 1306.399056434051, 1315.4343632238229, 1319.1359659423092, 1326.0187461278585, 1213.5327898759042, 1234.7900856854355, 1237.4988129807443, 1363.2706502021372, 1383.4466213514474, 9682.128608425275, 9777.951110244545, 9872.901270987199, 9885.802283954281, 9895.554700038372, 583.8277708076128, 590.8316129902958, 592.1946153231602, 597.7937611524018, 602.599271484458, 6942.652867356612, 7115.67979440916, 7130.750423735144, 7135.678894449762, 7253.238409966983, 12492.625221243377, 12532.436040378205, 12591.433385497674, 12625.800548947835, 12651.493940242288, 12584.4337004835, 13015.544455944186, 13105.934470327587, 13111.60665180027, 13125.212487250796, 9373.1564159226, 9561.856572151424, 9622.278329125204, 9662.420254784736, 9673.129418352382, 9578.0, 9627.0, 9684.46735429558, 9689.757756056155, 9708.2718796092, 11237.0, 11344.546218151512, 11410.82883756761, 11447.656570302905, 11519.0, 11485.655430337103, 11631.127665424958, 11698.76602467929, 11705.824412633987, 11742.88257117418, 8837.911620883966, 8974.86537701922, 8982.550872456482, 8998.640054398013, 9011.774705632411, 9952.10431061208, 10002.199824013916, 10070.546825392728, 10082.899171008195, 10172.898271017491, 9258.166764991183, 9276.95361523215, 9322.813543729224, 9387.765305867408, 9415.387999779992, 9002.909970900208, 9123.042080581443, 9151.267898568232, 9200.0, 9212.078792121003, 9049.502277374808, 9241.630334786532, 9353.25173986093, 9360.15758581731, 9361.719148425558, 8240.876386854321, 8371.95814020926, 8397.698356754712, 8409.117042710428, 8436.072032076589, 8557.272631826116, 8581.0, 8594.78513037179, 8594.78513037179, 8599.0], "ext.html": [602.6926267603524, 647.4690753582058, 653.1378580274038, 655.7311502284065, 661.0711949710657, 35927.46108808367, 46412.0, 46490.0, 46605.30092048618, 46748.0, 50293.24560131601, 50881.69268997513, 50894.23658645123, 50996.745016274865, 51028.0, 8335.0, 8462.957685211597, 9243.121903419182, 9404.62381504739, 10764.461776911163, 11037.0, 11149.275297105703, 11154.609588664358, 11166.162537809656, 11166.720831979224, 11168.218224724273, 11228.270162439456, 11274.718132046683, 11287.774244515105, 11291.153163512728, 11140.944295278512, 11177.44112794357, 11256.831147532794, 11266.155038372113, 11273.774524509547, 10958.0, 11057.668269951915, 11085.113190944705, 11085.667429977113, 11089.2237543372, 46143.76928115338, 46549.30176047362, 46672.0, 46672.299915501295, 46678.0, 3627.365211088049, 3657.3416784978695, 3779.3008293465796, 4186.790660466995, 4393.033532622818, 35331.1167220819, 35419.822900885585, 35483.4677479838, 35813.46279805805, 37272.44091338632, 3718.9814050929845, 3731.533558305212, 3741.681957033655, 3783.16770310534, 3858.305505009097, 349201.0, 349823.0, 454679.0, 464410.0, 472267.0, 72538.27461725421, 72808.63595681988, 72825.0, 73114.63442682753, 73418.0, 71700.64149679322, 73688.0, 77831.0, 77946.61026694831, 77992.61003694945, 19879.10544025522, 19976.3008294709, 20150.798492015187, 20320.39038828808, 20325.49186270355, 14764.778528322084, 14867.851321486647, 14867.925660371846, 14868.851311486964, 14889.255537223313, 23532.29403117909, 23801.642975355036, 23916.641250381257, 23932.88033559821, 23986.52026959451, 8972.730818075468, 9152.63389464414, 9214.0, 9276.72169834906, 9281.118293762082, 1097.720081379243, 1157.9594714184964, 1180.9940950295365, 1232.9136960412684, 1289.0976316578433, 31406.528902066486, 32482.837585811918, 35670.0, 35807.0, 36118.09704757402, 1222.2483172848633, 1234.4259919137644, 1243.6766440725296, 1306.882380585752, 1359.232033900843, 15095.698086038437, 16457.341706331612, 16894.15529223534, 17285.654286914192, 17620.383286585165, 456407.0, 460452.0, 461262.0, 461825.4543636369, 463617.0, 64428.67785661136, 64877.35122648808, 64960.0, 64975.35024649693, 65012.0, 1441.8630230128122, 1479.2160155117804, 1579.0683496736751, 1613.9972867289189, 1691.687037897993, 34237.14407139841, 34655.82672086624, 34674.82662586772, 34800.47799283063, 34839.47740783839, 53028.469715303894, 53166.20250696165, 53577.0, 53625.0, 54384.184237235684, 554186.0, 561257.0, 564582.0, 567370.0, 567811.0, 38634.0, 38634.0, 39273.60726392699, 39277.0, 39325.21349572935, 50360.49639503558, 50818.74590627023, 51008.74495627647, 51091.744541277054, 51817.0, 41404.79297603493, 42707.35938960856, 42909.785451072545, 43256.35115473333, 43520.12959740851, 42598.36102458404, 43098.0, 43279.567204327555, 43948.0, 44151.558484414745, 43289.35065974076, 43479.782601086794, 43536.78231608822, 43537.78231108824, 43836.780816095714, 36732.0, 38046.809765950995, 38304.61695383122, 38973.0, 39177.80411097926, 28884.855575721987, 28995.420091598473, 30676.233094172825, 31003.0, 31072.22319442032], "prototype.html": [363.1991458833271, 373.64877015605333, 373.9233457141286, 378.1340729728921, 389.06041908790274, 5957.0, 5976.432238937299, 6018.819435416939, 6042.879142417149, 6044.697765111749, 5902.734376953037, 5902.822915312548, 5913.615614985023, 5919.082542205965, 5942.316633587128, 4644.442666879971, 4661.254199328091, 4694.694844835092, 4700.7649617519155, 4756.429228492586, 4720.43354797423, 4735.573798358147, 4735.621150307984, 4737.952620473786, 4743.383360163174, 4552.84065057723, 4607.0785842831565, 4701.7414042227665, 4702.365180700613, 4707.105649926503, 4644.907101857961, 4666.463356713987, 4689.320048592935, 4705.505921878222, 4706.482286948433, 4148.087420767426, 4154.065335299563, 4170.270202714512, 4175.519815221258, 4186.937195942063, 5530.446955304477, 5611.8877622447735, 5612.803551875665, 5724.427557244284, 5750.223719797816, 5429.8099566515375, 5437.401885792599, 5441.047816632113, 5443.918341224885, 5451.155070963967, 6289.685515724242, 6293.559450838443, 6293.653849038301, 6294.339094395068, 6300.495960323163, 4547.257367231172, 4570.200214962401, 4617.630589552828, 4620.3762492063815, 4629.097326021427, 6561.704723287464, 6569.37590928861, 6577.046328282372, 6580.76967306142, 6581.341865813428, 4729.905401891943, 4730.5032971538185, 4732.645051621143, 4734.55021772931, 4735.289706544046, 4798.352222449995, 4799.0, 4799.880002999953, 4800.447948485899, 4803.231482962779, 5345.118055520873, 5435.809746658848, 5488.506034456918, 5488.80789172385, 5492.642978206404, 6413.486921046305, 6419.839504012437, 6420.0690899819265, 6420.325865784025, 6422.74309027643, 1744.2325376834153, 1762.647470505904, 1764.3824661368676, 1766.7703198584102, 1767.4432553745528, 1217.5616777959926, 1220.4568966809684, 1224.136983426682, 1228.1832581333492, 1252.154795513025, 6189.566730328834, 6225.595336303126, 6239.313675495692, 6240.126382306481, 6248.593841400295, 6567.4417674497245, 6580.473562115019, 6590.538662293593, 6594.505412094112, 6601.174853143357, 6077.301110372276, 6230.221222347207, 6239.1577137085915, 6241.282252540925, 6244.875102498016, 3623.4383670530583, 3650.014496086095, 3651.8721844735837, 3653.8721144759807, 3654.3056819204267, 6554.934450655433, 6645.169353830771, 6758.628275444898, 6791.456683465311, 6795.558288711218, 6593.934060659332, 6612.801615951529, 6719.294474080249, 6723.22682891464, 6729.0, 6633.4693224541925, 6637.9668101660145, 6640.269570347161, 6640.900386494206, 6641.269460359356, 6438.871222575616, 6527.608343499405, 6547.148870646785, 6588.868222635616, 6596.571222870498, 6481.449076828522, 6486.481081513562, 6487.902681459687, 6490.935090649033, 6493.610383376824, 6736.191657001191, 6762.8647427052165, 6764.3573860483175, 6767.627780472121, 6768.255491895986, 4642.396488456479, 4668.299755036772, 4741.146593613183, 4743.288506724019, 4744.217204161275, 6624.56940298879, 6624.701888414937, 6625.503087268377, 6633.9668301658185, 6639.568428052161, 6383.39357761012, 6442.420182183439, 6463.676816159267, 6475.870482590416, 6477.222733272038, 6276.309605943251, 6360.300366959538, 6375.203099612549, 6377.043443483514, 6377.744890204525, 6266.154069200599, 6266.843328916813, 6269.749210031548, 6286.748530058747, 6309.621422714652, 6481.805545833632, 6490.772822951174, 6491.253505846888, 6495.74017039332, 6498.675066246763, 6256.249250090018, 6339.587926784744, 6353.459955903615, 6353.9046914295395, 6355.809325720235], "yui.html": [813.6054013803305, 872.8647059705744, 948.0519480519481, 957.0716405087064, 962.5476026267661, 14036.298185090744, 14374.568762937115, 14376.353064112114, 14386.280685965712, 14387.496437624684, 12864.356782160878, 12984.610461686165, 13009.609711708641, 13028.609141725763, 13036.478540858354, 759.2938567132592, 767.8272388712523, 925.2366797392161, 937.5359197197397, 937.74212091675, 912.3978174404895, 927.8561822917425, 932.9533523323806, 936.3398803843309, 936.8782058332407, 972.8492083726999, 977.6773664690635, 977.8142152990945, 977.9315447918613, 978.5205249427801, 792.6987744657022, 800.1998001998031, 958.9952050239774, 973.4937832327186, 988.8220120378329, 716.7527203114917, 716.9820754481127, 722.0613202836345, 722.3895808042196, 722.7867779005206, 13471.191728496322, 13670.726585468334, 13682.726345473035, 13686.65783355424, 13717.245551494663, 12315.5073797048, 12857.871421285854, 12991.675208119872, 13000.544980925717, 13491.527796527074, 10162.644307449278, 10406.063454289151, 10477.79044419115, 10600.310979786367, 10761.408122553257, 3875.069983204011, 3935.704822138351, 3981.402789581557, 3998.3802510610903, 3999.920001599981, 41548.376774348406, 41978.580214198075, 41992.79003604963, 46839.0, 47134.2929856049, 10286.742831429274, 10381.273310868166, 10509.737256568647, 10515.158787296998, 10633.0, 20103.0, 20533.897330513253, 20575.691364629543, 20592.0, 20619.4845128873, 8176.550289734122, 8249.216324449168, 8354.289885359813, 8440.831183376298, 8555.786105347415, 4523.389342438794, 4556.908861822812, 4589.839355622537, 4612.331211974312, 4687.929681054787, 3224.081136876026, 3251.235959549504, 3260.347930413879, 3265.559149514833, 3269.2317305433203, 524.7638562646824, 533.871870751017, 538.2276433318201, 549.8323011481457, 550.6943646276275, 612.9509639228941, 684.3567046975827, 701.3792793377897, 706.5478094019832, 743.3198623259765, 8272.710455134042, 8528.40301178924, 8566.443181193203, 8568.0, 8582.656693732306, 600.5375860587324, 668.6055227415848, 729.8175456135966, 735.2867718313228, 751.143696186348, 4101.384792281182, 4222.619964203175, 4242.809073591696, 4243.724157929724, 4244.172386384687, 54047.0, 54149.45850541523, 54215.45784542183, 54362.45637543653, 54364.72817635886, 46490.0, 48150.759246203546, 48299.75850120727, 48450.75774621175, 48503.27245091327, 38621.61378386236, 39282.80358598246, 39376.60623393787, 39519.20961580752, 39551.0, 7674.309312161932, 7849.136594974662, 7922.801929951797, 7973.122956474667, 8087.636056377595, 27474.450510989267, 28049.298767530974, 28211.15366539007, 28638.856805715837, 28721.856390717912, 35305.29389412146, 35906.46140307845, 36124.27751445009, 36143.81928090343, 38457.42313865238, 10383.117435017806, 10461.9476902615, 10655.20085993569, 10855.945720271664, 11080.168987325822, 10580.36517808934, 10816.0, 11020.173486988348, 11278.097752179641, 11571.132165087483, 10071.899281007096, 10153.39079655223, 10521.736956576147, 10531.315464494783, 10550.947245263724, 10618.8407173894, 10667.093297069836, 10815.459227038775, 10927.672169834917, 11051.0, 10368.53341599645, 10419.589780710814, 10620.150387969099, 10625.0, 10956.178286628694, 9238.815223695623, 9432.386894851812, 9460.668876589287, 9461.858072129062, 10180.79638407213, 9661.3237073407, 9810.901890980998, 10028.147607453448, 10072.395656260647, 10153.39079655223]}, "summary": {"suite": 7458.932058129174, "subtests": {"jquery.html": {"std": 96597.87536088956, "min": 400.61340806122087, "max": 608695.0, "median": 8020.161123096447, "filtered": 7892.27710999314, "mean": 30442.74512326834}, "dojo.html": {"std": 638.2864140899819, "min": 3348.213169905072, "max": 6377.7767778127545, "median": 5955.34491205967, "filtered": 5674.432973883681, "mean": 5716.678636464278}, "mootools.html": {"std": 4075.5401313586026, "min": 583.8277708076128, "max": 15739.527814165593, "median": 8496.672331951351, "filtered": 5456.968637743097, "mean": 7074.623013503636}, "ext.html": {"std": 128106.93058761282, "min": 602.6926267603524, "max": 567811.0, "median": 34737.65230934917, "filtered": 22658.537428622767, "mean": 66518.87341290606}, "prototype.html": {"std": 1551.809293902815, "min": 363.1991458833271, "max": 6795.558288711218, "median": 6060.999437742012, "filtered": 4901.137963190109, "mean": 5385.9994409303845}, "yui.html": {"std": 14148.025015445864, "min": 524.7638562646824, "max": 54364.72817635886, "median": 10153.39079655223, "filtered": 6344.7838978604395, "mean": 12953.269133166415}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-060"}, "testrun": {"date": 1446026913, "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": "20151028004029", "branch": "Mozilla-Aurora", "revision": "927509f2757caac0fd74abb007e7459eeeffcee9"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 158.0, 159.0, 158.0], "ai-astar": [104.0, 115.0, 110.0, 110.0, 110.0, 110.0, 116.0, 110.0, 108.0, 110.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "audio-beat-detection": [162.0, 122.0, 158.0, 159.0, 131.0, 150.0, 145.0, 123.0, 161.0, 130.0], "json-stringify-tinderbox": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0], "stanford-crypto-pbkdf2": [137.0, 135.0, 131.0, 132.0, 132.0, 134.0, 132.0, 133.0, 135.0, 149.0], "json-parse-financial": [54.0, 55.0, 54.0, 52.0, 53.0, 53.0, 53.0, 52.0, 65.0, 51.0], "stanford-crypto-sha256-iterative": [61.0, 61.0, 61.0, 61.0, 59.0, 61.0, 62.0, 63.0, 63.0, 60.0], "audio-fft": [72.0, 71.0, 72.0, 143.0, 70.0, 70.0, 70.0, 72.0, 149.0, 72.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [113.0, 110.0, 106.0, 105.0, 112.0, 106.0, 114.0, 104.0, 107.0, 114.0], "audio-oscillator": [89.0, 88.0, 140.0, 87.0, 88.0, 88.0, 131.0, 88.0, 88.0, 131.0], "stanford-crypto-aes": [77.0, 85.0, 77.0, 79.0, 78.0, 78.0, 78.0, 79.0, 79.0, 78.0], "imaging-desaturate": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0]}, "summary": {"suite": 1452.6999999999998, "subtests": {"audio-fft": {"std": 29.99149879549203, "min": 70.0, "max": 149.0, "median": 72.0, "filtered": 86.1, "mean": 86.1}, "stanford-crypto-pbkdf2": {"std": 4.979959839195493, "min": 131.0, "max": 149.0, "median": 133.5, "filtered": 135.0, "mean": 135.0}, "audio-beat-detection": {"std": 15.36522046701576, "min": 122.0, "max": 162.0, "median": 147.5, "filtered": 144.1, "mean": 144.1}, "stanford-crypto-ccm": {"std": 3.726929030716845, "min": 104.0, "max": 114.0, "median": 108.5, "filtered": 109.1, "mean": 109.1}, "imaging-darkroom": {"std": 0.6000000000000001, "min": 145.0, "max": 147.0, "median": 145.0, "filtered": 145.2, "mean": 145.2}, "json-parse-financial": {"std": 3.7629775444453557, "min": 51.0, "max": 65.0, "median": 53.0, "filtered": 54.2, "mean": 54.2}, "audio-oscillator": {"std": 21.2122606056026, "min": 87.0, "max": 140.0, "median": 88.0, "filtered": 101.8, "mean": 101.8}, "ai-astar": {"std": 3.163858403911275, "min": 104.0, "max": 116.0, "median": 110.0, "filtered": 110.3, "mean": 110.3}, "audio-dft": {"std": 1.3416407864998738, "min": 158.0, "max": 162.0, "median": 160.0, "filtered": 160.0, "mean": 160.0}, "stanford-crypto-sha256-iterative": {"std": 1.16619037896906, "min": 59.0, "max": 63.0, "median": 61.0, "filtered": 61.2, "mean": 61.2}, "json-stringify-tinderbox": {"std": 0.45825756949558394, "min": 61.0, "max": 62.0, "median": 61.0, "filtered": 61.3, "mean": 61.3}, "imaging-gaussian-blur": {"std": 0.30000000000000004, "min": 109.0, "max": 110.0, "median": 110.0, "filtered": 109.9, "mean": 109.9}, "stanford-crypto-aes": {"std": 2.1817424229271425, "min": 77.0, "max": 85.0, "median": 78.0, "filtered": 78.8, "mean": 78.8}, "imaging-desaturate": {"std": 0.45825756949558394, "min": 95.0, "max": 96.0, "median": 96.0, "filtered": 95.7, "mean": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-060"}, "testrun": {"date": 1446026913, "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": "20151028004029", "branch": "Mozilla-Aurora", "revision": "927509f2757caac0fd74abb007e7459eeeffcee9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [164.31153466973382], "Encrypt": [280.8988764044944], "NavierStokes": [4817.307692307692], "Decrypt": [5081.218274111675], "Splay": [526.0389268805892], "Richards": [168.4352366515075], "RegExp": [23348.837209302324], "Earley": [539.0835579514825], "Boyer": [10265.30612244898], "RayTrace": [955.1098376313277]}, "summary": {"suite": 23450.90200006527, "subtests": {"DeltaBlue": {"std": 0.0, "min": 164.31153466973382, "max": 164.31153466973382, "median": 164.31153466973382, "value": 402.39414800000014, "filtered": 402.39414800000014, "mean": 164.31153466973382}, "Encrypt": {"std": 0.0, "min": 280.8988764044944, "max": 280.8988764044944, "median": 280.8988764044944, "value": 947.6043599999998, "filtered": 947.6043599999998, "mean": 280.8988764044944}, "NavierStokes": {"std": 0.0, "min": 4817.307692307692, "max": 4817.307692307692, "median": 4817.307692307692, "value": 308.055888223553, "filtered": 308.055888223553, "mean": 4817.307692307692}, "Decrypt": {"std": 0.0, "min": 5081.218274111675, "max": 5081.218274111675, "median": 5081.218274111675, "value": 52.38527172827171, "filtered": 52.38527172827171, "mean": 5081.218274111675}, "Splay": {"std": 0.0, "min": 526.0389268805892, "max": 526.0389268805892, "median": 526.0389268805892, "value": 154.91439100000002, "filtered": 154.91439100000002, "mean": 526.0389268805892}, "RegExp": {"std": 0.0, "min": 23348.837209302324, "max": 23348.837209302324, "median": 23348.837209302324, "value": 39.01628984063744, "filtered": 39.01628984063744, "mean": 23348.837209302324}, "Richards": {"std": 0.0, "min": 168.4352366515075, "max": 168.4352366515075, "median": 168.4352366515075, "value": 209.587974, "filtered": 209.587974, "mean": 168.4352366515075}, "Earley": {"std": 0.0, "min": 539.0835579514825, "max": 539.0835579514825, "median": 539.0835579514825, "value": 1236.288865, "filtered": 1236.288865, "mean": 539.0835579514825}, "Boyer": {"std": 0.0, "min": 10265.30612244898, "max": 10265.30612244898, "median": 10265.30612244898, "value": 64.9238310139165, "filtered": 64.9238310139165, "mean": 10265.30612244898}, "RayTrace": {"std": 0.0, "min": 955.1098376313277, "max": 955.1098376313277, "median": 955.1098376313277, "value": 774.7684829999998, "filtered": 774.7684829999998, "mean": 955.1098376313277}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-060"}, "testrun": {"date": 1446026913, "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": "20151028004029", "branch": "Mozilla-Aurora", "revision": "927509f2757caac0fd74abb007e7459eeeffcee9"}}] 03:28:41 INFO - RETURN: dromaeo_css: 7458.93 03:28:41 INFO - RETURN: kraken: 1452.70 03:28:41 INFO - RETURN: v8_7: 23450.90 03:28:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23450.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1452.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7458.93"}}} 03:28:41 INFO - Return code: 0 03:28:41 INFO - # TBPL SUCCESS # 03:28:41 INFO - Running post-action listener: _resource_record_post_action 03:28:41 INFO - Running post-run listener: _resource_record_post_run 03:28:42 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 7512064; Write bytes: 385011712; Read time: 1680; Write time: 270072 03:28:42 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 610304; Read time: 0; Write time: 56 03:28:42 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 5177344; Write bytes: 384401408; Read time: 1400; Write time: 270016 03:28:42 INFO - Running post-run listener: _upload_blobber_files 03:28:42 INFO - Blob upload gear active. 03:28:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:28:42 INFO - Copying logs to upload dir... 03:28:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.010974 ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-10-28 03:28:42.960246) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-28 03:28:42.964290) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/artifacts/public/build/firefox-43.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009825 build_url: 'https://queue.taskcluster.net/v1/task/2MyaIPZvSfWgQCkwPGPOaA/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-28 03:28:43.016659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:28:43.017147) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1446026822.461021-939000054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-28 03:28:43.066785) ========= ========= Started reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-28 03:28:43.067149) ========= ========= Finished reboot slave lost (results: 0, elapsed: 3 secs) (at 2015-10-28 03:28:47.063346) =========